builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1466523618.49 results: success (0) buildid: 20160621055904 builduid: aaa87a9ab85f4e26a03835bfe826c945 revision: 5f7dcce004111d3e2f78cdae83bafb8551937018 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.486645) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.487118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.487445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.505357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.505623) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 08:40:19-- 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% 230M=0s 2016-06-21 08:40:19 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.609004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.609317) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018276 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.659538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:18.659844) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5f7dcce004111d3e2f78cdae83bafb8551937018 --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 5f7dcce004111d3e2f78cdae83bafb8551937018 --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=78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 08:40:19,510 truncating revision to first 12 chars 2016-06-21 08:40:19,510 Setting DEBUG logging. 2016-06-21 08:40:19,510 attempt 1/10 2016-06-21 08:40:19,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5f7dcce00411?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 08:40:19,813 unpacking tar archive at: mozilla-beta-5f7dcce00411/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:19.305322) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:19.305627) ========= script_repo_revision: 5f7dcce004111d3e2f78cdae83bafb8551937018 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:19.306085) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:19.306383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:40:19.325058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-21 08:40:19.325329) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:20 INFO - MultiFileLogger online at 20160621 08:40:20 in /builds/slave/test 08:40:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:40:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:20 INFO - {'append_to_log': False, 08:40:20 INFO - 'base_work_dir': '/builds/slave/test', 08:40:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:40:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:20 INFO - 'branch': 'Mozilla-Beta', 08:40:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:20 INFO - 'config_files': ('talos/linux_config.py',), 08:40:20 INFO - 'default_actions': ('clobber', 08:40:20 INFO - 'read-buildbot-config', 08:40:20 INFO - 'download-and-extract', 08:40:20 INFO - 'populate-webroot', 08:40:20 INFO - 'create-virtualenv', 08:40:20 INFO - 'install', 08:40:20 INFO - 'run-tests'), 08:40:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:20 INFO - 'download_minidump_stackwalk': True, 08:40:20 INFO - 'download_symbols': 'ondemand', 08:40:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:20 INFO - 'installer_path': 'installer.exe', 08:40:20 INFO - 'log_level': 'info', 08:40:20 INFO - 'log_name': 'talos', 08:40:20 INFO - 'log_to_console': True, 08:40:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:20 INFO - 'opt_config_files': (), 08:40:20 INFO - 'pip_index': False, 08:40:20 INFO - 'sps_profile': False, 08:40:20 INFO - 'sps_profile_interval': 0, 08:40:20 INFO - 'suite': 'dromaeojs-e10s', 08:40:20 INFO - 'system_bits': '32', 08:40:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:20 INFO - 'title': 'talos-linux64-ix-019', 08:40:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:20 INFO - 'use_talos_json': True, 08:40:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:20 INFO - 'work_dir': 'build'} 08:40:20 INFO - ##### 08:40:20 INFO - ##### Running clobber step. 08:40:20 INFO - ##### 08:40:20 INFO - Running pre-action listener: _resource_record_pre_action 08:40:20 INFO - Running main action method: clobber 08:40:20 INFO - rmtree: /builds/slave/test/build 08:40:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:21 INFO - Running post-action listener: _resource_record_post_action 08:40:21 INFO - ##### 08:40:21 INFO - ##### Running read-buildbot-config step. 08:40:21 INFO - ##### 08:40:21 INFO - Running pre-action listener: _resource_record_pre_action 08:40:21 INFO - Running main action method: read_buildbot_config 08:40:21 INFO - Using buildbot properties: 08:40:21 INFO - { 08:40:21 INFO - "project": "", 08:40:21 INFO - "product": "firefox", 08:40:21 INFO - "script_repo_revision": "production", 08:40:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:40:21 INFO - "repository": "", 08:40:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:40:21 INFO - "buildid": "20160621055904", 08:40:21 INFO - "pgo_build": "True", 08:40:21 INFO - "basedir": "/builds/slave/test", 08:40:21 INFO - "buildnumber": 9, 08:40:21 INFO - "slavename": "talos-linux64-ix-019", 08:40:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:40:21 INFO - "platform": "ubuntu64_hw", 08:40:21 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:40:21 INFO - "branch": "mozilla-beta", 08:40:21 INFO - "repo_path": "releases/mozilla-beta", 08:40:21 INFO - "revision": "5f7dcce004111d3e2f78cdae83bafb8551937018", 08:40:21 INFO - "stage_platform": "linux64-pgo", 08:40:21 INFO - "builduid": "aaa87a9ab85f4e26a03835bfe826c945", 08:40:21 INFO - "slavebuilddir": "test" 08:40:21 INFO - } 08:40:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:40:21 INFO - Running post-action listener: _resource_record_post_action 08:40:21 INFO - ##### 08:40:21 INFO - ##### Running download-and-extract step. 08:40:21 INFO - ##### 08:40:21 INFO - Running pre-action listener: _resource_record_pre_action 08:40:21 INFO - Running main action method: download_and_extract 08:40:21 INFO - mkdir: /builds/slave/test/build/tests 08:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:21 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:30 INFO - Downloaded 1327 bytes. 08:40:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:40:30 INFO - Using the following test package requirements: 08:40:30 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:40:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:30 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:40:30 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'jsshell-linux-x86_64.zip'], 08:40:30 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:30 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:40:30 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:40:30 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:40:30 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:40:30 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:30 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:40:30 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:38 INFO - Downloaded 24186693 bytes. 08:40:38 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:40:38 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:40:39 INFO - Return code: 0 08:40:39 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:40: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:40:39 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:40 INFO - Downloaded 24186693 bytes. 08:40:40 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:40:40 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:40:42 INFO - Return code: 0 08:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:42 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:43 INFO - Downloaded 10840145 bytes. 08:40:43 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:40:43 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:40:43 INFO - Return code: 0 08:40:43 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:40:43 INFO - https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JCqgSmEVRgSJ9en9KpCLMw/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:40:46 INFO - Downloaded 56008338 bytes. 08:40:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:46 INFO - mkdir: /builds/slave/test/properties 08:40:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:46 INFO - Contents: 08:40:46 INFO - build_url:https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:40:47 INFO - Running post-action listener: _resource_record_post_action 08:40:47 INFO - Running post-action listener: set_extra_try_arguments 08:40:47 INFO - ##### 08:40:47 INFO - ##### Running populate-webroot step. 08:40:47 INFO - ##### 08:40:47 INFO - Running pre-action listener: _resource_record_pre_action 08:40:47 INFO - Running main action method: populate_webroot 08:40:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:47 INFO - '--tppagecycles', 08:40:47 INFO - '7'], 08:40:47 INFO - 'tests': ['tsvgm']}}, 08:40:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['damp', 'tps']}, 08:40:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'tests': ['damp', 'tps']}, 08:40:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['dromaeo_dom']}, 08:40:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tsvgx', 08:40:47 INFO - 'tsvgr_opacity', 08:40:47 INFO - 'tart', 08:40:47 INFO - 'tscrollx', 08:40:47 INFO - 'cart']}, 08:40:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:47 INFO - 'tsvgr_opacity', 08:40:47 INFO - 'tart', 08:40:47 INFO - 'tscrollx', 08:40:47 INFO - 'cart']}, 08:40:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tp5o']}, 08:40:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'tests': ['tp5o']}, 08:40:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s', 08:40:47 INFO - '--xperf_path', 08:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:47 INFO - 'tests': ['tp5n']}, 08:40:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:47 INFO - 'talos_options': ['--xperf_path', 08:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:47 INFO - 'tests': ['tp5n']}}, 08:40:47 INFO - 'talos.zip': {'path': '', 08:40:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:47 INFO - Running post-action listener: _resource_record_post_action 08:40:47 INFO - ##### 08:40:47 INFO - ##### Running create-virtualenv step. 08:40:47 INFO - ##### 08:40:47 INFO - Running pre-action listener: _resource_record_pre_action 08:40:47 INFO - Running main action method: create_virtualenv 08:40:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:47 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:40:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:47 INFO - Using real prefix '/usr' 08:40:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:49 INFO - Installing pip.................done. 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:49 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:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:40:49 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:40:49 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:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:50 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:40:50 INFO - Cleaning up... 08:40:50 INFO - Return code: 0 08:40:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:40:50 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:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:50 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:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:50 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:40:50 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:40:50 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:40:50 INFO - Using env: {'DISPLAY': ':0', 08:40:50 INFO - 'HOME': '/home/cltbld', 08:40:50 INFO - 'LANG': 'en_US.UTF-8', 08:40:50 INFO - 'LANGUAGE': 'en_US:en', 08:40:50 INFO - 'LOGNAME': 'cltbld', 08:40:50 INFO - 'MAIL': '/var/mail/cltbld', 08:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:50 INFO - 'MOZ_NO_REMOTE': '1', 08:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:50 INFO - 'NO_EM_RESTART': '1', 08:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:50 INFO - 'PWD': '/builds/slave/test', 08:40:50 INFO - 'SHELL': '/bin/bash', 08:40:50 INFO - 'SHLVL': '1', 08:40:50 INFO - 'TERM': 'linux', 08:40:50 INFO - 'TMOUT': '86400', 08:40:50 INFO - 'USER': 'cltbld', 08:40:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:50 INFO - '_': '/tools/buildbot/bin/python'} 08:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:50 INFO - Downloading/unpacking psutil>=0.7.1 08:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:52 INFO - Installing collected packages: psutil 08:40:52 INFO - Running setup.py install for psutil 08:40:52 INFO - building 'psutil._psutil_linux' extension 08:40:52 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:40:52 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:40:52 INFO - building 'psutil._psutil_posix' extension 08:40:52 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:40:52 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:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:52 INFO - Successfully installed psutil 08:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:40:52 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:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 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:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:40:52 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:40:52 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:40:52 INFO - Using env: {'DISPLAY': ':0', 08:40:52 INFO - 'HOME': '/home/cltbld', 08:40:52 INFO - 'LANG': 'en_US.UTF-8', 08:40:52 INFO - 'LANGUAGE': 'en_US:en', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MAIL': '/var/mail/cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SHLVL': '1', 08:40:52 INFO - 'TERM': 'linux', 08:40:52 INFO - 'TMOUT': '86400', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - '_': '/tools/buildbot/bin/python'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:54 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:40:54 INFO - Installing collected packages: mozsystemmonitor 08:40:54 INFO - Running setup.py install for mozsystemmonitor 08:40:55 INFO - Successfully installed mozsystemmonitor 08:40:55 INFO - Cleaning up... 08:40:55 INFO - Return code: 0 08:40:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:55 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:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:40:55 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:40:55 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:40:55 INFO - Using env: {'DISPLAY': ':0', 08:40:55 INFO - 'HOME': '/home/cltbld', 08:40:55 INFO - 'LANG': 'en_US.UTF-8', 08:40:55 INFO - 'LANGUAGE': 'en_US:en', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MAIL': '/var/mail/cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SHLVL': '1', 08:40:55 INFO - 'TERM': 'linux', 08:40:55 INFO - 'TMOUT': '86400', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - '_': '/tools/buildbot/bin/python'} 08:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:55 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 INFO - Downloading docopt-0.6.1.tar.gz 08:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:57 INFO - Running setup.py install for blobuploader 08:40:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:58 INFO - Running setup.py install for requests 08:40:58 INFO - Running setup.py install for docopt 08:40:58 INFO - Successfully installed blobuploader requests docopt 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:40:58 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:40:58 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:40:58 INFO - Using env: {'DISPLAY': ':0', 08:40:58 INFO - 'HOME': '/home/cltbld', 08:40:58 INFO - 'LANG': 'en_US.UTF-8', 08:40:58 INFO - 'LANGUAGE': 'en_US:en', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MAIL': '/var/mail/cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SHLVL': '1', 08:40:58 INFO - 'TERM': 'linux', 08:40:58 INFO - 'TMOUT': '86400', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - '_': '/tools/buildbot/bin/python'} 08:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:58 INFO - Running setup.py (path:/tmp/pip-45rDvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:58 INFO - Running setup.py (path:/tmp/pip-HraIQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:58 INFO - Running setup.py (path:/tmp/pip-cDN0GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:58 INFO - Running setup.py (path:/tmp/pip-tuQbY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:59 INFO - Running setup.py (path:/tmp/pip-SFrZI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:59 INFO - Running setup.py (path:/tmp/pip-aqkE5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:59 INFO - Running setup.py (path:/tmp/pip-ZrMoXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:59 INFO - Running setup.py (path:/tmp/pip-i27nzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:59 INFO - Running setup.py (path:/tmp/pip-TLWVDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:59 INFO - Running setup.py (path:/tmp/pip-M95GKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:59 INFO - Running setup.py (path:/tmp/pip-hV3aDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:59 INFO - Running setup.py (path:/tmp/pip-AoxgPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:59 INFO - Running setup.py (path:/tmp/pip-4t3GI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:59 INFO - Running setup.py (path:/tmp/pip-rV_g_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:59 INFO - Running setup.py (path:/tmp/pip-m20iVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:59 INFO - Running setup.py (path:/tmp/pip-L7_GA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:59 INFO - Running setup.py (path:/tmp/pip-w5cvuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:59 INFO - Running setup.py install for manifestparser 08:41:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Running setup.py install for mozcrash 08:41:00 INFO - Running setup.py install for mozdebug 08:41:00 INFO - Running setup.py install for mozdevice 08:41:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Running setup.py install for mozfile 08:41:00 INFO - Running setup.py install for mozhttpd 08:41:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Running setup.py install for mozinfo 08:41:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Running setup.py install for mozInstall 08:41:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:00 INFO - Running setup.py install for mozleak 08:41:00 INFO - Running setup.py install for mozlog 08:41:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Running setup.py install for moznetwork 08:41:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Running setup.py install for mozprocess 08:41:01 INFO - Running setup.py install for mozprofile 08:41:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Running setup.py install for mozrunner 08:41:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Running setup.py install for mozscreenshot 08:41:01 INFO - Running setup.py install for moztest 08:41:01 INFO - Running setup.py install for mozversion 08:41:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:01 INFO - Cleaning up... 08:41:01 INFO - Return code: 0 08:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:41:01 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:41:01 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:41:01 INFO - Using env: {'DISPLAY': ':0', 08:41:01 INFO - 'HOME': '/home/cltbld', 08:41:01 INFO - 'LANG': 'en_US.UTF-8', 08:41:01 INFO - 'LANGUAGE': 'en_US:en', 08:41:01 INFO - 'LOGNAME': 'cltbld', 08:41:01 INFO - 'MAIL': '/var/mail/cltbld', 08:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:01 INFO - 'MOZ_NO_REMOTE': '1', 08:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:01 INFO - 'NO_EM_RESTART': '1', 08:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:01 INFO - 'PWD': '/builds/slave/test', 08:41:01 INFO - 'SHELL': '/bin/bash', 08:41:01 INFO - 'SHLVL': '1', 08:41:01 INFO - 'TERM': 'linux', 08:41:01 INFO - 'TMOUT': '86400', 08:41:01 INFO - 'USER': 'cltbld', 08:41:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:01 INFO - '_': '/tools/buildbot/bin/python'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:01 INFO - Running setup.py (path:/tmp/pip-vJ_Shx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:02 INFO - Running setup.py (path:/tmp/pip-QogzVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:02 INFO - Running setup.py (path:/tmp/pip-F9i9hL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:02 INFO - Running setup.py (path:/tmp/pip-904LAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:02 INFO - Running setup.py (path:/tmp/pip-mJWaCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:02 INFO - Running setup.py (path:/tmp/pip-wW1dRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:02 INFO - Running setup.py (path:/tmp/pip-sPczmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:02 INFO - Running setup.py (path:/tmp/pip-DAUWhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:02 INFO - Running setup.py (path:/tmp/pip-W99CAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:02 INFO - Running setup.py (path:/tmp/pip-nH6Iek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:02 INFO - Running setup.py (path:/tmp/pip-ciuWqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:02 INFO - Running setup.py (path:/tmp/pip-2NFrNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:02 INFO - Running setup.py (path:/tmp/pip-JFlK8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:02 INFO - Running setup.py (path:/tmp/pip-I_GYk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:02 INFO - Running setup.py (path:/tmp/pip-LbJWDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:03 INFO - Running setup.py (path:/tmp/pip-SgCdDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:03 INFO - Running setup.py (path:/tmp/pip-yLJvZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:03 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:41:03 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:41:03 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:41:03 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:41:03 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:41:03 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:41:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:05 INFO - Downloading blessings-1.6.tar.gz 08:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:05 INFO - Installing collected packages: blessings 08:41:05 INFO - Running setup.py install for blessings 08:41:05 INFO - Successfully installed blessings 08:41:05 INFO - Cleaning up... 08:41:05 INFO - Return code: 0 08:41:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:05 INFO - Reading from file tmpfile_stdout 08:41:05 INFO - Current package versions: 08:41:05 INFO - argparse == 1.2.1 08:41:05 INFO - blessings == 1.6 08:41:05 INFO - blobuploader == 1.2.4 08:41:05 INFO - docopt == 0.6.1 08:41:05 INFO - manifestparser == 1.1 08:41:05 INFO - mozInstall == 1.12 08:41:05 INFO - mozcrash == 0.17 08:41:05 INFO - mozdebug == 0.1 08:41:05 INFO - mozdevice == 0.48 08:41:05 INFO - mozfile == 1.2 08:41:05 INFO - mozhttpd == 0.7 08:41:05 INFO - mozinfo == 0.9 08:41:05 INFO - mozleak == 0.1 08:41:05 INFO - mozlog == 3.1 08:41:05 INFO - moznetwork == 0.27 08:41:05 INFO - mozprocess == 0.22 08:41:05 INFO - mozprofile == 0.28 08:41:05 INFO - mozrunner == 6.11 08:41:05 INFO - mozscreenshot == 0.1 08:41:05 INFO - mozsystemmonitor == 0.0 08:41:05 INFO - moztest == 0.7 08:41:05 INFO - mozversion == 1.4 08:41:05 INFO - psutil == 3.1.1 08:41:05 INFO - requests == 1.2.3 08:41:05 INFO - wsgiref == 0.1.2 08:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:05 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:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:05 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:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:05 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:41:05 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:41:05 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:41:05 INFO - Using env: {'DISPLAY': ':0', 08:41:05 INFO - 'HOME': '/home/cltbld', 08:41:05 INFO - 'LANG': 'en_US.UTF-8', 08:41:05 INFO - 'LANGUAGE': 'en_US:en', 08:41:05 INFO - 'LOGNAME': 'cltbld', 08:41:05 INFO - 'MAIL': '/var/mail/cltbld', 08:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:05 INFO - 'MOZ_NO_REMOTE': '1', 08:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:05 INFO - 'NO_EM_RESTART': '1', 08:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:05 INFO - 'PWD': '/builds/slave/test', 08:41:05 INFO - 'SHELL': '/bin/bash', 08:41:05 INFO - 'SHLVL': '1', 08:41:05 INFO - 'TERM': 'linux', 08:41:05 INFO - 'TMOUT': '86400', 08:41:05 INFO - 'USER': 'cltbld', 08:41:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:05 INFO - '_': '/tools/buildbot/bin/python'} 08:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 INFO - Cleaning up... 08:41:05 INFO - Return code: 0 08:41:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:05 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:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:05 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:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:05 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:41:05 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:41:05 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:41:05 INFO - Using env: {'DISPLAY': ':0', 08:41:05 INFO - 'HOME': '/home/cltbld', 08:41:05 INFO - 'LANG': 'en_US.UTF-8', 08:41:05 INFO - 'LANGUAGE': 'en_US:en', 08:41:05 INFO - 'LOGNAME': 'cltbld', 08:41:05 INFO - 'MAIL': '/var/mail/cltbld', 08:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:05 INFO - 'MOZ_NO_REMOTE': '1', 08:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:05 INFO - 'NO_EM_RESTART': '1', 08:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:05 INFO - 'PWD': '/builds/slave/test', 08:41:05 INFO - 'SHELL': '/bin/bash', 08:41:05 INFO - 'SHLVL': '1', 08:41:05 INFO - 'TERM': 'linux', 08:41:05 INFO - 'TMOUT': '86400', 08:41:05 INFO - 'USER': 'cltbld', 08:41:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:05 INFO - '_': '/tools/buildbot/bin/python'} 08:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:05 INFO - Downloading/unpacking jsonschema 08:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:07 INFO - Downloading/unpacking functools32 (from jsonschema) 08:41: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:41: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:41: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:41: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:41: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:41: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:41:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:08 INFO - warning: no files found matching '*.txt' 08:41:08 INFO - no previously-included directories found matching 'build' 08:41:08 INFO - no previously-included directories found matching 'dist' 08:41:08 INFO - no previously-included directories found matching '.git*' 08:41:08 INFO - Installing collected packages: jsonschema, functools32 08:41:08 INFO - Running setup.py install for functools32 08:41:08 INFO - warning: no files found matching '*.txt' 08:41:08 INFO - no previously-included directories found matching 'build' 08:41:08 INFO - no previously-included directories found matching 'dist' 08:41:08 INFO - no previously-included directories found matching '.git*' 08:41:08 INFO - Successfully installed jsonschema functools32 08:41:08 INFO - Cleaning up... 08:41:08 INFO - Return code: 0 08:41:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:41:08 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:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:08 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:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:08 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 0x7fd9dbd10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', '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:41:08 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:41:08 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:41:08 INFO - Using env: {'DISPLAY': ':0', 08:41:08 INFO - 'HOME': '/home/cltbld', 08:41:08 INFO - 'LANG': 'en_US.UTF-8', 08:41:08 INFO - 'LANGUAGE': 'en_US:en', 08:41:08 INFO - 'LOGNAME': 'cltbld', 08:41:08 INFO - 'MAIL': '/var/mail/cltbld', 08:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:08 INFO - 'MOZ_NO_REMOTE': '1', 08:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:08 INFO - 'NO_EM_RESTART': '1', 08:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:08 INFO - 'PWD': '/builds/slave/test', 08:41:08 INFO - 'SHELL': '/bin/bash', 08:41:08 INFO - 'SHLVL': '1', 08:41:08 INFO - 'TERM': 'linux', 08:41:08 INFO - 'TMOUT': '86400', 08:41:08 INFO - 'USER': 'cltbld', 08:41:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:08 INFO - '_': '/tools/buildbot/bin/python'} 08:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:08 INFO - Downloading/unpacking flake8 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:41:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:41:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:11 INFO - no previously-included directories found matching 'docs/_build' 08:41:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:41:11 INFO - Running setup.py install for pep8 08:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:11 INFO - no previously-included directories found matching 'docs/_build' 08:41:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:41:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:41:11 INFO - Cleaning up... 08:41:11 INFO - Return code: 0 08:41:11 INFO - Running post-action listener: _resource_record_post_action 08:41:11 INFO - Running post-action listener: _start_resource_monitoring 08:41:11 INFO - Starting resource monitoring. 08:41:11 INFO - ##### 08:41:11 INFO - ##### Running install step. 08:41:11 INFO - ##### 08:41:11 INFO - Running pre-action listener: _resource_record_pre_action 08:41:11 INFO - Running main action method: install 08:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:11 INFO - Reading from file tmpfile_stdout 08:41:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:11 INFO - Reading from file tmpfile_stdout 08:41:11 INFO - Output received: 08:41:11 INFO - Usage: mozinstall [options] installer 08:41:11 INFO - Options: 08:41:11 INFO - -h, --help show this help message and exit 08:41:11 INFO - -d DEST, --destination=DEST 08:41:11 INFO - Directory to install application into. [default: 08:41:11 INFO - "/builds/slave/test"] 08:41:11 INFO - --app=APP Application being installed. [default: firefox] 08:41:11 INFO - mkdir: /builds/slave/test/build/application 08:41:11 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:41:11 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:41:24 INFO - Reading from file tmpfile_stdout 08:41:24 INFO - Output received: 08:41:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:24 INFO - Running post-action listener: _resource_record_post_action 08:41:24 INFO - ##### 08:41:24 INFO - ##### Running run-tests step. 08:41:24 INFO - ##### 08:41:24 INFO - Running pre-action listener: _resource_record_pre_action 08:41:24 INFO - Running main action method: run_tests 08:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:24 INFO - Python 2.7.3 08:41:24 INFO - Return code: 0 08:41:24 INFO - grabbing minidump binary from tooltool 08:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:24 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 0x229c410>, '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 0x229d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:24 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:41:24 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:41:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:24 INFO - Return code: 0 08:41:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:41:25 INFO - Return code: 0 08:41:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:41:25 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:41:25 INFO - Using env: {'DISPLAY': ':0', 08:41:25 INFO - 'HOME': '/home/cltbld', 08:41:25 INFO - 'LANG': 'en_US.UTF-8', 08:41:25 INFO - 'LANGUAGE': 'en_US:en', 08:41:25 INFO - 'LOGNAME': 'cltbld', 08:41:25 INFO - 'MAIL': '/var/mail/cltbld', 08:41:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:25 INFO - 'MOZ_NO_REMOTE': '1', 08:41:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:25 INFO - 'NO_EM_RESTART': '1', 08:41:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:25 INFO - 'PWD': '/builds/slave/test', 08:41:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:25 INFO - 'SHELL': '/bin/bash', 08:41:25 INFO - 'SHLVL': '1', 08:41:25 INFO - 'TERM': 'linux', 08:41:25 INFO - 'TMOUT': '86400', 08:41:25 INFO - 'USER': 'cltbld', 08:41:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450', 08:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:25 INFO - '_': '/tools/buildbot/bin/python'} 08:41:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:41:26 INFO - mozversion application_buildid: 20160621055904 08:41:26 INFO - mozversion application_changeset: 5f7dcce004111d3e2f78cdae83bafb8551937018 08:41:26 INFO - mozversion application_display_name: Firefox 08:41:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:26 INFO - mozversion application_name: Firefox 08:41:26 INFO - mozversion application_remotingname: firefox 08:41:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:26 INFO - mozversion application_vendor: Mozilla 08:41:26 INFO - mozversion application_version: 48.0 08:41:26 INFO - mozversion platform_buildid: 20160621055904 08:41:26 INFO - mozversion platform_changeset: 5f7dcce004111d3e2f78cdae83bafb8551937018 08:41:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:26 INFO - mozversion platform_version: 48.0 08:41:26 INFO - using testdate: 1466523686 08:41:26 INFO - actual date: 1466523686 08:41:26 INFO - starting webserver on 'localhost:51944' 08:41:26 INFO - SUITE-START | Running 2 tests 08:41:26 INFO - TEST-START | dromaeo_css 08:41:26 INFO - operating with platform_type : linux_ 08:41:26 INFO - Initialising browser for dromaeo_css test... 08:41:26 INFO - TEST-INFO | started process 29893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxlVbC/profile http://localhost:51944/getInfo.html) 08:41:29 INFO - PROCESS | 29893 | 08:41:29 INFO - PROCESS | 29893 | (process:29974): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:30 INFO - PROCESS | 29893 | __metrics Screen width/height:1600/1200 08:41:30 INFO - PROCESS | 29893 | colorDepth:24 08:41:30 INFO - PROCESS | 29893 | Browser inner width/height: 1024/697 08:41:30 INFO - PROCESS | 29893 | __metrics 08:41:31 ERROR - PROCESS | 29893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 08:41:32 INFO - TEST-INFO | 29893: exit 0 08:41:32 INFO - Browser initialized. 08:41:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:32 INFO - TEST-INFO | started process 30024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxlVbC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:34 INFO - PROCESS | 30024 | 08:41:34 INFO - PROCESS | 30024 | (process:30094): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:41:44 INFO - PROCESS | 30024 | RSS: Main: 151044096 08:41:44 INFO - PROCESS | 30024 | 08:42:33 INFO - PROCESS | 30024 | 1466523753980 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:44:41 INFO - PROCESS | 30024 | Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51944/tests/dromaeo/cssquery-ext.html) 08:44:42 INFO - PROCESS | 30024 | RSS: Main: 155496448 08:44:42 INFO - PROCESS | 30024 | 08:47:44 INFO - PROCESS | 30024 | Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-ext.html (next: http://localhost:51944/tests/dromaeo/cssquery-jquery.html) 08:47:45 INFO - PROCESS | 30024 | RSS: Main: 152875008 08:47:45 INFO - PROCESS | 30024 | 08:50:46 INFO - PROCESS | 30024 | Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51944/tests/dromaeo/cssquery-mootools.html) 08:50:47 INFO - PROCESS | 30024 | RSS: Main: 152604672 08:50:47 INFO - PROCESS | 30024 | 08:53:49 INFO - PROCESS | 30024 | Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51944/tests/dromaeo/cssquery-prototype.html) 08:53:49 INFO - PROCESS | 30024 | RSS: Main: 154177536 08:53:49 INFO - PROCESS | 30024 | 08:56:51 INFO - PROCESS | 30024 | Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51944/tests/dromaeo/cssquery-yui.html) 08:56:52 INFO - PROCESS | 30024 | RSS: Main: 152719360 08:56:52 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-yui.html (next: http://localhost:51944/tests/dromaeo/cssquery-dojo.html) 08:59:54 INFO - PROCESS | 30024 | RSS: Main: 156401664 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | __start_tp_report 08:59:54 INFO - PROCESS | 30024 | _x_x_mozilla_page_load 08:59:54 INFO - PROCESS | 30024 | _x_x_mozilla_page_load_details 08:59:54 INFO - PROCESS | 30024 | |i|pagename|runs| 08:59:54 INFO - PROCESS | 30024 | |0;dojo.html;3336.549565808616;3438.8968330950065;3439.1402149462633;3462.3248466549035;3479.947800782989;5712.542996560275;5724.62789918655;5725.942740572593;5735.569832262576;5763.1355296705515;5757.971210143944;5758.712064396785;5769.82690519284;5786.132080187974;5793.82618521444;5203.557697595699;5231.712255825928;5284.313039304904;5307.681539107666;5328.120860058086;5218.921716174261;5342.465753424665;5406.702631355274;5409.080456322415;5421.810236641718;5258.421573626898;5344.866378340534;5397.973010134944;5418.83743487694;5443.510084092431;5292.655977361478;5303.999999999981;5304.92042619361;5306.071437498461;5329.706866122362;5053.166227572447;5135.255387968761;5172.741362931876;5189.818356357547;5215.660982036194;5551.056320425538;5574.219609254707;5609.242752228438;5616.241807355996;5635.042042852725;6168.75324987;6176.227971503562;6180.81457556274;6180.845478863064;6198.2252218472695;6136.20229370179;6232.283287421959;6244.344343843876;6269.153664255313;6311;5795.710214489301;5802;5802.013657678247;5806.5354771618595;5829.562782791308;6333.778317758948;6341.651209183447;6349.619022858643;6365.904511432333;6368.458681012074;6148;6242.500599951993;6246.187995560548;6264.091706702503;6276.748930042747;6313.526485513605;6316.30520642729;6319.304876463585;6328.873422531524;6342.746290148342;6023.939760602338;6168.629882207082;6287.591306565058;6288.496920246369;6296.622202667854;6207.503399728011;6248.812535623939;6269.435750782361;6282.403171698681;6289.088082228142;4625.861224163281;4715.717056976592;4725;4737.194676904935;4755.0727608116085;4120.546739858613;4161.313383291784;4200.474940632421;4210.32634778434;4227.239096962515;5763.827085187451;5945.672987985702;5970.253718285215;6001.219841420588;6059.394060593905;6195.876082478325;6223.612353290919;6291.96854015727;6293;6300.684965751694;5875.941240587539;5963.373845746134;5983.820485385445;6005.129256257818;6024.427679370453;5116.692998420107;5136.9743151284;5139.7687104080405;5154.046501397253;5166.43169251382;6462.1276127723095;6466.6766661666725;6471.061696054046;6479.6760161991715;6490.0589414534625;6117.857853872152;6195.597286176384;6201.224846894138;6213.596116252339;6216.875662486816;6397.712102955471;6407.199100112486;6417.582857114273;6420.871582568416;6434.646094464662;6027.246594175728;6069.423404776539;6069.848253793514;6074.331823499323;6089.695515224133;6100;6124.29570599369;6148.815535533941;6155.292141403616;6169.074638804215;6110.832160913912;6126.816195513963;6128.172696686069;6128.724207410588;6130;6090.451859332681;6091.847703807441;6094.116353128683;6106.877862442815;6139.109829074849;5943.7028148591535;5994.490468310242;6061.030235162353;6111.358307377662;6113.172264937315;5974.701264936823;6022.48808851235;6036.154938308729;6045.304789949212;6065.636061836128;5867.325257595431;5871.354151043467;5874.089516125007;5881.2942446904935;5900.409959004065 08:59:54 INFO - PROCESS | 30024 | |1;ext.html;660.3462572053668;670.523928011112;671.8757029949456;715.6636380900975;730.4302643937727;40343;41222.58777412229;41299.79350103245;41311.58688413115;41318.38022429666;44764;45691.31463028057;45776.77111614445;45785.31322030172;45829;8950.552472376372;9118.224950879183;9122.543872806365;9124.908750912506;9147.817043659123;8834.823303533958;8941.374103812703;8960.014398416202;8964.462132272052;8993.955030224839;9209.493477858716;9224.723258302261;9235.769105772375;9241.722748317561;9257;9145.314101442385;9202.40184388016;9216.447013179231;9218.44689318643;9239.44563326196;9201.493917834516;9252.676156334563;9276.072392760738;9320.627174912996;9322.580483878242;45349.77325113386;45635.77182114068;45826.77086614545;45854;45897.770511147566;3688.4467329900463;3770.547534295902;3903.531576210873;4125.154343359604;4235.3858690490015;33720.83139584311;33765.662343376745;33916.83041584776;34004.149896252544;34546.13634659129;4645.814167433298;4648.093621743761;4652.418447694038;4668.346431499593;4693.530646935279;315490.42254788807;318077;318131;318423;321071;63340;63660;64069.679651601444;64070.67964660147;64144;69693.30306696969;70374.64812676006;70469.6476517614;70731.646341769;71040.64479677672;17890.55273618144;18122.818771812377;18186;18244.90877545604;18343.35798247055;14319.284035798377;14429;14459.710805784036;14464.20446875432;14491.492797752027;20489.38531844047;20693.379198624065;20707.585848283252;20742.27402040921;21544.4613884651;7742.690292388242;7838.804029899298;8000.51996880189;8047.597620118971;8156.510609363457;1061.3101484035285;1106.330669944688;1120.2046546951592;1137.1244142010605;1189.262657152571;33261.16847078794;33446;33727;33839.49240761391;34172.48741268883;1160.3212120909363;1175.2360965372577;1270.4410059573759;1290.2581015915887;1305.2560040776857;17361.211247296374;17627.647447050986;17767.733483997752;17865.28538858431;17900.194491247927;496534;540704;547656;552426;555847;58581;59508;59907.700461497414;60083.497912552535;60128.699356503814;1491.733104501139;1497.8202615685968;1507.5025241670223;1513.8259100203618;1593.0202925200917;33708;34162;34251.82874085614;34527.4531047947;34637.82681086679;55770.44229557815;56598.71700641471;56829.147562785765;56852.1472177926;56975.71512142578;436189;439910;440742;442354;443494;32174.678253218106;32481.187970299987;32613;32633;32827.67172328246;51960.74019629878;51964;53346;53368.199477007096;53403.73298133485;43216.35175472307;43570.56429435665;44156.779216105;44793.10413791641;44962.55037449714;42282.78858605687;42930.35604465998;43100.56899430966;43489.34765978449;43678;45648.771756142334;46228.53771462242;46270.305945410175;47321.52678473309;47361.52638473571;44313.556864430946;44559.55440445554;44650.10699785921;45334.546654533035;45905.31142032939;31487.055388338387;31510.21224469315;31660;31672.208194795316;32148.83925580357 08:59:54 INFO - PROCESS | 30024 | |2;jquery.html;443.3460645547817;447.6988280239569;453.12320659523823;454.7135304758;456.279079055093;18744.343947961825;19070;19514.31699890504;20207.292744753937;20218.595628087467;19703.704444433308;19791.901040494777;19864.304749333776;20333.49166270844;20342;5750.578749900216;5826.708664566776;5996.040633498641;5999.76000959961;6011.098335249726;5840.445157710011;5907;5933.584649074566;5937.079752638348;5945.851353716149;5662.235598194253;5861.912071318912;5862.9413705863035;5891.734871930752;5895.734691938852;5760.596758226926;5817.331006934214;5828.096645020008;5828.591998560102;5842.298924129132;5209.7134657593815;5248.239005344242;5295.523402893758;5303.681779093266;5308.867278318035;19885.20459181631;21336.893315533478;21355;22091.889540552194;22963;2357.823163262762;2373.7626237376126;2406.061635961976;2476.3561474016888;2685.3420911876715;9910.157636600825;10376.325538839952;10469.528871200815;10602.840957385646;10765.461726913623;2039.535925907481;2051.3948385226245;2100.7584127825344;2129.2866889592005;2134.3703607435846;79164.60417697874;83868.16131838664;84340;84569.57715211446;84848.15151848526;11470.139739519569;11529.942350288362;11575.30548167096;11605.129615278887;11837.467313970892;16412.343506259615;16434.589135271475;16591.91704041472;16592.25334859934;16632.3347066116;8972.596233169523;8986.640534378683;8994.730158095268;9047.55715956688;9074.591643376063;8740.125987401208;8745.956270218736;8758.47449153053;8764.5179515126;8826.382153249338;4979.950200498021;4988.7505624718615;5009.0983622948215;5091.9236211456855;5136.512031357015;2063.329417939176;2069.3998740365128;2111.2821640642255;2116.0590022297797;2120.6288899442843;1002.5288114586133;1040.3029969920171;1060.7454210989306;1112.010310823368;1136.6362763915633;17790.822091779177;17899.910500447415;17986.37047703324;18080.728789068173;18527.166277517543;1047.8899715529913;1056.9471526423647;1082.1613249731363;1102.4432661506048;1131.9094472442184;10062.19502439803;10105.848412273821;10805.459727013618;10828.350298982086;10845.349279043283;486713;493848;508715;525265;526491;93345.13309733903;95972.52013739887;97880;99019.50490247503;99079.50460247653;1136.9488373023235;1136.9602063927723;1153.5962413155496;1158.8435561199299;1165.947532361046;16708.16459177012;16772.077535735163;16801.831981680025;16941.66116677684;17090.572735681708;37981;40062.39906401348;40128.79935600303;40256.59743402529;40287.194256114126;57078.7146064267;57215.42784572101;57516.42483575111;58099;58264.70867645634;8265.107212475585;8410.243078122998;8690.30477561781;8718.564071796513;8918;10106.595736170764;13395.799063014258;13465.124766890121;13485.46058157702;13593.116447430886;11880.287182769061;11901.404929753651;11915.16593838423;12028.338441385808;12269;6091.329953705001;7346.742863999734;11049.226554141133;11214.271072380268;11314.490847911698;12179;12225.327606981346;12282.447289872156;12296.077794165294;12329.938350308192;9034.322425817958;9062.093790620886;9074;9206.549305910576;9289.767755806159;9398.436093834393;11708;12166.635000949986;12206.718294578941;12220 08:59:54 INFO - PROCESS | 30024 | |3;mootools.html;1519.9012064215824;1531.915744634045;1713.768641233433;1807.322254154692;1868.7196920461938;8297.792555186123;9149.222316103123;9262.583183756731;9395.248380129591;9485.38345007574;9193.44839309642;9251.213646840026;9383.390079644836;9459.290553208502;9467.952660236706;2517.546841568517;2532.9113481028166;2533;2553.131935142051;2554.833935794177;2496.750324967498;2556.079811267942;2578.948421031578;2580.213035024317;2588.4564241509306;2371.2649078785544;2373.643953406994;2374.121575017246;2377.7146742390937;2383.7020372453444;2401.939951501218;2480.875956202192;2492.8504289742673;2504.186139504668;2523.3439305780444;2552.4001859562986;2579.6904371475543;2593.988344545629;2613.4381108061857;2616.6336712860216;9557.283203759676;9644.324897257195;9650.13148816603;9661.565229564687;9667.081627245401;5786.537077033827;5844.123381492767;5889.469947704727;5917.082852157922;5927.170196172497;3582.5521809773777;3701.056230661164;3729;3735.9912823537766;3764.3224219640456;1208.528673817212;1250.1249125612017;1272.8981681465552;1274.6813296675832;1285.9519491614305;13675.384607692578;13728.382222799997;13757.724845503133;13837.654058648513;13857.930710346485;4854.635902307341;4951.034548263054;4957.752112394366;4976.402831660224;5010.674306170087;10826.40454774995;10840.024397804078;10845.620403285848;10858.348499089921;10907.345559266469;5590.580706446952;5647.491725744702;5650.0959846424375;5668.489835914787;5675.716214189274;5161.690298582097;5200.583953283728;5227.503387178212;5261.184516399964;5293.073712100444;4191.538930717618;4205.348171033434;4420.071784925138;4425.380446737459;4430.490493593278;1318.6176008957486;1328.362386054699;1330.693940393715;1334.1861464506644;1334.8998825087963;905.2395987370641;1050.9474526273655;1065.6643157405392;1072.8390741388698;1113.4098927568402;6222.844428889223;6419.069234960904;6435.324290949477;6449.516286278548;6544;482.70796168318367;484.52032487837494;484.7212852609693;487.14749188919393;489.55205986522645;4453.821847126079;4457.153140903283;4477.8208871644765;4558.840440584564;4561.133384656904;11665.24175928562;12034.939825300993;12147.271163730027;12155.149139560323;12185.939070304592;11561.479733412016;11883.287002779862;11887.108466864847;11889.405529723479;12134.5146194153;8994.145556172152;9044.728658140266;9046.773830654154;9073.81852362949;9125.17873391398;5980.5514586405325;6081.5134789217645;6094.177286066324;6149.692515374303;6208.906866397098;10431.739206519898;10443.164546836388;10583.206259530412;10654.840177397191;10663.840042399526;10117;10235.078842904175;10325.173986081245;10475.266731329039;10574.206934479791;7421.554706717614;7811.414143939341;8069.273765361146;8324.875126873223;8441.78895527592;9166.816663666823;9199.816003679754;9247.537623118951;9270.72187834366;9289.581968811284;8066.878996814935;8220.712275070344;8224.588770561568;8269.379796515164;8360.498370097814;8153.9184608153155;8242.505449673039;8254.0507841599;8334.166583341617;8348.582570871553;7345;7375;7413.184549699637;7523.811904702207;7757.146713861358;5432.266644003167;5546.168074788814;5561.221428999862;5635.15472679085;5714.000049991318;5258.737063146751;5317.946820531745;5335.439778823167;5435.809746658848;5732.226149469769 08:59:54 INFO - PROCESS | 30024 | |4;prototype.html;370.08773373634006;382.12684017021104;384.87299191266874;387.542699614455;389.21378814794133;6590.769323073693;6591.044298576703;6719.0593316935665;6782.220044694862;6809.931900680998;6611.272759996408;6697.933020669804;6698.062271282024;6700.262971073178;6705.932940670592;5065.138926382524;5071.644984851062;5078.314427552288;5083.694978301295;5092.719900405476;5079.593632509409;5090.312807770941;5092.439831618519;5099.796008159669;5108.080545501808;5054.9241761373605;5056.8482945511505;5057.5701065409485;5063.113955057868;5064.11378008847;4949.505049495057;5040.621953353513;5060.266261392096;5067.290579318898;5078.898422031576;4443.955560444387;4474.194644963905;4477.059817438342;4477.70894891831;4482.193205223059;6374.840628984266;6377.776777812801;6385.23377194735;6391.936080639181;6402.13571167891;5953.404659534055;5966.791162309341;5967.731452084623;5970.641761494324;5987.700614969234;7051.153861536597;7060.22337542875;7062.081929349203;7062.5056246062795;7067.15194176697;4660.254359302496;4830.2513110467935;4834.444038935532;4981.053599816023;4997.300377947054;7201.063861697946;7256.709731610729;7279.2356802535505;7355.448341374418;7357.742479013263;4951.925721114186;4973.477784832613;4978.950210497848;4980.576650984634;5001.874953126128;5046.44489106198;5048.29323894655;5049.065922804293;5053.1157047516535;5074.746262686851;5852.326982397079;5857.326407463111;5859.121131830174;5877.94122058774;5884.941150588525;6968.233494315621;7057.576545407292;7081.327273908971;7089.042979197846;7103.964480177566;1755.8683098767644;1764.9294028238983;1772.6720556696794;1774.9911250443665;1777.0403981849656;1134.5405110930087;1149.7757937202166;1155.2952698853692;1167.6280370564552;1173.4719376280707;6782;6819.386255237053;6827.795166145023;6838.281980391987;6854.691538880762;7238.131424229126;7248.818779530554;7253.782386528413;7258.709651613982;7300.671469783872;6785.796426107225;6825.215100263434;6830.21452532965;6839.1451068616425;6839.487038472134;3841.8079096045085;3879.1465877506903;3918.686505079587;3923.136909879822;3923.8234279457492;7626.237376262329;7630.969819074465;7633.580153091522;7633.847323053508;7639.236076392316;7422.072240969879;7437.665305061285;7438.330550250504;7439.293267139613;7452;7595.278448547379;7597.5821329826285;7601;7617.847643047219;7627.313541781266;7031.05080814104;7217.819554511179;7228.20489746138;7245.058142441449;7268.41852651776;7111.964440177766;7126.893096603451;7137.892931605927;7144.214136444883;7147.392471639969;7545.547267163988;7575.810604734926;7607.391408687181;7624.58064806441;7624.656890439833;4991;4993.425756038102;4996.850094497171;4998.950010499849;5001.549860512571;7062.788116356517;7249.782506524813;7257.600831954293;7264.055672762507;7266.527675701062;6918;6943.062686537455;6960.303969602999;6960.860782784417;6962.199347075151;6993.8251543709775;6996.335348141918;7001.719931202695;7004.929950700428;7022.08712867324;6769.458443324424;6786.423154031765;6799.490038247251;6818.761343352959;6878.518503704692;6906.723731050702;7044.6125463100025;7059.576425414286;7059.858802823812;7063.71745130189;6766.120404347404;6865.656717164222;6959.304069593;6960.095187625576;6971.128608923885 08:59:54 INFO - PROCESS | 30024 | |5;yui.html;791.2087912087912;796.0685997383061;823.2631794543887;836.9246767790902;849.3120572336412;14726;14782.556523304318;15407.69184616307;15527.301271442784;15697.215139243035;15231.390744370212;15432.61418464539;15596.922015389935;15622.29699663515;15649.45226917058;873.52829472085;888.0364804187465;907.850204716221;909.4225167018958;911.8723378726984;916.7112359606735;917.1424717888762;918.9081091890791;919.3610440743686;920.691568324612;965.2856885904415;966.5119114846992;967.6806653804227;970.2383628851353;970.7573106723319;957.042957042957;957.4064080270242;958.5782255807492;960.0591420408005;961.3318743473288;700.8808502554577;702.5924963521145;703.5075447186938;704.802655256529;705.5696025424487;15874.206289685584;15892.920535397365;15899.205039747967;15900.602484937854;15937.362505499766;15480.922595387063;15503.767443488357;15569.844301557067;15648.530544083696;15742.842571574252;12178.208416452902;12243.265404075784;12485.687857803627;12522.123451358408;12774.48902043917;3933.8229779659696;3968.4245784361397;4027.97986010071;4048.0891799345204;4075.8369665213354;61204.38795612076;61218.387816121714;61577.076343854875;61885.690571547304;62174.99999999955;12125.636230913087;12281.89462948339;12348;12367.443465044094;12437.129400941847;22309;22312.107515699514;22321.665175022386;22329.888350558467;22337.664935025987;8477.788055298544;8720.738377848675;9023.368364214442;9027.871516060492;9030.86453703195;4787.904241915142;4790.904181916342;4814.927776083362;4832.226843704991;4890.144224760724;3506.544149260631;3571.125074356747;3588.4258518636893;3599.5500562429697;3599.5680518337444;592.3927973826776;606.1392822192497;607.9392060793886;619.2074145094286;622.0451606783565;767.4896194031019;772.679338074704;775.1937984496174;812.3825892321878;834.1408349400127;10152.593896244216;10250.487475626189;10296;10508.474576271308;10676.733081672865;724.463896716426;730.9729829589436;836.7364280251701;854.0989256334626;879.0374539878823;4463.5313292103865;4921.335619691367;4942.481039490874;4951.009798040406;4960.776765045582;67618.3238167612;69276;69483.30516694768;69648.65175674089;69708.65145674239;58052;58134;59176.11235831466;60643;60797.39202608006;52666;53597.73201133969;53661.46338536643;54302.45697542974;54583.72708136434;9633;9677.758056048655;9712.465814380277;9788;9809.215262778818;37921.81039094787;38041.809790950865;38935;39528.209435811696;39563.406548901214;46838;47423;50706;50728.746356267984;51398;11278.266912650652;11306.83039754388;11916.880831191576;11946.104042196695;12361.381930903599;13421.798673020108;13498.73002539924;13623;13682.110662806886;13718.65703357424;12834.486620535074;12898.355082246038;12913.935430322788;13012.28432436225;13090.14914030585;12531;12577.811332830199;12612.49550017989;12689.175203611736;12772.872271277169;11680.357580333164;11710.648680539598;12068;12236.143469957373;12357.505699771908;9687.128158465772;9810.509474526389;9835.704928852147;9909.55407006672;10016.849747253651;10539.15686745074;10607.840882386616;10761.677149685522;10809.729756756144;10855.18586106061 08:59:54 INFO - PROCESS | 30024 | __end_tp_report 08:59:54 INFO - PROCESS | 30024 | __start_cc_report 08:59:54 INFO - PROCESS | 30024 | _x_x_mozilla_cycle_collect,344 08:59:54 INFO - PROCESS | 30024 | __end_cc_report 08:59:54 INFO - PROCESS | 30024 | __startTimestamp1466524794907__endTimestamp 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | ------- Summary: start ------- 08:59:54 INFO - PROCESS | 30024 | Number of tests: 6 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | [#0] dojo.html Cycles:165 Average:5766.47 Median:6023.94 stddev:664.14 (11.0%) stddev-sans-first:638.24 08:59:54 INFO - PROCESS | 30024 | Values: 3336.5 3438.9 3439.1 3462.3 3479.9 5712.5 5724.6 5725.9 5735.6 5763.1 5758.0 5758.7 5769.8 5786.1 5793.8 5203.6 5231.7 5284.3 5307.7 5328.1 5218.9 5342.5 5406.7 5409.1 5421.8 5258.4 5344.9 5398.0 5418.8 5443.5 5292.7 5304.0 5304.9 5306.1 5329.7 5053.2 5135.3 5172.7 5189.8 5215.7 5551.1 5574.2 5609.2 5616.2 5635.0 6168.8 6176.2 6180.8 6180.8 6198.2 6136.2 6232.3 6244.3 6269.2 6311.0 5795.7 5802.0 5802.0 5806.5 5829.6 6333.8 6341.7 6349.6 6365.9 6368.5 6148.0 6242.5 6246.2 6264.1 6276.7 6313.5 6316.3 6319.3 6328.9 6342.7 6023.9 6168.6 6287.6 6288.5 6296.6 6207.5 6248.8 6269.4 6282.4 6289.1 4625.9 4715.7 4725.0 4737.2 4755.1 4120.5 4161.3 4200.5 4210.3 4227.2 5763.8 5945.7 5970.3 6001.2 6059.4 6195.9 6223.6 6292.0 6293.0 6300.7 5875.9 5963.4 5983.8 6005.1 6024.4 5116.7 5137.0 5139.8 5154.0 5166.4 6462.1 6466.7 6471.1 6479.7 6490.1 6117.9 6195.6 6201.2 6213.6 6216.9 6397.7 6407.2 6417.6 6420.9 6434.6 6027.2 6069.4 6069.8 6074.3 6089.7 6100.0 6124.3 6148.8 6155.3 6169.1 6110.8 6126.8 6128.2 6128.7 6130.0 6090.5 6091.8 6094.1 6106.9 6139.1 5943.7 5994.5 6061.0 6111.4 6113.2 5974.7 6022.5 6036.2 6045.3 6065.6 5867.3 5871.4 5874.1 5881.3 5900.4 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | [#1] ext.html Cycles:180 Average:61558.64 Median:44707.05 stddev:116910.58 (261.5%) stddev-sans-first:117149.14 08:59:54 INFO - PROCESS | 30024 | Values: 660.3 670.5 671.9 715.7 730.4 40343.0 41222.6 41299.8 41311.6 41318.4 44764.0 45691.3 45776.8 45785.3 45829.0 8950.6 9118.2 9122.5 9124.9 9147.8 8834.8 8941.4 8960.0 8964.5 8994.0 9209.5 9224.7 9235.8 9241.7 9257.0 9145.3 9202.4 9216.4 9218.4 9239.4 9201.5 9252.7 9276.1 9320.6 9322.6 45349.8 45635.8 45826.8 45854.0 45897.8 3688.4 3770.5 3903.5 4125.2 4235.4 33720.8 33765.7 33916.8 34004.1 34546.1 4645.8 4648.1 4652.4 4668.3 4693.5 315490.4 318077.0 318131.0 318423.0 321071.0 63340.0 63660.0 64069.7 64070.7 64144.0 69693.3 70374.6 70469.6 70731.6 71040.6 17890.6 18122.8 18186.0 18244.9 18343.4 14319.3 14429.0 14459.7 14464.2 14491.5 20489.4 20693.4 20707.6 20742.3 21544.5 7742.7 7838.8 8000.5 8047.6 8156.5 1061.3 1106.3 1120.2 1137.1 1189.3 33261.2 33446.0 33727.0 33839.5 34172.5 1160.3 1175.2 1270.4 1290.3 1305.3 17361.2 17627.6 17767.7 17865.3 17900.2 496534.0 540704.0 547656.0 552426.0 555847.0 58581.0 59508.0 59907.7 60083.5 60128.7 1491.7 1497.8 1507.5 1513.8 1593.0 33708.0 34162.0 34251.8 34527.5 34637.8 55770.4 56598.7 56829.1 56852.1 56975.7 436189.0 439910.0 440742.0 442354.0 443494.0 32174.7 32481.2 32613.0 32633.0 32827.7 51960.7 51964.0 53346.0 53368.2 53403.7 43216.4 43570.6 44156.8 44793.1 44962.6 42282.8 42930.4 43100.6 43489.3 43678.0 45648.8 46228.5 46270.3 47321.5 47361.5 44313.6 44559.6 44650.1 45334.5 45905.3 31487.1 31510.2 31660.0 31672.2 32148.8 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | [#2] jquery.html Cycles:180 Average:29689.56 Median:12660.41 stddev:83862.61 (662.4%) stddev-sans-first:84069.11 08:59:54 INFO - PROCESS | 30024 | Values: 443.3 447.7 453.1 454.7 456.3 18744.3 19070.0 19514.3 20207.3 20218.6 19703.7 19791.9 19864.3 20333.5 20342.0 5750.6 5826.7 5996.0 5999.8 6011.1 5840.4 5907.0 5933.6 5937.1 5945.9 5662.2 5861.9 5862.9 5891.7 5895.7 5760.6 5817.3 5828.1 5828.6 5842.3 5209.7 5248.2 5295.5 5303.7 5308.9 19885.2 21336.9 21355.0 22091.9 22963.0 2357.8 2373.8 2406.1 2476.4 2685.3 9910.2 10376.3 10469.5 10602.8 10765.5 2039.5 2051.4 2100.8 2129.3 2134.4 79164.6 83868.2 84340.0 84569.6 84848.2 11470.1 11529.9 11575.3 11605.1 11837.5 16412.3 16434.6 16591.9 16592.3 16632.3 8972.6 8986.6 8994.7 9047.6 9074.6 8740.1 8746.0 8758.5 8764.5 8826.4 4980.0 4988.8 5009.1 5091.9 5136.5 2063.3 2069.4 2111.3 2116.1 2120.6 1002.5 1040.3 1060.7 1112.0 1136.6 17790.8 17899.9 17986.4 18080.7 18527.2 1047.9 1056.9 1082.2 1102.4 1131.9 10062.2 10105.8 10805.5 10828.4 10845.3 486713.0 493848.0 508715.0 525265.0 526491.0 93345.1 95972.5 97880.0 99019.5 99079.5 1136.9 1137.0 1153.6 1158.8 1165.9 16708.2 16772.1 16801.8 16941.7 17090.6 37981.0 40062.4 40128.8 40256.6 40287.2 57078.7 57215.4 57516.4 58099.0 58264.7 8265.1 8410.2 8690.3 8718.6 8918.0 10106.6 13395.8 13465.1 13485.5 13593.1 11880.3 11901.4 11915.2 12028.3 12269.0 6091.3 7346.7 11049.2 11214.3 11314.5 12179.0 12225.3 12282.4 12296.1 12329.9 9034.3 9062.1 9074.0 9206.5 9289.8 9398.4 11708.0 12166.6 12206.7 12220.0 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | [#3] mootools.html Cycles:180 Average:6220.09 Median:484.62 stddev:3566.57 (736.0%) stddev-sans-first:3559.08 08:59:54 INFO - PROCESS | 30024 | Values: 1519.9 1531.9 1713.8 1807.3 1868.7 8297.8 9149.2 9262.6 9395.2 9485.4 9193.4 9251.2 9383.4 9459.3 9468.0 2517.5 2532.9 2533.0 2553.1 2554.8 2496.8 2556.1 2578.9 2580.2 2588.5 2371.3 2373.6 2374.1 2377.7 2383.7 2401.9 2480.9 2492.9 2504.2 2523.3 2552.4 2579.7 2594.0 2613.4 2616.6 9557.3 9644.3 9650.1 9661.6 9667.1 5786.5 5844.1 5889.5 5917.1 5927.2 3582.6 3701.1 3729.0 3736.0 3764.3 1208.5 1250.1 1272.9 1274.7 1286.0 13675.4 13728.4 13757.7 13837.7 13857.9 4854.6 4951.0 4957.8 4976.4 5010.7 10826.4 10840.0 10845.6 10858.3 10907.3 5590.6 5647.5 5650.1 5668.5 5675.7 5161.7 5200.6 5227.5 5261.2 5293.1 4191.5 4205.3 4420.1 4425.4 4430.5 1318.6 1328.4 1330.7 1334.2 1334.9 905.2 1050.9 1065.7 1072.8 1113.4 6222.8 6419.1 6435.3 6449.5 6544.0 482.7 484.5 484.7 487.1 489.6 4453.8 4457.2 4477.8 4558.8 4561.1 11665.2 12034.9 12147.3 12155.1 12185.9 11561.5 11883.3 11887.1 11889.4 12134.5 8994.1 9044.7 9046.8 9073.8 9125.2 5980.6 6081.5 6094.2 6149.7 6208.9 10431.7 10443.2 10583.2 10654.8 10663.8 10117.0 10235.1 10325.2 10475.3 10574.2 7421.6 7811.4 8069.3 8324.9 8441.8 9166.8 9199.8 9247.5 9270.7 9289.6 8066.9 8220.7 8224.6 8269.4 8360.5 8153.9 8242.5 8254.1 8334.2 8348.6 7345.0 7375.0 7413.2 7523.8 7757.1 5432.3 5546.2 5561.2 5635.2 5714.0 5258.7 5317.9 5335.4 5435.8 5732.2 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | [#4] prototype.html Cycles:180 Average:5896.64 Median:6782.11 stddev:1781.11 (26.3%) stddev-sans-first:1737.14 08:59:54 INFO - PROCESS | 30024 | Values: 370.1 382.1 384.9 387.5 389.2 6590.8 6591.0 6719.1 6782.2 6809.9 6611.3 6697.9 6698.1 6700.3 6705.9 5065.1 5071.6 5078.3 5083.7 5092.7 5079.6 5090.3 5092.4 5099.8 5108.1 5054.9 5056.8 5057.6 5063.1 5064.1 4949.5 5040.6 5060.3 5067.3 5078.9 4444.0 4474.2 4477.1 4477.7 4482.2 6374.8 6377.8 6385.2 6391.9 6402.1 5953.4 5966.8 5967.7 5970.6 5987.7 7051.2 7060.2 7062.1 7062.5 7067.2 4660.3 4830.3 4834.4 4981.1 4997.3 7201.1 7256.7 7279.2 7355.4 7357.7 4951.9 4973.5 4979.0 4980.6 5001.9 5046.4 5048.3 5049.1 5053.1 5074.7 5852.3 5857.3 5859.1 5877.9 5884.9 6968.2 7057.6 7081.3 7089.0 7104.0 1755.9 1764.9 1772.7 1775.0 1777.0 1134.5 1149.8 1155.3 1167.6 1173.5 6782.0 6819.4 6827.8 6838.3 6854.7 7238.1 7248.8 7253.8 7258.7 7300.7 6785.8 6825.2 6830.2 6839.1 6839.5 3841.8 3879.1 3918.7 3923.1 3923.8 7626.2 7631.0 7633.6 7633.8 7639.2 7422.1 7437.7 7438.3 7439.3 7452.0 7595.3 7597.6 7601.0 7617.8 7627.3 7031.1 7217.8 7228.2 7245.1 7268.4 7112.0 7126.9 7137.9 7144.2 7147.4 7545.5 7575.8 7607.4 7624.6 7624.7 4991.0 4993.4 4996.9 4999.0 5001.5 7062.8 7249.8 7257.6 7264.1 7266.5 6918.0 6943.1 6960.3 6960.9 6962.2 6993.8 6996.3 7001.7 7004.9 7022.1 6769.5 6786.4 6799.5 6818.8 6878.5 6906.7 7044.6 7059.6 7059.9 7063.7 6766.1 6865.7 6959.3 6960.1 6971.1 08:59:54 INFO - PROCESS | 30024 | 08:59:54 INFO - PROCESS | 30024 | [#5] yui.html Cycles:180 Average:16072.17 Median:4802.92 stddev:18900.57 (393.5%) stddev-sans-first:18918.75 08:59:54 INFO - PROCESS | 30024 | Values: 791.2 796.1 823.3 836.9 849.3 14726.0 14782.6 15407.7 15527.3 15697.2 15231.4 15432.6 15596.9 15622.3 15649.5 873.5 888.0 907.9 909.4 911.9 916.7 917.1 918.9 919.4 920.7 965.3 966.5 967.7 970.2 970.8 957.0 957.4 958.6 960.1 961.3 700.9 702.6 703.5 704.8 705.6 15874.2 15892.9 15899.2 15900.6 15937.4 15480.9 15503.8 15569.8 15648.5 15742.8 12178.2 12243.3 12485.7 12522.1 12774.5 3933.8 3968.4 4028.0 4048.1 4075.8 61204.4 61218.4 61577.1 61885.7 62175.0 12125.6 12281.9 12348.0 12367.4 12437.1 22309.0 22312.1 22321.7 22329.9 22337.7 8477.8 8720.7 9023.4 9027.9 9030.9 4787.9 4790.9 4814.9 4832.2 4890.1 3506.5 3571.1 3588.4 3599.6 3599.6 592.4 606.1 607.9 619.2 622.0 767.5 772.7 775.2 812.4 834.1 10152.6 10250.5 10296.0 10508.5 10676.7 724.5 731.0 836.7 854.1 879.0 4463.5 4921.3 4942.5 4951.0 4960.8 67618.3 69276.0 69483.3 69648.7 69708.7 58052.0 58134.0 59176.1 60643.0 60797.4 52666.0 53597.7 53661.5 54302.5 54583.7 9633.0 9677.8 9712.5 9788.0 9809.2 37921.8 38041.8 38935.0 39528.2 39563.4 46838.0 47423.0 50706.0 50728.7 51398.0 11278.3 11306.8 11916.9 11946.1 12361.4 13421.8 13498.7 13623.0 13682.1 13718.7 12834.5 12898.4 12913.9 13012.3 13090.1 12531.0 12577.8 12612.5 12689.2 12772.9 11680.4 11710.6 12068.0 12236.1 12357.5 9687.1 9810.5 9835.7 9909.6 10016.8 10539.2 10607.8 10761.7 10809.7 10855.2 08:59:54 INFO - PROCESS | 30024 | -------- Summary: end -------- 08:59:54 INFO - PROCESS | 30024 | 08:59:55 INFO - TEST-INFO | 30024: exit 0 08:59:55 INFO - TEST-OK | dromaeo_css | took 1109528ms 08:59:55 INFO - TEST-START | kraken 08:59:55 INFO - operating with platform_type : linux_ 08:59:55 INFO - Initialising browser for kraken test... 08:59:55 INFO - TEST-INFO | started process 30269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9icSnt/profile http://localhost:51944/getInfo.html) 08:59:59 INFO - PROCESS | 30269 | 08:59:59 INFO - PROCESS | 30269 | (process:30345): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:00 INFO - PROCESS | 30269 | __metrics Screen width/height:1600/1200 09:00:00 INFO - PROCESS | 30269 | colorDepth:24 09:00:00 INFO - PROCESS | 30269 | Browser inner width/height: 1024/697 09:00:00 INFO - PROCESS | 30269 | __metrics 09:00:00 ERROR - PROCESS | 30269 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 09:00:01 INFO - TEST-INFO | 30269: exit 0 09:00:01 INFO - Browser initialized. 09:00:01 INFO - Running cycle 1/1 for kraken test... 09:00:01 INFO - TEST-INFO | started process 30395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9icSnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:03 INFO - PROCESS | 30395 | 09:00:03 INFO - PROCESS | 30395 | (process:30464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:13 INFO - PROCESS | 30395 | RSS: Main: 151515136 09:00:13 INFO - PROCESS | 30395 | 09:00:15 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:16 INFO - PROCESS | 30395 | RSS: Main: 156852224 09:00:16 INFO - PROCESS | 30395 | 09:00:19 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-dft) 09:00:19 INFO - PROCESS | 30395 | RSS: Main: 156323840 09:00:19 INFO - PROCESS | 30395 | 09:00:22 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-fft) 09:00:23 INFO - PROCESS | 30395 | RSS: Main: 156676096 09:00:23 INFO - PROCESS | 30395 | 09:00:25 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-oscillator) 09:00:26 INFO - PROCESS | 30395 | RSS: Main: 156532736 09:00:26 INFO - PROCESS | 30395 | 09:00:28 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:28 INFO - PROCESS | 30395 | RSS: Main: 156237824 09:00:28 INFO - PROCESS | 30395 | 09:00:31 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51944/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:32 INFO - PROCESS | 30395 | RSS: Main: 156581888 09:00:32 INFO - PROCESS | 30395 | 09:00:35 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51944/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:36 INFO - PROCESS | 30395 | RSS: Main: 157081600 09:00:36 INFO - PROCESS | 30395 | 09:00:39 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51944/tests/kraken/driver.html?testName=json-parse-financial) 09:00:39 INFO - PROCESS | 30395 | RSS: Main: 157097984 09:00:39 INFO - PROCESS | 30395 | 09:00:41 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:42 INFO - PROCESS | 30395 | RSS: Main: 156631040 09:00:42 INFO - PROCESS | 30395 | 09:00:43 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:44 INFO - PROCESS | 30395 | RSS: Main: 157016064 09:00:44 INFO - PROCESS | 30395 | 09:00:46 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:47 INFO - PROCESS | 30395 | RSS: Main: 156864512 09:00:47 INFO - PROCESS | 30395 | 09:00:49 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:50 INFO - PROCESS | 30395 | RSS: Main: 157757440 09:00:50 INFO - PROCESS | 30395 | 09:00:52 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:00:53 INFO - PROCESS | 30395 | RSS: Main: 157589504 09:00:53 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51944/tests/kraken/driver.html?testName=ai-astar) 09:00:55 INFO - PROCESS | 30395 | RSS: Main: 159137792 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | __start_tp_report 09:00:55 INFO - PROCESS | 30395 | _x_x_mozilla_page_load 09:00:55 INFO - PROCESS | 30395 | _x_x_mozilla_page_load_details 09:00:55 INFO - PROCESS | 30395 | |i|pagename|runs| 09:00:55 INFO - PROCESS | 30395 | |0;ai-astar;106;110;101;109;109;113;100;113;110;110 09:00:55 INFO - PROCESS | 30395 | |1;audio-beat-detection;153;133;163;174;133;161;158;128;179;132 09:00:55 INFO - PROCESS | 30395 | |2;audio-dft;162;162;162;162;162;162;163;163;162;164 09:00:55 INFO - PROCESS | 30395 | |3;audio-fft;74;76;76;168;77;85;76;78;169;76 09:00:55 INFO - PROCESS | 30395 | |4;audio-oscillator;92;93;148;92;101;93;159;93;92;147 09:00:55 INFO - PROCESS | 30395 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;117;118 09:00:55 INFO - PROCESS | 30395 | |6;imaging-darkroom;147;146;147;146;147;146;147;146;146;146 09:00:55 INFO - PROCESS | 30395 | |7;imaging-desaturate;95;95;94;96;96;95;100;94;95;96 09:00:55 INFO - PROCESS | 30395 | |8;json-parse-financial;54;56;57;55;57;58;54;73;57;54 09:00:55 INFO - PROCESS | 30395 | |9;json-stringify-tinderbox;58;58;58;59;58;59;58;60;59;59 09:00:55 INFO - PROCESS | 30395 | |10;stanford-crypto-aes;72;72;72;76;72;74;74;73;74;74 09:00:55 INFO - PROCESS | 30395 | |11;stanford-crypto-ccm;123;114;123;114;118;116;113;119;132;138 09:00:55 INFO - PROCESS | 30395 | |12;stanford-crypto-pbkdf2;162;160;163;174;159;163;161;160;163;161 09:00:55 INFO - PROCESS | 30395 | |13;stanford-crypto-sha256-iterative;66;66;67;68;66;64;66;66;65;66 09:00:55 INFO - PROCESS | 30395 | __end_tp_report 09:00:55 INFO - PROCESS | 30395 | __start_cc_report 09:00:55 INFO - PROCESS | 30395 | _x_x_mozilla_cycle_collect,833 09:00:55 INFO - PROCESS | 30395 | __end_cc_report 09:00:55 INFO - PROCESS | 30395 | __startTimestamp1466524855302__endTimestamp 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | ------- Summary: start ------- 09:00:55 INFO - PROCESS | 30395 | Number of tests: 14 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.48 (4.1%) stddev-sans-first:4.69 09:00:55 INFO - PROCESS | 30395 | Values: 106.0 110.0 101.0 109.0 109.0 113.0 100.0 113.0 110.0 110.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:159.50 stddev:18.70 (11.7%) stddev-sans-first:19.82 09:00:55 INFO - PROCESS | 30395 | Values: 153.0 133.0 163.0 174.0 133.0 161.0 158.0 128.0 179.0 132.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 09:00:55 INFO - PROCESS | 30395 | Values: 162.0 162.0 162.0 162.0 162.0 162.0 163.0 163.0 162.0 164.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:38.59 (50.8%) stddev-sans-first:40.14 09:00:55 INFO - PROCESS | 30395 | Values: 74.0 76.0 76.0 168.0 77.0 85.0 76.0 78.0 169.0 76.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:28.13 (30.6%) stddev-sans-first:28.99 09:00:55 INFO - PROCESS | 30395 | Values: 92.0 93.0 148.0 92.0 101.0 93.0 159.0 93.0 92.0 147.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:00:55 INFO - PROCESS | 30395 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:00:55 INFO - PROCESS | 30395 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.71 (1.8%) stddev-sans-first:1.80 09:00:55 INFO - PROCESS | 30395 | Values: 95.0 95.0 94.0 96.0 96.0 95.0 100.0 94.0 95.0 96.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:5.64 (9.9%) stddev-sans-first:5.84 09:00:55 INFO - PROCESS | 30395 | Values: 54.0 56.0 57.0 55.0 57.0 58.0 54.0 73.0 57.0 54.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 09:00:55 INFO - PROCESS | 30395 | Values: 58.0 58.0 58.0 59.0 58.0 59.0 58.0 60.0 59.0 59.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:74.00 stddev:1.34 (1.8%) stddev-sans-first:1.33 09:00:55 INFO - PROCESS | 30395 | Values: 72.0 72.0 72.0 76.0 72.0 74.0 74.0 73.0 74.0 74.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.00 stddev:8.29 (6.8%) stddev-sans-first:8.76 09:00:55 INFO - PROCESS | 30395 | Values: 123.0 114.0 123.0 114.0 118.0 116.0 113.0 119.0 132.0 138.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:162.50 stddev:4.25 (2.6%) stddev-sans-first:4.50 09:00:55 INFO - PROCESS | 30395 | Values: 162.0 160.0 163.0 174.0 159.0 163.0 161.0 160.0 163.0 161.0 09:00:55 INFO - PROCESS | 30395 | 09:00:55 INFO - PROCESS | 30395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 09:00:55 INFO - PROCESS | 30395 | Values: 66.0 66.0 67.0 68.0 66.0 64.0 66.0 66.0 65.0 66.0 09:00:55 INFO - PROCESS | 30395 | -------- Summary: end -------- 09:00:55 INFO - PROCESS | 30395 | 09:00:56 INFO - TEST-INFO | 30395: exit 0 09:00:56 INFO - TEST-OK | kraken | took 60576ms 09:00:56 INFO - SUITE-END | took 1170s 09:00:56 INFO - Completed test suite (00:19:30) 09:00:56 INFO - javascript benchmark 09:00:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.549565808616, 3438.8968330950065, 3439.1402149462633, 3462.3248466549035, 3479.947800782989, 5712.542996560275, 5724.62789918655, 5725.942740572593, 5735.569832262576, 5763.1355296705515, 5757.971210143944, 5758.712064396785, 5769.82690519284, 5786.132080187974, 5793.82618521444, 5203.557697595699, 5231.712255825928, 5284.313039304904, 5307.681539107666, 5328.120860058086, 5218.921716174261, 5342.465753424665, 5406.702631355274, 5409.080456322415, 5421.810236641718, 5258.421573626898, 5344.866378340534, 5397.973010134944, 5418.83743487694, 5443.510084092431, 5292.655977361478, 5303.999999999981, 5304.92042619361, 5306.071437498461, 5329.706866122362, 5053.166227572447, 5135.255387968761, 5172.741362931876, 5189.818356357547, 5215.660982036194, 5551.056320425538, 5574.219609254707, 5609.242752228438, 5616.241807355996, 5635.042042852725, 6168.75324987, 6176.227971503562, 6180.81457556274, 6180.845478863064, 6198.2252218472695, 6136.20229370179, 6232.283287421959, 6244.344343843876, 6269.153664255313, 6311.0, 5795.710214489301, 5802.0, 5802.013657678247, 5806.5354771618595, 5829.562782791308, 6333.778317758948, 6341.651209183447, 6349.619022858643, 6365.904511432333, 6368.458681012074, 6148.0, 6242.500599951993, 6246.187995560548, 6264.091706702503, 6276.748930042747, 6313.526485513605, 6316.30520642729, 6319.304876463585, 6328.873422531524, 6342.746290148342, 6023.939760602338, 6168.629882207082, 6287.591306565058, 6288.496920246369, 6296.622202667854, 6207.503399728011, 6248.812535623939, 6269.435750782361, 6282.403171698681, 6289.088082228142, 4625.861224163281, 4715.717056976592, 4725.0, 4737.194676904935, 4755.0727608116085, 4120.546739858613, 4161.313383291784, 4200.474940632421, 4210.32634778434, 4227.239096962515, 5763.827085187451, 5945.672987985702, 5970.253718285215, 6001.219841420588, 6059.394060593905, 6195.876082478325, 6223.612353290919, 6291.96854015727, 6293.0, 6300.684965751694, 5875.941240587539, 5963.373845746134, 5983.820485385445, 6005.129256257818, 6024.427679370453, 5116.692998420107, 5136.9743151284, 5139.7687104080405, 5154.046501397253, 5166.43169251382, 6462.1276127723095, 6466.6766661666725, 6471.061696054046, 6479.6760161991715, 6490.0589414534625, 6117.857853872152, 6195.597286176384, 6201.224846894138, 6213.596116252339, 6216.875662486816, 6397.712102955471, 6407.199100112486, 6417.582857114273, 6420.871582568416, 6434.646094464662, 6027.246594175728, 6069.423404776539, 6069.848253793514, 6074.331823499323, 6089.695515224133, 6100.0, 6124.29570599369, 6148.815535533941, 6155.292141403616, 6169.074638804215, 6110.832160913912, 6126.816195513963, 6128.172696686069, 6128.724207410588, 6130.0, 6090.451859332681, 6091.847703807441, 6094.116353128683, 6106.877862442815, 6139.109829074849, 5943.7028148591535, 5994.490468310242, 6061.030235162353, 6111.358307377662, 6113.172264937315, 5974.701264936823, 6022.48808851235, 6036.154938308729, 6045.304789949212, 6065.636061836128, 5867.325257595431, 5871.354151043467, 5874.089516125007, 5881.2942446904935, 5900.409959004065], "value": 5721.527208018308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3462572053668, 670.523928011112, 671.8757029949456, 715.6636380900975, 730.4302643937727, 40343.0, 41222.58777412229, 41299.79350103245, 41311.58688413115, 41318.38022429666, 44764.0, 45691.31463028057, 45776.77111614445, 45785.31322030172, 45829.0, 8950.552472376372, 9118.224950879183, 9122.543872806365, 9124.908750912506, 9147.817043659123, 8834.823303533958, 8941.374103812703, 8960.014398416202, 8964.462132272052, 8993.955030224839, 9209.493477858716, 9224.723258302261, 9235.769105772375, 9241.722748317561, 9257.0, 9145.314101442385, 9202.40184388016, 9216.447013179231, 9218.44689318643, 9239.44563326196, 9201.493917834516, 9252.676156334563, 9276.072392760738, 9320.627174912996, 9322.580483878242, 45349.77325113386, 45635.77182114068, 45826.77086614545, 45854.0, 45897.770511147566, 3688.4467329900463, 3770.547534295902, 3903.531576210873, 4125.154343359604, 4235.3858690490015, 33720.83139584311, 33765.662343376745, 33916.83041584776, 34004.149896252544, 34546.13634659129, 4645.814167433298, 4648.093621743761, 4652.418447694038, 4668.346431499593, 4693.530646935279, 315490.42254788807, 318077.0, 318131.0, 318423.0, 321071.0, 63340.0, 63660.0, 64069.679651601444, 64070.67964660147, 64144.0, 69693.30306696969, 70374.64812676006, 70469.6476517614, 70731.646341769, 71040.64479677672, 17890.55273618144, 18122.818771812377, 18186.0, 18244.90877545604, 18343.35798247055, 14319.284035798377, 14429.0, 14459.710805784036, 14464.20446875432, 14491.492797752027, 20489.38531844047, 20693.379198624065, 20707.585848283252, 20742.27402040921, 21544.4613884651, 7742.690292388242, 7838.804029899298, 8000.51996880189, 8047.597620118971, 8156.510609363457, 1061.3101484035285, 1106.330669944688, 1120.2046546951592, 1137.1244142010605, 1189.262657152571, 33261.16847078794, 33446.0, 33727.0, 33839.49240761391, 34172.48741268883, 1160.3212120909363, 1175.2360965372577, 1270.4410059573759, 1290.2581015915887, 1305.2560040776857, 17361.211247296374, 17627.647447050986, 17767.733483997752, 17865.28538858431, 17900.194491247927, 496534.0, 540704.0, 547656.0, 552426.0, 555847.0, 58581.0, 59508.0, 59907.700461497414, 60083.497912552535, 60128.699356503814, 1491.733104501139, 1497.8202615685968, 1507.5025241670223, 1513.8259100203618, 1593.0202925200917, 33708.0, 34162.0, 34251.82874085614, 34527.4531047947, 34637.82681086679, 55770.44229557815, 56598.71700641471, 56829.147562785765, 56852.1472177926, 56975.71512142578, 436189.0, 439910.0, 440742.0, 442354.0, 443494.0, 32174.678253218106, 32481.187970299987, 32613.0, 32633.0, 32827.67172328246, 51960.74019629878, 51964.0, 53346.0, 53368.199477007096, 53403.73298133485, 43216.35175472307, 43570.56429435665, 44156.779216105, 44793.10413791641, 44962.55037449714, 42282.78858605687, 42930.35604465998, 43100.56899430966, 43489.34765978449, 43678.0, 45648.771756142334, 46228.53771462242, 46270.305945410175, 47321.52678473309, 47361.52638473571, 44313.556864430946, 44559.55440445554, 44650.10699785921, 45334.546654533035, 45905.31142032939, 31487.055388338387, 31510.21224469315, 31660.0, 31672.208194795316, 32148.83925580357], "value": 21607.283795940788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.3460645547817, 447.6988280239569, 453.12320659523823, 454.7135304758, 456.279079055093, 18744.343947961825, 19070.0, 19514.31699890504, 20207.292744753937, 20218.595628087467, 19703.704444433308, 19791.901040494777, 19864.304749333776, 20333.49166270844, 20342.0, 5750.578749900216, 5826.708664566776, 5996.040633498641, 5999.76000959961, 6011.098335249726, 5840.445157710011, 5907.0, 5933.584649074566, 5937.079752638348, 5945.851353716149, 5662.235598194253, 5861.912071318912, 5862.9413705863035, 5891.734871930752, 5895.734691938852, 5760.596758226926, 5817.331006934214, 5828.096645020008, 5828.591998560102, 5842.298924129132, 5209.7134657593815, 5248.239005344242, 5295.523402893758, 5303.681779093266, 5308.867278318035, 19885.20459181631, 21336.893315533478, 21355.0, 22091.889540552194, 22963.0, 2357.823163262762, 2373.7626237376126, 2406.061635961976, 2476.3561474016888, 2685.3420911876715, 9910.157636600825, 10376.325538839952, 10469.528871200815, 10602.840957385646, 10765.461726913623, 2039.535925907481, 2051.3948385226245, 2100.7584127825344, 2129.2866889592005, 2134.3703607435846, 79164.60417697874, 83868.16131838664, 84340.0, 84569.57715211446, 84848.15151848526, 11470.139739519569, 11529.942350288362, 11575.30548167096, 11605.129615278887, 11837.467313970892, 16412.343506259615, 16434.589135271475, 16591.91704041472, 16592.25334859934, 16632.3347066116, 8972.596233169523, 8986.640534378683, 8994.730158095268, 9047.55715956688, 9074.591643376063, 8740.125987401208, 8745.956270218736, 8758.47449153053, 8764.5179515126, 8826.382153249338, 4979.950200498021, 4988.7505624718615, 5009.0983622948215, 5091.9236211456855, 5136.512031357015, 2063.329417939176, 2069.3998740365128, 2111.2821640642255, 2116.0590022297797, 2120.6288899442843, 1002.5288114586133, 1040.3029969920171, 1060.7454210989306, 1112.010310823368, 1136.6362763915633, 17790.822091779177, 17899.910500447415, 17986.37047703324, 18080.728789068173, 18527.166277517543, 1047.8899715529913, 1056.9471526423647, 1082.1613249731363, 1102.4432661506048, 1131.9094472442184, 10062.19502439803, 10105.848412273821, 10805.459727013618, 10828.350298982086, 10845.349279043283, 486713.0, 493848.0, 508715.0, 525265.0, 526491.0, 93345.13309733903, 95972.52013739887, 97880.0, 99019.50490247503, 99079.50460247653, 1136.9488373023235, 1136.9602063927723, 1153.5962413155496, 1158.8435561199299, 1165.947532361046, 16708.16459177012, 16772.077535735163, 16801.831981680025, 16941.66116677684, 17090.572735681708, 37981.0, 40062.39906401348, 40128.79935600303, 40256.59743402529, 40287.194256114126, 57078.7146064267, 57215.42784572101, 57516.42483575111, 58099.0, 58264.70867645634, 8265.107212475585, 8410.243078122998, 8690.30477561781, 8718.564071796513, 8918.0, 10106.595736170764, 13395.799063014258, 13465.124766890121, 13485.46058157702, 13593.116447430886, 11880.287182769061, 11901.404929753651, 11915.16593838423, 12028.338441385808, 12269.0, 6091.329953705001, 7346.742863999734, 11049.226554141133, 11214.271072380268, 11314.490847911698, 12179.0, 12225.327606981346, 12282.447289872156, 12296.077794165294, 12329.938350308192, 9034.322425817958, 9062.093790620886, 9074.0, 9206.549305910576, 9289.767755806159, 9398.436093834393, 11708.0, 12166.635000949986, 12206.718294578941, 12220.0], "value": 9454.991232120254, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.9012064215824, 1531.915744634045, 1713.768641233433, 1807.322254154692, 1868.7196920461938, 8297.792555186123, 9149.222316103123, 9262.583183756731, 9395.248380129591, 9485.38345007574, 9193.44839309642, 9251.213646840026, 9383.390079644836, 9459.290553208502, 9467.952660236706, 2517.546841568517, 2532.9113481028166, 2533.0, 2553.131935142051, 2554.833935794177, 2496.750324967498, 2556.079811267942, 2578.948421031578, 2580.213035024317, 2588.4564241509306, 2371.2649078785544, 2373.643953406994, 2374.121575017246, 2377.7146742390937, 2383.7020372453444, 2401.939951501218, 2480.875956202192, 2492.8504289742673, 2504.186139504668, 2523.3439305780444, 2552.4001859562986, 2579.6904371475543, 2593.988344545629, 2613.4381108061857, 2616.6336712860216, 9557.283203759676, 9644.324897257195, 9650.13148816603, 9661.565229564687, 9667.081627245401, 5786.537077033827, 5844.123381492767, 5889.469947704727, 5917.082852157922, 5927.170196172497, 3582.5521809773777, 3701.056230661164, 3729.0, 3735.9912823537766, 3764.3224219640456, 1208.528673817212, 1250.1249125612017, 1272.8981681465552, 1274.6813296675832, 1285.9519491614305, 13675.384607692578, 13728.382222799997, 13757.724845503133, 13837.654058648513, 13857.930710346485, 4854.635902307341, 4951.034548263054, 4957.752112394366, 4976.402831660224, 5010.674306170087, 10826.40454774995, 10840.024397804078, 10845.620403285848, 10858.348499089921, 10907.345559266469, 5590.580706446952, 5647.491725744702, 5650.0959846424375, 5668.489835914787, 5675.716214189274, 5161.690298582097, 5200.583953283728, 5227.503387178212, 5261.184516399964, 5293.073712100444, 4191.538930717618, 4205.348171033434, 4420.071784925138, 4425.380446737459, 4430.490493593278, 1318.6176008957486, 1328.362386054699, 1330.693940393715, 1334.1861464506644, 1334.8998825087963, 905.2395987370641, 1050.9474526273655, 1065.6643157405392, 1072.8390741388698, 1113.4098927568402, 6222.844428889223, 6419.069234960904, 6435.324290949477, 6449.516286278548, 6544.0, 482.70796168318367, 484.52032487837494, 484.7212852609693, 487.14749188919393, 489.55205986522645, 4453.821847126079, 4457.153140903283, 4477.8208871644765, 4558.840440584564, 4561.133384656904, 11665.24175928562, 12034.939825300993, 12147.271163730027, 12155.149139560323, 12185.939070304592, 11561.479733412016, 11883.287002779862, 11887.108466864847, 11889.405529723479, 12134.5146194153, 8994.145556172152, 9044.728658140266, 9046.773830654154, 9073.81852362949, 9125.17873391398, 5980.5514586405325, 6081.5134789217645, 6094.177286066324, 6149.692515374303, 6208.906866397098, 10431.739206519898, 10443.164546836388, 10583.206259530412, 10654.840177397191, 10663.840042399526, 10117.0, 10235.078842904175, 10325.173986081245, 10475.266731329039, 10574.206934479791, 7421.554706717614, 7811.414143939341, 8069.273765361146, 8324.875126873223, 8441.78895527592, 9166.816663666823, 9199.816003679754, 9247.537623118951, 9270.72187834366, 9289.581968811284, 8066.878996814935, 8220.712275070344, 8224.588770561568, 8269.379796515164, 8360.498370097814, 8153.9184608153155, 8242.505449673039, 8254.0507841599, 8334.166583341617, 8348.582570871553, 7345.0, 7375.0, 7413.184549699637, 7523.811904702207, 7757.146713861358, 5432.266644003167, 5546.168074788814, 5561.221428999862, 5635.15472679085, 5714.000049991318, 5258.737063146751, 5317.946820531745, 5335.439778823167, 5435.809746658848, 5732.226149469769], "value": 4895.937444947832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.08773373634006, 382.12684017021104, 384.87299191266874, 387.542699614455, 389.21378814794133, 6590.769323073693, 6591.044298576703, 6719.0593316935665, 6782.220044694862, 6809.931900680998, 6611.272759996408, 6697.933020669804, 6698.062271282024, 6700.262971073178, 6705.932940670592, 5065.138926382524, 5071.644984851062, 5078.314427552288, 5083.694978301295, 5092.719900405476, 5079.593632509409, 5090.312807770941, 5092.439831618519, 5099.796008159669, 5108.080545501808, 5054.9241761373605, 5056.8482945511505, 5057.5701065409485, 5063.113955057868, 5064.11378008847, 4949.505049495057, 5040.621953353513, 5060.266261392096, 5067.290579318898, 5078.898422031576, 4443.955560444387, 4474.194644963905, 4477.059817438342, 4477.70894891831, 4482.193205223059, 6374.840628984266, 6377.776777812801, 6385.23377194735, 6391.936080639181, 6402.13571167891, 5953.404659534055, 5966.791162309341, 5967.731452084623, 5970.641761494324, 5987.700614969234, 7051.153861536597, 7060.22337542875, 7062.081929349203, 7062.5056246062795, 7067.15194176697, 4660.254359302496, 4830.2513110467935, 4834.444038935532, 4981.053599816023, 4997.300377947054, 7201.063861697946, 7256.709731610729, 7279.2356802535505, 7355.448341374418, 7357.742479013263, 4951.925721114186, 4973.477784832613, 4978.950210497848, 4980.576650984634, 5001.874953126128, 5046.44489106198, 5048.29323894655, 5049.065922804293, 5053.1157047516535, 5074.746262686851, 5852.326982397079, 5857.326407463111, 5859.121131830174, 5877.94122058774, 5884.941150588525, 6968.233494315621, 7057.576545407292, 7081.327273908971, 7089.042979197846, 7103.964480177566, 1755.8683098767644, 1764.9294028238983, 1772.6720556696794, 1774.9911250443665, 1777.0403981849656, 1134.5405110930087, 1149.7757937202166, 1155.2952698853692, 1167.6280370564552, 1173.4719376280707, 6782.0, 6819.386255237053, 6827.795166145023, 6838.281980391987, 6854.691538880762, 7238.131424229126, 7248.818779530554, 7253.782386528413, 7258.709651613982, 7300.671469783872, 6785.796426107225, 6825.215100263434, 6830.21452532965, 6839.1451068616425, 6839.487038472134, 3841.8079096045085, 3879.1465877506903, 3918.686505079587, 3923.136909879822, 3923.8234279457492, 7626.237376262329, 7630.969819074465, 7633.580153091522, 7633.847323053508, 7639.236076392316, 7422.072240969879, 7437.665305061285, 7438.330550250504, 7439.293267139613, 7452.0, 7595.278448547379, 7597.5821329826285, 7601.0, 7617.847643047219, 7627.313541781266, 7031.05080814104, 7217.819554511179, 7228.20489746138, 7245.058142441449, 7268.41852651776, 7111.964440177766, 7126.893096603451, 7137.892931605927, 7144.214136444883, 7147.392471639969, 7545.547267163988, 7575.810604734926, 7607.391408687181, 7624.58064806441, 7624.656890439833, 4991.0, 4993.425756038102, 4996.850094497171, 4998.950010499849, 5001.549860512571, 7062.788116356517, 7249.782506524813, 7257.600831954293, 7264.055672762507, 7266.527675701062, 6918.0, 6943.062686537455, 6960.303969602999, 6960.860782784417, 6962.199347075151, 6993.8251543709775, 6996.335348141918, 7001.719931202695, 7004.929950700428, 7022.08712867324, 6769.458443324424, 6786.423154031765, 6799.490038247251, 6818.761343352959, 6878.518503704692, 6906.723731050702, 7044.6125463100025, 7059.576425414286, 7059.858802823812, 7063.71745130189, 6766.120404347404, 6865.656717164222, 6959.304069593, 6960.095187625576, 6971.128608923885], "value": 5316.501105001668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.2087912087912, 796.0685997383061, 823.2631794543887, 836.9246767790902, 849.3120572336412, 14726.0, 14782.556523304318, 15407.69184616307, 15527.301271442784, 15697.215139243035, 15231.390744370212, 15432.61418464539, 15596.922015389935, 15622.29699663515, 15649.45226917058, 873.52829472085, 888.0364804187465, 907.850204716221, 909.4225167018958, 911.8723378726984, 916.7112359606735, 917.1424717888762, 918.9081091890791, 919.3610440743686, 920.691568324612, 965.2856885904415, 966.5119114846992, 967.6806653804227, 970.2383628851353, 970.7573106723319, 957.042957042957, 957.4064080270242, 958.5782255807492, 960.0591420408005, 961.3318743473288, 700.8808502554577, 702.5924963521145, 703.5075447186938, 704.802655256529, 705.5696025424487, 15874.206289685584, 15892.920535397365, 15899.205039747967, 15900.602484937854, 15937.362505499766, 15480.922595387063, 15503.767443488357, 15569.844301557067, 15648.530544083696, 15742.842571574252, 12178.208416452902, 12243.265404075784, 12485.687857803627, 12522.123451358408, 12774.48902043917, 3933.8229779659696, 3968.4245784361397, 4027.97986010071, 4048.0891799345204, 4075.8369665213354, 61204.38795612076, 61218.387816121714, 61577.076343854875, 61885.690571547304, 62174.99999999955, 12125.636230913087, 12281.89462948339, 12348.0, 12367.443465044094, 12437.129400941847, 22309.0, 22312.107515699514, 22321.665175022386, 22329.888350558467, 22337.664935025987, 8477.788055298544, 8720.738377848675, 9023.368364214442, 9027.871516060492, 9030.86453703195, 4787.904241915142, 4790.904181916342, 4814.927776083362, 4832.226843704991, 4890.144224760724, 3506.544149260631, 3571.125074356747, 3588.4258518636893, 3599.5500562429697, 3599.5680518337444, 592.3927973826776, 606.1392822192497, 607.9392060793886, 619.2074145094286, 622.0451606783565, 767.4896194031019, 772.679338074704, 775.1937984496174, 812.3825892321878, 834.1408349400127, 10152.593896244216, 10250.487475626189, 10296.0, 10508.474576271308, 10676.733081672865, 724.463896716426, 730.9729829589436, 836.7364280251701, 854.0989256334626, 879.0374539878823, 4463.5313292103865, 4921.335619691367, 4942.481039490874, 4951.009798040406, 4960.776765045582, 67618.3238167612, 69276.0, 69483.30516694768, 69648.65175674089, 69708.65145674239, 58052.0, 58134.0, 59176.11235831466, 60643.0, 60797.39202608006, 52666.0, 53597.73201133969, 53661.46338536643, 54302.45697542974, 54583.72708136434, 9633.0, 9677.758056048655, 9712.465814380277, 9788.0, 9809.215262778818, 37921.81039094787, 38041.809790950865, 38935.0, 39528.209435811696, 39563.406548901214, 46838.0, 47423.0, 50706.0, 50728.746356267984, 51398.0, 11278.266912650652, 11306.83039754388, 11916.880831191576, 11946.104042196695, 12361.381930903599, 13421.798673020108, 13498.73002539924, 13623.0, 13682.110662806886, 13718.65703357424, 12834.486620535074, 12898.355082246038, 12913.935430322788, 13012.28432436225, 13090.14914030585, 12531.0, 12577.811332830199, 12612.49550017989, 12689.175203611736, 12772.872271277169, 11680.357580333164, 11710.648680539598, 12068.0, 12236.143469957373, 12357.505699771908, 9687.128158465772, 9810.509474526389, 9835.704928852147, 9909.55407006672, 10016.849747253651, 10539.15686745074, 10607.840882386616, 10761.677149685522, 10809.729756756144, 10855.18586106061], "value": 7240.972850656284, "unit": "score"}], "name": "dromaeo_css", "value": 7771.6188815712885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 101.0, 109.0, 109.0, 113.0, 100.0, 113.0, 110.0, 110.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 133.0, 163.0, 174.0, 133.0, 161.0, 158.0, 128.0, 179.0, 132.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 168.0, 77.0, 85.0, 76.0, 78.0, 169.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 92.0, 101.0, 93.0, 159.0, 93.0, 92.0, 147.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 100.0, 94.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 57.0, 55.0, 57.0, 58.0, 54.0, 73.0, 57.0, 54.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 60.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 76.0, 72.0, 74.0, 74.0, 73.0, 74.0, 74.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 114.0, 123.0, 114.0, 118.0, 116.0, 113.0, 119.0, 132.0, 138.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 174.0, 159.0, 163.0, 161.0, 160.0, 163.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 68.0, 66.0, 64.0, 66.0, 66.0, 65.0, 66.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1526.7999999999997, "alertThreshold": 2.0}]} 09:00:56 INFO - Return code: 0 09:00:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:00:56 ERROR - # TBPL SUCCESS # 09:00:56 INFO - Running post-action listener: _resource_record_post_action 09:00:56 INFO - Running post-run listener: _resource_record_post_run 09:00:57 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463413248; Read time: 12; Write time: 382720 09:00:57 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 241676288; Read time: 0; Write time: 251244 09:00:57 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221736960; Read time: 12; Write time: 131476 09:00:57 INFO - Running post-run listener: _upload_blobber_files 09:00:57 INFO - Blob upload gear active. 09:00:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:00:57 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:00:57 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:00:57 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:00:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:58 INFO - (blobuploader) - INFO - Done attempting. 09:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:59 INFO - (blobuploader) - INFO - Done attempting. 09:00:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:59 INFO - Return code: 0 09:00:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fecf2bca165ec0d00e6d1eba425f6e85906d0539c74f5908cebef5c58cca9c40978df26d01109bcc543b382f88cdc844bcecc89c65126321f2cab1dfafc0c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2367fcd51fc70dbd14e535274c64de2f55f7c26dbf12407e7e5b13a98af342a77948b694697992aab0125340f9e9a80ec443a541db5a3c978bebb0b33ce22e71"} 09:00:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:59 INFO - Contents: 09:00:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fecf2bca165ec0d00e6d1eba425f6e85906d0539c74f5908cebef5c58cca9c40978df26d01109bcc543b382f88cdc844bcecc89c65126321f2cab1dfafc0c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2367fcd51fc70dbd14e535274c64de2f55f7c26dbf12407e7e5b13a98af342a77948b694697992aab0125340f9e9a80ec443a541db5a3c978bebb0b33ce22e71"} 09:00:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:59 INFO - Copying logs to upload dir... 09:00:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.656693 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-21 09:00:59.002894) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:59.006797) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fecf2bca165ec0d00e6d1eba425f6e85906d0539c74f5908cebef5c58cca9c40978df26d01109bcc543b382f88cdc844bcecc89c65126321f2cab1dfafc0c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2367fcd51fc70dbd14e535274c64de2f55f7c26dbf12407e7e5b13a98af342a77948b694697992aab0125340f9e9a80ec443a541db5a3c978bebb0b33ce22e71"} build_url:https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/JCqgSmEVRgSJ9en9KpCLMw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fecf2bca165ec0d00e6d1eba425f6e85906d0539c74f5908cebef5c58cca9c40978df26d01109bcc543b382f88cdc844bcecc89c65126321f2cab1dfafc0c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2367fcd51fc70dbd14e535274c64de2f55f7c26dbf12407e7e5b13a98af342a77948b694697992aab0125340f9e9a80ec443a541db5a3c978bebb0b33ce22e71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:59.032332) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:59.032669) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1466523141.632899-1778121450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 09:00:59.117269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 09:00:59.117612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 09:00:59.117920) ========= ========= Total master_lag: 0.18 =========