builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1468376822.17 results: success (0) buildid: 20160712164026 builduid: fe52684c386341788feef6a4a2ece107 revision: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.167250) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.167837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.168254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.184690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.184991) ========= 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=db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 19:27:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-12 19:27:03 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.340717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.341438) ========= 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=db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015578 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.396212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:02.397014) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 --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 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 --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=db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 19:27:03,160 truncating revision to first 12 chars 2016-07-12 19:27:03,160 Setting DEBUG logging. 2016-07-12 19:27:03,160 attempt 1/10 2016-07-12 19:27:03,160 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01aead8192bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 19:27:03,537 unpacking tar archive at: mozilla-beta-01aead8192bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:03.211403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:03.211770) ========= script_repo_revision: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:03.212237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:03.212560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 19:27:03.221673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-12 19:27:03.221978) ========= /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=db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:27:04 INFO - MultiFileLogger online at 20160712 19:27:04 in /builds/slave/test 19:27:04 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 19:27:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:04 INFO - {'append_to_log': False, 19:27:04 INFO - 'base_work_dir': '/builds/slave/test', 19:27:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:27:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:04 INFO - 'branch': 'Mozilla-Beta', 19:27:04 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:04 INFO - 'config_files': ('talos/linux_config.py',), 19:27:04 INFO - 'default_actions': ('clobber', 19:27:04 INFO - 'read-buildbot-config', 19:27:04 INFO - 'download-and-extract', 19:27:04 INFO - 'populate-webroot', 19:27:04 INFO - 'create-virtualenv', 19:27:04 INFO - 'install', 19:27:04 INFO - 'run-tests'), 19:27:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:04 INFO - 'download_minidump_stackwalk': True, 19:27:04 INFO - 'download_symbols': 'ondemand', 19:27:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:04 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:04 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:04 INFO - 'installer_path': 'installer.exe', 19:27:04 INFO - 'log_level': 'info', 19:27:04 INFO - 'log_name': 'talos', 19:27:04 INFO - 'log_to_console': True, 19:27:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:27:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:27:04 INFO - 'opt_config_files': (), 19:27:04 INFO - 'pip_index': False, 19:27:04 INFO - 'sps_profile': False, 19:27:04 INFO - 'sps_profile_interval': 0, 19:27:04 INFO - 'suite': 'dromaeojs-e10s', 19:27:04 INFO - 'system_bits': '32', 19:27:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:04 INFO - 'title': 'talos-linux64-ix-049', 19:27:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:04 INFO - 'use_talos_json': True, 19:27:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:04 INFO - 'work_dir': 'build'} 19:27:04 INFO - ##### 19:27:04 INFO - ##### Running clobber step. 19:27:04 INFO - ##### 19:27:04 INFO - Running pre-action listener: _resource_record_pre_action 19:27:04 INFO - Running main action method: clobber 19:27:04 INFO - rmtree: /builds/slave/test/build 19:27:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:04 INFO - Running post-action listener: _resource_record_post_action 19:27:04 INFO - ##### 19:27:04 INFO - ##### Running read-buildbot-config step. 19:27:04 INFO - ##### 19:27:04 INFO - Running pre-action listener: _resource_record_pre_action 19:27:04 INFO - Running main action method: read_buildbot_config 19:27:04 INFO - Using buildbot properties: 19:27:04 INFO - { 19:27:04 INFO - "project": "", 19:27:04 INFO - "product": "firefox", 19:27:04 INFO - "script_repo_revision": "production", 19:27:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:27:04 INFO - "repository": "", 19:27:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 19:27:04 INFO - "buildid": "20160712164026", 19:27:04 INFO - "pgo_build": "True", 19:27:04 INFO - "basedir": "/builds/slave/test", 19:27:04 INFO - "buildnumber": 93, 19:27:04 INFO - "slavename": "talos-linux64-ix-049", 19:27:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:27:04 INFO - "platform": "ubuntu64_hw", 19:27:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:27:04 INFO - "branch": "mozilla-beta", 19:27:04 INFO - "repo_path": "releases/mozilla-beta", 19:27:04 INFO - "revision": "01aead8192bd5dca6f1dbef7424da9f0a70bc4a9", 19:27:04 INFO - "stage_platform": "linux64-pgo", 19:27:04 INFO - "builduid": "fe52684c386341788feef6a4a2ece107", 19:27:04 INFO - "slavebuilddir": "test" 19:27:04 INFO - } 19:27:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 19:27:04 INFO - Running post-action listener: _resource_record_post_action 19:27:04 INFO - ##### 19:27:04 INFO - ##### Running download-and-extract step. 19:27:04 INFO - ##### 19:27:04 INFO - Running pre-action listener: _resource_record_pre_action 19:27:04 INFO - Running main action method: download_and_extract 19:27:04 INFO - mkdir: /builds/slave/test/build/tests 19:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:04 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:27:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:09 INFO - Downloaded 1327 bytes. 19:27:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 19:27:09 INFO - Using the following test package requirements: 19:27:09 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:27:09 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:27:09 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 19:27:09 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'jsshell-linux-x86_64.zip'], 19:27:09 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:27:09 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 19:27:09 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 19:27:09 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 19:27:09 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:27:09 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 19:27:09 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:27:09 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:09 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:27:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:14 INFO - Downloaded 24236550 bytes. 19:27:14 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'] 19:27:14 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 19:27:15 INFO - Return code: 0 19:27:15 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 19:27: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')]} 19:27:15 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 19:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:17 INFO - Downloaded 24236550 bytes. 19:27: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'] 19:27: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 19:27:19 INFO - Return code: 0 19:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:19 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 19:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:19 INFO - Downloaded 10840145 bytes. 19:27:19 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'] 19:27:19 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 19:27:20 INFO - Return code: 0 19:27:20 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')]} 19:27:20 INFO - https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StHRWibKQOiFznIpf-aF4w/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 19:27:21 INFO - Downloaded 56026149 bytes. 19:27:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:21 INFO - mkdir: /builds/slave/test/properties 19:27:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:21 INFO - Contents: 19:27:21 INFO - build_url:https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 19:27:22 INFO - Running post-action listener: _resource_record_post_action 19:27:22 INFO - Running post-action listener: set_extra_try_arguments 19:27:22 INFO - ##### 19:27:22 INFO - ##### Running populate-webroot step. 19:27:22 INFO - ##### 19:27:22 INFO - Running pre-action listener: _resource_record_pre_action 19:27:22 INFO - Running main action method: populate_webroot 19:27:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:22 INFO - '--tppagecycles', 19:27:22 INFO - '7'], 19:27:22 INFO - 'tests': ['tsvgm']}}, 19:27:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['damp', 'tps']}, 19:27:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'tests': ['damp', 'tps']}, 19:27:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['dromaeo_dom']}, 19:27:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['a11yr', 19:27:22 INFO - 'ts_paint', 19:27:22 INFO - 'tpaint', 19:27:22 INFO - 'sessionrestore', 19:27:22 INFO - 'sessionrestore_no_auto_restore', 19:27:22 INFO - 'tabpaint']}, 19:27:22 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:22 INFO - 'ts_paint', 19:27:22 INFO - 'tpaint', 19:27:22 INFO - 'sessionrestore', 19:27:22 INFO - 'sessionrestore_no_auto_restore', 19:27:22 INFO - 'tabpaint']}, 19:27:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:22 INFO - 'ts_paint', 19:27:22 INFO - 'tpaint', 19:27:22 INFO - 'sessionrestore', 19:27:22 INFO - 'sessionrestore_no_auto_restore', 19:27:22 INFO - 'tabpaint']}, 19:27:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:22 INFO - 'ts_paint', 19:27:22 INFO - 'tpaint', 19:27:22 INFO - 'sessionrestore', 19:27:22 INFO - 'sessionrestore_no_auto_restore', 19:27:22 INFO - 'tabpaint']}, 19:27:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['a11yr', 19:27:22 INFO - 'ts_paint', 19:27:22 INFO - 'tpaint', 19:27:22 INFO - 'sessionrestore', 19:27:22 INFO - 'sessionrestore_no_auto_restore', 19:27:22 INFO - 'tabpaint']}, 19:27:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['a11yr', 19:27:22 INFO - 'ts_paint', 19:27:22 INFO - 'tpaint', 19:27:22 INFO - 'sessionrestore', 19:27:22 INFO - 'sessionrestore_no_auto_restore', 19:27:22 INFO - 'tabpaint']}, 19:27:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['tsvgx', 19:27:22 INFO - 'tsvgr_opacity', 19:27:22 INFO - 'tart', 19:27:22 INFO - 'tscrollx', 19:27:22 INFO - 'cart']}, 19:27:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:22 INFO - 'tsvgr_opacity', 19:27:22 INFO - 'tart', 19:27:22 INFO - 'tscrollx', 19:27:22 INFO - 'cart']}, 19:27:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'talos_options': ['--disable-e10s'], 19:27:22 INFO - 'tests': ['tp5o']}, 19:27:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'tests': ['tp5o']}, 19:27:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'talos_options': ['--disable-e10s', 19:27:22 INFO - '--xperf_path', 19:27:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:22 INFO - 'tests': ['tp5n']}, 19:27:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:22 INFO - 'talos_options': ['--xperf_path', 19:27:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:22 INFO - 'tests': ['tp5n']}}, 19:27:22 INFO - 'talos.zip': {'path': '', 19:27:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:22 INFO - Running post-action listener: _resource_record_post_action 19:27:22 INFO - ##### 19:27:22 INFO - ##### Running create-virtualenv step. 19:27:22 INFO - ##### 19:27:22 INFO - Running pre-action listener: _resource_record_pre_action 19:27:22 INFO - Running main action method: create_virtualenv 19:27:22 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:22 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 19:27:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:22 INFO - Using real prefix '/usr' 19:27:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:23 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:25 INFO - Installing pip.................done. 19:27:25 INFO - Return code: 0 19:27:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:25 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')]} 19:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:25 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')]} 19:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:25 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:25 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 19:27:25 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 19:27:25 INFO - Using env: {'DISPLAY': ':0', 19:27:25 INFO - 'HOME': '/home/cltbld', 19:27:25 INFO - 'LANG': 'en_US.UTF-8', 19:27:25 INFO - 'LANGUAGE': 'en_US:en', 19:27:25 INFO - 'LOGNAME': 'cltbld', 19:27:25 INFO - 'MAIL': '/var/mail/cltbld', 19:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:25 INFO - 'MOZ_NO_REMOTE': '1', 19:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:25 INFO - 'NO_EM_RESTART': '1', 19:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:25 INFO - 'PWD': '/builds/slave/test', 19:27:25 INFO - 'SHELL': '/bin/bash', 19:27:25 INFO - 'SHLVL': '1', 19:27:25 INFO - 'TERM': 'linux', 19:27:25 INFO - 'TMOUT': '86400', 19:27:25 INFO - 'USER': 'cltbld', 19:27:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:25 INFO - '_': '/tools/buildbot/bin/python'} 19:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:25 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 19:27:25 INFO - Cleaning up... 19:27:25 INFO - Return code: 0 19:27:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:27:25 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')]} 19:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:25 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')]} 19:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:25 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:25 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 19:27:25 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 19:27:25 INFO - Using env: {'DISPLAY': ':0', 19:27:25 INFO - 'HOME': '/home/cltbld', 19:27:25 INFO - 'LANG': 'en_US.UTF-8', 19:27:25 INFO - 'LANGUAGE': 'en_US:en', 19:27:25 INFO - 'LOGNAME': 'cltbld', 19:27:25 INFO - 'MAIL': '/var/mail/cltbld', 19:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:25 INFO - 'MOZ_NO_REMOTE': '1', 19:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:25 INFO - 'NO_EM_RESTART': '1', 19:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:25 INFO - 'PWD': '/builds/slave/test', 19:27:25 INFO - 'SHELL': '/bin/bash', 19:27:25 INFO - 'SHLVL': '1', 19:27:25 INFO - 'TERM': 'linux', 19:27:25 INFO - 'TMOUT': '86400', 19:27:25 INFO - 'USER': 'cltbld', 19:27:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:25 INFO - '_': '/tools/buildbot/bin/python'} 19:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:25 INFO - Downloading/unpacking psutil>=0.7.1 19:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:27 INFO - Installing collected packages: psutil 19:27:27 INFO - Running setup.py install for psutil 19:27:27 INFO - building 'psutil._psutil_linux' extension 19:27:27 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 19:27:27 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 19:27:27 INFO - building 'psutil._psutil_posix' extension 19:27:27 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 19:27:27 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 19:27:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:27 INFO - Successfully installed psutil 19:27:27 INFO - Cleaning up... 19:27:28 INFO - Return code: 0 19:27:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:28 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:28 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 19:27:28 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 19:27:28 INFO - Using env: {'DISPLAY': ':0', 19:27:28 INFO - 'HOME': '/home/cltbld', 19:27:28 INFO - 'LANG': 'en_US.UTF-8', 19:27:28 INFO - 'LANGUAGE': 'en_US:en', 19:27:28 INFO - 'LOGNAME': 'cltbld', 19:27:28 INFO - 'MAIL': '/var/mail/cltbld', 19:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:28 INFO - 'MOZ_NO_REMOTE': '1', 19:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:28 INFO - 'NO_EM_RESTART': '1', 19:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:28 INFO - 'PWD': '/builds/slave/test', 19:27:28 INFO - 'SHELL': '/bin/bash', 19:27:28 INFO - 'SHLVL': '1', 19:27:28 INFO - 'TERM': 'linux', 19:27:28 INFO - 'TMOUT': '86400', 19:27:28 INFO - 'USER': 'cltbld', 19:27:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:28 INFO - '_': '/tools/buildbot/bin/python'} 19:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:27:28 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 19:27:28 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 19:27:28 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 19:27:28 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 19:27:28 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 19:27:28 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 19:27:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:27:30 INFO - Installing collected packages: mozsystemmonitor 19:27:30 INFO - Running setup.py install for mozsystemmonitor 19:27:30 INFO - Successfully installed mozsystemmonitor 19:27:30 INFO - Cleaning up... 19:27:30 INFO - Return code: 0 19:27:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:30 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:30 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 19:27:30 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 19:27:30 INFO - Using env: {'DISPLAY': ':0', 19:27:30 INFO - 'HOME': '/home/cltbld', 19:27:30 INFO - 'LANG': 'en_US.UTF-8', 19:27:30 INFO - 'LANGUAGE': 'en_US:en', 19:27:30 INFO - 'LOGNAME': 'cltbld', 19:27:30 INFO - 'MAIL': '/var/mail/cltbld', 19:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:30 INFO - 'MOZ_NO_REMOTE': '1', 19:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:30 INFO - 'NO_EM_RESTART': '1', 19:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:30 INFO - 'PWD': '/builds/slave/test', 19:27:30 INFO - 'SHELL': '/bin/bash', 19:27:30 INFO - 'SHLVL': '1', 19:27:30 INFO - 'TERM': 'linux', 19:27:30 INFO - 'TMOUT': '86400', 19:27:30 INFO - 'USER': 'cltbld', 19:27:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:30 INFO - '_': '/tools/buildbot/bin/python'} 19:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:30 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:32 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 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 19:27:32 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 19:27:33 INFO - Downloading docopt-0.6.1.tar.gz 19:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:33 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:33 INFO - Running setup.py install for blobuploader 19:27:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:33 INFO - Running setup.py install for requests 19:27:33 INFO - Running setup.py install for docopt 19:27:33 INFO - Successfully installed blobuploader requests docopt 19:27:33 INFO - Cleaning up... 19:27:33 INFO - Return code: 0 19:27:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:33 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')]} 19:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:33 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')]} 19:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:33 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:33 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 19:27:33 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 19:27:33 INFO - Using env: {'DISPLAY': ':0', 19:27:33 INFO - 'HOME': '/home/cltbld', 19:27:33 INFO - 'LANG': 'en_US.UTF-8', 19:27:33 INFO - 'LANGUAGE': 'en_US:en', 19:27:33 INFO - 'LOGNAME': 'cltbld', 19:27:33 INFO - 'MAIL': '/var/mail/cltbld', 19:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:33 INFO - 'MOZ_NO_REMOTE': '1', 19:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:33 INFO - 'NO_EM_RESTART': '1', 19:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:33 INFO - 'PWD': '/builds/slave/test', 19:27:33 INFO - 'SHELL': '/bin/bash', 19:27:33 INFO - 'SHLVL': '1', 19:27:33 INFO - 'TERM': 'linux', 19:27:33 INFO - 'TMOUT': '86400', 19:27:33 INFO - 'USER': 'cltbld', 19:27:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:33 INFO - '_': '/tools/buildbot/bin/python'} 19:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:34 INFO - Running setup.py (path:/tmp/pip-JzfoLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:34 INFO - Running setup.py (path:/tmp/pip-UOkWwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:34 INFO - Running setup.py (path:/tmp/pip-bYtdVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:34 INFO - Running setup.py (path:/tmp/pip-nfl01E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:34 INFO - Running setup.py (path:/tmp/pip-hI6zkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:34 INFO - Running setup.py (path:/tmp/pip-NGi4oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:34 INFO - Running setup.py (path:/tmp/pip-sjvdJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:34 INFO - Running setup.py (path:/tmp/pip-thoFuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:34 INFO - Running setup.py (path:/tmp/pip-mbU5dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:34 INFO - Running setup.py (path:/tmp/pip-CqDGfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:34 INFO - Running setup.py (path:/tmp/pip-_Ie1tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:34 INFO - Running setup.py (path:/tmp/pip-ljmxTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:34 INFO - Running setup.py (path:/tmp/pip-QugHNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:34 INFO - Running setup.py (path:/tmp/pip-gS0E2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:35 INFO - Running setup.py (path:/tmp/pip-iH_WHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:35 INFO - Running setup.py (path:/tmp/pip-XW9MHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:35 INFO - Running setup.py (path:/tmp/pip-hYQ_Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:35 INFO - Running setup.py install for manifestparser 19:27:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozcrash 19:27:35 INFO - Running setup.py install for mozdebug 19:27:35 INFO - Running setup.py install for mozdevice 19:27:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozfile 19:27:35 INFO - Running setup.py install for mozhttpd 19:27:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozinfo 19:27:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozInstall 19:27:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozleak 19:27:36 INFO - Running setup.py install for mozlog 19:27:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for moznetwork 19:27:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozprocess 19:27:36 INFO - Running setup.py install for mozprofile 19:27:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozrunner 19:27:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozscreenshot 19:27:36 INFO - Running setup.py install for moztest 19:27:36 INFO - Running setup.py install for mozversion 19:27:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:37 INFO - Cleaning up... 19:27:37 INFO - Return code: 0 19:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:37 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:37 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 19:27:37 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 19:27:37 INFO - Using env: {'DISPLAY': ':0', 19:27:37 INFO - 'HOME': '/home/cltbld', 19:27:37 INFO - 'LANG': 'en_US.UTF-8', 19:27:37 INFO - 'LANGUAGE': 'en_US:en', 19:27:37 INFO - 'LOGNAME': 'cltbld', 19:27:37 INFO - 'MAIL': '/var/mail/cltbld', 19:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:37 INFO - 'MOZ_NO_REMOTE': '1', 19:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:37 INFO - 'NO_EM_RESTART': '1', 19:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:37 INFO - 'PWD': '/builds/slave/test', 19:27:37 INFO - 'SHELL': '/bin/bash', 19:27:37 INFO - 'SHLVL': '1', 19:27:37 INFO - 'TERM': 'linux', 19:27:37 INFO - 'TMOUT': '86400', 19:27:37 INFO - 'USER': 'cltbld', 19:27:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:37 INFO - '_': '/tools/buildbot/bin/python'} 19:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:37 INFO - Running setup.py (path:/tmp/pip-kg2p34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:37 INFO - Running setup.py (path:/tmp/pip-1fX2R1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:37 INFO - Running setup.py (path:/tmp/pip-FpIT8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:37 INFO - Running setup.py (path:/tmp/pip-Wpz57g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:37 INFO - Running setup.py (path:/tmp/pip-iA1oc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:37 INFO - Running setup.py (path:/tmp/pip-yBWp9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:37 INFO - Running setup.py (path:/tmp/pip-_Ycdao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:37 INFO - Running setup.py (path:/tmp/pip-w75NeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:37 INFO - Running setup.py (path:/tmp/pip-InAVT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:37 INFO - Running setup.py (path:/tmp/pip-w33Ztj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:38 INFO - Running setup.py (path:/tmp/pip-Lk2J20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:38 INFO - Running setup.py (path:/tmp/pip-uS1_Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:38 INFO - Running setup.py (path:/tmp/pip-p2dfDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:38 INFO - Running setup.py (path:/tmp/pip-jzJTPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:38 INFO - Running setup.py (path:/tmp/pip-ZQvkbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:38 INFO - Running setup.py (path:/tmp/pip-sqyr9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:38 INFO - Running setup.py (path:/tmp/pip-uCJUjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:38 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)) 19:27:38 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)) 19:27:38 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)) 19:27:38 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)) 19:27:38 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)) 19:27:38 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)) 19:27:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:40 INFO - Downloading blessings-1.6.tar.gz 19:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:40 INFO - Installing collected packages: blessings 19:27:40 INFO - Running setup.py install for blessings 19:27:40 INFO - Successfully installed blessings 19:27:40 INFO - Cleaning up... 19:27:40 INFO - Return code: 0 19:27:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:40 INFO - Reading from file tmpfile_stdout 19:27:40 INFO - Current package versions: 19:27:40 INFO - argparse == 1.2.1 19:27:40 INFO - blessings == 1.6 19:27:40 INFO - blobuploader == 1.2.4 19:27:40 INFO - docopt == 0.6.1 19:27:40 INFO - manifestparser == 1.1 19:27:40 INFO - mozInstall == 1.12 19:27:40 INFO - mozcrash == 0.17 19:27:40 INFO - mozdebug == 0.1 19:27:40 INFO - mozdevice == 0.48 19:27:40 INFO - mozfile == 1.2 19:27:40 INFO - mozhttpd == 0.7 19:27:40 INFO - mozinfo == 0.9 19:27:40 INFO - mozleak == 0.1 19:27:40 INFO - mozlog == 3.1 19:27:40 INFO - moznetwork == 0.27 19:27:40 INFO - mozprocess == 0.22 19:27:40 INFO - mozprofile == 0.28 19:27:40 INFO - mozrunner == 6.11 19:27:40 INFO - mozscreenshot == 0.1 19:27:40 INFO - mozsystemmonitor == 0.0 19:27:40 INFO - moztest == 0.7 19:27:40 INFO - mozversion == 1.4 19:27:40 INFO - psutil == 3.1.1 19:27:40 INFO - requests == 1.2.3 19:27:40 INFO - wsgiref == 0.1.2 19:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:40 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:40 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 19:27:40 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 19:27:40 INFO - Using env: {'DISPLAY': ':0', 19:27:40 INFO - 'HOME': '/home/cltbld', 19:27:40 INFO - 'LANG': 'en_US.UTF-8', 19:27:40 INFO - 'LANGUAGE': 'en_US:en', 19:27:40 INFO - 'LOGNAME': 'cltbld', 19:27:40 INFO - 'MAIL': '/var/mail/cltbld', 19:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:40 INFO - 'MOZ_NO_REMOTE': '1', 19:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:40 INFO - 'NO_EM_RESTART': '1', 19:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:40 INFO - 'PWD': '/builds/slave/test', 19:27:40 INFO - 'SHELL': '/bin/bash', 19:27:40 INFO - 'SHLVL': '1', 19:27:40 INFO - 'TERM': 'linux', 19:27:40 INFO - 'TMOUT': '86400', 19:27:40 INFO - 'USER': 'cltbld', 19:27:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:40 INFO - '_': '/tools/buildbot/bin/python'} 19:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 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)) 19:27:41 INFO - Cleaning up... 19:27:41 INFO - Return code: 0 19:27:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27:41 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')]} 19:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:41 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')]} 19:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:41 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:41 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 19:27:41 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 19:27:41 INFO - Using env: {'DISPLAY': ':0', 19:27:41 INFO - 'HOME': '/home/cltbld', 19:27:41 INFO - 'LANG': 'en_US.UTF-8', 19:27:41 INFO - 'LANGUAGE': 'en_US:en', 19:27:41 INFO - 'LOGNAME': 'cltbld', 19:27:41 INFO - 'MAIL': '/var/mail/cltbld', 19:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:41 INFO - 'MOZ_NO_REMOTE': '1', 19:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:41 INFO - 'NO_EM_RESTART': '1', 19:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:41 INFO - 'PWD': '/builds/slave/test', 19:27:41 INFO - 'SHELL': '/bin/bash', 19:27:41 INFO - 'SHLVL': '1', 19:27:41 INFO - 'TERM': 'linux', 19:27:41 INFO - 'TMOUT': '86400', 19:27:41 INFO - 'USER': 'cltbld', 19:27:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:41 INFO - '_': '/tools/buildbot/bin/python'} 19:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:41 INFO - Downloading/unpacking jsonschema 19:27:41 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 19:27:41 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 19:27:41 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 19:27:41 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 19:27:41 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 19:27:41 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 19:27:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:43 INFO - Downloading/unpacking functools32 (from jsonschema) 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:43 INFO - warning: no files found matching '*.txt' 19:27:43 INFO - no previously-included directories found matching 'build' 19:27:43 INFO - no previously-included directories found matching 'dist' 19:27:43 INFO - no previously-included directories found matching '.git*' 19:27:43 INFO - Installing collected packages: jsonschema, functools32 19:27:43 INFO - Running setup.py install for functools32 19:27:43 INFO - warning: no files found matching '*.txt' 19:27:43 INFO - no previously-included directories found matching 'build' 19:27:43 INFO - no previously-included directories found matching 'dist' 19:27:43 INFO - no previously-included directories found matching '.git*' 19:27:43 INFO - Successfully installed jsonschema functools32 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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 0x7fd077274f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd6b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, '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': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', '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 19:27:43 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 19:27:43 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 19:27:43 INFO - Using env: {'DISPLAY': ':0', 19:27:43 INFO - 'HOME': '/home/cltbld', 19:27:43 INFO - 'LANG': 'en_US.UTF-8', 19:27:43 INFO - 'LANGUAGE': 'en_US:en', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MAIL': '/var/mail/cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SHLVL': '1', 19:27:43 INFO - 'TERM': 'linux', 19:27:43 INFO - 'TMOUT': '86400', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - '_': '/tools/buildbot/bin/python'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Downloading/unpacking flake8 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:27:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:27:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:27:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:27:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:27:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:27:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:27:46 INFO - no previously-included directories found matching 'docs/_build' 19:27:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:27:46 INFO - Running setup.py install for pep8 19:27:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:27:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:27:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:27:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:27:46 INFO - no previously-included directories found matching 'docs/_build' 19:27:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:27:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:27:46 INFO - Cleaning up... 19:27:46 INFO - Return code: 0 19:27:46 INFO - Running post-action listener: _resource_record_post_action 19:27:46 INFO - Running post-action listener: _start_resource_monitoring 19:27:46 INFO - Starting resource monitoring. 19:27:46 INFO - ##### 19:27:46 INFO - ##### Running install step. 19:27:46 INFO - ##### 19:27:46 INFO - Running pre-action listener: _resource_record_pre_action 19:27:46 INFO - Running main action method: install 19:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:47 INFO - Reading from file tmpfile_stdout 19:27:47 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:47 INFO - Reading from file tmpfile_stdout 19:27:47 INFO - Output received: 19:27:47 INFO - Usage: mozinstall [options] installer 19:27:47 INFO - Options: 19:27:47 INFO - -h, --help show this help message and exit 19:27:47 INFO - -d DEST, --destination=DEST 19:27:47 INFO - Directory to install application into. [default: 19:27:47 INFO - "/builds/slave/test"] 19:27:47 INFO - --app=APP Application being installed. [default: firefox] 19:27:47 INFO - mkdir: /builds/slave/test/build/application 19:27:47 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'] 19:27:47 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 19:28:00 INFO - Reading from file tmpfile_stdout 19:28:00 INFO - Output received: 19:28:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:28:00 INFO - Running post-action listener: _resource_record_post_action 19:28:00 INFO - ##### 19:28:00 INFO - ##### Running run-tests step. 19:28:00 INFO - ##### 19:28:00 INFO - Running pre-action listener: _resource_record_pre_action 19:28:00 INFO - Running main action method: run_tests 19:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:00 INFO - Python 2.7.3 19:28:00 INFO - Return code: 0 19:28:00 INFO - grabbing minidump binary from tooltool 19:28:00 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')]} 19:28:00 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 0xdfa410>, '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 0xdfb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:00 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 19:28:00 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 19:28:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:00 INFO - Return code: 0 19:28:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:28:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:28:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:28:01 INFO - Return code: 0 19:28:01 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/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 19:28:01 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/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 19:28:01 INFO - Using env: {'DISPLAY': ':0', 19:28:01 INFO - 'HOME': '/home/cltbld', 19:28:01 INFO - 'LANG': 'en_US.UTF-8', 19:28:01 INFO - 'LANGUAGE': 'en_US:en', 19:28:01 INFO - 'LOGNAME': 'cltbld', 19:28:01 INFO - 'MAIL': '/var/mail/cltbld', 19:28:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:01 INFO - 'MOZ_NO_REMOTE': '1', 19:28:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:01 INFO - 'NO_EM_RESTART': '1', 19:28:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:01 INFO - 'PWD': '/builds/slave/test', 19:28:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:01 INFO - 'SHELL': '/bin/bash', 19:28:01 INFO - 'SHLVL': '1', 19:28:01 INFO - 'TERM': 'linux', 19:28:01 INFO - 'TMOUT': '86400', 19:28:01 INFO - 'USER': 'cltbld', 19:28:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812', 19:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:01 INFO - '_': '/tools/buildbot/bin/python'} 19:28:01 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/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 19:28:01 INFO - mozversion application_buildid: 20160712164026 19:28:01 INFO - mozversion application_changeset: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 19:28:01 INFO - mozversion application_display_name: Firefox 19:28:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:01 INFO - mozversion application_name: Firefox 19:28:01 INFO - mozversion application_remotingname: firefox 19:28:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:28:01 INFO - mozversion application_vendor: Mozilla 19:28:01 INFO - mozversion application_version: 48.0 19:28:01 INFO - mozversion platform_buildid: 20160712164026 19:28:01 INFO - mozversion platform_changeset: 01aead8192bd5dca6f1dbef7424da9f0a70bc4a9 19:28:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:28:01 INFO - mozversion platform_version: 48.0 19:28:01 INFO - using testdate: 1468376881 19:28:01 INFO - actual date: 1468376881 19:28:01 INFO - starting webserver on 'localhost:40862' 19:28:01 INFO - SUITE-START | Running 2 tests 19:28:01 INFO - TEST-START | dromaeo_css 19:28:01 INFO - operating with platform_type : linux_ 19:28:01 INFO - Initialising browser for dromaeo_css test... 19:28:01 INFO - TEST-INFO | started process 29829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQu0OZo/profile http://localhost:40862/getInfo.html) 19:28:05 INFO - PROCESS | 29829 | 19:28:05 INFO - PROCESS | 29829 | (process:29906): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:06 INFO - PROCESS | 29829 | __metrics Screen width/height:1600/1200 19:28:06 INFO - PROCESS | 29829 | colorDepth:24 19:28:06 INFO - PROCESS | 29829 | Browser inner width/height: 1024/697 19:28:06 INFO - PROCESS | 29829 | __metrics 19:28:06 ERROR - PROCESS | 29829 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:28:07 INFO - TEST-INFO | 29829: exit 0 19:28:07 INFO - Browser initialized. 19:28:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:07 INFO - TEST-INFO | started process 29956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQu0OZo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:09 INFO - PROCESS | 29956 | 19:28:09 INFO - PROCESS | 29956 | (process:30023): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:19 INFO - PROCESS | 29956 | RSS: Main: 150351872 19:28:19 INFO - PROCESS | 29956 | 19:29:09 INFO - PROCESS | 29956 | 1468376949124 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] 19:31:16 INFO - PROCESS | 29956 | Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40862/tests/dromaeo/cssquery-ext.html) 19:31:17 INFO - PROCESS | 29956 | RSS: Main: 155127808 19:31:17 INFO - PROCESS | 29956 | 19:34:19 INFO - PROCESS | 29956 | Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-ext.html (next: http://localhost:40862/tests/dromaeo/cssquery-jquery.html) 19:34:19 INFO - PROCESS | 29956 | RSS: Main: 152809472 19:34:19 INFO - PROCESS | 29956 | 19:37:21 INFO - PROCESS | 29956 | Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40862/tests/dromaeo/cssquery-mootools.html) 19:37:22 INFO - PROCESS | 29956 | RSS: Main: 152535040 19:37:22 INFO - PROCESS | 29956 | 19:40:23 INFO - PROCESS | 29956 | Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40862/tests/dromaeo/cssquery-prototype.html) 19:40:24 INFO - PROCESS | 29956 | RSS: Main: 153333760 19:40:24 INFO - PROCESS | 29956 | 19:43:26 INFO - PROCESS | 29956 | Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40862/tests/dromaeo/cssquery-yui.html) 19:43:27 INFO - PROCESS | 29956 | RSS: Main: 152481792 19:43:27 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | Cycle 1(1): loaded http://localhost:40862/tests/dromaeo/cssquery-yui.html (next: http://localhost:40862/tests/dromaeo/cssquery-dojo.html) 19:46:29 INFO - PROCESS | 29956 | RSS: Main: 156504064 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | __start_tp_report 19:46:29 INFO - PROCESS | 29956 | _x_x_mozilla_page_load 19:46:29 INFO - PROCESS | 29956 | _x_x_mozilla_page_load_details 19:46:29 INFO - PROCESS | 29956 | |i|pagename|runs| 19:46:29 INFO - PROCESS | 29956 | |0;dojo.html;3350.9999999999995;3359.2777552826137;3401.710854577361;3435.759496835221;3451.206222568809;5526.557875369971;5534.363548191959;5547.861303467415;5555.250041244431;5557.221988921544;5586.608937374385;5586.692731899744;5587.217789509472;5590;5593.077142271531;5031.84904452867;5063.164577844651;5078;5093.083245015896;5105.157648987913;5047.217681259411;5080.618953578478;5162.22566615007;5209.2446595243855;5225.608079394061;5121.28302037715;5151.150060240056;5156;5200.219967004941;5258.55302299305;5148.176291793314;5170.3020092287625;5172.2241663750365;5193.169092945111;5216.921746173811;4973.229149481836;5031.974840125813;5077.720725360104;5120.078385890538;5134.435212126663;5442.210879422461;5456.727163641802;5521.199426083235;5531.695756733378;5551.666899985973;5991.071383935497;6017.939820601781;6018.368071352489;6021.397860213988;6083.330833608299;5948.315943666447;6084.482818960394;6088.786892458787;6105.755769769204;6123.2039834821635;5736.1682556029145;5751.827445176651;5756.913646295309;5762;5774.451427114417;6262.718177682015;6283.057541368831;6294.087357333161;6297.086922396318;6301.842453938597;5901.498372638288;6006.309274433496;6022.337542870281;6032.4570788629235;6070.817875463743;6056.515478761688;6057.061155520902;6058.575899687068;6062.030075188037;6089.269287685506;5957.880842383215;5991.700414979234;6012.518998480111;6020.217371741645;6030.698465076816;5938.138969849434;6047.848803779941;6099;6121.087175196906;6178;4647.86056418308;4668.996165824364;4669.252919532859;4669.556392142741;4675.976620116946;4146.709730318909;4147.212029714345;4154.293770059097;4155.8961025974595;4179.2477354076555;5774.942250577525;5778.046622307273;5786.334571524244;5802.622829516068;5822.505087067562;6046.637201767908;6065.332813390523;6070.028795392716;6105.297890742621;6114.847128821815;5631.2397826293745;5789.102689083199;5830.883382332329;5838.38696936824;5843.649381037151;5084.46613105626;5140.974295128501;5158.252053452228;5168.508991645787;5200.97399513;6364.395382438661;6375.585586936927;6406.103145559626;6412.935870641327;6451.0645956337;5994.250718660168;6071.635701857815;6076.90884636722;6084;6128.662923539248;6322.715477803418;6405.327440618668;6406.295307516077;6413.7113829876835;6420.486361091195;5985.132155837467;6006.969965150146;6016.729247183975;6020.729067191899;6020.789272375446;5855.38518455556;6048.727807248596;6103.511719062553;6116.822755456359;6144.600600960924;5994.10088486713;6018;6030.969845150747;6035.034394496859;6046;5913.2608423947;5980.910286345621;6007.7596896125415;6021.729022194099;6048;5767.394423585463;5776.855578610568;5810.593258472036;5862.94137058624;5874;5866.208061911758;5916.349201587908;5959.76160953557;5965.463108320272;5971.850703732442;5760.1935728998815;5770.221020162225;5774.1916131740745;5780.075187969905;5788 19:46:29 INFO - PROCESS | 29956 | |1;ext.html;661.1867403094194;681.0975457518782;691.0394551573312;731.9853602927944;750.3696894608528;31932.20169495761;32737.345253094925;40798.38802417962;41422.58577414225;41454.7927260364;43975.560244397544;44348.33477497832;44461.333080003824;44586;44669.55330446694;8698.739037828875;8853.203211710945;8861.556922153899;8865.379423440361;8867;8701.347398945072;8796.164364385373;8799.252063574604;8806.779830504256;8824.8676269856;8973.77565560863;9014.36899417041;9023.909760902372;9033.774155646095;9077.546122693871;8930.151635594608;8992.505412202327;8993.820123597558;9029.142231487998;9055.909440905572;8907.242884354837;8982.910170898273;9031.322650801216;9038.457692538403;9080.727578172666;44240.3363949541;44571.77714111441;44769.10461790746;44776.77611611954;44780.10439791218;3810.2569998850236;3858.4212368145004;3916.725829191958;4000.4799376080923;4135.7518548886865;33870.83064584686;34054.31891362159;34233.14417139567;34624.30751384983;34631.13422164441;4348.630366418858;4386.188555117282;4418.1384629997165;4440.622547083502;4501.932471012905;321662;322658.3867080673;322791;323050;324374;59216.703916481005;59269.40730592639;59430.70284648549;59481.70259148676;59711.40288597145;64986;65193.67403162954;65222.347776522576;69582.30417695758;71375.28624713686;18255;18269.45191644253;18289.908550457163;18295.81704182941;18382.264709411473;13789.172649641054;13942.86057139436;13950.302484875716;13952.093113947562;14059.156450612996;20922;21062.47343816417;21079.367618971457;21146.259880904094;21169.57660846805;7582.241775822374;7667.808304792425;7765.184655611192;7887.526748395115;7920.920790792134;1093.338530189224;1116.4361997191365;1127.4081107418672;1178.6817559258952;1189.2270024483983;31050.84474577658;31384.529232061537;31421.685783142333;31879.362412752078;32158.35683286368;1181.007953319216;1254.4292346982102;1291.599604122725;1305.3277562055548;1335.3857225676297;16409.42567010149;16478;16745.158032616404;16819.663606727798;17065.573360665836;492339;571830;901784;918082;925131;63015.369846301866;64295.357046429875;64326;64392.67803660952;64649.35350646434;1488.5311126994961;1532.3793863485307;1541.3141152187393;1546.5515000649686;1564.9921750391402;32572.83713581417;32628;33708.49437258394;33796.493052604725;34217.31565368629;53992.46007539874;54598.727006364716;55021.724891375285;55022.72488637531;55031.72484137554;443915;446440;448252;448788;449607;27813.582796258477;28072.578911315937;46954.53045469638;47386.28920566263;47930.76034619805;46540.30189547092;46901;47362.28956565723;47951.5204847947;48177.27734083922;39019.804900975316;39331.60668393394;39335.213295734495;40007;40307.79846100751;38237.61762382452;39125.6087439122;39232.607673922896;39454.210915782096;39517.80241098776;42720.78639606782;43291.78354108209;43296.13407731891;43816;44049;36406.45390319201;36862;37007.62992370042;37240.44139337966;37259.6274037267;28159.43681126407;28291.2927176814;28581.428371432037;28638.713612864438;28855.278618034718 19:46:29 INFO - PROCESS | 29956 | |2;jquery.html;413.3324680640766;414.93775933609976;415.6591594892188;423.27197220780255;430.7028150576102;18609.906950465247;18929;19234.422967310984;19245.422637320884;19837.206511739514;19018.61962760744;19419.708704369412;19458.610827783436;20202.59594808103;20590.588188236226;5662.858428539299;5731.083026715726;5868.471837534621;5969.731362088694;5973.402659734035;5698.458646428583;5787.276590426197;5799.536037117042;5811.215485909391;5818.156367326735;5635.492805647491;5805.709714514279;5818.767249310023;5842.649441033552;5865.208196893429;5807.390224026459;5822.039363505017;5832.533397328203;5863.091220860773;5864.472197502245;5092.821751238689;5238.319018527605;5247.790088396459;5254;5273.393559740641;23837;23996;24174.274771756875;24358.26925192247;24382.634260486106;2561.3724637463756;2565.7819085377764;2580.832245904029;2587.430765231646;2750.4499100179846;14805.851941480554;15112.244387780676;15188.848111518853;15315.846841531553;15565.610859728484;2052.5997430501056;2072.347210628662;2106.7787882272296;2135.9572808543744;2143.9249626263163;74341.62829185874;74621;75779.62110189469;78165.60917195435;78869.21130788734;10363.274570779973;11279.436028198721;11457.71355716097;11755.471003804849;11863.46614402354;16102.919485402497;16113.838861611468;16163.43427980015;16187.757183642254;16209.432669856498;8723.302135829246;8966.237869781142;8978.820423591622;9019;9024.8646270306;8577.871331930026;8771.824563508693;8794.692185773467;8807;8815.691450799191;4838.104950584153;4931.7040977541465;4934.1118598651865;4961.479044700327;5023.547880690755;1962.9411117666493;2090.397455168325;2124.6069477146775;2153.6554151335713;2154.7737487563895;984.8178087053918;1053.4777246878186;1100.2243418390017;1101.983470247947;1184.8518935133109;19374.90312548428;19446.8055319445;19554;19792.505187370432;20040.89979550093;1057.3655806516028;1083.539495714334;1121.5009320852143;1128.6692978998342;1149.9540018399337;10661.307015043998;11002.669919902415;11109.111271098292;11133.220674552866;11178.776424471627;405322;406370;414610;416093;510695;100188.49905750425;102047.4897625522;103697.48151259196;104144;106599.46700266449;1137.3801278303345;1146.7133216695827;1165.5862168930078;1175.9706007350055;1189.1854079955258;17320;17945.371911983017;17997.910010449865;18109.728354074963;18327.908360458114;37071.07322316964;41675.58324416838;41713.791431043865;42289.365659515744;42467.787661062735;59713.70143149256;59884;60173.39826601678;60278.397216027275;60579.69710151597;8592.527410992456;8788.736337909873;8802.295816334807;8803.779905502157;8933.910660893307;13438.932805335911;13590;13715.519956801463;13767.242801645605;13805.24071176095;11556;11941.880581194077;12007.879921201025;12100.334481603597;12106.213096148722;11911.940440297743;11923.523059077887;12037.03703703684;12264.325462099314;12290.508379664714;12415.503379864704;12470.064745143969;12683.746325073631;12833.101682882108;13265.46938122503;8715.564221788758;8885.689000884939;8933.28533717314;9013.909860901307;9073.31950103758;11754.76490470203;12821.102522823312;12863.549775757803;12891.548795792101;12981.221126732426 19:46:29 INFO - PROCESS | 29956 | |3;mootools.html;1564.0381165583162;1565.6399028223507;1792.0054369824743;1943.1547276934534;1951.541387773872;8446.91553084469;8584.871226931593;8724.476531408103;8752.168543988319;8815.911840881598;8864;8865.468071915673;8958.37291389603;8960.686375976842;8975.461472311667;2417.697787776528;2427.2111563741764;2431.63525471179;2442.5969714997095;2444.8044156467527;2489.962650560243;2502.0367158643962;2526.178991827654;2532.8353657012326;2537.53055684698;2384.0582969726947;2411.5176964607062;2452.7424620414868;2454.2514533067406;2457.7910877575337;2395.73646898841;2416.854988700666;2418.733939266679;2423.5152969406013;2427.635854621812;2418.6130219165025;2437.1348171399077;2450.644656524794;2462.704475462938;2468.062136388179;8903.287736981027;8941.50821704806;8952.776180595472;8965.551722413853;8980;5187.714675692835;5225.790968361261;5280.049591073605;5317.9202311965355;5325.680459172462;3411.385950528904;3417.2140407706365;3444.810535420551;3468.549088618489;3499.9650003500146;1064.3454275620516;1089.54239219528;1092.2190633696946;1093.2238110941241;1095.2771171027164;11810.468528916133;11902.642920712393;11994.820077698841;12003.039756819433;12017.098717596127;4638.79125439356;4667.743274119956;4672.322513235562;4776.307435421844;4803.327534145223;9589.280803939733;9666.661666841626;9676.661316854017;9694.61221551144;9709.708708738608;5279.630425870152;5309.203619457112;5315.415304316522;5322.92015619766;5333.893322133536;4837.7097374157665;4960.925586116211;5003.74981250936;5017.724025178577;5043.420006699276;4059.65492933104;4125.281190517402;4162.313218318944;4189.476315460567;4211.957880421218;1254.5196667931746;1255.6358655989661;1257.5472829781272;1265.6266401411606;1277.3485522383467;991.9156871665989;1095.1129585036147;1096.6107032003683;1102.2339474065448;1111.9499622517005;5920.644761314335;5954.791582294599;6047.576669633171;6088.330283668793;6170.413810688067;471.3730738118363;475.9904801904012;477.44377799863463;479.6834089500913;489.6058672768456;4564.292534657134;4616.422947131608;4649.95350046502;4672.345871577982;4673.182193116259;10611.31026483276;10675.039246467855;10772.030517253485;10773.569057237622;10788.78422431547;10150.746231344276;10611.363318200933;10687.89312106869;10706.304090234109;10746.301490403099;8158.143394943446;8331.16688331162;8352.0812710603;8361.372897032625;8391.328693704489;6024.728887199999;6138.662373569497;6188.938110618837;6206.317305096345;6291.779787707408;9507.144357007903;9517.762055948657;9656.37233579815;9676.70969870905;9694.85457718149;9257.444553326823;9635.951820240854;9645.855312170463;9680.27397945143;9857;6962.443004559725;7798.610069496389;7920.683172673029;8164.632591533514;8463.322934165375;8541.743747687578;8551.615177316911;8572.657093716181;8580.699675511327;8607.48355098696;7462;7710.383169346551;7715.42134339938;7791.727289544839;7846.882296765667;7443.55338679681;7621.352185064332;7679.078510578766;7719.343855772322;7762;7159.498835081703;7203.819904502429;7277.417806575567;7364.263573642593;7380.741674041383;5351.357837059578;5402.838389746224;5487.6158668892795;5532.806351777668;5566.582506311962;5385;5490.752916118704;5502.532284755841;5530.281063461724;5622.32532096151 19:46:29 INFO - PROCESS | 29956 | |4;prototype.html;334.2446071877558;348.70534398433347;348.74890079143023;349.0157755130532;350.09849637184254;6409.487241020719;6462.709178086986;6546.279909209983;6633.3698298661675;6636.502262330327;6494.707738151783;6505.349465053492;6520.119783829182;6549.115869357635;6559.475241980642;4818.51814818518;4874.3419638348905;4879.463259041502;4880.292357608145;4891.241857512074;4867.440244371907;4870.902581948359;4878.219484882419;4881.755912204376;4884.926726099111;4822.4936381679945;4826.806927722887;4828.985912958283;4834.1540230459705;4837.903241935159;4785.4735979042625;4814.422269327703;4836.782344794475;4850.66045376822;4850.951490485103;4208.200441916057;4221.24017676818;4222.78886055696;4238.830446782125;4239.364095385686;6293.1504246927;6303.401176888188;6304.369563043705;6316.147320111818;6316.652584107872;5670.376258611549;5679.460451257124;5683.175939488751;5691.544676425918;5708.743106560173;6890.414314783249;6895;6905.792826215222;6924.065251191075;6954.687039083254;4457.799399027052;4708.152532544141;4709.71741695496;4717.764111794397;4723.07899959508;7116.857662846766;7138.571685698875;7152.642367881637;7184.892226616605;7221.711131554732;4698.694584851974;4716.976415117971;4728.101660684459;4732.668713190113;4754.619630429557;4778.307145463958;4786.928196077061;4789.161896668069;4790.760461976887;4799.256115302133;5617.803376881871;5621.747021384048;5631;5639.041362968305;5649.378568357477;6789.796306110825;6947.687354069079;6950.79147625572;6953;6959.373656370951;1656.1139790212178;1669.1654172913543;1681.428314373119;1682.2766210529346;1683.9410620628219;1073.061071562383;1073.7100982734619;1079.7408621930838;1087.211771465681;1089.624079692505;6648.800535983928;6759.391654751096;6762.459003279726;6827.931720682829;6833.453323734089;7124.608146551989;7126.073610430714;7165.0685410897295;7224.349808517259;7226.855462890818;6762.69567869447;6780.762673306411;6817.761378351734;6832.180138383326;6844.384005439534;3857.9614203858164;3881.5536213335827;3892.6107389260847;3898.785566793797;3904.472896159039;7333.74331898381;7649.38804895607;7653.732119375795;7655.846883062419;7663.31030207284;7343.1555371131935;7364.742234021891;7367.18960914299;7368;7386.852262954711;7542.2834830691;7621.809454763676;7630.847383052308;7638.732644357421;7650.6174691264105;6918.169819621477;7142.928570714226;7186.389156921511;7205.531640443354;7208.927910721035;7049.400800931979;7100.573965562083;7100.928990710234;7103.680334384861;7162.391196748126;7626.046744156981;7630.2751238632245;7644.464887457824;7653.502522336031;7683.538987660758;4639.257718764981;4681.250999840009;4683.601893838925;4685.437747470325;4693.882652933567;7073.929260707533;7214.567125972459;7226.819329516804;7231.855362892607;7236.927630723625;6983.720651173896;6984.882418812966;6984.895226571504;6989.825254368681;6998.125234345707;6928.722851086101;6930.930690693231;6939.097917270722;6951.304869513008;6957.8956315654295;6833.086735714008;6852.760153394806;6862.348076932683;6866.896996544956;6885.104936358442;6833.111695479556;6984.2317345093015;6992.405645520188;7004.929950700428;7009.228984811564;6632.83417914556;6846.212685541226;6862.691178896862;6868;6897.89653155193 19:46:29 INFO - PROCESS | 29956 | |5;yui.html;850.7447765670299;916.7433118726759;930.7998780262242;935.2471260635189;947.478886612363;15236.162011089385;15625.531234062968;16748.832511674897;17224;17242.913785431087;15820;15972.201389930515;15982.520524384287;16000.679986400264;16009.83990160098;892.1168043636818;897.2642433204791;912.0742446416859;918.5636822509322;924.9537523123851;918.673870775875;921.8847644044495;922.23454532738;923.3029063057415;924.0851556958596;954.0983770337034;958.1616085924816;958.4632605740773;958.918491928187;959.1128206409079;948.4309414351403;951.0632027452954;951.4196340232453;952.9904700952972;954.8567714842794;696.3245651717825;697.3584302441766;698.601796975724;700.3556727810427;701.3162166887295;15780.526584202493;15859.127747973856;15861;15924.044557326597;15945.123018233993;14596.562103136923;14733.852661473462;14753.483628072965;14768.704625907529;14800.629984250372;11912.940435297854;12022.458989345501;12032.87967120335;12080.275183489019;12372.44324005413;3874.341361968472;3909.5894931032117;3980.8208630611402;3994.820233089518;4068.3694027425795;58796.41203587952;58946.70526647339;58967.99999999957;59057.40942590605;59912.70043649754;11789.764204715857;11796.174267801343;11825.763484730258;11865.110116741278;11974.161808673309;20130.597388052156;20140.093695783726;20140.992950352425;20141;20158;8439.873401898976;8521.318294536422;8578.09929957358;8613.956930215434;8649.135086491426;4732.077244937204;4777.068471648065;4882.389701287339;4889.853304400803;4894.730789806524;3644.599094099647;3698;3700.9444858327147;3706.1105334720014;3708.072981754561;642.7204166187723;658.6937074260396;660.3462572053633;668.6255696809704;669.9631520266335;726.9055022846997;742.8440027594157;752.3492179264897;819.4304958054095;836.573347592732;9598.712038638852;9809.362391444532;10213.285070045025;10434.478276086316;10450.738731531772;682.205230905989;786.6656670914838;788.7673136424769;819.692615269274;834.2741814621319;4750.14497390473;5098.46466121052;5138.794448222104;5150.716710580954;5274.762635681327;65729;66720.33279667239;66848;67282.66358668175;67478.32521674721;58588.41411585915;58850.411495885346;60213.39786602078;60728.392716073155;61148.388516115156;52152.739236303576;53325;53689.46310536923;53894;54258.45741542613;10011.499425028866;10019.477600759184;10076.798464030531;10283.280170388001;10284.588616455258;38424.2315153701;38741.41887871628;39796;39809.80095099506;40488.59511404966;53511.732441337546;54573.727131365675;54764.726176368866;56877.431225687214;59126.40873591209;13828;13958.581242562334;14099.718005640036;14389.784153237919;14422.350994205077;13114.73770524565;14606.85393146055;14669.706605868036;14990;15181.6204594886;13994;14025.719485610027;14039.649008774863;14116.364763585869;14394.136351818925;13940.442382304595;14034;14133.363998619881;14436.133831970115;14470.059446135967;12961.416736246703;13432.865671343161;13539.526116585872;13859.584212473643;14191.361388737325;11264.83102753443;11332.263402878787;11442.256253343507;11714;11853.525858965544;11688.977612720584;11836.112291577994;11921;11992.340421276913;11999.100067495147 19:46:29 INFO - PROCESS | 29956 | __end_tp_report 19:46:29 INFO - PROCESS | 29956 | __start_cc_report 19:46:29 INFO - PROCESS | 29956 | _x_x_mozilla_cycle_collect,324 19:46:29 INFO - PROCESS | 29956 | __end_cc_report 19:46:29 INFO - PROCESS | 29956 | __startTimestamp1468377989699__endTimestamp 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | ------- Summary: start ------- 19:46:29 INFO - PROCESS | 29956 | Number of tests: 6 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | [#0] dojo.html Cycles:165 Average:5638.83 Median:5843.65 stddev:641.89 (11.0%) stddev-sans-first:618.26 19:46:29 INFO - PROCESS | 29956 | Values: 3351.0 3359.3 3401.7 3435.8 3451.2 5526.6 5534.4 5547.9 5555.3 5557.2 5586.6 5586.7 5587.2 5590.0 5593.1 5031.8 5063.2 5078.0 5093.1 5105.2 5047.2 5080.6 5162.2 5209.2 5225.6 5121.3 5151.2 5156.0 5200.2 5258.6 5148.2 5170.3 5172.2 5193.2 5216.9 4973.2 5032.0 5077.7 5120.1 5134.4 5442.2 5456.7 5521.2 5531.7 5551.7 5991.1 6017.9 6018.4 6021.4 6083.3 5948.3 6084.5 6088.8 6105.8 6123.2 5736.2 5751.8 5756.9 5762.0 5774.5 6262.7 6283.1 6294.1 6297.1 6301.8 5901.5 6006.3 6022.3 6032.5 6070.8 6056.5 6057.1 6058.6 6062.0 6089.3 5957.9 5991.7 6012.5 6020.2 6030.7 5938.1 6047.8 6099.0 6121.1 6178.0 4647.9 4669.0 4669.3 4669.6 4676.0 4146.7 4147.2 4154.3 4155.9 4179.2 5774.9 5778.0 5786.3 5802.6 5822.5 6046.6 6065.3 6070.0 6105.3 6114.8 5631.2 5789.1 5830.9 5838.4 5843.6 5084.5 5141.0 5158.3 5168.5 5201.0 6364.4 6375.6 6406.1 6412.9 6451.1 5994.3 6071.6 6076.9 6084.0 6128.7 6322.7 6405.3 6406.3 6413.7 6420.5 5985.1 6007.0 6016.7 6020.7 6020.8 5855.4 6048.7 6103.5 6116.8 6144.6 5994.1 6018.0 6031.0 6035.0 6046.0 5913.3 5980.9 6007.8 6021.7 6048.0 5767.4 5776.9 5810.6 5862.9 5874.0 5866.2 5916.3 5959.8 5965.5 5971.9 5760.2 5770.2 5774.2 5780.1 5788.0 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | [#1] ext.html Cycles:180 Average:67047.98 Median:24082.32 stddev:149071.69 (619.0%) stddev-sans-first:149406.55 19:46:29 INFO - PROCESS | 29956 | Values: 661.2 681.1 691.0 732.0 750.4 31932.2 32737.3 40798.4 41422.6 41454.8 43975.6 44348.3 44461.3 44586.0 44669.6 8698.7 8853.2 8861.6 8865.4 8867.0 8701.3 8796.2 8799.3 8806.8 8824.9 8973.8 9014.4 9023.9 9033.8 9077.5 8930.2 8992.5 8993.8 9029.1 9055.9 8907.2 8982.9 9031.3 9038.5 9080.7 44240.3 44571.8 44769.1 44776.8 44780.1 3810.3 3858.4 3916.7 4000.5 4135.8 33870.8 34054.3 34233.1 34624.3 34631.1 4348.6 4386.2 4418.1 4440.6 4501.9 321662.0 322658.4 322791.0 323050.0 324374.0 59216.7 59269.4 59430.7 59481.7 59711.4 64986.0 65193.7 65222.3 69582.3 71375.3 18255.0 18269.5 18289.9 18295.8 18382.3 13789.2 13942.9 13950.3 13952.1 14059.2 20922.0 21062.5 21079.4 21146.3 21169.6 7582.2 7667.8 7765.2 7887.5 7920.9 1093.3 1116.4 1127.4 1178.7 1189.2 31050.8 31384.5 31421.7 31879.4 32158.4 1181.0 1254.4 1291.6 1305.3 1335.4 16409.4 16478.0 16745.2 16819.7 17065.6 492339.0 571830.0 901784.0 918082.0 925131.0 63015.4 64295.4 64326.0 64392.7 64649.4 1488.5 1532.4 1541.3 1546.6 1565.0 32572.8 32628.0 33708.5 33796.5 34217.3 53992.5 54598.7 55021.7 55022.7 55031.7 443915.0 446440.0 448252.0 448788.0 449607.0 27813.6 28072.6 46954.5 47386.3 47930.8 46540.3 46901.0 47362.3 47951.5 48177.3 39019.8 39331.6 39335.2 40007.0 40307.8 38237.6 39125.6 39232.6 39454.2 39517.8 42720.8 43291.8 43296.1 43816.0 44049.0 36406.5 36862.0 37007.6 37240.4 37259.6 28159.4 28291.3 28581.4 28638.7 28855.3 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | [#2] jquery.html Cycles:180 Average:28009.00 Median:2139.94 stddev:71835.59 (3356.9%) stddev-sans-first:72007.23 19:46:29 INFO - PROCESS | 29956 | Values: 413.3 414.9 415.7 423.3 430.7 18609.9 18929.0 19234.4 19245.4 19837.2 19018.6 19419.7 19458.6 20202.6 20590.6 5662.9 5731.1 5868.5 5969.7 5973.4 5698.5 5787.3 5799.5 5811.2 5818.2 5635.5 5805.7 5818.8 5842.6 5865.2 5807.4 5822.0 5832.5 5863.1 5864.5 5092.8 5238.3 5247.8 5254.0 5273.4 23837.0 23996.0 24174.3 24358.3 24382.6 2561.4 2565.8 2580.8 2587.4 2750.4 14805.9 15112.2 15188.8 15315.8 15565.6 2052.6 2072.3 2106.8 2136.0 2143.9 74341.6 74621.0 75779.6 78165.6 78869.2 10363.3 11279.4 11457.7 11755.5 11863.5 16102.9 16113.8 16163.4 16187.8 16209.4 8723.3 8966.2 8978.8 9019.0 9024.9 8577.9 8771.8 8794.7 8807.0 8815.7 4838.1 4931.7 4934.1 4961.5 5023.5 1962.9 2090.4 2124.6 2153.7 2154.8 984.8 1053.5 1100.2 1102.0 1184.9 19374.9 19446.8 19554.0 19792.5 20040.9 1057.4 1083.5 1121.5 1128.7 1150.0 10661.3 11002.7 11109.1 11133.2 11178.8 405322.0 406370.0 414610.0 416093.0 510695.0 100188.5 102047.5 103697.5 104144.0 106599.5 1137.4 1146.7 1165.6 1176.0 1189.2 17320.0 17945.4 17997.9 18109.7 18327.9 37071.1 41675.6 41713.8 42289.4 42467.8 59713.7 59884.0 60173.4 60278.4 60579.7 8592.5 8788.7 8802.3 8803.8 8933.9 13438.9 13590.0 13715.5 13767.2 13805.2 11556.0 11941.9 12007.9 12100.3 12106.2 11911.9 11923.5 12037.0 12264.3 12290.5 12415.5 12470.1 12683.7 12833.1 13265.5 8715.6 8885.7 8933.3 9013.9 9073.3 11754.8 12821.1 12863.5 12891.5 12981.2 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | [#3] mootools.html Cycles:180 Average:5823.79 Median:5252.71 stddev:3184.25 (60.6%) stddev-sans-first:3177.09 19:46:29 INFO - PROCESS | 29956 | Values: 1564.0 1565.6 1792.0 1943.2 1951.5 8446.9 8584.9 8724.5 8752.2 8815.9 8864.0 8865.5 8958.4 8960.7 8975.5 2417.7 2427.2 2431.6 2442.6 2444.8 2490.0 2502.0 2526.2 2532.8 2537.5 2384.1 2411.5 2452.7 2454.3 2457.8 2395.7 2416.9 2418.7 2423.5 2427.6 2418.6 2437.1 2450.6 2462.7 2468.1 8903.3 8941.5 8952.8 8965.6 8980.0 5187.7 5225.8 5280.0 5317.9 5325.7 3411.4 3417.2 3444.8 3468.5 3500.0 1064.3 1089.5 1092.2 1093.2 1095.3 11810.5 11902.6 11994.8 12003.0 12017.1 4638.8 4667.7 4672.3 4776.3 4803.3 9589.3 9666.7 9676.7 9694.6 9709.7 5279.6 5309.2 5315.4 5322.9 5333.9 4837.7 4960.9 5003.7 5017.7 5043.4 4059.7 4125.3 4162.3 4189.5 4212.0 1254.5 1255.6 1257.5 1265.6 1277.3 991.9 1095.1 1096.6 1102.2 1111.9 5920.6 5954.8 6047.6 6088.3 6170.4 471.4 476.0 477.4 479.7 489.6 4564.3 4616.4 4650.0 4672.3 4673.2 10611.3 10675.0 10772.0 10773.6 10788.8 10150.7 10611.4 10687.9 10706.3 10746.3 8158.1 8331.2 8352.1 8361.4 8391.3 6024.7 6138.7 6188.9 6206.3 6291.8 9507.1 9517.8 9656.4 9676.7 9694.9 9257.4 9636.0 9645.9 9680.3 9857.0 6962.4 7798.6 7920.7 8164.6 8463.3 8541.7 8551.6 8572.7 8580.7 8607.5 7462.0 7710.4 7715.4 7791.7 7846.9 7443.6 7621.4 7679.1 7719.3 7762.0 7159.5 7203.8 7277.4 7364.3 7380.7 5351.4 5402.8 5487.6 5532.8 5566.6 5385.0 5490.8 5502.5 5530.3 5622.3 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | [#4] prototype.html Cycles:180 Average:5781.56 Median:6642.65 stddev:1809.18 (27.2%) stddev-sans-first:1767.45 19:46:29 INFO - PROCESS | 29956 | Values: 334.2 348.7 348.7 349.0 350.1 6409.5 6462.7 6546.3 6633.4 6636.5 6494.7 6505.3 6520.1 6549.1 6559.5 4818.5 4874.3 4879.5 4880.3 4891.2 4867.4 4870.9 4878.2 4881.8 4884.9 4822.5 4826.8 4829.0 4834.2 4837.9 4785.5 4814.4 4836.8 4850.7 4851.0 4208.2 4221.2 4222.8 4238.8 4239.4 6293.2 6303.4 6304.4 6316.1 6316.7 5670.4 5679.5 5683.2 5691.5 5708.7 6890.4 6895.0 6905.8 6924.1 6954.7 4457.8 4708.2 4709.7 4717.8 4723.1 7116.9 7138.6 7152.6 7184.9 7221.7 4698.7 4717.0 4728.1 4732.7 4754.6 4778.3 4786.9 4789.2 4790.8 4799.3 5617.8 5621.7 5631.0 5639.0 5649.4 6789.8 6947.7 6950.8 6953.0 6959.4 1656.1 1669.2 1681.4 1682.3 1683.9 1073.1 1073.7 1079.7 1087.2 1089.6 6648.8 6759.4 6762.5 6827.9 6833.5 7124.6 7126.1 7165.1 7224.3 7226.9 6762.7 6780.8 6817.8 6832.2 6844.4 3858.0 3881.6 3892.6 3898.8 3904.5 7333.7 7649.4 7653.7 7655.8 7663.3 7343.2 7364.7 7367.2 7368.0 7386.9 7542.3 7621.8 7630.8 7638.7 7650.6 6918.2 7142.9 7186.4 7205.5 7208.9 7049.4 7100.6 7100.9 7103.7 7162.4 7626.0 7630.3 7644.5 7653.5 7683.5 4639.3 4681.3 4683.6 4685.4 4693.9 7073.9 7214.6 7226.8 7231.9 7236.9 6983.7 6984.9 6984.9 6989.8 6998.1 6928.7 6930.9 6939.1 6951.3 6957.9 6833.1 6852.8 6862.3 6866.9 6885.1 6833.1 6984.2 6992.4 7004.9 7009.2 6632.8 6846.2 6862.7 6868.0 6897.9 19:46:29 INFO - PROCESS | 29956 | 19:46:29 INFO - PROCESS | 29956 | [#5] yui.html Cycles:180 Average:16375.40 Median:22241.71 stddev:18870.69 (84.8%) stddev-sans-first:18887.61 19:46:29 INFO - PROCESS | 29956 | Values: 850.7 916.7 930.8 935.2 947.5 15236.2 15625.5 16748.8 17224.0 17242.9 15820.0 15972.2 15982.5 16000.7 16009.8 892.1 897.3 912.1 918.6 925.0 918.7 921.9 922.2 923.3 924.1 954.1 958.2 958.5 958.9 959.1 948.4 951.1 951.4 953.0 954.9 696.3 697.4 698.6 700.4 701.3 15780.5 15859.1 15861.0 15924.0 15945.1 14596.6 14733.9 14753.5 14768.7 14800.6 11912.9 12022.5 12032.9 12080.3 12372.4 3874.3 3909.6 3980.8 3994.8 4068.4 58796.4 58946.7 58968.0 59057.4 59912.7 11789.8 11796.2 11825.8 11865.1 11974.2 20130.6 20140.1 20141.0 20141.0 20158.0 8439.9 8521.3 8578.1 8614.0 8649.1 4732.1 4777.1 4882.4 4889.9 4894.7 3644.6 3698.0 3700.9 3706.1 3708.1 642.7 658.7 660.3 668.6 670.0 726.9 742.8 752.3 819.4 836.6 9598.7 9809.4 10213.3 10434.5 10450.7 682.2 786.7 788.8 819.7 834.3 4750.1 5098.5 5138.8 5150.7 5274.8 65729.0 66720.3 66848.0 67282.7 67478.3 58588.4 58850.4 60213.4 60728.4 61148.4 52152.7 53325.0 53689.5 53894.0 54258.5 10011.5 10019.5 10076.8 10283.3 10284.6 38424.2 38741.4 39796.0 39809.8 40488.6 53511.7 54573.7 54764.7 56877.4 59126.4 13828.0 13958.6 14099.7 14389.8 14422.4 13114.7 14606.9 14669.7 14990.0 15181.6 13994.0 14025.7 14039.6 14116.4 14394.1 13940.4 14034.0 14133.4 14436.1 14470.1 12961.4 13432.9 13539.5 13859.6 14191.4 11264.8 11332.3 11442.3 11714.0 11853.5 11689.0 11836.1 11921.0 11992.3 11999.1 19:46:29 INFO - PROCESS | 29956 | -------- Summary: end -------- 19:46:29 INFO - PROCESS | 29956 | 19:46:30 INFO - TEST-INFO | 29956: exit 0 19:46:30 INFO - TEST-OK | dromaeo_css | took 1108791ms 19:46:30 INFO - TEST-START | kraken 19:46:30 INFO - operating with platform_type : linux_ 19:46:30 INFO - Initialising browser for kraken test... 19:46:30 INFO - TEST-INFO | started process 30196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIduw8/profile http://localhost:40862/getInfo.html) 19:46:33 INFO - PROCESS | 30196 | 19:46:33 INFO - PROCESS | 30196 | (process:30274): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:46:34 INFO - PROCESS | 30196 | __metrics Screen width/height:1600/1200 19:46:34 INFO - PROCESS | 30196 | colorDepth:24 19:46:34 INFO - PROCESS | 30196 | Browser inner width/height: 1024/697 19:46:34 INFO - PROCESS | 30196 | __metrics 19:46:35 ERROR - PROCESS | 30196 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:46:36 INFO - TEST-INFO | 30196: exit 0 19:46:36 INFO - Browser initialized. 19:46:36 INFO - Running cycle 1/1 for kraken test... 19:46:36 INFO - TEST-INFO | started process 30324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIduw8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:37 INFO - PROCESS | 30324 | 19:46:37 INFO - PROCESS | 30324 | (process:30392): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:46:47 INFO - PROCESS | 30324 | RSS: Main: 150306816 19:46:47 INFO - PROCESS | 30324 | 19:46:50 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-beat-detection) 19:46:51 INFO - PROCESS | 30324 | RSS: Main: 155742208 19:46:51 INFO - PROCESS | 30324 | 19:46:53 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-dft) 19:46:54 INFO - PROCESS | 30324 | RSS: Main: 155512832 19:46:54 INFO - PROCESS | 30324 | 19:46:57 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-fft) 19:46:57 INFO - PROCESS | 30324 | RSS: Main: 155815936 19:46:57 INFO - PROCESS | 30324 | 19:47:00 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40862/tests/kraken/driver.html?testName=audio-oscillator) 19:47:00 INFO - PROCESS | 30324 | RSS: Main: 155828224 19:47:00 INFO - PROCESS | 30324 | 19:47:02 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:03 INFO - PROCESS | 30324 | RSS: Main: 155598848 19:47:03 INFO - PROCESS | 30324 | 19:47:06 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40862/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:07 INFO - PROCESS | 30324 | RSS: Main: 156278784 19:47:07 INFO - PROCESS | 30324 | 19:47:10 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40862/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:11 INFO - PROCESS | 30324 | RSS: Main: 156082176 19:47:11 INFO - PROCESS | 30324 | 19:47:13 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40862/tests/kraken/driver.html?testName=json-parse-financial) 19:47:14 INFO - PROCESS | 30324 | RSS: Main: 156102656 19:47:14 INFO - PROCESS | 30324 | 19:47:16 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:16 INFO - PROCESS | 30324 | RSS: Main: 155783168 19:47:16 INFO - PROCESS | 30324 | 19:47:18 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:19 INFO - PROCESS | 30324 | RSS: Main: 155766784 19:47:19 INFO - PROCESS | 30324 | 19:47:20 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:21 INFO - PROCESS | 30324 | RSS: Main: 156168192 19:47:21 INFO - PROCESS | 30324 | 19:47:24 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:24 INFO - PROCESS | 30324 | RSS: Main: 156585984 19:47:24 INFO - PROCESS | 30324 | 19:47:27 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:28 INFO - PROCESS | 30324 | RSS: Main: 156610560 19:47:28 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | Cycle 1(1): loaded http://localhost:40862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40862/tests/kraken/driver.html?testName=ai-astar) 19:47:29 INFO - PROCESS | 30324 | RSS: Main: 157978624 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | __start_tp_report 19:47:29 INFO - PROCESS | 30324 | _x_x_mozilla_page_load 19:47:29 INFO - PROCESS | 30324 | _x_x_mozilla_page_load_details 19:47:29 INFO - PROCESS | 30324 | |i|pagename|runs| 19:47:29 INFO - PROCESS | 30324 | |0;ai-astar;108;111;104;109;113;112;102;113;111;111 19:47:29 INFO - PROCESS | 30324 | |1;audio-beat-detection;154;133;160;169;127;152;160;129;173;135 19:47:29 INFO - PROCESS | 30324 | |2;audio-dft;162;163;163;162;163;161;162;163;162;163 19:47:29 INFO - PROCESS | 30324 | |3;audio-fft;78;74;78;168;72;75;76;74;176;79 19:47:29 INFO - PROCESS | 30324 | |4;audio-oscillator;92;91;158;92;92;91;158;92;91;148 19:47:29 INFO - PROCESS | 30324 | |5;imaging-gaussian-blur;118;117;116;117;117;116;117;121;117;118 19:47:29 INFO - PROCESS | 30324 | |6;imaging-darkroom;146;147;148;146;146;146;147;146;146;146 19:47:29 INFO - PROCESS | 30324 | |7;imaging-desaturate;95;95;97;96;95;96;95;94;95;95 19:47:29 INFO - PROCESS | 30324 | |8;json-parse-financial;60;57;57;55;58;57;57;74;55;56 19:47:29 INFO - PROCESS | 30324 | |9;json-stringify-tinderbox;57;57;56;58;58;58;58;57;57;57 19:47:29 INFO - PROCESS | 30324 | |10;stanford-crypto-aes;74;80;71;74;79;73;74;74;74;74 19:47:29 INFO - PROCESS | 30324 | |11;stanford-crypto-ccm;116;121;123;115;117;118;114;113;125;131 19:47:29 INFO - PROCESS | 30324 | |12;stanford-crypto-pbkdf2;166;160;158;161;160;160;159;162;160;165 19:47:29 INFO - PROCESS | 30324 | |13;stanford-crypto-sha256-iterative;67;69;69;70;66;68;65;66;65;67 19:47:29 INFO - PROCESS | 30324 | __end_tp_report 19:47:29 INFO - PROCESS | 30324 | __start_cc_report 19:47:29 INFO - PROCESS | 30324 | _x_x_mozilla_cycle_collect,876 19:47:29 INFO - PROCESS | 30324 | __end_cc_report 19:47:29 INFO - PROCESS | 30324 | __startTimestamp1468378049952__endTimestamp 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | ------- Summary: start ------- 19:47:29 INFO - PROCESS | 30324 | Number of tests: 14 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:3.94 19:47:29 INFO - PROCESS | 30324 | Values: 108.0 111.0 104.0 109.0 113.0 112.0 102.0 113.0 111.0 111.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:157.00 stddev:16.96 (10.8%) stddev-sans-first:17.90 19:47:29 INFO - PROCESS | 30324 | Values: 154.0 133.0 160.0 169.0 127.0 152.0 160.0 129.0 173.0 135.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 19:47:29 INFO - PROCESS | 30324 | Values: 162.0 163.0 163.0 162.0 163.0 161.0 162.0 163.0 162.0 163.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:40.68 (53.9%) stddev-sans-first:42.68 19:47:29 INFO - PROCESS | 30324 | Values: 78.0 74.0 78.0 168.0 72.0 75.0 76.0 74.0 176.0 79.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:91.50 stddev:30.60 (33.4%) stddev-sans-first:31.72 19:47:29 INFO - PROCESS | 30324 | Values: 92.0 91.0 158.0 92.0 92.0 91.0 158.0 92.0 91.0 148.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:1.43 (1.2%) stddev-sans-first:1.50 19:47:29 INFO - PROCESS | 30324 | Values: 118.0 117.0 116.0 117.0 117.0 116.0 117.0 121.0 117.0 118.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 19:47:29 INFO - PROCESS | 30324 | Values: 146.0 147.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 19:47:29 INFO - PROCESS | 30324 | Values: 95.0 95.0 97.0 96.0 95.0 96.0 95.0 94.0 95.0 95.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.00 stddev:5.60 (9.8%) stddev-sans-first:5.92 19:47:29 INFO - PROCESS | 30324 | Values: 60.0 57.0 57.0 55.0 58.0 57.0 57.0 74.0 55.0 56.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 19:47:29 INFO - PROCESS | 30324 | Values: 57.0 57.0 56.0 58.0 58.0 58.0 58.0 57.0 57.0 57.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:2.71 (3.7%) stddev-sans-first:2.86 19:47:29 INFO - PROCESS | 30324 | Values: 74.0 80.0 71.0 74.0 79.0 73.0 74.0 74.0 74.0 74.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:119.50 stddev:5.68 (4.8%) stddev-sans-first:5.89 19:47:29 INFO - PROCESS | 30324 | Values: 116.0 121.0 123.0 115.0 117.0 118.0 114.0 113.0 125.0 131.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:160.50 stddev:2.56 (1.6%) stddev-sans-first:2.01 19:47:29 INFO - PROCESS | 30324 | Values: 166.0 160.0 158.0 161.0 160.0 160.0 159.0 162.0 160.0 165.0 19:47:29 INFO - PROCESS | 30324 | 19:47:29 INFO - PROCESS | 30324 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.75 (2.6%) stddev-sans-first:1.86 19:47:29 INFO - PROCESS | 30324 | Values: 67.0 69.0 69.0 70.0 66.0 68.0 65.0 66.0 65.0 67.0 19:47:29 INFO - PROCESS | 30324 | -------- Summary: end -------- 19:47:29 INFO - PROCESS | 30324 | 19:47:30 INFO - TEST-INFO | 30324: exit 0 19:47:30 INFO - TEST-OK | kraken | took 60504ms 19:47:30 INFO - SUITE-END | took 1169s 19:47:31 INFO - Completed test suite (00:19:29) 19:47:31 INFO - javascript benchmark 19:47:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.9999999999995, 3359.2777552826137, 3401.710854577361, 3435.759496835221, 3451.206222568809, 5526.557875369971, 5534.363548191959, 5547.861303467415, 5555.250041244431, 5557.221988921544, 5586.608937374385, 5586.692731899744, 5587.217789509472, 5590.0, 5593.077142271531, 5031.84904452867, 5063.164577844651, 5078.0, 5093.083245015896, 5105.157648987913, 5047.217681259411, 5080.618953578478, 5162.22566615007, 5209.2446595243855, 5225.608079394061, 5121.28302037715, 5151.150060240056, 5156.0, 5200.219967004941, 5258.55302299305, 5148.176291793314, 5170.3020092287625, 5172.2241663750365, 5193.169092945111, 5216.921746173811, 4973.229149481836, 5031.974840125813, 5077.720725360104, 5120.078385890538, 5134.435212126663, 5442.210879422461, 5456.727163641802, 5521.199426083235, 5531.695756733378, 5551.666899985973, 5991.071383935497, 6017.939820601781, 6018.368071352489, 6021.397860213988, 6083.330833608299, 5948.315943666447, 6084.482818960394, 6088.786892458787, 6105.755769769204, 6123.2039834821635, 5736.1682556029145, 5751.827445176651, 5756.913646295309, 5762.0, 5774.451427114417, 6262.718177682015, 6283.057541368831, 6294.087357333161, 6297.086922396318, 6301.842453938597, 5901.498372638288, 6006.309274433496, 6022.337542870281, 6032.4570788629235, 6070.817875463743, 6056.515478761688, 6057.061155520902, 6058.575899687068, 6062.030075188037, 6089.269287685506, 5957.880842383215, 5991.700414979234, 6012.518998480111, 6020.217371741645, 6030.698465076816, 5938.138969849434, 6047.848803779941, 6099.0, 6121.087175196906, 6178.0, 4647.86056418308, 4668.996165824364, 4669.252919532859, 4669.556392142741, 4675.976620116946, 4146.709730318909, 4147.212029714345, 4154.293770059097, 4155.8961025974595, 4179.2477354076555, 5774.942250577525, 5778.046622307273, 5786.334571524244, 5802.622829516068, 5822.505087067562, 6046.637201767908, 6065.332813390523, 6070.028795392716, 6105.297890742621, 6114.847128821815, 5631.2397826293745, 5789.102689083199, 5830.883382332329, 5838.38696936824, 5843.649381037151, 5084.46613105626, 5140.974295128501, 5158.252053452228, 5168.508991645787, 5200.97399513, 6364.395382438661, 6375.585586936927, 6406.103145559626, 6412.935870641327, 6451.0645956337, 5994.250718660168, 6071.635701857815, 6076.90884636722, 6084.0, 6128.662923539248, 6322.715477803418, 6405.327440618668, 6406.295307516077, 6413.7113829876835, 6420.486361091195, 5985.132155837467, 6006.969965150146, 6016.729247183975, 6020.729067191899, 6020.789272375446, 5855.38518455556, 6048.727807248596, 6103.511719062553, 6116.822755456359, 6144.600600960924, 5994.10088486713, 6018.0, 6030.969845150747, 6035.034394496859, 6046.0, 5913.2608423947, 5980.910286345621, 6007.7596896125415, 6021.729022194099, 6048.0, 5767.394423585463, 5776.855578610568, 5810.593258472036, 5862.94137058624, 5874.0, 5866.208061911758, 5916.349201587908, 5959.76160953557, 5965.463108320272, 5971.850703732442, 5760.1935728998815, 5770.221020162225, 5774.1916131740745, 5780.075187969905, 5788.0], "value": 5596.397394625781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.1867403094194, 681.0975457518782, 691.0394551573312, 731.9853602927944, 750.3696894608528, 31932.20169495761, 32737.345253094925, 40798.38802417962, 41422.58577414225, 41454.7927260364, 43975.560244397544, 44348.33477497832, 44461.333080003824, 44586.0, 44669.55330446694, 8698.739037828875, 8853.203211710945, 8861.556922153899, 8865.379423440361, 8867.0, 8701.347398945072, 8796.164364385373, 8799.252063574604, 8806.779830504256, 8824.8676269856, 8973.77565560863, 9014.36899417041, 9023.909760902372, 9033.774155646095, 9077.546122693871, 8930.151635594608, 8992.505412202327, 8993.820123597558, 9029.142231487998, 9055.909440905572, 8907.242884354837, 8982.910170898273, 9031.322650801216, 9038.457692538403, 9080.727578172666, 44240.3363949541, 44571.77714111441, 44769.10461790746, 44776.77611611954, 44780.10439791218, 3810.2569998850236, 3858.4212368145004, 3916.725829191958, 4000.4799376080923, 4135.7518548886865, 33870.83064584686, 34054.31891362159, 34233.14417139567, 34624.30751384983, 34631.13422164441, 4348.630366418858, 4386.188555117282, 4418.1384629997165, 4440.622547083502, 4501.932471012905, 321662.0, 322658.3867080673, 322791.0, 323050.0, 324374.0, 59216.703916481005, 59269.40730592639, 59430.70284648549, 59481.70259148676, 59711.40288597145, 64986.0, 65193.67403162954, 65222.347776522576, 69582.30417695758, 71375.28624713686, 18255.0, 18269.45191644253, 18289.908550457163, 18295.81704182941, 18382.264709411473, 13789.172649641054, 13942.86057139436, 13950.302484875716, 13952.093113947562, 14059.156450612996, 20922.0, 21062.47343816417, 21079.367618971457, 21146.259880904094, 21169.57660846805, 7582.241775822374, 7667.808304792425, 7765.184655611192, 7887.526748395115, 7920.920790792134, 1093.338530189224, 1116.4361997191365, 1127.4081107418672, 1178.6817559258952, 1189.2270024483983, 31050.84474577658, 31384.529232061537, 31421.685783142333, 31879.362412752078, 32158.35683286368, 1181.007953319216, 1254.4292346982102, 1291.599604122725, 1305.3277562055548, 1335.3857225676297, 16409.42567010149, 16478.0, 16745.158032616404, 16819.663606727798, 17065.573360665836, 492339.0, 571830.0, 901784.0, 918082.0, 925131.0, 63015.369846301866, 64295.357046429875, 64326.0, 64392.67803660952, 64649.35350646434, 1488.5311126994961, 1532.3793863485307, 1541.3141152187393, 1546.5515000649686, 1564.9921750391402, 32572.83713581417, 32628.0, 33708.49437258394, 33796.493052604725, 34217.31565368629, 53992.46007539874, 54598.727006364716, 55021.724891375285, 55022.72488637531, 55031.72484137554, 443915.0, 446440.0, 448252.0, 448788.0, 449607.0, 27813.582796258477, 28072.578911315937, 46954.53045469638, 47386.28920566263, 47930.76034619805, 46540.30189547092, 46901.0, 47362.28956565723, 47951.5204847947, 48177.27734083922, 39019.804900975316, 39331.60668393394, 39335.213295734495, 40007.0, 40307.79846100751, 38237.61762382452, 39125.6087439122, 39232.607673922896, 39454.210915782096, 39517.80241098776, 42720.78639606782, 43291.78354108209, 43296.13407731891, 43816.0, 44049.0, 36406.45390319201, 36862.0, 37007.62992370042, 37240.44139337966, 37259.6274037267, 28159.43681126407, 28291.2927176814, 28581.428371432037, 28638.713612864438, 28855.278618034718], "value": 21242.96805094916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.3324680640766, 414.93775933609976, 415.6591594892188, 423.27197220780255, 430.7028150576102, 18609.906950465247, 18929.0, 19234.422967310984, 19245.422637320884, 19837.206511739514, 19018.61962760744, 19419.708704369412, 19458.610827783436, 20202.59594808103, 20590.588188236226, 5662.858428539299, 5731.083026715726, 5868.471837534621, 5969.731362088694, 5973.402659734035, 5698.458646428583, 5787.276590426197, 5799.536037117042, 5811.215485909391, 5818.156367326735, 5635.492805647491, 5805.709714514279, 5818.767249310023, 5842.649441033552, 5865.208196893429, 5807.390224026459, 5822.039363505017, 5832.533397328203, 5863.091220860773, 5864.472197502245, 5092.821751238689, 5238.319018527605, 5247.790088396459, 5254.0, 5273.393559740641, 23837.0, 23996.0, 24174.274771756875, 24358.26925192247, 24382.634260486106, 2561.3724637463756, 2565.7819085377764, 2580.832245904029, 2587.430765231646, 2750.4499100179846, 14805.851941480554, 15112.244387780676, 15188.848111518853, 15315.846841531553, 15565.610859728484, 2052.5997430501056, 2072.347210628662, 2106.7787882272296, 2135.9572808543744, 2143.9249626263163, 74341.62829185874, 74621.0, 75779.62110189469, 78165.60917195435, 78869.21130788734, 10363.274570779973, 11279.436028198721, 11457.71355716097, 11755.471003804849, 11863.46614402354, 16102.919485402497, 16113.838861611468, 16163.43427980015, 16187.757183642254, 16209.432669856498, 8723.302135829246, 8966.237869781142, 8978.820423591622, 9019.0, 9024.8646270306, 8577.871331930026, 8771.824563508693, 8794.692185773467, 8807.0, 8815.691450799191, 4838.104950584153, 4931.7040977541465, 4934.1118598651865, 4961.479044700327, 5023.547880690755, 1962.9411117666493, 2090.397455168325, 2124.6069477146775, 2153.6554151335713, 2154.7737487563895, 984.8178087053918, 1053.4777246878186, 1100.2243418390017, 1101.983470247947, 1184.8518935133109, 19374.90312548428, 19446.8055319445, 19554.0, 19792.505187370432, 20040.89979550093, 1057.3655806516028, 1083.539495714334, 1121.5009320852143, 1128.6692978998342, 1149.9540018399337, 10661.307015043998, 11002.669919902415, 11109.111271098292, 11133.220674552866, 11178.776424471627, 405322.0, 406370.0, 414610.0, 416093.0, 510695.0, 100188.49905750425, 102047.4897625522, 103697.48151259196, 104144.0, 106599.46700266449, 1137.3801278303345, 1146.7133216695827, 1165.5862168930078, 1175.9706007350055, 1189.1854079955258, 17320.0, 17945.371911983017, 17997.910010449865, 18109.728354074963, 18327.908360458114, 37071.07322316964, 41675.58324416838, 41713.791431043865, 42289.365659515744, 42467.787661062735, 59713.70143149256, 59884.0, 60173.39826601678, 60278.397216027275, 60579.69710151597, 8592.527410992456, 8788.736337909873, 8802.295816334807, 8803.779905502157, 8933.910660893307, 13438.932805335911, 13590.0, 13715.519956801463, 13767.242801645605, 13805.24071176095, 11556.0, 11941.880581194077, 12007.879921201025, 12100.334481603597, 12106.213096148722, 11911.940440297743, 11923.523059077887, 12037.03703703684, 12264.325462099314, 12290.508379664714, 12415.503379864704, 12470.064745143969, 12683.746325073631, 12833.101682882108, 13265.46938122503, 8715.564221788758, 8885.689000884939, 8933.28533717314, 9013.909860901307, 9073.31950103758, 11754.76490470203, 12821.102522823312, 12863.549775757803, 12891.548795792101, 12981.221126732426], "value": 9691.036803879046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1564.0381165583162, 1565.6399028223507, 1792.0054369824743, 1943.1547276934534, 1951.541387773872, 8446.91553084469, 8584.871226931593, 8724.476531408103, 8752.168543988319, 8815.911840881598, 8864.0, 8865.468071915673, 8958.37291389603, 8960.686375976842, 8975.461472311667, 2417.697787776528, 2427.2111563741764, 2431.63525471179, 2442.5969714997095, 2444.8044156467527, 2489.962650560243, 2502.0367158643962, 2526.178991827654, 2532.8353657012326, 2537.53055684698, 2384.0582969726947, 2411.5176964607062, 2452.7424620414868, 2454.2514533067406, 2457.7910877575337, 2395.73646898841, 2416.854988700666, 2418.733939266679, 2423.5152969406013, 2427.635854621812, 2418.6130219165025, 2437.1348171399077, 2450.644656524794, 2462.704475462938, 2468.062136388179, 8903.287736981027, 8941.50821704806, 8952.776180595472, 8965.551722413853, 8980.0, 5187.714675692835, 5225.790968361261, 5280.049591073605, 5317.9202311965355, 5325.680459172462, 3411.385950528904, 3417.2140407706365, 3444.810535420551, 3468.549088618489, 3499.9650003500146, 1064.3454275620516, 1089.54239219528, 1092.2190633696946, 1093.2238110941241, 1095.2771171027164, 11810.468528916133, 11902.642920712393, 11994.820077698841, 12003.039756819433, 12017.098717596127, 4638.79125439356, 4667.743274119956, 4672.322513235562, 4776.307435421844, 4803.327534145223, 9589.280803939733, 9666.661666841626, 9676.661316854017, 9694.61221551144, 9709.708708738608, 5279.630425870152, 5309.203619457112, 5315.415304316522, 5322.92015619766, 5333.893322133536, 4837.7097374157665, 4960.925586116211, 5003.74981250936, 5017.724025178577, 5043.420006699276, 4059.65492933104, 4125.281190517402, 4162.313218318944, 4189.476315460567, 4211.957880421218, 1254.5196667931746, 1255.6358655989661, 1257.5472829781272, 1265.6266401411606, 1277.3485522383467, 991.9156871665989, 1095.1129585036147, 1096.6107032003683, 1102.2339474065448, 1111.9499622517005, 5920.644761314335, 5954.791582294599, 6047.576669633171, 6088.330283668793, 6170.413810688067, 471.3730738118363, 475.9904801904012, 477.44377799863463, 479.6834089500913, 489.6058672768456, 4564.292534657134, 4616.422947131608, 4649.95350046502, 4672.345871577982, 4673.182193116259, 10611.31026483276, 10675.039246467855, 10772.030517253485, 10773.569057237622, 10788.78422431547, 10150.746231344276, 10611.363318200933, 10687.89312106869, 10706.304090234109, 10746.301490403099, 8158.143394943446, 8331.16688331162, 8352.0812710603, 8361.372897032625, 8391.328693704489, 6024.728887199999, 6138.662373569497, 6188.938110618837, 6206.317305096345, 6291.779787707408, 9507.144357007903, 9517.762055948657, 9656.37233579815, 9676.70969870905, 9694.85457718149, 9257.444553326823, 9635.951820240854, 9645.855312170463, 9680.27397945143, 9857.0, 6962.443004559725, 7798.610069496389, 7920.683172673029, 8164.632591533514, 8463.322934165375, 8541.743747687578, 8551.615177316911, 8572.657093716181, 8580.699675511327, 8607.48355098696, 7462.0, 7710.383169346551, 7715.42134339938, 7791.727289544839, 7846.882296765667, 7443.55338679681, 7621.352185064332, 7679.078510578766, 7719.343855772322, 7762.0, 7159.498835081703, 7203.819904502429, 7277.417806575567, 7364.263573642593, 7380.741674041383, 5351.357837059578, 5402.838389746224, 5487.6158668892795, 5532.806351777668, 5566.582506311962, 5385.0, 5490.752916118704, 5502.532284755841, 5530.281063461724, 5622.32532096151], "value": 4652.178739052177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.2446071877558, 348.70534398433347, 348.74890079143023, 349.0157755130532, 350.09849637184254, 6409.487241020719, 6462.709178086986, 6546.279909209983, 6633.3698298661675, 6636.502262330327, 6494.707738151783, 6505.349465053492, 6520.119783829182, 6549.115869357635, 6559.475241980642, 4818.51814818518, 4874.3419638348905, 4879.463259041502, 4880.292357608145, 4891.241857512074, 4867.440244371907, 4870.902581948359, 4878.219484882419, 4881.755912204376, 4884.926726099111, 4822.4936381679945, 4826.806927722887, 4828.985912958283, 4834.1540230459705, 4837.903241935159, 4785.4735979042625, 4814.422269327703, 4836.782344794475, 4850.66045376822, 4850.951490485103, 4208.200441916057, 4221.24017676818, 4222.78886055696, 4238.830446782125, 4239.364095385686, 6293.1504246927, 6303.401176888188, 6304.369563043705, 6316.147320111818, 6316.652584107872, 5670.376258611549, 5679.460451257124, 5683.175939488751, 5691.544676425918, 5708.743106560173, 6890.414314783249, 6895.0, 6905.792826215222, 6924.065251191075, 6954.687039083254, 4457.799399027052, 4708.152532544141, 4709.71741695496, 4717.764111794397, 4723.07899959508, 7116.857662846766, 7138.571685698875, 7152.642367881637, 7184.892226616605, 7221.711131554732, 4698.694584851974, 4716.976415117971, 4728.101660684459, 4732.668713190113, 4754.619630429557, 4778.307145463958, 4786.928196077061, 4789.161896668069, 4790.760461976887, 4799.256115302133, 5617.803376881871, 5621.747021384048, 5631.0, 5639.041362968305, 5649.378568357477, 6789.796306110825, 6947.687354069079, 6950.79147625572, 6953.0, 6959.373656370951, 1656.1139790212178, 1669.1654172913543, 1681.428314373119, 1682.2766210529346, 1683.9410620628219, 1073.061071562383, 1073.7100982734619, 1079.7408621930838, 1087.211771465681, 1089.624079692505, 6648.800535983928, 6759.391654751096, 6762.459003279726, 6827.931720682829, 6833.453323734089, 7124.608146551989, 7126.073610430714, 7165.0685410897295, 7224.349808517259, 7226.855462890818, 6762.69567869447, 6780.762673306411, 6817.761378351734, 6832.180138383326, 6844.384005439534, 3857.9614203858164, 3881.5536213335827, 3892.6107389260847, 3898.785566793797, 3904.472896159039, 7333.74331898381, 7649.38804895607, 7653.732119375795, 7655.846883062419, 7663.31030207284, 7343.1555371131935, 7364.742234021891, 7367.18960914299, 7368.0, 7386.852262954711, 7542.2834830691, 7621.809454763676, 7630.847383052308, 7638.732644357421, 7650.6174691264105, 6918.169819621477, 7142.928570714226, 7186.389156921511, 7205.531640443354, 7208.927910721035, 7049.400800931979, 7100.573965562083, 7100.928990710234, 7103.680334384861, 7162.391196748126, 7626.046744156981, 7630.2751238632245, 7644.464887457824, 7653.502522336031, 7683.538987660758, 4639.257718764981, 4681.250999840009, 4683.601893838925, 4685.437747470325, 4693.882652933567, 7073.929260707533, 7214.567125972459, 7226.819329516804, 7231.855362892607, 7236.927630723625, 6983.720651173896, 6984.882418812966, 6984.895226571504, 6989.825254368681, 6998.125234345707, 6928.722851086101, 6930.930690693231, 6939.097917270722, 6951.304869513008, 6957.8956315654295, 6833.086735714008, 6852.760153394806, 6862.348076932683, 6866.896996544956, 6885.104936358442, 6833.111695479556, 6984.2317345093015, 6992.405645520188, 7004.929950700428, 7009.228984811564, 6632.83417914556, 6846.212685541226, 6862.691178896862, 6868.0, 6897.89653155193], "value": 5179.1624589391795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.7447765670299, 916.7433118726759, 930.7998780262242, 935.2471260635189, 947.478886612363, 15236.162011089385, 15625.531234062968, 16748.832511674897, 17224.0, 17242.913785431087, 15820.0, 15972.201389930515, 15982.520524384287, 16000.679986400264, 16009.83990160098, 892.1168043636818, 897.2642433204791, 912.0742446416859, 918.5636822509322, 924.9537523123851, 918.673870775875, 921.8847644044495, 922.23454532738, 923.3029063057415, 924.0851556958596, 954.0983770337034, 958.1616085924816, 958.4632605740773, 958.918491928187, 959.1128206409079, 948.4309414351403, 951.0632027452954, 951.4196340232453, 952.9904700952972, 954.8567714842794, 696.3245651717825, 697.3584302441766, 698.601796975724, 700.3556727810427, 701.3162166887295, 15780.526584202493, 15859.127747973856, 15861.0, 15924.044557326597, 15945.123018233993, 14596.562103136923, 14733.852661473462, 14753.483628072965, 14768.704625907529, 14800.629984250372, 11912.940435297854, 12022.458989345501, 12032.87967120335, 12080.275183489019, 12372.44324005413, 3874.341361968472, 3909.5894931032117, 3980.8208630611402, 3994.820233089518, 4068.3694027425795, 58796.41203587952, 58946.70526647339, 58967.99999999957, 59057.40942590605, 59912.70043649754, 11789.764204715857, 11796.174267801343, 11825.763484730258, 11865.110116741278, 11974.161808673309, 20130.597388052156, 20140.093695783726, 20140.992950352425, 20141.0, 20158.0, 8439.873401898976, 8521.318294536422, 8578.09929957358, 8613.956930215434, 8649.135086491426, 4732.077244937204, 4777.068471648065, 4882.389701287339, 4889.853304400803, 4894.730789806524, 3644.599094099647, 3698.0, 3700.9444858327147, 3706.1105334720014, 3708.072981754561, 642.7204166187723, 658.6937074260396, 660.3462572053633, 668.6255696809704, 669.9631520266335, 726.9055022846997, 742.8440027594157, 752.3492179264897, 819.4304958054095, 836.573347592732, 9598.712038638852, 9809.362391444532, 10213.285070045025, 10434.478276086316, 10450.738731531772, 682.205230905989, 786.6656670914838, 788.7673136424769, 819.692615269274, 834.2741814621319, 4750.14497390473, 5098.46466121052, 5138.794448222104, 5150.716710580954, 5274.762635681327, 65729.0, 66720.33279667239, 66848.0, 67282.66358668175, 67478.32521674721, 58588.41411585915, 58850.411495885346, 60213.39786602078, 60728.392716073155, 61148.388516115156, 52152.739236303576, 53325.0, 53689.46310536923, 53894.0, 54258.45741542613, 10011.499425028866, 10019.477600759184, 10076.798464030531, 10283.280170388001, 10284.588616455258, 38424.2315153701, 38741.41887871628, 39796.0, 39809.80095099506, 40488.59511404966, 53511.732441337546, 54573.727131365675, 54764.726176368866, 56877.431225687214, 59126.40873591209, 13828.0, 13958.581242562334, 14099.718005640036, 14389.784153237919, 14422.350994205077, 13114.73770524565, 14606.85393146055, 14669.706605868036, 14990.0, 15181.6204594886, 13994.0, 14025.719485610027, 14039.649008774863, 14116.364763585869, 14394.136351818925, 13940.442382304595, 14034.0, 14133.363998619881, 14436.133831970115, 14470.059446135967, 12961.416736246703, 13432.865671343161, 13539.526116585872, 13859.584212473643, 14191.361388737325, 11264.83102753443, 11332.263402878787, 11442.256253343507, 11714.0, 11853.525858965544, 11688.977612720584, 11836.112291577994, 11921.0, 11992.340421276913, 11999.100067495147], "value": 7437.100361420591, "unit": "score"}], "name": "dromaeo_css", "value": 7687.919796751209, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 109.0, 113.0, 112.0, 102.0, 113.0, 111.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 160.0, 169.0, 127.0, 152.0, 160.0, 129.0, 173.0, 135.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 78.0, 168.0, 72.0, 75.0, 76.0, 74.0, 176.0, 79.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 158.0, 92.0, 92.0, 91.0, 158.0, 92.0, 91.0, 148.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 121.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 55.0, 58.0, 57.0, 57.0, 74.0, 55.0, 56.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 71.0, 74.0, 79.0, 73.0, 74.0, 74.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 123.0, 115.0, 117.0, 118.0, 114.0, 113.0, 125.0, 131.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 160.0, 158.0, 161.0, 160.0, 160.0, 159.0, 162.0, 160.0, 165.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 70.0, 66.0, 68.0, 65.0, 66.0, 65.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1523.7999999999997, "alertThreshold": 2.0}]} 19:47:31 INFO - Return code: 0 19:47:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:47:31 ERROR - # TBPL SUCCESS # 19:47:31 INFO - Running post-action listener: _resource_record_post_action 19:47:31 INFO - Running post-run listener: _resource_record_post_run 19:47:32 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 463568896; Read time: 0; Write time: 312580 19:47:32 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242520064; Read time: 0; Write time: 215644 19:47:32 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 221048832; Read time: 0; Write time: 96936 19:47:32 INFO - Running post-run listener: _upload_blobber_files 19:47:32 INFO - Blob upload gear active. 19:47:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47:32 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 19:47:32 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'] 19:47:32 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 19:47:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:47:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:33 INFO - (blobuploader) - INFO - Done attempting. 19:47:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:47:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:37 INFO - (blobuploader) - INFO - Done attempting. 19:47:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:47:37 INFO - Return code: 0 19:47:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:47:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:47:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcf862cb3aada159f9259bef793fff9f6d1ab049bdb597fc2ab61af98022c37768c0177c94164727874a3e6548bdf080a5ec6d334c2319acb82cb59797ea0acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/592fd57d30b1c9498af106698959ce9b0f58a0d5fbf9ec7a4573caf41d0e9ab941b77b246e1fcdb2ab9ba61a90630ead5bcc04e5cc8f65509bf2cb6efbdbd511"} 19:47:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:47:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:47:37 INFO - Contents: 19:47:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcf862cb3aada159f9259bef793fff9f6d1ab049bdb597fc2ab61af98022c37768c0177c94164727874a3e6548bdf080a5ec6d334c2319acb82cb59797ea0acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/592fd57d30b1c9498af106698959ce9b0f58a0d5fbf9ec7a4573caf41d0e9ab941b77b246e1fcdb2ab9ba61a90630ead5bcc04e5cc8f65509bf2cb6efbdbd511"} 19:47:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:47:37 INFO - Copying logs to upload dir... 19:47:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:47:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.259970 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-12 19:47:36.493491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:36.497116) ========= 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=db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812 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/bcf862cb3aada159f9259bef793fff9f6d1ab049bdb597fc2ab61af98022c37768c0177c94164727874a3e6548bdf080a5ec6d334c2319acb82cb59797ea0acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/592fd57d30b1c9498af106698959ce9b0f58a0d5fbf9ec7a4573caf41d0e9ab941b77b246e1fcdb2ab9ba61a90630ead5bcc04e5cc8f65509bf2cb6efbdbd511"} build_url:https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/StHRWibKQOiFznIpf-aF4w/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/bcf862cb3aada159f9259bef793fff9f6d1ab049bdb597fc2ab61af98022c37768c0177c94164727874a3e6548bdf080a5ec6d334c2319acb82cb59797ea0acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/592fd57d30b1c9498af106698959ce9b0f58a0d5fbf9ec7a4573caf41d0e9ab941b77b246e1fcdb2ab9ba61a90630ead5bcc04e5cc8f65509bf2cb6efbdbd511"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:36.522643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:36.523021) ========= 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=db7e7c15f3ca076d53731445000001ba-1468376186.846967-258486812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:47:36.608093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:47:36.608646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:47:36.609185) ========= ========= Total master_lag: 0.18 =========