builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1468424531.38 results: success (0) buildid: 20160713055926 builduid: a17a4545e083444193b0f0066652e7b1 revision: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.376889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.377383) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.377673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.392616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.392899) ========= 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=33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 08:42:12-- 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% 222M=0s 2016-07-13 08:42:12 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126477 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.540166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.540487) ========= 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=33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.590385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:11.590773) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e019c07ecb8b1f1668d469e64eafa126bb72ceb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e019c07ecb8b1f1668d469e64eafa126bb72ceb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 08:42:12,546 truncating revision to first 12 chars 2016-07-13 08:42:12,546 Setting DEBUG logging. 2016-07-13 08:42:12,546 attempt 1/10 2016-07-13 08:42:12,547 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e019c07ecb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 08:42:12,848 unpacking tar archive at: mozilla-beta-3e019c07ecb8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:12.249823) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:12.250152) ========= script_repo_revision: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:12.250582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:12.251253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:12.260845) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-13 08:42:12.261209) ========= /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=33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:13 INFO - MultiFileLogger online at 20160713 08:42:13 in /builds/slave/test 08:42:13 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:42:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:13 INFO - {'append_to_log': False, 08:42:13 INFO - 'base_work_dir': '/builds/slave/test', 08:42:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:13 INFO - 'branch': 'Mozilla-Beta', 08:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:13 INFO - 'config_files': ('talos/linux_config.py',), 08:42:13 INFO - 'default_actions': ('clobber', 08:42:13 INFO - 'read-buildbot-config', 08:42:13 INFO - 'download-and-extract', 08:42:13 INFO - 'populate-webroot', 08:42:13 INFO - 'create-virtualenv', 08:42:13 INFO - 'install', 08:42:13 INFO - 'run-tests'), 08:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:13 INFO - 'download_minidump_stackwalk': True, 08:42:13 INFO - 'download_symbols': 'ondemand', 08:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:13 INFO - 'installer_path': 'installer.exe', 08:42:13 INFO - 'log_level': 'info', 08:42:13 INFO - 'log_name': 'talos', 08:42:13 INFO - 'log_to_console': True, 08:42:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:13 INFO - 'opt_config_files': (), 08:42:13 INFO - 'pip_index': False, 08:42:13 INFO - 'sps_profile': False, 08:42:13 INFO - 'sps_profile_interval': 0, 08:42:13 INFO - 'suite': 'dromaeojs-e10s', 08:42:13 INFO - 'system_bits': '32', 08:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:13 INFO - 'title': 'talos-linux64-ix-063', 08:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:13 INFO - 'use_talos_json': True, 08:42:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:13 INFO - 'work_dir': 'build'} 08:42:13 INFO - ##### 08:42:13 INFO - ##### Running clobber step. 08:42:13 INFO - ##### 08:42:13 INFO - Running pre-action listener: _resource_record_pre_action 08:42:13 INFO - Running main action method: clobber 08:42:13 INFO - rmtree: /builds/slave/test/build 08:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:13 INFO - Running post-action listener: _resource_record_post_action 08:42:13 INFO - ##### 08:42:13 INFO - ##### Running read-buildbot-config step. 08:42:13 INFO - ##### 08:42:13 INFO - Running pre-action listener: _resource_record_pre_action 08:42:13 INFO - Running main action method: read_buildbot_config 08:42:13 INFO - Using buildbot properties: 08:42:13 INFO - { 08:42:13 INFO - "project": "", 08:42:13 INFO - "product": "firefox", 08:42:13 INFO - "script_repo_revision": "production", 08:42:13 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:42:13 INFO - "repository": "", 08:42:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:42:13 INFO - "buildid": "20160713055926", 08:42:13 INFO - "pgo_build": "True", 08:42:13 INFO - "basedir": "/builds/slave/test", 08:42:13 INFO - "buildnumber": 47, 08:42:13 INFO - "slavename": "talos-linux64-ix-063", 08:42:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:13 INFO - "platform": "ubuntu64_hw", 08:42:13 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:42:13 INFO - "branch": "mozilla-beta", 08:42:13 INFO - "repo_path": "releases/mozilla-beta", 08:42:13 INFO - "revision": "3e019c07ecb8b1f1668d469e64eafa126bb72ceb", 08:42:13 INFO - "stage_platform": "linux64-pgo", 08:42:13 INFO - "builduid": "a17a4545e083444193b0f0066652e7b1", 08:42:13 INFO - "slavebuilddir": "test" 08:42:13 INFO - } 08:42:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:42:13 INFO - Running post-action listener: _resource_record_post_action 08:42:13 INFO - ##### 08:42:13 INFO - ##### Running download-and-extract step. 08:42:13 INFO - ##### 08:42:13 INFO - Running pre-action listener: _resource_record_pre_action 08:42:13 INFO - Running main action method: download_and_extract 08:42:13 INFO - mkdir: /builds/slave/test/build/tests 08:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:13 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:42:15 INFO - Downloaded 1327 bytes. 08:42:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:15 INFO - Using the following test package requirements: 08:42:15 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:42:15 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:15 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:42:15 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'jsshell-linux-x86_64.zip'], 08:42:15 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:15 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:42:15 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:42:15 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:42:15 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:15 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:15 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:15 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:15 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:17 INFO - Downloaded 24237901 bytes. 08:42:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:18 INFO - Return code: 0 08:42:18 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:18 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:27 INFO - Downloaded 24237901 bytes. 08:42:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:28 INFO - Return code: 0 08:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:28 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:42:29 INFO - Downloaded 10840145 bytes. 08:42:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:42:29 INFO - Return code: 0 08:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:29 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:42:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:42:31 INFO - Downloaded 56030297 bytes. 08:42:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:31 INFO - mkdir: /builds/slave/test/properties 08:42:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:31 INFO - Contents: 08:42:31 INFO - build_url:https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:31 INFO - Running post-action listener: _resource_record_post_action 08:42:31 INFO - Running post-action listener: set_extra_try_arguments 08:42:31 INFO - ##### 08:42:31 INFO - ##### Running populate-webroot step. 08:42:31 INFO - ##### 08:42:31 INFO - Running pre-action listener: _resource_record_pre_action 08:42:31 INFO - Running main action method: populate_webroot 08:42:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:31 INFO - '--tppagecycles', 08:42:31 INFO - '7'], 08:42:31 INFO - 'tests': ['tsvgm']}}, 08:42:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['damp', 'tps']}, 08:42:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'tests': ['damp', 'tps']}, 08:42:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['dromaeo_dom']}, 08:42:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['a11yr', 08:42:31 INFO - 'ts_paint', 08:42:31 INFO - 'tpaint', 08:42:31 INFO - 'sessionrestore', 08:42:31 INFO - 'sessionrestore_no_auto_restore', 08:42:31 INFO - 'tabpaint']}, 08:42:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:31 INFO - 'ts_paint', 08:42:31 INFO - 'tpaint', 08:42:31 INFO - 'sessionrestore', 08:42:31 INFO - 'sessionrestore_no_auto_restore', 08:42:31 INFO - 'tabpaint']}, 08:42:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:31 INFO - 'ts_paint', 08:42:31 INFO - 'tpaint', 08:42:31 INFO - 'sessionrestore', 08:42:31 INFO - 'sessionrestore_no_auto_restore', 08:42:31 INFO - 'tabpaint']}, 08:42:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:31 INFO - 'ts_paint', 08:42:31 INFO - 'tpaint', 08:42:31 INFO - 'sessionrestore', 08:42:31 INFO - 'sessionrestore_no_auto_restore', 08:42:31 INFO - 'tabpaint']}, 08:42:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['a11yr', 08:42:31 INFO - 'ts_paint', 08:42:31 INFO - 'tpaint', 08:42:31 INFO - 'sessionrestore', 08:42:31 INFO - 'sessionrestore_no_auto_restore', 08:42:31 INFO - 'tabpaint']}, 08:42:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['a11yr', 08:42:31 INFO - 'ts_paint', 08:42:31 INFO - 'tpaint', 08:42:31 INFO - 'sessionrestore', 08:42:31 INFO - 'sessionrestore_no_auto_restore', 08:42:31 INFO - 'tabpaint']}, 08:42:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['tsvgx', 08:42:31 INFO - 'tsvgr_opacity', 08:42:31 INFO - 'tart', 08:42:31 INFO - 'tscrollx', 08:42:31 INFO - 'cart']}, 08:42:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:31 INFO - 'tsvgr_opacity', 08:42:31 INFO - 'tart', 08:42:31 INFO - 'tscrollx', 08:42:31 INFO - 'cart']}, 08:42:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'talos_options': ['--disable-e10s'], 08:42:31 INFO - 'tests': ['tp5o']}, 08:42:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'tests': ['tp5o']}, 08:42:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'talos_options': ['--disable-e10s', 08:42:31 INFO - '--xperf_path', 08:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:31 INFO - 'tests': ['tp5n']}, 08:42:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:31 INFO - 'talos_options': ['--xperf_path', 08:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:31 INFO - 'tests': ['tp5n']}}, 08:42:31 INFO - 'talos.zip': {'path': '', 08:42:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:31 INFO - Running post-action listener: _resource_record_post_action 08:42:31 INFO - ##### 08:42:31 INFO - ##### Running create-virtualenv step. 08:42:31 INFO - ##### 08:42:31 INFO - Running pre-action listener: _resource_record_pre_action 08:42:31 INFO - Running main action method: create_virtualenv 08:42:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:31 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:42:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:32 INFO - Using real prefix '/usr' 08:42:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:34 INFO - Installing pip.................done. 08:42:34 INFO - Return code: 0 08:42:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:42:34 INFO - Using env: {'DISPLAY': ':0', 08:42:34 INFO - 'HOME': '/home/cltbld', 08:42:34 INFO - 'LANG': 'en_US.UTF-8', 08:42:34 INFO - 'LANGUAGE': 'en_US:en', 08:42:34 INFO - 'LOGNAME': 'cltbld', 08:42:34 INFO - 'MAIL': '/var/mail/cltbld', 08:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:34 INFO - 'MOZ_NO_REMOTE': '1', 08:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:34 INFO - 'NO_EM_RESTART': '1', 08:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:34 INFO - 'PWD': '/builds/slave/test', 08:42:34 INFO - 'SHELL': '/bin/bash', 08:42:34 INFO - 'SHLVL': '1', 08:42:34 INFO - 'TERM': 'linux', 08:42:34 INFO - 'TMOUT': '86400', 08:42:34 INFO - 'USER': 'cltbld', 08:42:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:34 INFO - '_': '/tools/buildbot/bin/python'} 08:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:35 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:42:35 INFO - Cleaning up... 08:42:35 INFO - Return code: 0 08:42:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:35 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:42:35 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:42:35 INFO - Using env: {'DISPLAY': ':0', 08:42:35 INFO - 'HOME': '/home/cltbld', 08:42:35 INFO - 'LANG': 'en_US.UTF-8', 08:42:35 INFO - 'LANGUAGE': 'en_US:en', 08:42:35 INFO - 'LOGNAME': 'cltbld', 08:42:35 INFO - 'MAIL': '/var/mail/cltbld', 08:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:35 INFO - 'MOZ_NO_REMOTE': '1', 08:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:35 INFO - 'NO_EM_RESTART': '1', 08:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:35 INFO - 'PWD': '/builds/slave/test', 08:42:35 INFO - 'SHELL': '/bin/bash', 08:42:35 INFO - 'SHLVL': '1', 08:42:35 INFO - 'TERM': 'linux', 08:42:35 INFO - 'TMOUT': '86400', 08:42:35 INFO - 'USER': 'cltbld', 08:42:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:35 INFO - '_': '/tools/buildbot/bin/python'} 08:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:35 INFO - Downloading/unpacking psutil>=0.7.1 08:42:35 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:42:35 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:42:35 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:42:35 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:42:35 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:42:35 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:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:37 INFO - Installing collected packages: psutil 08:42:37 INFO - Running setup.py install for psutil 08:42:37 INFO - building 'psutil._psutil_linux' extension 08:42:37 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:42:37 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:42:37 INFO - building 'psutil._psutil_posix' extension 08:42:37 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:42:37 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:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:37 INFO - Successfully installed psutil 08:42:37 INFO - Cleaning up... 08:42:37 INFO - Return code: 0 08:42:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:37 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:37 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:42:37 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:42:37 INFO - Using env: {'DISPLAY': ':0', 08:42:37 INFO - 'HOME': '/home/cltbld', 08:42:37 INFO - 'LANG': 'en_US.UTF-8', 08:42:37 INFO - 'LANGUAGE': 'en_US:en', 08:42:37 INFO - 'LOGNAME': 'cltbld', 08:42:37 INFO - 'MAIL': '/var/mail/cltbld', 08:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:37 INFO - 'MOZ_NO_REMOTE': '1', 08:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:37 INFO - 'NO_EM_RESTART': '1', 08:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:37 INFO - 'PWD': '/builds/slave/test', 08:42:37 INFO - 'SHELL': '/bin/bash', 08:42:37 INFO - 'SHLVL': '1', 08:42:37 INFO - 'TERM': 'linux', 08:42:37 INFO - 'TMOUT': '86400', 08:42:37 INFO - 'USER': 'cltbld', 08:42:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:37 INFO - '_': '/tools/buildbot/bin/python'} 08:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42:38 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:42:38 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:42:38 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:42:38 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:42:38 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:42:38 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:42:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:40 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:42:40 INFO - Installing collected packages: mozsystemmonitor 08:42:40 INFO - Running setup.py install for mozsystemmonitor 08:42:40 INFO - Successfully installed mozsystemmonitor 08:42:40 INFO - Cleaning up... 08:42:40 INFO - Return code: 0 08:42:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:40 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:40 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:42:40 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:42:40 INFO - Using env: {'DISPLAY': ':0', 08:42:40 INFO - 'HOME': '/home/cltbld', 08:42:40 INFO - 'LANG': 'en_US.UTF-8', 08:42:40 INFO - 'LANGUAGE': 'en_US:en', 08:42:40 INFO - 'LOGNAME': 'cltbld', 08:42:40 INFO - 'MAIL': '/var/mail/cltbld', 08:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:40 INFO - 'MOZ_NO_REMOTE': '1', 08:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:40 INFO - 'NO_EM_RESTART': '1', 08:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:40 INFO - 'PWD': '/builds/slave/test', 08:42:40 INFO - 'SHELL': '/bin/bash', 08:42:40 INFO - 'SHLVL': '1', 08:42:40 INFO - 'TERM': 'linux', 08:42:40 INFO - 'TMOUT': '86400', 08:42:40 INFO - 'USER': 'cltbld', 08:42:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:40 INFO - '_': '/tools/buildbot/bin/python'} 08:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - Downloading docopt-0.6.1.tar.gz 08:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:43 INFO - Running setup.py install for blobuploader 08:42:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:43 INFO - Running setup.py install for requests 08:42:43 INFO - Running setup.py install for docopt 08:42:43 INFO - Successfully installed blobuploader requests docopt 08:42:43 INFO - Cleaning up... 08:42:43 INFO - Return code: 0 08:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:43 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:42:43 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:42:43 INFO - Using env: {'DISPLAY': ':0', 08:42:43 INFO - 'HOME': '/home/cltbld', 08:42:43 INFO - 'LANG': 'en_US.UTF-8', 08:42:43 INFO - 'LANGUAGE': 'en_US:en', 08:42:43 INFO - 'LOGNAME': 'cltbld', 08:42:43 INFO - 'MAIL': '/var/mail/cltbld', 08:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:43 INFO - 'MOZ_NO_REMOTE': '1', 08:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:43 INFO - 'NO_EM_RESTART': '1', 08:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:43 INFO - 'PWD': '/builds/slave/test', 08:42:43 INFO - 'SHELL': '/bin/bash', 08:42:43 INFO - 'SHLVL': '1', 08:42:43 INFO - 'TERM': 'linux', 08:42:43 INFO - 'TMOUT': '86400', 08:42:43 INFO - 'USER': 'cltbld', 08:42:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:43 INFO - '_': '/tools/buildbot/bin/python'} 08:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:43 INFO - Running setup.py (path:/tmp/pip-RUTO_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:44 INFO - Running setup.py (path:/tmp/pip-STHUfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:44 INFO - Running setup.py (path:/tmp/pip-q1O26w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:44 INFO - Running setup.py (path:/tmp/pip-1ZELYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:44 INFO - Running setup.py (path:/tmp/pip-91OhCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:44 INFO - Running setup.py (path:/tmp/pip-3uZp8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:44 INFO - Running setup.py (path:/tmp/pip-OhCIst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:44 INFO - Running setup.py (path:/tmp/pip-LbAwjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:44 INFO - Running setup.py (path:/tmp/pip-I7Ek40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:44 INFO - Running setup.py (path:/tmp/pip-EucaY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:44 INFO - Running setup.py (path:/tmp/pip-RowP1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:44 INFO - Running setup.py (path:/tmp/pip-3juvcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:44 INFO - Running setup.py (path:/tmp/pip-TOY32G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:44 INFO - Running setup.py (path:/tmp/pip-RzqN5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:44 INFO - Running setup.py (path:/tmp/pip-Nl3HfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:45 INFO - Running setup.py (path:/tmp/pip-YsT1Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:45 INFO - Running setup.py (path:/tmp/pip-c7NgbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:45 INFO - Running setup.py install for manifestparser 08:42:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozcrash 08:42:45 INFO - Running setup.py install for mozdebug 08:42:45 INFO - Running setup.py install for mozdevice 08:42:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozfile 08:42:45 INFO - Running setup.py install for mozhttpd 08:42:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozinfo 08:42:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozInstall 08:42:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Running setup.py install for mozleak 08:42:46 INFO - Running setup.py install for mozlog 08:42:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Running setup.py install for moznetwork 08:42:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Running setup.py install for mozprocess 08:42:46 INFO - Running setup.py install for mozprofile 08:42:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Running setup.py install for mozrunner 08:42:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Running setup.py install for mozscreenshot 08:42:46 INFO - Running setup.py install for moztest 08:42:46 INFO - Running setup.py install for mozversion 08:42:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:46 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:47 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:42:47 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:42:47 INFO - Using env: {'DISPLAY': ':0', 08:42:47 INFO - 'HOME': '/home/cltbld', 08:42:47 INFO - 'LANG': 'en_US.UTF-8', 08:42:47 INFO - 'LANGUAGE': 'en_US:en', 08:42:47 INFO - 'LOGNAME': 'cltbld', 08:42:47 INFO - 'MAIL': '/var/mail/cltbld', 08:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:47 INFO - 'MOZ_NO_REMOTE': '1', 08:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:47 INFO - 'NO_EM_RESTART': '1', 08:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:47 INFO - 'PWD': '/builds/slave/test', 08:42:47 INFO - 'SHELL': '/bin/bash', 08:42:47 INFO - 'SHLVL': '1', 08:42:47 INFO - 'TERM': 'linux', 08:42:47 INFO - 'TMOUT': '86400', 08:42:47 INFO - 'USER': 'cltbld', 08:42:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:47 INFO - '_': '/tools/buildbot/bin/python'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:47 INFO - Running setup.py (path:/tmp/pip-l37Buy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:47 INFO - Running setup.py (path:/tmp/pip-yYS4ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:47 INFO - Running setup.py (path:/tmp/pip-tWBqqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:47 INFO - Running setup.py (path:/tmp/pip-PmMh8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:47 INFO - Running setup.py (path:/tmp/pip-28djES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:47 INFO - Running setup.py (path:/tmp/pip-Fnyv9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:47 INFO - Running setup.py (path:/tmp/pip-y9epJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:47 INFO - Running setup.py (path:/tmp/pip-ViRKIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:47 INFO - Running setup.py (path:/tmp/pip-wa4yQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:47 INFO - Running setup.py (path:/tmp/pip-07dL8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:47 INFO - Running setup.py (path:/tmp/pip-aluJOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:47 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:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:48 INFO - Running setup.py (path:/tmp/pip-tHRGWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:48 INFO - Running setup.py (path:/tmp/pip-fQk1JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:48 INFO - Running setup.py (path:/tmp/pip-nGwE2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:48 INFO - Running setup.py (path:/tmp/pip-EBIOw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:48 INFO - Running setup.py (path:/tmp/pip-83lwqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:48 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:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:48 INFO - Running setup.py (path:/tmp/pip-SeyeOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:48 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:42:48 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:42:48 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:42:48 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:42:48 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:42:48 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:42:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:50 INFO - Downloading blessings-1.6.tar.gz 08:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:50 INFO - Installing collected packages: blessings 08:42:50 INFO - Running setup.py install for blessings 08:42:50 INFO - Successfully installed blessings 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:50 INFO - Reading from file tmpfile_stdout 08:42:50 INFO - Current package versions: 08:42:50 INFO - argparse == 1.2.1 08:42:50 INFO - blessings == 1.6 08:42:50 INFO - blobuploader == 1.2.4 08:42:50 INFO - docopt == 0.6.1 08:42:50 INFO - manifestparser == 1.1 08:42:50 INFO - mozInstall == 1.12 08:42:50 INFO - mozcrash == 0.17 08:42:50 INFO - mozdebug == 0.1 08:42:50 INFO - mozdevice == 0.48 08:42:50 INFO - mozfile == 1.2 08:42:50 INFO - mozhttpd == 0.7 08:42:50 INFO - mozinfo == 0.9 08:42:50 INFO - mozleak == 0.1 08:42:50 INFO - mozlog == 3.1 08:42:50 INFO - moznetwork == 0.27 08:42:50 INFO - mozprocess == 0.22 08:42:50 INFO - mozprofile == 0.28 08:42:50 INFO - mozrunner == 6.11 08:42:50 INFO - mozscreenshot == 0.1 08:42:50 INFO - mozsystemmonitor == 0.0 08:42:50 INFO - moztest == 0.7 08:42:50 INFO - mozversion == 1.4 08:42:50 INFO - psutil == 3.1.1 08:42:50 INFO - requests == 1.2.3 08:42:50 INFO - wsgiref == 0.1.2 08:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:50 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:42:50 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:42:50 INFO - Using env: {'DISPLAY': ':0', 08:42:50 INFO - 'HOME': '/home/cltbld', 08:42:50 INFO - 'LANG': 'en_US.UTF-8', 08:42:50 INFO - 'LANGUAGE': 'en_US:en', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MAIL': '/var/mail/cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SHLVL': '1', 08:42:50 INFO - 'TERM': 'linux', 08:42:50 INFO - 'TMOUT': '86400', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - '_': '/tools/buildbot/bin/python'} 08:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 INFO - Cleaning up... 08:42:51 INFO - Return code: 0 08:42:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:51 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:51 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:42:51 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:42:51 INFO - Using env: {'DISPLAY': ':0', 08:42:51 INFO - 'HOME': '/home/cltbld', 08:42:51 INFO - 'LANG': 'en_US.UTF-8', 08:42:51 INFO - 'LANGUAGE': 'en_US:en', 08:42:51 INFO - 'LOGNAME': 'cltbld', 08:42:51 INFO - 'MAIL': '/var/mail/cltbld', 08:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:51 INFO - 'MOZ_NO_REMOTE': '1', 08:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:51 INFO - 'NO_EM_RESTART': '1', 08:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:51 INFO - 'PWD': '/builds/slave/test', 08:42:51 INFO - 'SHELL': '/bin/bash', 08:42:51 INFO - 'SHLVL': '1', 08:42:51 INFO - 'TERM': 'linux', 08:42:51 INFO - 'TMOUT': '86400', 08:42:51 INFO - 'USER': 'cltbld', 08:42:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:51 INFO - '_': '/tools/buildbot/bin/python'} 08:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:51 INFO - Downloading/unpacking jsonschema 08:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:51 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:42:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:53 INFO - Downloading/unpacking functools32 (from jsonschema) 08:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:53 INFO - warning: no files found matching '*.txt' 08:42:53 INFO - no previously-included directories found matching 'build' 08:42:53 INFO - no previously-included directories found matching 'dist' 08:42:53 INFO - no previously-included directories found matching '.git*' 08:42:53 INFO - Installing collected packages: jsonschema, functools32 08:42:53 INFO - Running setup.py install for functools32 08:42:53 INFO - warning: no files found matching '*.txt' 08:42:53 INFO - no previously-included directories found matching 'build' 08:42:53 INFO - no previously-included directories found matching 'dist' 08:42:53 INFO - no previously-included directories found matching '.git*' 08:42:53 INFO - Successfully installed jsonschema functools32 08:42:53 INFO - Cleaning up... 08:42:53 INFO - Return code: 0 08:42:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:53 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 0x7f1b12099f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', '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:42:53 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:42:53 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:42:53 INFO - Using env: {'DISPLAY': ':0', 08:42:53 INFO - 'HOME': '/home/cltbld', 08:42:53 INFO - 'LANG': 'en_US.UTF-8', 08:42:53 INFO - 'LANGUAGE': 'en_US:en', 08:42:53 INFO - 'LOGNAME': 'cltbld', 08:42:53 INFO - 'MAIL': '/var/mail/cltbld', 08:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:53 INFO - 'MOZ_NO_REMOTE': '1', 08:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:53 INFO - 'NO_EM_RESTART': '1', 08:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:53 INFO - 'PWD': '/builds/slave/test', 08:42:53 INFO - 'SHELL': '/bin/bash', 08:42:53 INFO - 'SHLVL': '1', 08:42:53 INFO - 'TERM': 'linux', 08:42:53 INFO - 'TMOUT': '86400', 08:42:53 INFO - 'USER': 'cltbld', 08:42:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:53 INFO - '_': '/tools/buildbot/bin/python'} 08:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:53 INFO - Downloading/unpacking flake8 08:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:42:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:42: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:42: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:42: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:42: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:42: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:42: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:42:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:42:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:42: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:42: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:42: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:42: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:42: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:42: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:42:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:56 INFO - no previously-included directories found matching 'docs/_build' 08:42:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:42:56 INFO - Running setup.py install for pep8 08:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:56 INFO - no previously-included directories found matching 'docs/_build' 08:42:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:42:56 INFO - Cleaning up... 08:42:56 INFO - Return code: 0 08:42:56 INFO - Running post-action listener: _resource_record_post_action 08:42:56 INFO - Running post-action listener: _start_resource_monitoring 08:42:56 INFO - Starting resource monitoring. 08:42:56 INFO - ##### 08:42:56 INFO - ##### Running install step. 08:42:56 INFO - ##### 08:42:56 INFO - Running pre-action listener: _resource_record_pre_action 08:42:56 INFO - Running main action method: install 08:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:56 INFO - Reading from file tmpfile_stdout 08:42:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:57 INFO - Reading from file tmpfile_stdout 08:42:57 INFO - Output received: 08:42:57 INFO - Usage: mozinstall [options] installer 08:42:57 INFO - Options: 08:42:57 INFO - -h, --help show this help message and exit 08:42:57 INFO - -d DEST, --destination=DEST 08:42:57 INFO - Directory to install application into. [default: 08:42:57 INFO - "/builds/slave/test"] 08:42:57 INFO - --app=APP Application being installed. [default: firefox] 08:42:57 INFO - mkdir: /builds/slave/test/build/application 08:42:57 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:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:43:12 INFO - Reading from file tmpfile_stdout 08:43:12 INFO - Output received: 08:43:12 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:12 INFO - Running post-action listener: _resource_record_post_action 08:43:12 INFO - ##### 08:43:12 INFO - ##### Running run-tests step. 08:43:12 INFO - ##### 08:43:12 INFO - Running pre-action listener: _resource_record_pre_action 08:43:12 INFO - Running main action method: run_tests 08:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:12 INFO - Python 2.7.3 08:43:12 INFO - Return code: 0 08:43:12 INFO - grabbing minidump binary from tooltool 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - 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 0x220d410>, '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 0x220e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:43:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:43:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:12 INFO - Return code: 0 08:43:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:24 INFO - Return code: 0 08:43:26 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/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:43:26 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/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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:43:26 INFO - Using env: {'DISPLAY': ':0', 08:43:26 INFO - 'HOME': '/home/cltbld', 08:43:26 INFO - 'LANG': 'en_US.UTF-8', 08:43:26 INFO - 'LANGUAGE': 'en_US:en', 08:43:26 INFO - 'LOGNAME': 'cltbld', 08:43:26 INFO - 'MAIL': '/var/mail/cltbld', 08:43:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:26 INFO - 'MOZ_NO_REMOTE': '1', 08:43:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:26 INFO - 'NO_EM_RESTART': '1', 08:43:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:26 INFO - 'PWD': '/builds/slave/test', 08:43:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:26 INFO - 'SHELL': '/bin/bash', 08:43:26 INFO - 'SHLVL': '1', 08:43:26 INFO - 'TERM': 'linux', 08:43:26 INFO - 'TMOUT': '86400', 08:43:26 INFO - 'USER': 'cltbld', 08:43:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696', 08:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:26 INFO - '_': '/tools/buildbot/bin/python'} 08:43:26 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/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:43:26 INFO - mozversion application_buildid: 20160713055926 08:43:26 INFO - mozversion application_changeset: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb 08:43:26 INFO - mozversion application_display_name: Firefox 08:43:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:26 INFO - mozversion application_name: Firefox 08:43:26 INFO - mozversion application_remotingname: firefox 08:43:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:26 INFO - mozversion application_vendor: Mozilla 08:43:26 INFO - mozversion application_version: 48.0 08:43:26 INFO - mozversion platform_buildid: 20160713055926 08:43:26 INFO - mozversion platform_changeset: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb 08:43:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:26 INFO - mozversion platform_version: 48.0 08:43:26 INFO - using testdate: 1468424606 08:43:26 INFO - actual date: 1468424606 08:43:26 INFO - starting webserver on 'localhost:33103' 08:43:26 INFO - SUITE-START | Running 2 tests 08:43:26 INFO - TEST-START | dromaeo_css 08:43:26 INFO - operating with platform_type : linux_ 08:43:26 INFO - Initialising browser for dromaeo_css test... 08:43:26 INFO - TEST-INFO | started process 6763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmwj_X6/profile http://localhost:33103/getInfo.html) 08:43:33 INFO - PROCESS | 6763 | 08:43:33 INFO - PROCESS | 6763 | (process:6841): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:43:36 INFO - PROCESS | 6763 | __metrics Screen width/height:1600/1200 08:43:36 INFO - PROCESS | 6763 | colorDepth:24 08:43:36 INFO - PROCESS | 6763 | Browser inner width/height: 1024/697 08:43:36 INFO - PROCESS | 6763 | __metrics 08:43:38 ERROR - PROCESS | 6763 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:43:39 INFO - TEST-INFO | 6763: exit 0 08:43:39 INFO - Browser initialized. 08:43:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:39 INFO - TEST-INFO | started process 6893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmwj_X6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:48 INFO - PROCESS | 6893 | 08:43:48 INFO - PROCESS | 6893 | (process:6962): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:43:58 INFO - PROCESS | 6893 | RSS: Main: 148905984 08:43:58 INFO - PROCESS | 6893 | 08:44:42 INFO - PROCESS | 6893 | 1468424682339 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:46:54 INFO - PROCESS | 6893 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33103/tests/dromaeo/cssquery-ext.html) 08:46:55 INFO - PROCESS | 6893 | RSS: Main: 154566656 08:46:55 INFO - PROCESS | 6893 | 08:49:57 INFO - PROCESS | 6893 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-ext.html (next: http://localhost:33103/tests/dromaeo/cssquery-jquery.html) 08:49:58 INFO - PROCESS | 6893 | RSS: Main: 154853376 08:49:58 INFO - PROCESS | 6893 | 08:52:59 INFO - PROCESS | 6893 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33103/tests/dromaeo/cssquery-mootools.html) 08:53:00 INFO - PROCESS | 6893 | RSS: Main: 154497024 08:53:00 INFO - PROCESS | 6893 | 08:56:02 INFO - PROCESS | 6893 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33103/tests/dromaeo/cssquery-prototype.html) 08:56:02 INFO - PROCESS | 6893 | RSS: Main: 155893760 08:56:02 INFO - PROCESS | 6893 | 08:59:05 INFO - PROCESS | 6893 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33103/tests/dromaeo/cssquery-yui.html) 08:59:05 INFO - PROCESS | 6893 | RSS: Main: 154705920 08:59:05 INFO - PROCESS | 6893 | 09:02:07 INFO - PROCESS | 6893 | Cycle 1(1): loaded http://localhost:33103/tests/dromaeo/cssquery-yui.html (next: http://localhost:33103/tests/dromaeo/cssquery-dojo.html) 09:02:08 INFO - PROCESS | 6893 | RSS: Main: 157913088 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | __start_tp_report 09:02:08 INFO - PROCESS | 6893 | _x_x_mozilla_page_load 09:02:08 INFO - PROCESS | 6893 | _x_x_mozilla_page_load_details 09:02:08 INFO - PROCESS | 6893 | |i|pagename|runs| 09:02:08 INFO - PROCESS | 6893 | |0;dojo.html;3271.8364081795908;3373.460246360583;3373.966260337396;3386.712129468995;3415.5047518109873;5529.778808847646;5537.36320323163;5538.778448862051;5560.443955604437;5574.554035677146;5525.060739674255;5543.223948647193;5565.30433695788;5570.972145139269;5573.777048918038;5027.044861476317;5055.974720126413;5087.236914462842;5121.897562048757;5191.688498690071;4955.876103097416;5032.748362581875;5120.3855537335385;5207.713575753332;5230.7646155922885;5039.21892106724;5067.341245638062;5157.6131790115705;5162.303089082963;5203.037438073969;5075.593952483792;5076.492350764931;5087.872803179932;5090.134677104864;5118.027574760784;4927.063857866994;4942.110420124376;4988.351514303154;5031.22016087507;5063.493650634944;5392.299001129867;5394.298741163663;5398.595105367113;5417.26866872971;5425.457454254543;5875.236219291507;5889.4405031522365;5892.116182572606;5907.556933230025;5937.287525496925;5859.7656093756195;5952.166696662427;5992.8501787455225;6003.759849606011;6044.304904935944;5467.808626698046;5503.174523821419;5505.862353441156;5550.195221692832;5574.693391863487;6011.428914253139;6011.579189456696;6083.847903802441;6091.451769340692;6097.146399504073;5897.76408943646;5964.194833697482;5970;5973.910391344133;5975.372585878507;5951.285845698544;5955.7617695292565;5956.910646340309;5963.5527335450015;5969.671668058211;5700.230468886647;5842.1820945066875;5930;5936.1392598073035;5939.732712027969;6000.7899723510345;6029.065494848305;6031.8539477499135;6032.607880487754;6053.818385448443;4570.6800523963;4572.7713614319155;4573.199690054227;4576.130535198302;4607;3965.524137103566;3991.44119823225;4050.3721923101966;4080.714349995472;4133.524644665842;5589.55283577321;5615.2700148980375;5643.661380317194;5659.547236221092;5700.657960522382;6026.668533230627;6040.969795150996;6067.180930574405;6071.817845464643;6074.848128796727;5606.467385598362;5651.152327150878;5723.656580605177;5759.884802303931;5771.451712087345;5057.494250574913;5107.744612769421;5119.846404607868;5125.1287281162295;5134.666246693953;6111.54163437744;6149.262088549313;6152.661603611755;6160.691965401802;6169.56813023084;5808;6014.218151640259;6035.939640603713;6095.207623008981;6124.816255512342;6117.632942023492;6124.011734871534;6146.0473626587955;6159.81520554384;6163.044728067157;5876.1773351729935;5876.500497457593;5881.117832325185;5886.175935369138;5920.052791553331;5885.529157667291;5932.79235226765;5975.312839023568;6002.849928751816;6042.244719410074;5707.942920570741;5714.714264286852;5746.827595172152;5762.481376676119;5781.075027995501;5687.459691329317;5728.713564321851;5744.368119506935;5765.91351129725;5774.624649397776;5722.542196624343;5771.989901767258;5808.6224395414165;5814.04068328721;5827.504662103769;5884.32330282023;5895.322037965689;5897.292324921037;5897.587168898136;5900.468957793819;5625.578081643975;5646.9152962704775;5787.131930210502;5789.189513468202;5800.9419905800405 09:02:08 INFO - PROCESS | 6893 | |1;ext.html;665.1884700665187;668.9632070236138;672.6031641331615;686.505715884563;735.5770432001597;31999;32751.344973100524;40439.39340909885;41436.79281603595;41465.58534414655;42916;43622;43773.78113109438;43890.56109438905;43957.7802110989;8867.955660221689;8920.643174273022;8971.192592666659;8988.056254093324;9018.45889246644;8856.468611883307;9001.099890010979;9015.504147271897;9027.503487308195;9038.367314287969;8984.505852178128;9212.401193922373;9213.585388657526;9244.630214791401;9253.444793312423;9193.678221262257;9240.999999999967;9264.861027084598;9272.953635231814;9294.163525282689;9097.681581144629;9180.586873590704;9196.03441638625;9203.401778884418;9218.86171707425;43903.78048109771;44173;44283.77858110721;44375.778121109186;44388.77805610983;3733.309337772521;3906.140649057203;4009.4186342980397;4237.3685182689;4250.511191213019;33142.502862457084;33404.164895877555;33580.66419335824;33637.32725345504;33694;4505.549445055501;4547.090581883604;4593.655475839326;4635.559926318244;4721.480637129947;321999;322027;323821;327096.3645181783;327984;60698.39301607016;62647.373526265066;62664.37335626585;62844.68577657083;62856.37143628597;72409.6379518099;73173;73471.26528734752;73916.26083739093;73951.26048739551;19055.237790488503;19296.80703192978;19313;19412.708809367872;19413.126409311615;15468.5359439217;15488.690226195413;15633.218339083227;15670.451534196249;15697.764533532007;21062.157513699585;21273.149074036864;21437.46406339854;21441.356759297247;21676.891615541823;7933.642986065641;7976.960115199387;8016.7194148204535;8115.730780174339;8140.0638926523025;1074.790415868898;1119.4011204005817;1162.9533419921968;1226.3316492511603;1254.3414707278753;31863.459427088717;32142;32662.46290059851;32975.67024329726;33347.666523334454;1155.630198336541;1248.9437975291135;1264.4499642655474;1265.2914367953974;1299.7985312276612;17336.39322623702;17397.65204695899;17593.7360939586;17605.64788704219;17947.679679259378;499357;508076;557276;567393;585793;59686.403135968954;60639.39360606426;60772;60867;60888.39111608916;1566.4908904606048;1568.200217888885;1575.1809059289105;1575.346231313992;1650.1419261983942;30489.54265685972;30680.693193067782;31262.53106203363;31663;31862.203444914063;55183.72408137934;55949;56031.43968560425;56104;56393;455986;462397;462961;463486;464625;31317.217069573442;31645.683543164272;32204.67795322017;32283.677163229007;32303;52416.213756794445;52572.474275256754;52827.73586132045;53122;53645.195322070984;43376;43403.565964339956;43834.342484862114;44084.11831763283;44604.33093503665;42413.363799542414;42477.78761106174;42609.78695106505;43385.566144338154;44055;42612.360814587184;43174.352384713624;43844.34233486436;44366;44570.77714611406;35993.28013439769;36698.082547936516;37542;37992.430113547765;38062.80968595139;28583.285417863888;29703.40593188081;29736.25659358447;29835.254118647208;30035.69964300329 09:02:08 INFO - PROCESS | 6893 | |2;jquery.html;430.4576233945228;434.87542010653436;441.84535412605584;445.0986751827547;447.58374711518314;18610.90694546527;19019.334323298688;19542.70685939712;21274.14903403862;21279.680804787902;17706.291748330084;17786.555336116602;17924.82075179248;18116.4565063048;18142.274309027624;5855.268091488564;5886.88226235475;5978.22283103196;5994.700264986755;6059.66671833049;5945.31628862682;6006.489448396892;6012.128241404994;6027.0658048002415;6044.032954727245;5727.799527016535;5907.734151963151;5949.702514874239;6003.429674180968;6007.18902948103;5902.173695682608;5928.97035514824;5942.821715348503;5946.672932988684;5966.67183304918;5250.18622113573;5287.656302340336;5297.973510132425;5353.277307563468;5366.007288651612;23494.177703780457;23949.640755388682;24158.758412415827;24245.393865153514;24284.150054748;2389.1518510928545;2438.7317395086525;2442.401611605168;2458.557459657261;2529.4941011797714;13854.515091971833;13929.094608850392;14516.782248266285;14863.628409289746;14863.628409289746;1821.7631707878024;1842.3828017614114;1851.8333349998566;1880.3888736160802;1958.7747409048;80112.59943700302;81620.59189704132;83520.58239708823;83563;83672.74490882641;10769.130823701102;11148.045767871521;11236.94381528087;11275.323480591027;11310.886891131147;16048.518544443685;16136.031838089752;16189.838101619069;16197.109158996132;16202;8956.238719708897;9002.369834111549;9064.818703626022;9231.07689231085;9427.952860235655;9517.952410238044;9544.475053871965;9581.329306948446;9611;9621.18219951298;6878.69045892936;6987.680851595554;7012.123484564429;7017.61403122823;7055.400290975324;2050.5283784729595;2051.938441846747;2094.832413406924;2112.3979665795173;2124.2034237161065;1086.9782604347868;1109.1348747976592;1109.6171820721838;1146;1169.0472265103913;19550.608987820164;20151.294704685264;20154.899225503777;20337;20504.69242961357;1120.355795417638;1145.495981768036;1168.976620467586;1198.6823491774687;1262.9099384875697;11398.601048963246;11601.07191424684;11621.941890290494;11641.941790290994;11680.70798230051;527283;532092;539797;543658;544715;52227;83722.58138709389;90451;99258;101356;1159.976800464003;1172.8533933258343;1200.6938230751102;1237.696764292754;1268.245393990574;17281.989017632626;17358.132093395532;17814.91092544529;17918.91040544789;17960.910195448938;40825.591744083365;41394.172116558104;41402.792986034874;41406.585934140276;41895.7905210472;58811.70594147002;61254.69372653287;61455.385446146756;61651.691741541006;61741.38258617356;8212.384071194565;8448.83102337962;8516.148385161434;8674.609642565974;8727.781805454915;9638.566264517973;12106.273623582612;12881.613551593467;13043.869561304266;13398.933005334911;11764.764704705687;11792.882071179178;11826.290422574673;11921.880781192078;12012.699682508008;12004.159708820647;12048.819267710816;12130.818037729265;12132.696682583006;12634.557790477289;11545.769084618429;11708.765824683629;12005.75988480243;12116.091293152873;12194.939025304817;8617.396782225183;8650.567471626267;8766.91233087661;8804.075572065098;8907.866382004404;10927.747070089697;11360.318380897173;11540.653780386601;11867.821982670093;12413.193142446073 09:02:08 INFO - PROCESS | 6893 | |3;mootools.html;1528.778327142564;1593.2511719491843;1799.7840259168893;1914.1195050276872;1927.6433859735941;8371.079181290053;8431.747047588575;8508.936382952132;8675.349348798842;8697.913020869797;8567.957160214206;8634.74095777126;8658.740237792861;8675.219230269275;8696.39125261232;2320.791128798412;2346.3430239532872;2349.929502114939;2351.835371523994;2359.846609970355;2354.8469349492316;2371.122684606698;2379.690640216778;2381.7499162587937;2393.940151496209;2276.2602154299834;2279.3048120323297;2305.8155347572238;2321.94195145121;2328.976710232893;2281.418238349227;2337.2170322941834;2377.940551486209;2382.404398900275;2399.664047033417;2396.3769419950763;2405.0740464920955;2422.818288628342;2424.333308340203;2424.5756992526235;8646;8741.694040708608;8753;8753.649854005833;8790.120987901222;5333.146696528575;5420.186971954199;5421.539169170625;5425.294711687495;5431.049566325877;3429.605595356541;3463.4631632097066;3485.076454739496;3498.0380395391217;3531.311394278117;1119.798436281469;1136.9658910232706;1148.1422420666554;1179.7522520270754;1186.9703257418548;12097.274163550128;12169.817452738216;12175.512979480898;12223.93888030563;12248.387580621022;4512.593866552026;4524.298733696282;4624.491305956342;4626.375439315717;4718.4809670936165;9858.309918305793;9895.752606184758;9897.851532227023;9898.505074746377;9932.851007234898;5336.039512887717;5358;5366.946330536723;5398.271233383522;5400.243965844785;4185.288500954845;4807.927881081787;4851.75741212945;4909.140900342426;4990.451050384455;4011.4584531088512;4033.657139143147;4082.6529744971417;4120.608542188487;4177.749335039907;1201.5734414282979;1214.2350319298785;1217.9391030448442;1240.2806372304042;1254.5358217459598;888.2849306308354;923.6905636611676;971.9405847626122;986.4032260482305;999.8300288950751;5498.890022199534;5591.9720401397735;5756.94243057564;5848.9707551462825;6015.368386319461;461.55690537084104;462.9467611224752;463.77275135183515;470.30395015377434;474.28146358267253;3887.5918028607157;4018.1561872006623;4039.4950631171105;4040.2121586290978;4111.09555897702;10511.421871796972;10947.945260273647;10959.287646302964;10980.286281391844;10992.945035274772;10740.248182627298;10761.78476430467;10776.245662803685;10796.838047429295;10804.567817287378;8184.54984975832;8349.165083491602;8377.078521362646;8405.243528082501;8458.87311690325;5611.859703507445;5741.856453588526;5745.339285981999;5809;5846.6784326862435;8953.641854325753;9043.502607356659;9223.031581684096;9266.351355405057;9595.040495950348;9217.953910230406;9312.767180820534;9386.202172815387;9395.389299695498;9398.765030874283;6883.27725588826;7274.16347120088;7321.707131714672;7508.361789247975;7816.7264145754625;8288.50268983863;8317.875231871405;8331.000279966443;8338.708145214889;8374.832503349777;7263.891041634485;7340.522866013692;7460.925390746023;7553.886691699519;7576.886346704694;7282.817929551804;7346.5592064476305;7389.630518473948;7402.33378995893;7430.92569074324;6903.654817259016;6919.446444284546;6970.0241966125795;6976.267491913276;6977.825554361181;5028.195488721787;5120.923186152137;5140.768665409991;5233.895322093461;5357.979173932446;4844.588210002048;5078.111330517071;5092.261622064854;5171.81898633546;5247.658902171346 09:02:08 INFO - PROCESS | 6893 | |4;prototype.html;341.8974307707687;342.2948725625212;343.3699162037661;344.2907610322734;344.95822615700575;6378.649174295412;6501.739930402779;6510.121133646956;6558.049082882979;6571.967140164298;6421.614703117804;6421.64680942548;6422.389872962073;6425.164728585289;6472.417482426581;4691.507391723862;4774.618030557547;4795.352627395292;4803.063402636487;4805.327254184417;4764.094821983812;4777.546133117348;4805.303231031498;4816.927746083811;4861.368022157115;4805.303231031516;4808.326834243208;4810.567048965592;4811.4226292844905;4813.8074477021055;4762.3332733417;4793.856184314476;4808.182608956486;4808.975955120237;4810.302506136608;4178.770167640779;4179.310413781753;4179.686523510719;4182.372644103379;4182.996080940583;6029.517638588946;6220.253569571681;6222.066689996492;6243.87512249757;6286.025666021774;5529.889402211933;5531.3362396512675;5533.6403133796575;5538.529225015878;5571.052921003439;6833.487488438337;6841;6859;6871.553349032297;6878.071460352839;4610.193216187187;4614.700044497097;4614.76926153691;4619.86140415788;4645.976770116162;7086.185088714812;7121.8219544511285;7145.499815012951;7158.355747982707;7168.964155179191;4661.370714953506;4661.580457758818;4668.299755036772;4729.787159577827;4820.68665536739;4810.7113573185725;4835.202191638411;4841.515848415201;4862.197737373293;4880.951190488121;5687.175359572839;5702.914456283159;5719.342275638355;5725.1698503716725;5740.368559458456;6915.4121899638085;6920.792376228721;6925.896111558331;6930.688119034656;6946.6179360135675;1713.5459103337625;1735.9324015730235;1737.252981218063;1737.5308666660185;1737.539552018716;1099.290957332516;1127.22784892349;1129.8079326514512;1136.9204155709022;1142.5087212498538;6629.839778038824;6633.535652504278;6645.60126392418;6649.800505984828;6660.23407308156;7068.469864760164;7079.362857342864;7091.539049961736;7094.574325540484;7095;6519.837004074841;6604.306547812506;6753.49348798842;6758.290379510081;6772.932270677329;3840.0591854995146;3862.6909847212155;3872.206197729459;3878.3988481784804;3878.9030274242805;7379.852402951911;7381.704731810775;7395.519291246052;7399.963000184965;7408.444366672521;7281.4538909582;7299.525530840585;7301.123865136217;7302.160251571031;7318.194998550155;7103.857922841617;7359.889601655872;7383.2985866342615;7397.334239918433;7407.777766667009;7051.858962820817;7124.251953544803;7163.534370265916;7166.960790685425;7178.174509931425;7030.261822508767;7058.047163632844;7062.223155452793;7066.364027237573;7074.080369551925;7219.566825990458;7341.70633174667;7368.852622947618;7377.963110184414;7380.557166570023;4680.46174689915;4714.269288260325;4728.62171026324;4736.85789426304;4743.691660042086;7089;7104.644767761488;7113.430925526049;7120.323569260912;7127.607981561064;6879.58722476653;6897.034415181979;6902.482313826383;6903.206131294965;6916.100906882073;6759.324067593201;6848.383645471931;6910.205326387329;6910.965445172742;6918.688659010256;6754.2570317266045;6772.153480814898;6787.389134977876;6792.966035169792;6795.218549866631;6888.793336199922;6922.7923162305215;6925.3074692530345;6954.235034146341;6968.547044442095;6721.865562688817;6758.3917447428;6759.763408280686;6772.492063095386;6773.424258938046 09:02:08 INFO - PROCESS | 6893 | |5;yui.html;863.145485968891;864.3906046237403;906.5603182456507;913.7898283394817;926.3932124458479;13674.042817002814;13905.93047034766;13950.441982320708;15074.773878391805;15438.69122617547;14719.852801472009;14819.77770333446;14828.332725027372;14838.183899885502;14841.777373339408;905.7554460295717;907.1563445995238;909.963601455941;916.2807196350866;917.0600134861787;897.1521911793358;915.5376534849892;921.806420651664;924.8057907839362;925.5326060339519;974.2352253481018;977.2865807960158;978;978.9412635241908;983.7147227304073;967.4340510801189;968.2544440780559;968.4479846487505;969.2633598465146;972.4311277902435;718.1059580821858;718.7843646905959;720.2329519062182;720.6576875983918;723.9239879812596;14069.507567235098;14106.294685265799;14108.012439129265;14135.081219720789;14158.292085395791;14564.781528277084;14636.04865683727;14925.328360223815;14959;15060.924695376452;11612.129090318176;11764.58823941158;11767.293962362286;11935.343556104412;11992.86067823564;3664.798436086014;3704.981475092607;3761.492198553188;3799.3731034379293;3820.465134881119;57029.42970570282;57323.71338143324;58364;58768;58893;11572.305661660328;11713.121515886343;11766.88233117675;11767.293962362286;11820.822687659693;20690.275840345515;21015.159393624388;21018.684719729215;21081.578368432547;21091.894540527504;7651.426143039294;7693.653785579662;7895.052593688794;8035;8139.348852091937;4701.435827700698;4852.611791056707;4960.627952903546;4966.304717339575;5061.038402703474;3681.079730067483;3748.700103991674;3753.5120434343908;3755.211405604799;3761.2853557824474;682.2393031769541;706.8586282743472;720.4992530191466;723.4321057969574;729.7336472187613;678.5996262205323;713.8144082538578;758.6510205305511;776.9456138070394;781.2382926646587;9437.386569872937;9655.131038206455;9711.486227192663;9749.122578967927;9968.152707019839;620.460199626328;695.0581961442173;710.087537514302;718.3857801579678;726.9600171990486;4534.659900507475;4582.9541704582525;4637.559431853969;4716.575508204278;4722.740249286254;63082;63997;64178;64254.0361894572;64377;55727;56230.43769562252;56733.14900276499;56900;56955;50242;50318.74840625847;50843.237351439755;51822.48177518177;53011.73494132505;8978.955105224431;9013;9096.408733432305;9156.221721153777;9202.631894724404;38681.2263754729;39067;39739.80130099331;40410.19179616332;40599.1880162401;45880.541194587626;47931;49868;50034.49965500444;51215.23177152271;10947.34315941046;11052.834207486734;11311.547538098384;11397.145214108808;11665.88334116648;12661.87338126607;12798.680032998876;12838.229706217657;13090.491180732219;13143.671408214872;11469.713257168638;11700.824487632523;11813.704657383634;12213.75572488563;12401.379931003234;13376.130551514121;13981.650458738206;13988.720225595634;14165.362558684677;14240.928795355956;12633.81049284243;12661.113722039368;12708.555200567936;13112.344382781013;13316.201027938354;11456.82814757796;11523.213197918905;11587.130965177477;11843;11867.406629668654;10330.483475826028;10398.220133489867;10626.36241825493;10637.734056648645;10663.360198388122 09:02:08 INFO - PROCESS | 6893 | __end_tp_report 09:02:08 INFO - PROCESS | 6893 | __start_cc_report 09:02:08 INFO - PROCESS | 6893 | _x_x_mozilla_cycle_collect,338 09:02:08 INFO - PROCESS | 6893 | __end_cc_report 09:02:08 INFO - PROCESS | 6893 | __startTimestamp1468425728167__endTimestamp 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | ------- Summary: start ------- 09:02:08 INFO - PROCESS | 6893 | Number of tests: 6 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | [#0] dojo.html Cycles:165 Average:5537.70 Median:5746.83 stddev:614.51 (10.7%) stddev-sans-first:590.13 09:02:08 INFO - PROCESS | 6893 | Values: 3271.8 3373.5 3374.0 3386.7 3415.5 5529.8 5537.4 5538.8 5560.4 5574.6 5525.1 5543.2 5565.3 5571.0 5573.8 5027.0 5056.0 5087.2 5121.9 5191.7 4955.9 5032.7 5120.4 5207.7 5230.8 5039.2 5067.3 5157.6 5162.3 5203.0 5075.6 5076.5 5087.9 5090.1 5118.0 4927.1 4942.1 4988.4 5031.2 5063.5 5392.3 5394.3 5398.6 5417.3 5425.5 5875.2 5889.4 5892.1 5907.6 5937.3 5859.8 5952.2 5992.9 6003.8 6044.3 5467.8 5503.2 5505.9 5550.2 5574.7 6011.4 6011.6 6083.8 6091.5 6097.1 5897.8 5964.2 5970.0 5973.9 5975.4 5951.3 5955.8 5956.9 5963.6 5969.7 5700.2 5842.2 5930.0 5936.1 5939.7 6000.8 6029.1 6031.9 6032.6 6053.8 4570.7 4572.8 4573.2 4576.1 4607.0 3965.5 3991.4 4050.4 4080.7 4133.5 5589.6 5615.3 5643.7 5659.5 5700.7 6026.7 6041.0 6067.2 6071.8 6074.8 5606.5 5651.2 5723.7 5759.9 5771.5 5057.5 5107.7 5119.8 5125.1 5134.7 6111.5 6149.3 6152.7 6160.7 6169.6 5808.0 6014.2 6035.9 6095.2 6124.8 6117.6 6124.0 6146.0 6159.8 6163.0 5876.2 5876.5 5881.1 5886.2 5920.1 5885.5 5932.8 5975.3 6002.8 6042.2 5707.9 5714.7 5746.8 5762.5 5781.1 5687.5 5728.7 5744.4 5765.9 5774.6 5722.5 5772.0 5808.6 5814.0 5827.5 5884.3 5895.3 5897.3 5897.6 5900.5 5625.6 5646.9 5787.1 5789.2 5800.9 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | [#1] ext.html Cycles:180 Average:61890.55 Median:43804.06 stddev:120014.31 (274.0%) stddev-sans-first:120262.94 09:02:08 INFO - PROCESS | 6893 | Values: 665.2 669.0 672.6 686.5 735.6 31999.0 32751.3 40439.4 41436.8 41465.6 42916.0 43622.0 43773.8 43890.6 43957.8 8868.0 8920.6 8971.2 8988.1 9018.5 8856.5 9001.1 9015.5 9027.5 9038.4 8984.5 9212.4 9213.6 9244.6 9253.4 9193.7 9241.0 9264.9 9273.0 9294.2 9097.7 9180.6 9196.0 9203.4 9218.9 43903.8 44173.0 44283.8 44375.8 44388.8 3733.3 3906.1 4009.4 4237.4 4250.5 33142.5 33404.2 33580.7 33637.3 33694.0 4505.5 4547.1 4593.7 4635.6 4721.5 321999.0 322027.0 323821.0 327096.4 327984.0 60698.4 62647.4 62664.4 62844.7 62856.4 72409.6 73173.0 73471.3 73916.3 73951.3 19055.2 19296.8 19313.0 19412.7 19413.1 15468.5 15488.7 15633.2 15670.5 15697.8 21062.2 21273.1 21437.5 21441.4 21676.9 7933.6 7977.0 8016.7 8115.7 8140.1 1074.8 1119.4 1163.0 1226.3 1254.3 31863.5 32142.0 32662.5 32975.7 33347.7 1155.6 1248.9 1264.4 1265.3 1299.8 17336.4 17397.7 17593.7 17605.6 17947.7 499357.0 508076.0 557276.0 567393.0 585793.0 59686.4 60639.4 60772.0 60867.0 60888.4 1566.5 1568.2 1575.2 1575.3 1650.1 30489.5 30680.7 31262.5 31663.0 31862.2 55183.7 55949.0 56031.4 56104.0 56393.0 455986.0 462397.0 462961.0 463486.0 464625.0 31317.2 31645.7 32204.7 32283.7 32303.0 52416.2 52572.5 52827.7 53122.0 53645.2 43376.0 43403.6 43834.3 44084.1 44604.3 42413.4 42477.8 42609.8 43385.6 44055.0 42612.4 43174.4 43844.3 44366.0 44570.8 35993.3 36698.1 37542.0 37992.4 38062.8 28583.3 29703.4 29736.3 29835.3 30035.7 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | [#2] jquery.html Cycles:180 Average:30640.29 Median:12941.66 stddev:88285.36 (682.2%) stddev-sans-first:88503.88 09:02:08 INFO - PROCESS | 6893 | Values: 430.5 434.9 441.8 445.1 447.6 18610.9 19019.3 19542.7 21274.1 21279.7 17706.3 17786.6 17924.8 18116.5 18142.3 5855.3 5886.9 5978.2 5994.7 6059.7 5945.3 6006.5 6012.1 6027.1 6044.0 5727.8 5907.7 5949.7 6003.4 6007.2 5902.2 5929.0 5942.8 5946.7 5966.7 5250.2 5287.7 5298.0 5353.3 5366.0 23494.2 23949.6 24158.8 24245.4 24284.2 2389.2 2438.7 2442.4 2458.6 2529.5 13854.5 13929.1 14516.8 14863.6 14863.6 1821.8 1842.4 1851.8 1880.4 1958.8 80112.6 81620.6 83520.6 83563.0 83672.7 10769.1 11148.0 11236.9 11275.3 11310.9 16048.5 16136.0 16189.8 16197.1 16202.0 8956.2 9002.4 9064.8 9231.1 9428.0 9518.0 9544.5 9581.3 9611.0 9621.2 6878.7 6987.7 7012.1 7017.6 7055.4 2050.5 2051.9 2094.8 2112.4 2124.2 1087.0 1109.1 1109.6 1146.0 1169.0 19550.6 20151.3 20154.9 20337.0 20504.7 1120.4 1145.5 1169.0 1198.7 1262.9 11398.6 11601.1 11621.9 11641.9 11680.7 527283.0 532092.0 539797.0 543658.0 544715.0 52227.0 83722.6 90451.0 99258.0 101356.0 1160.0 1172.9 1200.7 1237.7 1268.2 17282.0 17358.1 17814.9 17918.9 17960.9 40825.6 41394.2 41402.8 41406.6 41895.8 58811.7 61254.7 61455.4 61651.7 61741.4 8212.4 8448.8 8516.1 8674.6 8727.8 9638.6 12106.3 12881.6 13043.9 13398.9 11764.8 11792.9 11826.3 11921.9 12012.7 12004.2 12048.8 12130.8 12132.7 12634.6 11545.8 11708.8 12005.8 12116.1 12194.9 8617.4 8650.6 8766.9 8804.1 8907.9 10927.7 11360.3 11540.7 11867.8 12413.2 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | [#3] mootools.html Cycles:180 Average:5689.92 Median:5156.29 stddev:3187.14 (61.8%) stddev-sans-first:3180.74 09:02:08 INFO - PROCESS | 6893 | Values: 1528.8 1593.3 1799.8 1914.1 1927.6 8371.1 8431.7 8508.9 8675.3 8697.9 8568.0 8634.7 8658.7 8675.2 8696.4 2320.8 2346.3 2349.9 2351.8 2359.8 2354.8 2371.1 2379.7 2381.7 2393.9 2276.3 2279.3 2305.8 2321.9 2329.0 2281.4 2337.2 2377.9 2382.4 2399.7 2396.4 2405.1 2422.8 2424.3 2424.6 8646.0 8741.7 8753.0 8753.6 8790.1 5333.1 5420.2 5421.5 5425.3 5431.0 3429.6 3463.5 3485.1 3498.0 3531.3 1119.8 1137.0 1148.1 1179.8 1187.0 12097.3 12169.8 12175.5 12223.9 12248.4 4512.6 4524.3 4624.5 4626.4 4718.5 9858.3 9895.8 9897.9 9898.5 9932.9 5336.0 5358.0 5366.9 5398.3 5400.2 4185.3 4807.9 4851.8 4909.1 4990.5 4011.5 4033.7 4082.7 4120.6 4177.7 1201.6 1214.2 1217.9 1240.3 1254.5 888.3 923.7 971.9 986.4 999.8 5498.9 5592.0 5756.9 5849.0 6015.4 461.6 462.9 463.8 470.3 474.3 3887.6 4018.2 4039.5 4040.2 4111.1 10511.4 10947.9 10959.3 10980.3 10992.9 10740.2 10761.8 10776.2 10796.8 10804.6 8184.5 8349.2 8377.1 8405.2 8458.9 5611.9 5741.9 5745.3 5809.0 5846.7 8953.6 9043.5 9223.0 9266.4 9595.0 9218.0 9312.8 9386.2 9395.4 9398.8 6883.3 7274.2 7321.7 7508.4 7816.7 8288.5 8317.9 8331.0 8338.7 8374.8 7263.9 7340.5 7460.9 7553.9 7576.9 7282.8 7346.6 7389.6 7402.3 7430.9 6903.7 6919.4 6970.0 6976.3 6977.8 5028.2 5120.9 5140.8 5233.9 5358.0 4844.6 5078.1 5092.3 5171.8 5247.7 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | [#4] prototype.html Cycles:180 Average:5721.21 Median:6588.14 stddev:1765.46 (26.8%) stddev-sans-first:1723.62 09:02:08 INFO - PROCESS | 6893 | Values: 341.9 342.3 343.4 344.3 345.0 6378.6 6501.7 6510.1 6558.0 6572.0 6421.6 6421.6 6422.4 6425.2 6472.4 4691.5 4774.6 4795.4 4803.1 4805.3 4764.1 4777.5 4805.3 4816.9 4861.4 4805.3 4808.3 4810.6 4811.4 4813.8 4762.3 4793.9 4808.2 4809.0 4810.3 4178.8 4179.3 4179.7 4182.4 4183.0 6029.5 6220.3 6222.1 6243.9 6286.0 5529.9 5531.3 5533.6 5538.5 5571.1 6833.5 6841.0 6859.0 6871.6 6878.1 4610.2 4614.7 4614.8 4619.9 4646.0 7086.2 7121.8 7145.5 7158.4 7169.0 4661.4 4661.6 4668.3 4729.8 4820.7 4810.7 4835.2 4841.5 4862.2 4881.0 5687.2 5702.9 5719.3 5725.2 5740.4 6915.4 6920.8 6925.9 6930.7 6946.6 1713.5 1735.9 1737.3 1737.5 1737.5 1099.3 1127.2 1129.8 1136.9 1142.5 6629.8 6633.5 6645.6 6649.8 6660.2 7068.5 7079.4 7091.5 7094.6 7095.0 6519.8 6604.3 6753.5 6758.3 6772.9 3840.1 3862.7 3872.2 3878.4 3878.9 7379.9 7381.7 7395.5 7400.0 7408.4 7281.5 7299.5 7301.1 7302.2 7318.2 7103.9 7359.9 7383.3 7397.3 7407.8 7051.9 7124.3 7163.5 7167.0 7178.2 7030.3 7058.0 7062.2 7066.4 7074.1 7219.6 7341.7 7368.9 7378.0 7380.6 4680.5 4714.3 4728.6 4736.9 4743.7 7089.0 7104.6 7113.4 7120.3 7127.6 6879.6 6897.0 6902.5 6903.2 6916.1 6759.3 6848.4 6910.2 6911.0 6918.7 6754.3 6772.2 6787.4 6793.0 6795.2 6888.8 6922.8 6925.3 6954.2 6968.5 6721.9 6758.4 6759.8 6772.5 6773.4 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - PROCESS | 6893 | [#5] yui.html Cycles:180 Average:15487.76 Median:4719.66 stddev:17968.58 (380.7%) stddev-sans-first:17985.42 09:02:08 INFO - PROCESS | 6893 | Values: 863.1 864.4 906.6 913.8 926.4 13674.0 13905.9 13950.4 15074.8 15438.7 14719.9 14819.8 14828.3 14838.2 14841.8 905.8 907.2 910.0 916.3 917.1 897.2 915.5 921.8 924.8 925.5 974.2 977.3 978.0 978.9 983.7 967.4 968.3 968.4 969.3 972.4 718.1 718.8 720.2 720.7 723.9 14069.5 14106.3 14108.0 14135.1 14158.3 14564.8 14636.0 14925.3 14959.0 15060.9 11612.1 11764.6 11767.3 11935.3 11992.9 3664.8 3705.0 3761.5 3799.4 3820.5 57029.4 57323.7 58364.0 58768.0 58893.0 11572.3 11713.1 11766.9 11767.3 11820.8 20690.3 21015.2 21018.7 21081.6 21091.9 7651.4 7693.7 7895.1 8035.0 8139.3 4701.4 4852.6 4960.6 4966.3 5061.0 3681.1 3748.7 3753.5 3755.2 3761.3 682.2 706.9 720.5 723.4 729.7 678.6 713.8 758.7 776.9 781.2 9437.4 9655.1 9711.5 9749.1 9968.2 620.5 695.1 710.1 718.4 727.0 4534.7 4583.0 4637.6 4716.6 4722.7 63082.0 63997.0 64178.0 64254.0 64377.0 55727.0 56230.4 56733.1 56900.0 56955.0 50242.0 50318.7 50843.2 51822.5 53011.7 8979.0 9013.0 9096.4 9156.2 9202.6 38681.2 39067.0 39739.8 40410.2 40599.2 45880.5 47931.0 49868.0 50034.5 51215.2 10947.3 11052.8 11311.5 11397.1 11665.9 12661.9 12798.7 12838.2 13090.5 13143.7 11469.7 11700.8 11813.7 12213.8 12401.4 13376.1 13981.7 13988.7 14165.4 14240.9 12633.8 12661.1 12708.6 13112.3 13316.2 11456.8 11523.2 11587.1 11843.0 11867.4 10330.5 10398.2 10626.4 10637.7 10663.4 09:02:08 INFO - PROCESS | 6893 | -------- Summary: end -------- 09:02:08 INFO - PROCESS | 6893 | 09:02:08 INFO - TEST-INFO | 6893: exit 0 09:02:09 INFO - TEST-OK | dromaeo_css | took 1122485ms 09:02:09 INFO - TEST-START | kraken 09:02:09 INFO - operating with platform_type : linux_ 09:02:09 INFO - Initialising browser for kraken test... 09:02:09 INFO - TEST-INFO | started process 7134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvqvnwO/profile http://localhost:33103/getInfo.html) 09:02:14 INFO - PROCESS | 7134 | 09:02:14 INFO - PROCESS | 7134 | (process:7212): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:15 INFO - PROCESS | 7134 | __metrics Screen width/height:1600/1200 09:02:15 INFO - PROCESS | 7134 | colorDepth:24 09:02:15 INFO - PROCESS | 7134 | Browser inner width/height: 1024/697 09:02:15 INFO - PROCESS | 7134 | __metrics 09:02:17 ERROR - PROCESS | 7134 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:02:18 INFO - TEST-INFO | 7134: exit 0 09:02:18 INFO - Browser initialized. 09:02:18 INFO - Running cycle 1/1 for kraken test... 09:02:18 INFO - TEST-INFO | started process 7265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvqvnwO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:19 INFO - PROCESS | 7265 | 09:02:19 INFO - PROCESS | 7265 | (process:7332): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:29 INFO - PROCESS | 7265 | RSS: Main: 150781952 09:02:29 INFO - PROCESS | 7265 | 09:02:32 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:33 INFO - PROCESS | 7265 | RSS: Main: 155848704 09:02:33 INFO - PROCESS | 7265 | 09:02:35 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-dft) 09:02:36 INFO - PROCESS | 7265 | RSS: Main: 155791360 09:02:36 INFO - PROCESS | 7265 | 09:02:39 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-fft) 09:02:39 INFO - PROCESS | 7265 | RSS: Main: 156250112 09:02:39 INFO - PROCESS | 7265 | 09:02:42 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33103/tests/kraken/driver.html?testName=audio-oscillator) 09:02:42 INFO - PROCESS | 7265 | RSS: Main: 155951104 09:02:42 INFO - PROCESS | 7265 | 09:02:44 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33103/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:45 INFO - PROCESS | 7265 | RSS: Main: 156123136 09:02:45 INFO - PROCESS | 7265 | 09:02:48 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33103/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:49 INFO - PROCESS | 7265 | RSS: Main: 156590080 09:02:49 INFO - PROCESS | 7265 | 09:02:52 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33103/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:53 INFO - PROCESS | 7265 | RSS: Main: 156721152 09:02:53 INFO - PROCESS | 7265 | 09:02:55 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33103/tests/kraken/driver.html?testName=json-parse-financial) 09:02:56 INFO - PROCESS | 7265 | RSS: Main: 156725248 09:02:56 INFO - PROCESS | 7265 | 09:02:58 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33103/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:58 INFO - PROCESS | 7265 | RSS: Main: 156090368 09:02:58 INFO - PROCESS | 7265 | 09:03:00 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:01 INFO - PROCESS | 7265 | RSS: Main: 156839936 09:03:01 INFO - PROCESS | 7265 | 09:03:02 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:03 INFO - PROCESS | 7265 | RSS: Main: 156868608 09:03:03 INFO - PROCESS | 7265 | 09:03:06 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:06 INFO - PROCESS | 7265 | RSS: Main: 157323264 09:03:06 INFO - PROCESS | 7265 | 09:03:09 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:10 INFO - PROCESS | 7265 | RSS: Main: 157454336 09:03:10 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | Cycle 1(1): loaded http://localhost:33103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33103/tests/kraken/driver.html?testName=ai-astar) 09:03:11 INFO - PROCESS | 7265 | RSS: Main: 158908416 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | __start_tp_report 09:03:11 INFO - PROCESS | 7265 | _x_x_mozilla_page_load 09:03:11 INFO - PROCESS | 7265 | _x_x_mozilla_page_load_details 09:03:11 INFO - PROCESS | 7265 | |i|pagename|runs| 09:03:11 INFO - PROCESS | 7265 | |0;ai-astar;107;111;102;109;112;113;101;110;113;116 09:03:11 INFO - PROCESS | 7265 | |1;audio-beat-detection;172;128;163;180;129;166;158;128;173;132 09:03:11 INFO - PROCESS | 7265 | |2;audio-dft;163;161;169;162;161;162;162;162;162;163 09:03:11 INFO - PROCESS | 7265 | |3;audio-fft;76;77;76;202;73;76;76;78;169;76 09:03:11 INFO - PROCESS | 7265 | |4;audio-oscillator;92;92;157;92;92;93;149;93;91;163 09:03:11 INFO - PROCESS | 7265 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;119;118;119 09:03:11 INFO - PROCESS | 7265 | |6;imaging-darkroom;147;147;149;147;147;147;146;147;147;147 09:03:11 INFO - PROCESS | 7265 | |7;imaging-desaturate;95;96;95;96;94;95;95;96;95;96 09:03:11 INFO - PROCESS | 7265 | |8;json-parse-financial;53;55;55;54;53;55;55;87;53;54 09:03:11 INFO - PROCESS | 7265 | |9;json-stringify-tinderbox;60;61;59;60;60;60;59;59;61;61 09:03:11 INFO - PROCESS | 7265 | |10;stanford-crypto-aes;72;73;73;75;74;78;74;81;75;73 09:03:11 INFO - PROCESS | 7265 | |11;stanford-crypto-ccm;124;113;116;121;114;113;114;119;136;132 09:03:11 INFO - PROCESS | 7265 | |12;stanford-crypto-pbkdf2;162;166;157;162;161;161;163;160;160;160 09:03:11 INFO - PROCESS | 7265 | |13;stanford-crypto-sha256-iterative;67;66;67;66;68;69;66;68;66;65 09:03:11 INFO - PROCESS | 7265 | __end_tp_report 09:03:11 INFO - PROCESS | 7265 | __start_cc_report 09:03:11 INFO - PROCESS | 7265 | _x_x_mozilla_cycle_collect,827 09:03:11 INFO - PROCESS | 7265 | __end_cc_report 09:03:11 INFO - PROCESS | 7265 | __startTimestamp1468425791983__endTimestamp 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | ------- Summary: start ------- 09:03:11 INFO - PROCESS | 7265 | Number of tests: 14 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.50 stddev:4.84 (4.3%) stddev-sans-first:5.05 09:03:11 INFO - PROCESS | 7265 | Values: 107.0 111.0 102.0 109.0 112.0 113.0 101.0 110.0 113.0 116.0 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:164.50 stddev:21.22 (12.9%) stddev-sans-first:21.35 09:03:11 INFO - PROCESS | 7265 | Values: 172.0 128.0 163.0 180.0 129.0 166.0 158.0 128.0 173.0 132.0 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 09:03:11 INFO - PROCESS | 7265 | Values: 163.0 161.0 169.0 162.0 161.0 162.0 162.0 162.0 162.0 163.0 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | [#3] audio-fft Cycles:10 Average:97.90 Median:76.00 stddev:46.84 (61.6%) stddev-sans-first:49.00 09:03:11 INFO - PROCESS | 7265 | Values: 76.0 77.0 76.0 202.0 73.0 76.0 76.0 78.0 169.0 76.0 09:03:11 INFO - PROCESS | 7265 | 09:03:11 INFO - PROCESS | 7265 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:92.00 stddev:31.19 (33.9%) stddev-sans-first:32.28 09:03:11 INFO - PROCESS | 7265 | Values: 92.0 92.0 157.0 92.0 92.0 93.0 149.0 93.0 91.0 163.0 09:03:11 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 09:03:12 INFO - PROCESS | 7265 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 119.0 118.0 119.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:03:12 INFO - PROCESS | 7265 | Values: 147.0 147.0 149.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:03:12 INFO - PROCESS | 7265 | Values: 95.0 96.0 95.0 96.0 94.0 95.0 95.0 96.0 95.0 96.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:55.00 stddev:10.44 (19.0%) stddev-sans-first:10.95 09:03:12 INFO - PROCESS | 7265 | Values: 53.0 55.0 55.0 54.0 53.0 55.0 55.0 87.0 53.0 54.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 09:03:12 INFO - PROCESS | 7265 | Values: 60.0 61.0 59.0 60.0 60.0 60.0 59.0 59.0 61.0 61.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.50 stddev:2.74 (3.7%) stddev-sans-first:2.71 09:03:12 INFO - PROCESS | 7265 | Values: 72.0 73.0 73.0 75.0 74.0 78.0 74.0 81.0 75.0 73.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.00 stddev:8.19 (6.8%) stddev-sans-first:8.57 09:03:12 INFO - PROCESS | 7265 | Values: 124.0 113.0 116.0 121.0 114.0 113.0 114.0 119.0 136.0 132.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:161.50 stddev:2.35 (1.5%) stddev-sans-first:2.47 09:03:12 INFO - PROCESS | 7265 | Values: 162.0 166.0 157.0 162.0 161.0 161.0 163.0 160.0 160.0 160.0 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - PROCESS | 7265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 09:03:12 INFO - PROCESS | 7265 | Values: 67.0 66.0 67.0 66.0 68.0 69.0 66.0 68.0 66.0 65.0 09:03:12 INFO - PROCESS | 7265 | -------- Summary: end -------- 09:03:12 INFO - PROCESS | 7265 | 09:03:12 INFO - TEST-INFO | 7265: exit 0 09:03:12 INFO - TEST-OK | kraken | took 63899ms 09:03:12 INFO - SUITE-END | took 1186s 09:03:13 INFO - Completed test suite (00:19:46) 09:03:13 INFO - javascript benchmark 09:03:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.8364081795908, 3373.460246360583, 3373.966260337396, 3386.712129468995, 3415.5047518109873, 5529.778808847646, 5537.36320323163, 5538.778448862051, 5560.443955604437, 5574.554035677146, 5525.060739674255, 5543.223948647193, 5565.30433695788, 5570.972145139269, 5573.777048918038, 5027.044861476317, 5055.974720126413, 5087.236914462842, 5121.897562048757, 5191.688498690071, 4955.876103097416, 5032.748362581875, 5120.3855537335385, 5207.713575753332, 5230.7646155922885, 5039.21892106724, 5067.341245638062, 5157.6131790115705, 5162.303089082963, 5203.037438073969, 5075.593952483792, 5076.492350764931, 5087.872803179932, 5090.134677104864, 5118.027574760784, 4927.063857866994, 4942.110420124376, 4988.351514303154, 5031.22016087507, 5063.493650634944, 5392.299001129867, 5394.298741163663, 5398.595105367113, 5417.26866872971, 5425.457454254543, 5875.236219291507, 5889.4405031522365, 5892.116182572606, 5907.556933230025, 5937.287525496925, 5859.7656093756195, 5952.166696662427, 5992.8501787455225, 6003.759849606011, 6044.304904935944, 5467.808626698046, 5503.174523821419, 5505.862353441156, 5550.195221692832, 5574.693391863487, 6011.428914253139, 6011.579189456696, 6083.847903802441, 6091.451769340692, 6097.146399504073, 5897.76408943646, 5964.194833697482, 5970.0, 5973.910391344133, 5975.372585878507, 5951.285845698544, 5955.7617695292565, 5956.910646340309, 5963.5527335450015, 5969.671668058211, 5700.230468886647, 5842.1820945066875, 5930.0, 5936.1392598073035, 5939.732712027969, 6000.7899723510345, 6029.065494848305, 6031.8539477499135, 6032.607880487754, 6053.818385448443, 4570.6800523963, 4572.7713614319155, 4573.199690054227, 4576.130535198302, 4607.0, 3965.524137103566, 3991.44119823225, 4050.3721923101966, 4080.714349995472, 4133.524644665842, 5589.55283577321, 5615.2700148980375, 5643.661380317194, 5659.547236221092, 5700.657960522382, 6026.668533230627, 6040.969795150996, 6067.180930574405, 6071.817845464643, 6074.848128796727, 5606.467385598362, 5651.152327150878, 5723.656580605177, 5759.884802303931, 5771.451712087345, 5057.494250574913, 5107.744612769421, 5119.846404607868, 5125.1287281162295, 5134.666246693953, 6111.54163437744, 6149.262088549313, 6152.661603611755, 6160.691965401802, 6169.56813023084, 5808.0, 6014.218151640259, 6035.939640603713, 6095.207623008981, 6124.816255512342, 6117.632942023492, 6124.011734871534, 6146.0473626587955, 6159.81520554384, 6163.044728067157, 5876.1773351729935, 5876.500497457593, 5881.117832325185, 5886.175935369138, 5920.052791553331, 5885.529157667291, 5932.79235226765, 5975.312839023568, 6002.849928751816, 6042.244719410074, 5707.942920570741, 5714.714264286852, 5746.827595172152, 5762.481376676119, 5781.075027995501, 5687.459691329317, 5728.713564321851, 5744.368119506935, 5765.91351129725, 5774.624649397776, 5722.542196624343, 5771.989901767258, 5808.6224395414165, 5814.04068328721, 5827.504662103769, 5884.32330282023, 5895.322037965689, 5897.292324921037, 5897.587168898136, 5900.468957793819, 5625.578081643975, 5646.9152962704775, 5787.131930210502, 5789.189513468202, 5800.9419905800405], "value": 5497.872853537953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.1884700665187, 668.9632070236138, 672.6031641331615, 686.505715884563, 735.5770432001597, 31999.0, 32751.344973100524, 40439.39340909885, 41436.79281603595, 41465.58534414655, 42916.0, 43622.0, 43773.78113109438, 43890.56109438905, 43957.7802110989, 8867.955660221689, 8920.643174273022, 8971.192592666659, 8988.056254093324, 9018.45889246644, 8856.468611883307, 9001.099890010979, 9015.504147271897, 9027.503487308195, 9038.367314287969, 8984.505852178128, 9212.401193922373, 9213.585388657526, 9244.630214791401, 9253.444793312423, 9193.678221262257, 9240.999999999967, 9264.861027084598, 9272.953635231814, 9294.163525282689, 9097.681581144629, 9180.586873590704, 9196.03441638625, 9203.401778884418, 9218.86171707425, 43903.78048109771, 44173.0, 44283.77858110721, 44375.778121109186, 44388.77805610983, 3733.309337772521, 3906.140649057203, 4009.4186342980397, 4237.3685182689, 4250.511191213019, 33142.502862457084, 33404.164895877555, 33580.66419335824, 33637.32725345504, 33694.0, 4505.549445055501, 4547.090581883604, 4593.655475839326, 4635.559926318244, 4721.480637129947, 321999.0, 322027.0, 323821.0, 327096.3645181783, 327984.0, 60698.39301607016, 62647.373526265066, 62664.37335626585, 62844.68577657083, 62856.37143628597, 72409.6379518099, 73173.0, 73471.26528734752, 73916.26083739093, 73951.26048739551, 19055.237790488503, 19296.80703192978, 19313.0, 19412.708809367872, 19413.126409311615, 15468.5359439217, 15488.690226195413, 15633.218339083227, 15670.451534196249, 15697.764533532007, 21062.157513699585, 21273.149074036864, 21437.46406339854, 21441.356759297247, 21676.891615541823, 7933.642986065641, 7976.960115199387, 8016.7194148204535, 8115.730780174339, 8140.0638926523025, 1074.790415868898, 1119.4011204005817, 1162.9533419921968, 1226.3316492511603, 1254.3414707278753, 31863.459427088717, 32142.0, 32662.46290059851, 32975.67024329726, 33347.666523334454, 1155.630198336541, 1248.9437975291135, 1264.4499642655474, 1265.2914367953974, 1299.7985312276612, 17336.39322623702, 17397.65204695899, 17593.7360939586, 17605.64788704219, 17947.679679259378, 499357.0, 508076.0, 557276.0, 567393.0, 585793.0, 59686.403135968954, 60639.39360606426, 60772.0, 60867.0, 60888.39111608916, 1566.4908904606048, 1568.200217888885, 1575.1809059289105, 1575.346231313992, 1650.1419261983942, 30489.54265685972, 30680.693193067782, 31262.53106203363, 31663.0, 31862.203444914063, 55183.72408137934, 55949.0, 56031.43968560425, 56104.0, 56393.0, 455986.0, 462397.0, 462961.0, 463486.0, 464625.0, 31317.217069573442, 31645.683543164272, 32204.67795322017, 32283.677163229007, 32303.0, 52416.213756794445, 52572.474275256754, 52827.73586132045, 53122.0, 53645.195322070984, 43376.0, 43403.565964339956, 43834.342484862114, 44084.11831763283, 44604.33093503665, 42413.363799542414, 42477.78761106174, 42609.78695106505, 43385.566144338154, 44055.0, 42612.360814587184, 43174.352384713624, 43844.34233486436, 44366.0, 44570.77714611406, 35993.28013439769, 36698.082547936516, 37542.0, 37992.430113547765, 38062.80968595139, 28583.285417863888, 29703.40593188081, 29736.25659358447, 29835.254118647208, 30035.69964300329], "value": 21415.49089021148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.4576233945228, 434.87542010653436, 441.84535412605584, 445.0986751827547, 447.58374711518314, 18610.90694546527, 19019.334323298688, 19542.70685939712, 21274.14903403862, 21279.680804787902, 17706.291748330084, 17786.555336116602, 17924.82075179248, 18116.4565063048, 18142.274309027624, 5855.268091488564, 5886.88226235475, 5978.22283103196, 5994.700264986755, 6059.66671833049, 5945.31628862682, 6006.489448396892, 6012.128241404994, 6027.0658048002415, 6044.032954727245, 5727.799527016535, 5907.734151963151, 5949.702514874239, 6003.429674180968, 6007.18902948103, 5902.173695682608, 5928.97035514824, 5942.821715348503, 5946.672932988684, 5966.67183304918, 5250.18622113573, 5287.656302340336, 5297.973510132425, 5353.277307563468, 5366.007288651612, 23494.177703780457, 23949.640755388682, 24158.758412415827, 24245.393865153514, 24284.150054748, 2389.1518510928545, 2438.7317395086525, 2442.401611605168, 2458.557459657261, 2529.4941011797714, 13854.515091971833, 13929.094608850392, 14516.782248266285, 14863.628409289746, 14863.628409289746, 1821.7631707878024, 1842.3828017614114, 1851.8333349998566, 1880.3888736160802, 1958.7747409048, 80112.59943700302, 81620.59189704132, 83520.58239708823, 83563.0, 83672.74490882641, 10769.130823701102, 11148.045767871521, 11236.94381528087, 11275.323480591027, 11310.886891131147, 16048.518544443685, 16136.031838089752, 16189.838101619069, 16197.109158996132, 16202.0, 8956.238719708897, 9002.369834111549, 9064.818703626022, 9231.07689231085, 9427.952860235655, 9517.952410238044, 9544.475053871965, 9581.329306948446, 9611.0, 9621.18219951298, 6878.69045892936, 6987.680851595554, 7012.123484564429, 7017.61403122823, 7055.400290975324, 2050.5283784729595, 2051.938441846747, 2094.832413406924, 2112.3979665795173, 2124.2034237161065, 1086.9782604347868, 1109.1348747976592, 1109.6171820721838, 1146.0, 1169.0472265103913, 19550.608987820164, 20151.294704685264, 20154.899225503777, 20337.0, 20504.69242961357, 1120.355795417638, 1145.495981768036, 1168.976620467586, 1198.6823491774687, 1262.9099384875697, 11398.601048963246, 11601.07191424684, 11621.941890290494, 11641.941790290994, 11680.70798230051, 527283.0, 532092.0, 539797.0, 543658.0, 544715.0, 52227.0, 83722.58138709389, 90451.0, 99258.0, 101356.0, 1159.976800464003, 1172.8533933258343, 1200.6938230751102, 1237.696764292754, 1268.245393990574, 17281.989017632626, 17358.132093395532, 17814.91092544529, 17918.91040544789, 17960.910195448938, 40825.591744083365, 41394.172116558104, 41402.792986034874, 41406.585934140276, 41895.7905210472, 58811.70594147002, 61254.69372653287, 61455.385446146756, 61651.691741541006, 61741.38258617356, 8212.384071194565, 8448.83102337962, 8516.148385161434, 8674.609642565974, 8727.781805454915, 9638.566264517973, 12106.273623582612, 12881.613551593467, 13043.869561304266, 13398.933005334911, 11764.764704705687, 11792.882071179178, 11826.290422574673, 11921.880781192078, 12012.699682508008, 12004.159708820647, 12048.819267710816, 12130.818037729265, 12132.696682583006, 12634.557790477289, 11545.769084618429, 11708.765824683629, 12005.75988480243, 12116.091293152873, 12194.939025304817, 8617.396782225183, 8650.567471626267, 8766.91233087661, 8804.075572065098, 8907.866382004404, 10927.747070089697, 11360.318380897173, 11540.653780386601, 11867.821982670093, 12413.193142446073], "value": 9776.518091482692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.778327142564, 1593.2511719491843, 1799.7840259168893, 1914.1195050276872, 1927.6433859735941, 8371.079181290053, 8431.747047588575, 8508.936382952132, 8675.349348798842, 8697.913020869797, 8567.957160214206, 8634.74095777126, 8658.740237792861, 8675.219230269275, 8696.39125261232, 2320.791128798412, 2346.3430239532872, 2349.929502114939, 2351.835371523994, 2359.846609970355, 2354.8469349492316, 2371.122684606698, 2379.690640216778, 2381.7499162587937, 2393.940151496209, 2276.2602154299834, 2279.3048120323297, 2305.8155347572238, 2321.94195145121, 2328.976710232893, 2281.418238349227, 2337.2170322941834, 2377.940551486209, 2382.404398900275, 2399.664047033417, 2396.3769419950763, 2405.0740464920955, 2422.818288628342, 2424.333308340203, 2424.5756992526235, 8646.0, 8741.694040708608, 8753.0, 8753.649854005833, 8790.120987901222, 5333.146696528575, 5420.186971954199, 5421.539169170625, 5425.294711687495, 5431.049566325877, 3429.605595356541, 3463.4631632097066, 3485.076454739496, 3498.0380395391217, 3531.311394278117, 1119.798436281469, 1136.9658910232706, 1148.1422420666554, 1179.7522520270754, 1186.9703257418548, 12097.274163550128, 12169.817452738216, 12175.512979480898, 12223.93888030563, 12248.387580621022, 4512.593866552026, 4524.298733696282, 4624.491305956342, 4626.375439315717, 4718.4809670936165, 9858.309918305793, 9895.752606184758, 9897.851532227023, 9898.505074746377, 9932.851007234898, 5336.039512887717, 5358.0, 5366.946330536723, 5398.271233383522, 5400.243965844785, 4185.288500954845, 4807.927881081787, 4851.75741212945, 4909.140900342426, 4990.451050384455, 4011.4584531088512, 4033.657139143147, 4082.6529744971417, 4120.608542188487, 4177.749335039907, 1201.5734414282979, 1214.2350319298785, 1217.9391030448442, 1240.2806372304042, 1254.5358217459598, 888.2849306308354, 923.6905636611676, 971.9405847626122, 986.4032260482305, 999.8300288950751, 5498.890022199534, 5591.9720401397735, 5756.94243057564, 5848.9707551462825, 6015.368386319461, 461.55690537084104, 462.9467611224752, 463.77275135183515, 470.30395015377434, 474.28146358267253, 3887.5918028607157, 4018.1561872006623, 4039.4950631171105, 4040.2121586290978, 4111.09555897702, 10511.421871796972, 10947.945260273647, 10959.287646302964, 10980.286281391844, 10992.945035274772, 10740.248182627298, 10761.78476430467, 10776.245662803685, 10796.838047429295, 10804.567817287378, 8184.54984975832, 8349.165083491602, 8377.078521362646, 8405.243528082501, 8458.87311690325, 5611.859703507445, 5741.856453588526, 5745.339285981999, 5809.0, 5846.6784326862435, 8953.641854325753, 9043.502607356659, 9223.031581684096, 9266.351355405057, 9595.040495950348, 9217.953910230406, 9312.767180820534, 9386.202172815387, 9395.389299695498, 9398.765030874283, 6883.27725588826, 7274.16347120088, 7321.707131714672, 7508.361789247975, 7816.7264145754625, 8288.50268983863, 8317.875231871405, 8331.000279966443, 8338.708145214889, 8374.832503349777, 7263.891041634485, 7340.522866013692, 7460.925390746023, 7553.886691699519, 7576.886346704694, 7282.817929551804, 7346.5592064476305, 7389.630518473948, 7402.33378995893, 7430.92569074324, 6903.654817259016, 6919.446444284546, 6970.0241966125795, 6976.267491913276, 6977.825554361181, 5028.195488721787, 5120.923186152137, 5140.768665409991, 5233.895322093461, 5357.979173932446, 4844.588210002048, 5078.111330517071, 5092.261622064854, 5171.81898633546, 5247.658902171346], "value": 4522.043435799537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8974307707687, 342.2948725625212, 343.3699162037661, 344.2907610322734, 344.95822615700575, 6378.649174295412, 6501.739930402779, 6510.121133646956, 6558.049082882979, 6571.967140164298, 6421.614703117804, 6421.64680942548, 6422.389872962073, 6425.164728585289, 6472.417482426581, 4691.507391723862, 4774.618030557547, 4795.352627395292, 4803.063402636487, 4805.327254184417, 4764.094821983812, 4777.546133117348, 4805.303231031498, 4816.927746083811, 4861.368022157115, 4805.303231031516, 4808.326834243208, 4810.567048965592, 4811.4226292844905, 4813.8074477021055, 4762.3332733417, 4793.856184314476, 4808.182608956486, 4808.975955120237, 4810.302506136608, 4178.770167640779, 4179.310413781753, 4179.686523510719, 4182.372644103379, 4182.996080940583, 6029.517638588946, 6220.253569571681, 6222.066689996492, 6243.87512249757, 6286.025666021774, 5529.889402211933, 5531.3362396512675, 5533.6403133796575, 5538.529225015878, 5571.052921003439, 6833.487488438337, 6841.0, 6859.0, 6871.553349032297, 6878.071460352839, 4610.193216187187, 4614.700044497097, 4614.76926153691, 4619.86140415788, 4645.976770116162, 7086.185088714812, 7121.8219544511285, 7145.499815012951, 7158.355747982707, 7168.964155179191, 4661.370714953506, 4661.580457758818, 4668.299755036772, 4729.787159577827, 4820.68665536739, 4810.7113573185725, 4835.202191638411, 4841.515848415201, 4862.197737373293, 4880.951190488121, 5687.175359572839, 5702.914456283159, 5719.342275638355, 5725.1698503716725, 5740.368559458456, 6915.4121899638085, 6920.792376228721, 6925.896111558331, 6930.688119034656, 6946.6179360135675, 1713.5459103337625, 1735.9324015730235, 1737.252981218063, 1737.5308666660185, 1737.539552018716, 1099.290957332516, 1127.22784892349, 1129.8079326514512, 1136.9204155709022, 1142.5087212498538, 6629.839778038824, 6633.535652504278, 6645.60126392418, 6649.800505984828, 6660.23407308156, 7068.469864760164, 7079.362857342864, 7091.539049961736, 7094.574325540484, 7095.0, 6519.837004074841, 6604.306547812506, 6753.49348798842, 6758.290379510081, 6772.932270677329, 3840.0591854995146, 3862.6909847212155, 3872.206197729459, 3878.3988481784804, 3878.9030274242805, 7379.852402951911, 7381.704731810775, 7395.519291246052, 7399.963000184965, 7408.444366672521, 7281.4538909582, 7299.525530840585, 7301.123865136217, 7302.160251571031, 7318.194998550155, 7103.857922841617, 7359.889601655872, 7383.2985866342615, 7397.334239918433, 7407.777766667009, 7051.858962820817, 7124.251953544803, 7163.534370265916, 7166.960790685425, 7178.174509931425, 7030.261822508767, 7058.047163632844, 7062.223155452793, 7066.364027237573, 7074.080369551925, 7219.566825990458, 7341.70633174667, 7368.852622947618, 7377.963110184414, 7380.557166570023, 4680.46174689915, 4714.269288260325, 4728.62171026324, 4736.85789426304, 4743.691660042086, 7089.0, 7104.644767761488, 7113.430925526049, 7120.323569260912, 7127.607981561064, 6879.58722476653, 6897.034415181979, 6902.482313826383, 6903.206131294965, 6916.100906882073, 6759.324067593201, 6848.383645471931, 6910.205326387329, 6910.965445172742, 6918.688659010256, 6754.2570317266045, 6772.153480814898, 6787.389134977876, 6792.966035169792, 6795.218549866631, 6888.793336199922, 6922.7923162305215, 6925.3074692530345, 6954.235034146341, 6968.547044442095, 6721.865562688817, 6758.3917447428, 6759.763408280686, 6772.492063095386, 6773.424258938046], "value": 5139.773136651257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.145485968891, 864.3906046237403, 906.5603182456507, 913.7898283394817, 926.3932124458479, 13674.042817002814, 13905.93047034766, 13950.441982320708, 15074.773878391805, 15438.69122617547, 14719.852801472009, 14819.77770333446, 14828.332725027372, 14838.183899885502, 14841.777373339408, 905.7554460295717, 907.1563445995238, 909.963601455941, 916.2807196350866, 917.0600134861787, 897.1521911793358, 915.5376534849892, 921.806420651664, 924.8057907839362, 925.5326060339519, 974.2352253481018, 977.2865807960158, 978.0, 978.9412635241908, 983.7147227304073, 967.4340510801189, 968.2544440780559, 968.4479846487505, 969.2633598465146, 972.4311277902435, 718.1059580821858, 718.7843646905959, 720.2329519062182, 720.6576875983918, 723.9239879812596, 14069.507567235098, 14106.294685265799, 14108.012439129265, 14135.081219720789, 14158.292085395791, 14564.781528277084, 14636.04865683727, 14925.328360223815, 14959.0, 15060.924695376452, 11612.129090318176, 11764.58823941158, 11767.293962362286, 11935.343556104412, 11992.86067823564, 3664.798436086014, 3704.981475092607, 3761.492198553188, 3799.3731034379293, 3820.465134881119, 57029.42970570282, 57323.71338143324, 58364.0, 58768.0, 58893.0, 11572.305661660328, 11713.121515886343, 11766.88233117675, 11767.293962362286, 11820.822687659693, 20690.275840345515, 21015.159393624388, 21018.684719729215, 21081.578368432547, 21091.894540527504, 7651.426143039294, 7693.653785579662, 7895.052593688794, 8035.0, 8139.348852091937, 4701.435827700698, 4852.611791056707, 4960.627952903546, 4966.304717339575, 5061.038402703474, 3681.079730067483, 3748.700103991674, 3753.5120434343908, 3755.211405604799, 3761.2853557824474, 682.2393031769541, 706.8586282743472, 720.4992530191466, 723.4321057969574, 729.7336472187613, 678.5996262205323, 713.8144082538578, 758.6510205305511, 776.9456138070394, 781.2382926646587, 9437.386569872937, 9655.131038206455, 9711.486227192663, 9749.122578967927, 9968.152707019839, 620.460199626328, 695.0581961442173, 710.087537514302, 718.3857801579678, 726.9600171990486, 4534.659900507475, 4582.9541704582525, 4637.559431853969, 4716.575508204278, 4722.740249286254, 63082.0, 63997.0, 64178.0, 64254.0361894572, 64377.0, 55727.0, 56230.43769562252, 56733.14900276499, 56900.0, 56955.0, 50242.0, 50318.74840625847, 50843.237351439755, 51822.48177518177, 53011.73494132505, 8978.955105224431, 9013.0, 9096.408733432305, 9156.221721153777, 9202.631894724404, 38681.2263754729, 39067.0, 39739.80130099331, 40410.19179616332, 40599.1880162401, 45880.541194587626, 47931.0, 49868.0, 50034.49965500444, 51215.23177152271, 10947.34315941046, 11052.834207486734, 11311.547538098384, 11397.145214108808, 11665.88334116648, 12661.87338126607, 12798.680032998876, 12838.229706217657, 13090.491180732219, 13143.671408214872, 11469.713257168638, 11700.824487632523, 11813.704657383634, 12213.75572488563, 12401.379931003234, 13376.130551514121, 13981.650458738206, 13988.720225595634, 14165.362558684677, 14240.928795355956, 12633.81049284243, 12661.113722039368, 12708.555200567936, 13112.344382781013, 13316.201027938354, 11456.82814757796, 11523.213197918905, 11587.130965177477, 11843.0, 11867.406629668654, 10330.483475826028, 10398.220133489867, 10626.36241825493, 10637.734056648645, 10663.360198388122], "value": 7097.560878226807, "unit": "score"}], "name": "dromaeo_css", "value": 7581.516334638203, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 102.0, 109.0, 112.0, 113.0, 101.0, 110.0, 113.0, 116.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 128.0, 163.0, 180.0, 129.0, 166.0, 158.0, 128.0, 173.0, 132.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 169.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 202.0, 73.0, 76.0, 76.0, 78.0, 169.0, 76.0], "value": 97.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 157.0, 92.0, 92.0, 93.0, 149.0, 93.0, 91.0, 163.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 119.0, 118.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 94.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 53.0, 55.0, 55.0, 87.0, 53.0, 54.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 61.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 75.0, 74.0, 78.0, 74.0, 81.0, 75.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 113.0, 116.0, 121.0, 114.0, 113.0, 114.0, 119.0, 136.0, 132.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 157.0, 162.0, 161.0, 161.0, 163.0, 160.0, 160.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 68.0, 69.0, 66.0, 68.0, 66.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1534.6, "alertThreshold": 2.0}]} 09:03:13 INFO - Return code: 0 09:03:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:13 ERROR - # TBPL SUCCESS # 09:03:13 INFO - Running post-action listener: _resource_record_post_action 09:03:13 INFO - Running post-run listener: _resource_record_post_run 09:03:14 INFO - Total resource usage - Wall time: 1216s; CPU: 13.0%; Read bytes: 28672; Write bytes: 456220672; Read time: 4720; Write time: 3397576 09:03:14 INFO - install - Wall time: 16s; CPU: 20.0%; Read bytes: 0; Write bytes: 143728640; Read time: 0; Write time: 974364 09:03:14 INFO - run-tests - Wall time: 1201s; CPU: 13.0%; Read bytes: 28672; Write bytes: 296615936; Read time: 4720; Write time: 2246192 09:03:14 INFO - Running post-run listener: _upload_blobber_files 09:03:14 INFO - Blob upload gear active. 09:03:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:14 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:15 INFO - (blobuploader) - INFO - Done attempting. 09:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:16 INFO - (blobuploader) - INFO - Done attempting. 09:03:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:16 INFO - Return code: 0 09:03:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437bc2706e87ba2596cd8abf329249010ee6fea70ff97fc36ee8037bf3cbaa074676318cdbbaa04229f768818d152963f4e94ebb501082965fbd05ca7ee2e130", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10d6c3ba37d9658925b258a607b7c7130c1e6dd0e7c28d804f798957fd068223352f69f1d6134404e1bf9b4bd64ef33036e7d288daa82e65f438c3d534b3a466"} 09:03:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:16 INFO - Contents: 09:03:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437bc2706e87ba2596cd8abf329249010ee6fea70ff97fc36ee8037bf3cbaa074676318cdbbaa04229f768818d152963f4e94ebb501082965fbd05ca7ee2e130", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10d6c3ba37d9658925b258a607b7c7130c1e6dd0e7c28d804f798957fd068223352f69f1d6134404e1bf9b4bd64ef33036e7d288daa82e65f438c3d534b3a466"} 09:03:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:16 INFO - Copying logs to upload dir... 09:03:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.131465 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-13 09:03:15.419295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:15.427757) ========= 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=33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696 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/437bc2706e87ba2596cd8abf329249010ee6fea70ff97fc36ee8037bf3cbaa074676318cdbbaa04229f768818d152963f4e94ebb501082965fbd05ca7ee2e130", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10d6c3ba37d9658925b258a607b7c7130c1e6dd0e7c28d804f798957fd068223352f69f1d6134404e1bf9b4bd64ef33036e7d288daa82e65f438c3d534b3a466"} build_url:https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437bc2706e87ba2596cd8abf329249010ee6fea70ff97fc36ee8037bf3cbaa074676318cdbbaa04229f768818d152963f4e94ebb501082965fbd05ca7ee2e130", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10d6c3ba37d9658925b258a607b7c7130c1e6dd0e7c28d804f798957fd068223352f69f1d6134404e1bf9b4bd64ef33036e7d288daa82e65f438c3d534b3a466"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:15.456057) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:15.456465) ========= 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=33d5923976266a1c518c4bf7000001ab-1468424139.584553-2080747696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:15.506164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 09:03:15.506830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 09:03:15.507138) ========= ========= Total master_lag: 0.16 =========