builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1466747619.06 results: success (0) buildid: 20160623200357 builduid: 48b2abe674764200b7cc847833de78c8 revision: f751465bac6aac4ffba8318060817e907088e2fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.057105) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.057754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.058220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.076499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.077000) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 22:53:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.3M=0s 2016-06-23 22:53:39 (71.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130324 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.237202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.237543) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014858 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.299688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:39.300099) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f751465bac6aac4ffba8318060817e907088e2fd --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 f751465bac6aac4ffba8318060817e907088e2fd --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=5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 22:53:39,416 truncating revision to first 12 chars 2016-06-23 22:53:39,416 Setting DEBUG logging. 2016-06-23 22:53:39,416 attempt 1/10 2016-06-23 22:53:39,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f751465bac6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 22:53:39,720 unpacking tar archive at: mozilla-beta-f751465bac6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715162 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:40.031898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:40.032295) ========= script_repo_revision: f751465bac6aac4ffba8318060817e907088e2fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:40.032810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:40.033207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 22:53:40.042636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-23 22:53:40.043010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:40 INFO - MultiFileLogger online at 20160623 22:53:40 in /builds/slave/test 22:53:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:53:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:53:40 INFO - {'append_to_log': False, 22:53:40 INFO - 'base_work_dir': '/builds/slave/test', 22:53:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:53:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:53:40 INFO - 'branch': 'Mozilla-Beta', 22:53:40 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:40 INFO - 'config_files': ('talos/linux_config.py',), 22:53:40 INFO - 'default_actions': ('clobber', 22:53:40 INFO - 'read-buildbot-config', 22:53:40 INFO - 'download-and-extract', 22:53:40 INFO - 'populate-webroot', 22:53:40 INFO - 'create-virtualenv', 22:53:40 INFO - 'install', 22:53:40 INFO - 'run-tests'), 22:53:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:40 INFO - 'download_minidump_stackwalk': True, 22:53:40 INFO - 'download_symbols': 'ondemand', 22:53:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:40 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:40 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:40 INFO - 'installer_path': 'installer.exe', 22:53:40 INFO - 'log_level': 'info', 22:53:40 INFO - 'log_name': 'talos', 22:53:40 INFO - 'log_to_console': True, 22:53:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:40 INFO - 'opt_config_files': (), 22:53:40 INFO - 'pip_index': False, 22:53:40 INFO - 'sps_profile': False, 22:53:40 INFO - 'sps_profile_interval': 0, 22:53:40 INFO - 'suite': 'dromaeojs', 22:53:40 INFO - 'system_bits': '32', 22:53:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:40 INFO - 'title': 'talos-linux64-ix-011', 22:53:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:40 INFO - 'use_talos_json': True, 22:53:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:53:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:40 INFO - 'work_dir': 'build'} 22:53:40 INFO - ##### 22:53:40 INFO - ##### Running clobber step. 22:53:40 INFO - ##### 22:53:40 INFO - Running pre-action listener: _resource_record_pre_action 22:53:40 INFO - Running main action method: clobber 22:53:40 INFO - rmtree: /builds/slave/test/build 22:53:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:53:40 INFO - Running post-action listener: _resource_record_post_action 22:53:40 INFO - ##### 22:53:40 INFO - ##### Running read-buildbot-config step. 22:53:40 INFO - ##### 22:53:40 INFO - Running pre-action listener: _resource_record_pre_action 22:53:40 INFO - Running main action method: read_buildbot_config 22:53:40 INFO - Using buildbot properties: 22:53:40 INFO - { 22:53:40 INFO - "project": "", 22:53:40 INFO - "product": "firefox", 22:53:40 INFO - "script_repo_revision": "production", 22:53:40 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 22:53:40 INFO - "repository": "", 22:53:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 22:53:40 INFO - "buildid": "20160623200357", 22:53:40 INFO - "pgo_build": "True", 22:53:40 INFO - "basedir": "/builds/slave/test", 22:53:40 INFO - "buildnumber": 271, 22:53:40 INFO - "slavename": "talos-linux64-ix-011", 22:53:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:53:40 INFO - "platform": "ubuntu64_hw", 22:53:40 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:53:40 INFO - "branch": "mozilla-beta", 22:53:40 INFO - "repo_path": "releases/mozilla-beta", 22:53:40 INFO - "revision": "f751465bac6aac4ffba8318060817e907088e2fd", 22:53:40 INFO - "stage_platform": "linux64-pgo", 22:53:40 INFO - "builduid": "48b2abe674764200b7cc847833de78c8", 22:53:40 INFO - "slavebuilddir": "test" 22:53:40 INFO - } 22:53:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 22:53:40 INFO - Running post-action listener: _resource_record_post_action 22:53:40 INFO - ##### 22:53:40 INFO - ##### Running download-and-extract step. 22:53:40 INFO - ##### 22:53:40 INFO - Running pre-action listener: _resource_record_pre_action 22:53:40 INFO - Running main action method: download_and_extract 22:53:40 INFO - mkdir: /builds/slave/test/build/tests 22:53: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')]} 22:53:40 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:43 INFO - Downloaded 1327 bytes. 22:53:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 22:53:43 INFO - Using the following test package requirements: 22:53:43 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:53:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:43 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 22:53:43 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'jsshell-linux-x86_64.zip'], 22:53:43 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:43 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 22:53:43 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 22:53:43 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 22:53:43 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 22:53:43 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:43 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53: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')]} 22:53:43 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:44 INFO - Downloaded 24229886 bytes. 22:53:44 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'] 22:53:44 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 22:53:45 INFO - Return code: 0 22:53:45 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 22:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:45 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 22:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:48 INFO - Downloaded 24229886 bytes. 22:53:48 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'] 22:53:48 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 22:53:50 INFO - Return code: 0 22:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:50 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 22:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:51 INFO - Downloaded 10840145 bytes. 22:53:51 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'] 22:53:51 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 22:53:51 INFO - Return code: 0 22:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:51 INFO - https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dntH06m9Ty-Wnm8qwmtCCw/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 22:53:53 INFO - Downloaded 56025715 bytes. 22:53:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:53 INFO - mkdir: /builds/slave/test/properties 22:53:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:53:53 INFO - Writing to file /builds/slave/test/properties/build_url 22:53:53 INFO - Contents: 22:53:53 INFO - build_url:https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 22:53:53 INFO - Running post-action listener: _resource_record_post_action 22:53:53 INFO - Running post-action listener: set_extra_try_arguments 22:53:53 INFO - ##### 22:53:53 INFO - ##### Running populate-webroot step. 22:53:53 INFO - ##### 22:53:53 INFO - Running pre-action listener: _resource_record_pre_action 22:53:53 INFO - Running main action method: populate_webroot 22:53:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:53 INFO - '--tppagecycles', 22:53:53 INFO - '7'], 22:53:53 INFO - 'tests': ['tsvgm']}}, 22:53:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:53:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:53:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:53:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['damp', 'tps']}, 22:53:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'tests': ['damp', 'tps']}, 22:53:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['dromaeo_dom']}, 22:53:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['a11yr', 22:53:53 INFO - 'ts_paint', 22:53:53 INFO - 'tpaint', 22:53:53 INFO - 'sessionrestore', 22:53:53 INFO - 'sessionrestore_no_auto_restore', 22:53:53 INFO - 'tabpaint']}, 22:53:53 INFO - 'other-e10s': {'tests': ['a11yr', 22:53:53 INFO - 'ts_paint', 22:53:53 INFO - 'tpaint', 22:53:53 INFO - 'sessionrestore', 22:53:53 INFO - 'sessionrestore_no_auto_restore', 22:53:53 INFO - 'tabpaint']}, 22:53:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:53:53 INFO - 'ts_paint', 22:53:53 INFO - 'tpaint', 22:53:53 INFO - 'sessionrestore', 22:53:53 INFO - 'sessionrestore_no_auto_restore', 22:53:53 INFO - 'tabpaint']}, 22:53:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:53:53 INFO - 'ts_paint', 22:53:53 INFO - 'tpaint', 22:53:53 INFO - 'sessionrestore', 22:53:53 INFO - 'sessionrestore_no_auto_restore', 22:53:53 INFO - 'tabpaint']}, 22:53:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['a11yr', 22:53:53 INFO - 'ts_paint', 22:53:53 INFO - 'tpaint', 22:53:53 INFO - 'sessionrestore', 22:53:53 INFO - 'sessionrestore_no_auto_restore', 22:53:53 INFO - 'tabpaint']}, 22:53:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['a11yr', 22:53:53 INFO - 'ts_paint', 22:53:53 INFO - 'tpaint', 22:53:53 INFO - 'sessionrestore', 22:53:53 INFO - 'sessionrestore_no_auto_restore', 22:53:53 INFO - 'tabpaint']}, 22:53:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['tsvgx', 22:53:53 INFO - 'tsvgr_opacity', 22:53:53 INFO - 'tart', 22:53:53 INFO - 'tscrollx', 22:53:53 INFO - 'cart']}, 22:53:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:53:53 INFO - 'tsvgr_opacity', 22:53:53 INFO - 'tart', 22:53:53 INFO - 'tscrollx', 22:53:53 INFO - 'cart']}, 22:53:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'talos_options': ['--disable-e10s'], 22:53:53 INFO - 'tests': ['tp5o']}, 22:53:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'tests': ['tp5o']}, 22:53:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'talos_options': ['--disable-e10s', 22:53:53 INFO - '--xperf_path', 22:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:53 INFO - 'tests': ['tp5n']}, 22:53:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:53 INFO - 'talos_options': ['--xperf_path', 22:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:53 INFO - 'tests': ['tp5n']}}, 22:53:53 INFO - 'talos.zip': {'path': '', 22:53:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:53 INFO - Running post-action listener: _resource_record_post_action 22:53:53 INFO - ##### 22:53:53 INFO - ##### Running create-virtualenv step. 22:53:53 INFO - ##### 22:53:53 INFO - Running pre-action listener: _resource_record_pre_action 22:53:53 INFO - Running main action method: create_virtualenv 22:53:53 INFO - Creating virtualenv /builds/slave/test/build/venv 22:53:53 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 22:53:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:53:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:54 INFO - Using real prefix '/usr' 22:53:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:53:54 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:56 INFO - Installing pip.................done. 22:53:56 INFO - Return code: 0 22:53:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:53:56 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')]} 22:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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')]} 22:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:53:56 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 22:53:56 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 22:53:56 INFO - Using env: {'DISPLAY': ':0', 22:53:56 INFO - 'HOME': '/home/cltbld', 22:53:56 INFO - 'LANG': 'en_US.UTF-8', 22:53:56 INFO - 'LANGUAGE': 'en_US:en', 22:53:56 INFO - 'LOGNAME': 'cltbld', 22:53:56 INFO - 'MAIL': '/var/mail/cltbld', 22:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:56 INFO - 'MOZ_NO_REMOTE': '1', 22:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:56 INFO - 'NO_EM_RESTART': '1', 22:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:56 INFO - 'PWD': '/builds/slave/test', 22:53:56 INFO - 'SHELL': '/bin/bash', 22:53:56 INFO - 'SHLVL': '1', 22:53:56 INFO - 'TERM': 'linux', 22:53:56 INFO - 'TMOUT': '86400', 22:53:56 INFO - 'USER': 'cltbld', 22:53:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:56 INFO - '_': '/tools/buildbot/bin/python'} 22:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:56 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 22:53:56 INFO - Cleaning up... 22:53:56 INFO - Return code: 0 22:53:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:53:56 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')]} 22:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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')]} 22:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:53:56 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 22:53:56 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 22:53:56 INFO - Using env: {'DISPLAY': ':0', 22:53:56 INFO - 'HOME': '/home/cltbld', 22:53:56 INFO - 'LANG': 'en_US.UTF-8', 22:53:56 INFO - 'LANGUAGE': 'en_US:en', 22:53:56 INFO - 'LOGNAME': 'cltbld', 22:53:56 INFO - 'MAIL': '/var/mail/cltbld', 22:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:56 INFO - 'MOZ_NO_REMOTE': '1', 22:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:56 INFO - 'NO_EM_RESTART': '1', 22:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:56 INFO - 'PWD': '/builds/slave/test', 22:53:56 INFO - 'SHELL': '/bin/bash', 22:53:56 INFO - 'SHLVL': '1', 22:53:56 INFO - 'TERM': 'linux', 22:53:56 INFO - 'TMOUT': '86400', 22:53:56 INFO - 'USER': 'cltbld', 22:53:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:56 INFO - '_': '/tools/buildbot/bin/python'} 22:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:57 INFO - Downloading/unpacking psutil>=0.7.1 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:59 INFO - Installing collected packages: psutil 22:53:59 INFO - Running setup.py install for psutil 22:53:59 INFO - building 'psutil._psutil_linux' extension 22:53:59 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 22:53:59 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 22:53:59 INFO - building 'psutil._psutil_posix' extension 22:53:59 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 22:53:59 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 22:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:59 INFO - Successfully installed psutil 22:53:59 INFO - Cleaning up... 22:53:59 INFO - Return code: 0 22:53:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:53:59 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 22:53:59 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 22:53:59 INFO - Using env: {'DISPLAY': ':0', 22:53:59 INFO - 'HOME': '/home/cltbld', 22:53:59 INFO - 'LANG': 'en_US.UTF-8', 22:53:59 INFO - 'LANGUAGE': 'en_US:en', 22:53:59 INFO - 'LOGNAME': 'cltbld', 22:53:59 INFO - 'MAIL': '/var/mail/cltbld', 22:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:59 INFO - 'MOZ_NO_REMOTE': '1', 22:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:59 INFO - 'NO_EM_RESTART': '1', 22:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:59 INFO - 'PWD': '/builds/slave/test', 22:53:59 INFO - 'SHELL': '/bin/bash', 22:53:59 INFO - 'SHLVL': '1', 22:53:59 INFO - 'TERM': 'linux', 22:53:59 INFO - 'TMOUT': '86400', 22:53:59 INFO - 'USER': 'cltbld', 22:53:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:59 INFO - '_': '/tools/buildbot/bin/python'} 22:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:59 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 22:53:59 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 22:53:59 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 22:53:59 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 22:53:59 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 22:53:59 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 22:54:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:01 INFO - Installing collected packages: mozsystemmonitor 22:54:01 INFO - Running setup.py install for mozsystemmonitor 22:54:01 INFO - Successfully installed mozsystemmonitor 22:54:01 INFO - Cleaning up... 22:54:01 INFO - Return code: 0 22:54:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:54:01 INFO - Using env: {'DISPLAY': ':0', 22:54:01 INFO - 'HOME': '/home/cltbld', 22:54:01 INFO - 'LANG': 'en_US.UTF-8', 22:54:01 INFO - 'LANGUAGE': 'en_US:en', 22:54:01 INFO - 'LOGNAME': 'cltbld', 22:54:01 INFO - 'MAIL': '/var/mail/cltbld', 22:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:01 INFO - 'MOZ_NO_REMOTE': '1', 22:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:01 INFO - 'NO_EM_RESTART': '1', 22:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:01 INFO - 'PWD': '/builds/slave/test', 22:54:01 INFO - 'SHELL': '/bin/bash', 22:54:01 INFO - 'SHLVL': '1', 22:54:01 INFO - 'TERM': 'linux', 22:54:01 INFO - 'TMOUT': '86400', 22:54:01 INFO - 'USER': 'cltbld', 22:54:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:01 INFO - '_': '/tools/buildbot/bin/python'} 22:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:02 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:02 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 22:54:03 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:54:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:04 INFO - Downloading docopt-0.6.1.tar.gz 22:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:04 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:04 INFO - Running setup.py install for blobuploader 22:54:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:54:04 INFO - Running setup.py install for requests 22:54:05 INFO - Running setup.py install for docopt 22:54:05 INFO - Successfully installed blobuploader requests docopt 22:54:05 INFO - Cleaning up... 22:54:05 INFO - Return code: 0 22:54:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:05 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:54:05 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 22:54:05 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 22:54:05 INFO - Using env: {'DISPLAY': ':0', 22:54:05 INFO - 'HOME': '/home/cltbld', 22:54:05 INFO - 'LANG': 'en_US.UTF-8', 22:54:05 INFO - 'LANGUAGE': 'en_US:en', 22:54:05 INFO - 'LOGNAME': 'cltbld', 22:54:05 INFO - 'MAIL': '/var/mail/cltbld', 22:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:05 INFO - 'MOZ_NO_REMOTE': '1', 22:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:05 INFO - 'NO_EM_RESTART': '1', 22:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:05 INFO - 'PWD': '/builds/slave/test', 22:54:05 INFO - 'SHELL': '/bin/bash', 22:54:05 INFO - 'SHLVL': '1', 22:54:05 INFO - 'TERM': 'linux', 22:54:05 INFO - 'TMOUT': '86400', 22:54:05 INFO - 'USER': 'cltbld', 22:54:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:05 INFO - '_': '/tools/buildbot/bin/python'} 22:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:05 INFO - Running setup.py (path:/tmp/pip-TO8Pi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:05 INFO - Running setup.py (path:/tmp/pip-F1P4eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:05 INFO - Running setup.py (path:/tmp/pip-INZkUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:05 INFO - Running setup.py (path:/tmp/pip-Sq9UN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:05 INFO - Running setup.py (path:/tmp/pip-7s8n55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:05 INFO - Running setup.py (path:/tmp/pip-EPshOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:05 INFO - Running setup.py (path:/tmp/pip-J0wCR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:06 INFO - Running setup.py (path:/tmp/pip-ymPwhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:06 INFO - Running setup.py (path:/tmp/pip-J_vgrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:06 INFO - Running setup.py (path:/tmp/pip-xQIQkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:06 INFO - Running setup.py (path:/tmp/pip-6aakhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:06 INFO - Running setup.py (path:/tmp/pip-OUGkiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:06 INFO - Running setup.py (path:/tmp/pip-w5ap0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:06 INFO - Running setup.py (path:/tmp/pip-QmQqEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:06 INFO - Running setup.py (path:/tmp/pip-m2GTuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:06 INFO - Running setup.py (path:/tmp/pip-5THiZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:06 INFO - Running setup.py (path:/tmp/pip-6lNtth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:06 INFO - Running setup.py install for manifestparser 22:54:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:54:06 INFO - Running setup.py install for mozcrash 22:54:06 INFO - Running setup.py install for mozdebug 22:54:07 INFO - Running setup.py install for mozdevice 22:54:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Running setup.py install for mozfile 22:54:07 INFO - Running setup.py install for mozhttpd 22:54:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Running setup.py install for mozinfo 22:54:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Running setup.py install for mozInstall 22:54:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Running setup.py install for mozleak 22:54:07 INFO - Running setup.py install for mozlog 22:54:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Running setup.py install for moznetwork 22:54:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:54:07 INFO - Running setup.py install for mozprocess 22:54:08 INFO - Running setup.py install for mozprofile 22:54:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:54:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:54:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:54:08 INFO - Running setup.py install for mozrunner 22:54:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:54:08 INFO - Running setup.py install for mozscreenshot 22:54:08 INFO - Running setup.py install for moztest 22:54:08 INFO - Running setup.py install for mozversion 22:54:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:54:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:08 INFO - Cleaning up... 22:54:08 INFO - Return code: 0 22:54:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:08 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:54:08 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 22:54:08 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 22:54:08 INFO - Using env: {'DISPLAY': ':0', 22:54:08 INFO - 'HOME': '/home/cltbld', 22:54:08 INFO - 'LANG': 'en_US.UTF-8', 22:54:08 INFO - 'LANGUAGE': 'en_US:en', 22:54:08 INFO - 'LOGNAME': 'cltbld', 22:54:08 INFO - 'MAIL': '/var/mail/cltbld', 22:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:08 INFO - 'MOZ_NO_REMOTE': '1', 22:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:08 INFO - 'NO_EM_RESTART': '1', 22:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:08 INFO - 'PWD': '/builds/slave/test', 22:54:08 INFO - 'SHELL': '/bin/bash', 22:54:08 INFO - 'SHLVL': '1', 22:54:08 INFO - 'TERM': 'linux', 22:54:08 INFO - 'TMOUT': '86400', 22:54:08 INFO - 'USER': 'cltbld', 22:54:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:08 INFO - '_': '/tools/buildbot/bin/python'} 22:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:08 INFO - Running setup.py (path:/tmp/pip-0QSFqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:08 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)) 22:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:08 INFO - Running setup.py (path:/tmp/pip-kUz27T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:08 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)) 22:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:08 INFO - Running setup.py (path:/tmp/pip-kO0c64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:08 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)) 22:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:09 INFO - Running setup.py (path:/tmp/pip-T5v3Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:09 INFO - Running setup.py (path:/tmp/pip-Ohwzvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:09 INFO - Running setup.py (path:/tmp/pip-IvTy9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:09 INFO - Running setup.py (path:/tmp/pip-dP0Vl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:09 INFO - Running setup.py (path:/tmp/pip-Os6Wmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:09 INFO - Running setup.py (path:/tmp/pip-8e7Xxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:09 INFO - Running setup.py (path:/tmp/pip-16_K8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:09 INFO - Running setup.py (path:/tmp/pip-wjNPuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:09 INFO - Running setup.py (path:/tmp/pip-ggcW2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:09 INFO - Running setup.py (path:/tmp/pip-ZBDoBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:09 INFO - Running setup.py (path:/tmp/pip-H4VQyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:09 INFO - Running setup.py (path:/tmp/pip-DTc15t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:09 INFO - Running setup.py (path:/tmp/pip-2ufC14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:09 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)) 22:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:09 INFO - Running setup.py (path:/tmp/pip-JUIWFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:10 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)) 22:54:10 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)) 22:54:10 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)) 22:54:10 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)) 22:54:10 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)) 22:54:10 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)) 22:54:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - Downloading blessings-1.6.tar.gz 22:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:11 INFO - Installing collected packages: blessings 22:54:11 INFO - Running setup.py install for blessings 22:54:12 INFO - Successfully installed blessings 22:54:12 INFO - Cleaning up... 22:54:12 INFO - Return code: 0 22:54:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:12 INFO - Reading from file tmpfile_stdout 22:54:12 INFO - Current package versions: 22:54:12 INFO - argparse == 1.2.1 22:54:12 INFO - blessings == 1.6 22:54:12 INFO - blobuploader == 1.2.4 22:54:12 INFO - docopt == 0.6.1 22:54:12 INFO - manifestparser == 1.1 22:54:12 INFO - mozInstall == 1.12 22:54:12 INFO - mozcrash == 0.17 22:54:12 INFO - mozdebug == 0.1 22:54:12 INFO - mozdevice == 0.48 22:54:12 INFO - mozfile == 1.2 22:54:12 INFO - mozhttpd == 0.7 22:54:12 INFO - mozinfo == 0.9 22:54:12 INFO - mozleak == 0.1 22:54:12 INFO - mozlog == 3.1 22:54:12 INFO - moznetwork == 0.27 22:54:12 INFO - mozprocess == 0.22 22:54:12 INFO - mozprofile == 0.28 22:54:12 INFO - mozrunner == 6.11 22:54:12 INFO - mozscreenshot == 0.1 22:54:12 INFO - mozsystemmonitor == 0.0 22:54:12 INFO - moztest == 0.7 22:54:12 INFO - mozversion == 1.4 22:54:12 INFO - psutil == 3.1.1 22:54:12 INFO - requests == 1.2.3 22:54:12 INFO - wsgiref == 0.1.2 22:54:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:12 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:54:12 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 22:54:12 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 22:54:12 INFO - Using env: {'DISPLAY': ':0', 22:54:12 INFO - 'HOME': '/home/cltbld', 22:54:12 INFO - 'LANG': 'en_US.UTF-8', 22:54:12 INFO - 'LANGUAGE': 'en_US:en', 22:54:12 INFO - 'LOGNAME': 'cltbld', 22:54:12 INFO - 'MAIL': '/var/mail/cltbld', 22:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:12 INFO - 'MOZ_NO_REMOTE': '1', 22:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:12 INFO - 'NO_EM_RESTART': '1', 22:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:12 INFO - 'PWD': '/builds/slave/test', 22:54:12 INFO - 'SHELL': '/bin/bash', 22:54:12 INFO - 'SHLVL': '1', 22:54:12 INFO - 'TERM': 'linux', 22:54:12 INFO - 'TMOUT': '86400', 22:54:12 INFO - 'USER': 'cltbld', 22:54:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:12 INFO - '_': '/tools/buildbot/bin/python'} 22:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 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)) 22:54:12 INFO - Cleaning up... 22:54:12 INFO - Return code: 0 22:54:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:12 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:54:12 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 22:54:12 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 22:54:12 INFO - Using env: {'DISPLAY': ':0', 22:54:12 INFO - 'HOME': '/home/cltbld', 22:54:12 INFO - 'LANG': 'en_US.UTF-8', 22:54:12 INFO - 'LANGUAGE': 'en_US:en', 22:54:12 INFO - 'LOGNAME': 'cltbld', 22:54:12 INFO - 'MAIL': '/var/mail/cltbld', 22:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:12 INFO - 'MOZ_NO_REMOTE': '1', 22:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:12 INFO - 'NO_EM_RESTART': '1', 22:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:12 INFO - 'PWD': '/builds/slave/test', 22:54:12 INFO - 'SHELL': '/bin/bash', 22:54:12 INFO - 'SHLVL': '1', 22:54:12 INFO - 'TERM': 'linux', 22:54:12 INFO - 'TMOUT': '86400', 22:54:12 INFO - 'USER': 'cltbld', 22:54:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:12 INFO - '_': '/tools/buildbot/bin/python'} 22:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:12 INFO - Downloading/unpacking jsonschema 22:54:12 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 22:54:12 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 22:54:12 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 22:54:12 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 22:54:12 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 22:54:12 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 22:54:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:14 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:14 INFO - warning: no files found matching '*.txt' 22:54:14 INFO - no previously-included directories found matching 'build' 22:54:14 INFO - no previously-included directories found matching 'dist' 22:54:14 INFO - no previously-included directories found matching '.git*' 22:54:14 INFO - Installing collected packages: jsonschema, functools32 22:54:15 INFO - Running setup.py install for functools32 22:54:15 INFO - warning: no files found matching '*.txt' 22:54:15 INFO - no previously-included directories found matching 'build' 22:54:15 INFO - no previously-included directories found matching 'dist' 22:54:15 INFO - no previously-included directories found matching '.git*' 22:54:15 INFO - Successfully installed jsonschema functools32 22:54:15 INFO - Cleaning up... 22:54:15 INFO - Return code: 0 22:54:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:15 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 0x7fa2309aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a595a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', '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 22:54:15 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 22:54:15 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 22:54:15 INFO - Using env: {'DISPLAY': ':0', 22:54:15 INFO - 'HOME': '/home/cltbld', 22:54:15 INFO - 'LANG': 'en_US.UTF-8', 22:54:15 INFO - 'LANGUAGE': 'en_US:en', 22:54:15 INFO - 'LOGNAME': 'cltbld', 22:54:15 INFO - 'MAIL': '/var/mail/cltbld', 22:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:15 INFO - 'MOZ_NO_REMOTE': '1', 22:54:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:15 INFO - 'NO_EM_RESTART': '1', 22:54:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:15 INFO - 'PWD': '/builds/slave/test', 22:54:15 INFO - 'SHELL': '/bin/bash', 22:54:15 INFO - 'SHLVL': '1', 22:54:15 INFO - 'TERM': 'linux', 22:54:15 INFO - 'TMOUT': '86400', 22:54:15 INFO - 'USER': 'cltbld', 22:54:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:15 INFO - '_': '/tools/buildbot/bin/python'} 22:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:15 INFO - Downloading/unpacking flake8 22:54:15 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 22:54:15 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 22:54:15 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 22:54:15 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 22:54:15 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 22:54:15 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 22:54:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:17 INFO - no previously-included directories found matching 'docs/_build' 22:54:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:18 INFO - Running setup.py install for pep8 22:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:18 INFO - no previously-included directories found matching 'docs/_build' 22:54:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:54:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:18 INFO - Cleaning up... 22:54:18 INFO - Return code: 0 22:54:18 INFO - Running post-action listener: _resource_record_post_action 22:54:18 INFO - Running post-action listener: _start_resource_monitoring 22:54:18 INFO - Starting resource monitoring. 22:54:18 INFO - ##### 22:54:18 INFO - ##### Running install step. 22:54:18 INFO - ##### 22:54:18 INFO - Running pre-action listener: _resource_record_pre_action 22:54:18 INFO - Running main action method: install 22:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:18 INFO - Reading from file tmpfile_stdout 22:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:54:18 INFO - Reading from file tmpfile_stdout 22:54:18 INFO - Output received: 22:54:18 INFO - Usage: mozinstall [options] installer 22:54:18 INFO - Options: 22:54:18 INFO - -h, --help show this help message and exit 22:54:18 INFO - -d DEST, --destination=DEST 22:54:18 INFO - Directory to install application into. [default: 22:54:18 INFO - "/builds/slave/test"] 22:54:18 INFO - --app=APP Application being installed. [default: firefox] 22:54:18 INFO - mkdir: /builds/slave/test/build/application 22:54:18 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'] 22:54:18 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 22:54:31 INFO - Reading from file tmpfile_stdout 22:54:31 INFO - Output received: 22:54:31 INFO - /builds/slave/test/build/application/firefox/firefox 22:54:31 INFO - Running post-action listener: _resource_record_post_action 22:54:31 INFO - ##### 22:54:31 INFO - ##### Running run-tests step. 22:54:31 INFO - ##### 22:54:31 INFO - Running pre-action listener: _resource_record_pre_action 22:54:31 INFO - Running main action method: run_tests 22:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:54:31 INFO - Python 2.7.3 22:54:31 INFO - Return code: 0 22:54:31 INFO - grabbing minidump binary from tooltool 22:54:31 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')]} 22:54:31 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 0x1ae8410>, '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 0x1ae9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ae97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:54:31 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 22:54:31 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 22:54:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:31 INFO - Return code: 0 22:54:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:54:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:54:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:54:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:54:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:54:32 INFO - Return code: 0 22:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:54:32 INFO - Using env: {'DISPLAY': ':0', 22:54:32 INFO - 'HOME': '/home/cltbld', 22:54:32 INFO - 'LANG': 'en_US.UTF-8', 22:54:32 INFO - 'LANGUAGE': 'en_US:en', 22:54:32 INFO - 'LOGNAME': 'cltbld', 22:54:32 INFO - 'MAIL': '/var/mail/cltbld', 22:54:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:54:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:32 INFO - 'MOZ_NO_REMOTE': '1', 22:54:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:32 INFO - 'NO_EM_RESTART': '1', 22:54:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:32 INFO - 'PWD': '/builds/slave/test', 22:54:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:54:32 INFO - 'SHELL': '/bin/bash', 22:54:32 INFO - 'SHLVL': '1', 22:54:32 INFO - 'TERM': 'linux', 22:54:32 INFO - 'TMOUT': '86400', 22:54:32 INFO - 'USER': 'cltbld', 22:54:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754', 22:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:32 INFO - '_': '/tools/buildbot/bin/python'} 22:54:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:54:33 INFO - mozversion application_buildid: 20160623200357 22:54:33 INFO - mozversion application_changeset: f751465bac6aac4ffba8318060817e907088e2fd 22:54:33 INFO - mozversion application_display_name: Firefox 22:54:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:33 INFO - mozversion application_name: Firefox 22:54:33 INFO - mozversion application_remotingname: firefox 22:54:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:54:33 INFO - mozversion application_vendor: Mozilla 22:54:33 INFO - mozversion application_version: 48.0 22:54:33 INFO - mozversion platform_buildid: 20160623200357 22:54:33 INFO - mozversion platform_changeset: f751465bac6aac4ffba8318060817e907088e2fd 22:54:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:54:33 INFO - mozversion platform_version: 48.0 22:54:33 INFO - using testdate: 1466747673 22:54:33 INFO - actual date: 1466747673 22:54:33 INFO - starting webserver on 'localhost:48593' 22:54:33 INFO - SUITE-START | Running 2 tests 22:54:33 INFO - TEST-START | dromaeo_css 22:54:33 INFO - operating with platform_type : linux_ 22:54:33 INFO - Initialising browser for dromaeo_css test... 22:54:33 INFO - TEST-INFO | started process 6480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_2HVl/profile http://localhost:48593/getInfo.html) 22:54:37 INFO - PROCESS | 6480 | __metrics Screen width/height:1600/1200 22:54:37 INFO - PROCESS | 6480 | colorDepth:24 22:54:37 INFO - PROCESS | 6480 | Browser inner width/height: 1024/697 22:54:37 INFO - PROCESS | 6480 | __metrics 22:54:39 ERROR - PROCESS | 6480 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:54:40 INFO - TEST-INFO | 6480: exit 0 22:54:40 INFO - Browser initialized. 22:54:40 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:40 INFO - TEST-INFO | started process 6569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_2HVl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:51 INFO - PROCESS | 6569 | RSS: Main: 139161600 22:54:51 INFO - PROCESS | 6569 | 22:55:42 INFO - PROCESS | 6569 | 1466747742712 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] 22:57:50 INFO - PROCESS | 6569 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48593/tests/dromaeo/cssquery-ext.html) 22:57:51 INFO - PROCESS | 6569 | RSS: Main: 243515392 22:57:51 INFO - PROCESS | 6569 | 23:00:53 INFO - PROCESS | 6569 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-ext.html (next: http://localhost:48593/tests/dromaeo/cssquery-jquery.html) 23:00:54 INFO - PROCESS | 6569 | RSS: Main: 225947648 23:00:54 INFO - PROCESS | 6569 | 23:03:55 INFO - PROCESS | 6569 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48593/tests/dromaeo/cssquery-mootools.html) 23:03:56 INFO - PROCESS | 6569 | RSS: Main: 216625152 23:03:56 INFO - PROCESS | 6569 | 23:06:58 INFO - PROCESS | 6569 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48593/tests/dromaeo/cssquery-prototype.html) 23:06:58 INFO - PROCESS | 6569 | RSS: Main: 217866240 23:06:58 INFO - PROCESS | 6569 | 23:10:01 INFO - PROCESS | 6569 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48593/tests/dromaeo/cssquery-yui.html) 23:10:01 INFO - PROCESS | 6569 | RSS: Main: 208101376 23:10:01 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-yui.html (next: http://localhost:48593/tests/dromaeo/cssquery-dojo.html) 23:13:04 INFO - PROCESS | 6569 | RSS: Main: 254345216 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | __start_tp_report 23:13:04 INFO - PROCESS | 6569 | _x_x_mozilla_page_load 23:13:04 INFO - PROCESS | 6569 | _x_x_mozilla_page_load_details 23:13:04 INFO - PROCESS | 6569 | |i|pagename|runs| 23:13:04 INFO - PROCESS | 6569 | |0;dojo.html;3093.4741094014016;3103.968960310397;3106.3476669899346;3131.765117616178;3249.2851572654017;5292.232626269189;5302.257683924254;5308.389535203452;5324.92012619811;5347.064263753847;5303.390110137336;5312.096943519601;5315.734213289339;5316.308879845615;5337.412884582693;4838.250071238955;4879;4926.236433352836;4952.62855285855;4975.154223781948;4870.4885986971385;4915.5084491550915;4964.205727083668;4967.652264341497;4974.676646017997;4898.583620392271;4901.975490122562;4969.875753106165;4987.401511818587;4996.950030499703;4990.451050384455;4997.250412438127;5012.423571289312;5018.949810501885;5053.418856831457;4787.497312782178;4883.267509873512;4902.975485122552;4919.163742163841;4963.726995015273;5253.08071087562;5322.4411436799355;5326.360836699582;5329.493698098674;5342.252084708144;5598.832035038915;5669.376368599451;5672.971635141839;5678.4605462480995;5678.971605141989;5697.572682048822;5714.028615135396;5798.942010579883;5848.912266316009;5859.619124756877;5343.225232341328;5369.731513424353;5389.973050134763;5392.78428862845;5394.190871369247;5666.065099258576;5828.825135245949;5837.532997360201;5839.649621022752;5842.912356314659;5612.887742245132;5681.119426488901;5715.171300161536;5735.627184233012;5738.053221218535;5696.743646535916;5707.229524014288;5707.914381284284;5715.8571035724435;5717.742701578439;5495.873345964068;5603.075492543766;5612.85967850807;5615.803446879339;5634.915476267859;5706.4864162225595;5737.885242295214;5738.626989245769;5739.110437882052;5767;4366;4374.343848422762;4392.626626736763;4396.714213576107;4411.4926783420315;3894.844206231719;3898.317794385971;3907.531096268466;3923.0780766519847;3923.725339226227;5434.293541839615;5486.1222204447095;5487;5490.039243132436;5504.284443022461;5780.21967034445;5790.334111577138;5793.8841223175305;5796.101604251264;5799.797007104731;5440.673559586358;5480.862978425571;5488.094464413327;5576.163575463713;5592.5805564582815;4939.851804445872;4948.727819969864;4958.380202474691;4958.380202474691;4959.2561115832195;5947.940520594739;5990.371011043778;6000.729967151488;6017.428344307284;6038.758449662052;5652.0674088774895;5683.516901063291;5763.193152958505;5772.682502462405;5814.186013958049;5984.940150598438;5987.042073268256;5988.790392336247;5990.131430942576;5991.610545314541;5675.290588676416;5682.971585142213;5683.175939488834;5685.658860468385;5691.971540142438;5652.463016013472;5736.4550367715;5811.070228763378;5819.447152520504;5839.328477225174;5463.836084917459;5482.533984611353;5496.835094947158;5506.063969125178;5508.862278443071;5508.14623733322;5510.6969116698965;5510.889782204414;5513.393526712139;5562.694051827189;5456.290682211287;5553.972230138824;5618.494335509824;5643.012472817322;5654.378018417889;5645.435456454322;5661.433856614306;5667.4332566743;5668.886622267449;5670.716464176692;5445.891082178414;5492.505674489315;5548.750306236309;5555.666660000413;5586.664800112007 23:13:04 INFO - PROCESS | 6569 | |1;ext.html;664.4684252597921;672.7880717573964;693.9201991770947;740.9555426674403;749.898763666905;32759.1810204745;33141.17147071324;33324.50013249803;33336.83331583345;40563.18873622533;44206.33690494645;44838.775806120924;44897.77551112248;44945;44979.550204497944;8899.37704360695;9094.59074341653;9103.08969103091;9103.135202155818;9105.908940910605;8818.86771698425;8923.15230053144;8933.062028487013;8935.55322233889;8936.597853096626;8877.866831997526;9172.724818255463;9189;9189.127032931894;9193.08069193082;9095.681651142211;9138.63445462184;9141.72574822753;9145.45127292358;9149.764781754444;9143.862842057375;9247.537623118817;9247.72256832296;9248.907510924939;9259.398139121004;42821.785891070656;43207.56792432098;43235;43247.35128973068;43282.78358608187;3872.845086196549;3950.2889479893606;4236.237477254093;4240;4521.1409832131785;32799.97209446019;33217.3356532868;33424.16439589005;34506;34948.30103397918;4391.692581519295;4455.287154055368;4478.664100192466;4524.411826462571;4611.723296602215;345869;346131;346502;346816;347031.9999999975;41334.379984300256;60042.69978650079;60244.69877650672;60630;60639.39360606337;39383.2123357537;39468.407973880414;39490.407643885366;39497.802510987836;39517.40723889144;17364.39224627132;17442.389516366868;17511.912440437973;17529.386471473437;17545.56136096608;13535;13696.93151534236;13698.315084245747;13708.86291137076;13715;9348.1119293667;9353;9391.15479606825;9428.057194280516;9440.858387124199;3578.248567800739;3600.369935261319;3620.330238905811;3630.364686179908;3651.2514934438377;1118.369012024453;1174.4186627619383;1186.2467333243453;1203.3501908969233;1275.9234445933273;33906.15234619154;34471.4829277561;34677.65322346795;34834;35194.47208291878;1145.9228325374122;1188.4906169165113;1221.6762557922157;1234.975300493985;1304.9320658935835;17954.640907182045;18297.817021829876;18340.449786506426;18358.173882175335;18395.63208735818;429204;433237;434701;434863;435560;61785.69107154435;62349;62523.062154067724;62594.68702656458;62655.37344626587;1432.9498467553585;1484.970300593982;1496.6408062064809;1546.9226538673022;1590.236686390539;30919.2270193247;31368.68631313749;32185.678143219204;32393.838030809697;32753.34493310073;46011.3098303519;46474.53525464837;46510;46550.30174547452;46558.53441465542;241216;244328;245282;245603;436154;30424.543631845983;30703;30987.84506077455;31174.532382013833;31282.843585781924;48706;50326;56004;57043.71478142583;57535.42464575468;42247;42706;43185.35221971736;43228.78385608052;43961;40495.987600310225;41486.17027659369;41544.169116618104;41797.16405671809;42675.146497070506;41399.37900931428;42300.57699422966;42558.787206063775;43226.567734323515;43265.567344326155;35503.28993420169;36299.27401451903;36642.26715465623;36823.26353472969;36872.26255474929;29007.7099229005;29102;29117.563236551046;29325.26686832846;29431.705682943753 23:13:04 INFO - PROCESS | 6569 | |2;jquery.html;415.62801292842926;429.3216717586214;437.5689945403778;438.7985043211253;444.9644028477722;18747.3438429655;19127.46980241581;19482.41552753418;19602;20015.799842001576;20110.798892011077;20180.39458816238;20689.379318620428;20912;20954.89522552385;5412.675239485634;5724.971375143118;5773.249477567911;5797.072468405056;5804.970975145118;4342.240107981106;5676.233708449368;5841.8831623367505;6097.5426842986735;6392.264889537693;6360.332165122665;6381.872362552746;6389;6396.616203027833;6399.968000160016;5315.415304316522;5541.501264886139;5548.667079975195;5550.084236101038;6319.936800631981;4015.959840401617;4157.501099868035;5400.675959442446;5423.728813559306;5497.670139791585;14049.64875878101;14186.645333866632;14209.076410033314;14279.071860329046;20806.271780487612;2391.5336509380677;2484.1802205272215;2521.735217802141;2528.898844046236;2726.9590956135676;10350.327228730108;10498.685039448828;10634.915874396416;10925.125989920787;11121.16591255651;1923.6248931458372;1941.4175747275901;2001.3695685859054;2003.9098240579208;2025.3518873960338;80429.19570804275;81785;82224.17775822285;83051.58474207591;83203;10650.307729997525;10781.892181078088;10951;11002.834957475645;11449.141314401453;14738.336774845158;14760.630984225265;14764.26178691061;14814.037087589271;14831.92584037073;8525.872111918326;8711.912880871238;8772.956135219283;8842.602082906285;8911.2425443838;8766.430182038148;8831.514266715263;8978;9085.182333590008;9170.266378689688;4494.9325760113625;4674.672772905932;4752.904941901143;5017.623678224075;5080.669756465818;1772.9028033243071;1985.8312043476178;2059.618970490464;2082.7708952015264;2084.1871670048695;1012.3318609717551;1040.1626690514058;1103.784761971424;1112.1380929779486;1112.8497652816766;17945.282188712565;18538.721919171225;18690.439286821416;19441.31955381555;19582.90208548948;1076.612419528969;1085.5006696919347;1096.3476731344838;1115.0299239661547;1179.1804695736553;10831.350118992885;11144.944275278573;11238.325700458;11243.269187502787;11253.212275140826;455745;457520;464726;505625;508714;54793.72603136959;80133;88518.55740721384;96484.51757741306;96936;1127.5997021057406;1132.541320765108;1189.8274750161352;1194.3490797515376;1229.5266322465736;17192.570185744957;17717.291308348038;17776.91111544486;17917.193726282087;18048.90975545114;29978.25054373658;34153.829230853684;39659;40883.38674919819;41080.794596026826;60910;61041.38958610357;61253.38746612477;61565;62112;8900.777480563038;8926.107389261022;9065.546722663972;9099.54502274897;9189.402688825205;12966.286854223108;13802.792958105838;14091.859081409055;14172.574822755334;14552.85447145515;11965.04279657608;12228.510859565518;12312;12529.93735031319;12775.48898044105;10864.728381790519;11315.321080735182;11635.767284654428;11763;11870.703232419259;11719.648410547697;11877.346745929057;12143.574974875837;12180.330081845583;12906.67733306675;8475.915240847513;8801.823963520566;8884.422512536665;8933.776655583662;9175.587098580447;11549.826752598885;11795.941020294844;12153.574624888086;12177.695557610776;12724.681882953 23:13:04 INFO - PROCESS | 6569 | |3;mootools.html;1401.8457969623346;1501.759718445049;1555.1291276884945;1719.4927496388564;1851.8055604161555;7558.848823023543;8106.635201415936;8239.340852731782;8247.752567422973;8252.422330436872;8156.796080098001;8333.58332083395;8343.08226095129;8347;8349.62426690799;2334.9883250583725;2355.0579768092816;2357.139644029934;2358.422186564294;2358.9764102358927;2347.776961188693;2351.3651314145172;2396.496735685508;2400.327908185711;2400.543896659638;2356.02225076593;2376.2514807835564;2378.0368950575044;2402.255300856731;2411.0958390603523;2351.3651314145254;2384;2389.653500242464;2391.0555330644384;2392.437777122375;2266.875321857297;2319.0607803839303;2319.7100362454694;2321.1991862807304;2327.359976006595;7139.643017849139;7320.96339518299;8507.106753790888;8553.144685531397;8554.572271386469;4998.9500104999215;5082.593392528625;5097;5108.157154069574;5112.744362781846;3409.3692666856464;3437.5874895012507;3486.2504561519395;3556.5376501054957;3578.405655899478;1118.0943435816932;1133.2916926920675;1157.1784033336342;1175.4651633506735;1176.4999875053068;10999;11000.779984400348;11031;11312.264702794291;11313.264637798598;4270.743755374688;4386.824527018884;4392.956070439254;4409.536998615164;4446.088551846864;9805.754856128511;9818.459984700767;9847.50762461874;9862.211023118134;9870.012998700216;5098.59211263098;5134.794608215704;5136.768845401966;5141.76862041209;5145.3568303962;4728.881777955578;4729.125111854318;4731.195696731495;4735.029318989667;4742.359781429532;3678.7424880258127;3888.650021498079;3890.463267009515;3892.746971446847;3907.769052748375;1184.1474138620179;1195.6413076077142;1200.5257923120319;1208.6555331730415;1217.5008246618843;997.0777031246068;1010.6917390196061;1036.828923227674;1058.6718117383637;1062.0229388962173;5767.163761254678;5814.208521922929;5902.055671092605;5948.851278718067;5966.612170208922;1023.2223510132204;1038.3925403638805;1050.6847945616285;1056.1234175634206;1074.248026381536;3716.591174970751;4317.56824317572;4320.265554855682;4339.696221264481;4359.302511598193;9616.95191524038;9775.853362199572;9876.851847222297;9887.752806179904;9888.011198880198;9650.517474126265;9678.516074196263;9773.07155820196;9782.119609235204;10110.342827716175;7986.920130798734;8005.039395272488;8042.919570804334;8100.554469504116;8108.513489190667;6047.213862197887;6135.6932153393045;6193.102000210034;6234.937650623617;6250.531210159347;9340.34617576763;9381.061893810564;9416.435013899189;9584.424934503952;9599.616015359587;9483.715488535356;9672.95163524206;9763.170130538983;9805.235057689684;9813.705588832347;7268.055152830098;7281.8179545509665;7471.626418679153;7496.362809161283;7501.399888009056;8293.50716870969;8311.95844020776;8315.293200077818;8336.166383361615;8369.204925532309;7507.099148102263;7592.4305677075545;7592.696292148473;7654;7833.09919359281;7523.586202758901;7550.8867366990635;7594.582297973665;7657.961710191414;7679.308862202429;7018.789436316919;7049;7056.682449289691;7064.646767661699;7072.858542829217;5122.154844450624;5208.218767184952;5224.399194092728;5258.921116183337;5323.0684630190335;4733.313669517832;5062.721550314768;5284.497972692588;5306.681599103912;5354.518093371616 23:13:04 INFO - PROCESS | 6569 | |4;prototype.html;358.5571818803777;366.8165917041479;371.0649164106451;373.52189197826783;379.07127537533034;6041.395860413956;6041.697915104243;6043.637381757087;6082.209312789337;6154.3537928517535;6064.605800622957;6084.361142080084;6091.299500557438;6092.939070609293;6106.328303886569;4497.977510112445;4596.310553416981;4704.153252414564;4756.833510827122;4762.119007983517;4696.201645720219;4703.90592188156;4724.220503616899;4754.524547545235;4758.571728544431;4681.69568978017;4694.2723877799;4697.486844538173;4703.2239680452685;4707.799511124658;4434.312681534351;4507;4527.7736113194205;4573.062522182944;4706.035262771141;4142.420061191436;4146.963259185204;4155.91688166238;4163.521195062546;4167.541570427251;5755.683437410982;5774.451427114417;5778.479936805666;5779;5784.421557844224;5397.865053373658;5403.108487099624;5473.2063850741415;5481.671099734029;5503.229547863302;6392.776252831175;6405.455536279422;6408.455281301049;6408.711607977652;6418.229812422493;4364.236258654754;4543;4546.113507865967;4644.117617652635;4648.83729069481;6652.268250492442;6660.666966651648;6697.631630260334;6711.597304161766;6720.865582688368;4652.767361631905;4660.161170989254;4660.650451216173;4669.4396672399525;4677.22825733757;4696.295555666609;4709.7174169549935;4710.9764451177525;4720.362751028636;4726.031163611451;5411.972940135274;5413.079776438015;5421.241026256327;5428.131498960148;5428.701421421781;6241.095041219089;6480.935190648128;6490.513211509156;6503.154589903377;6504.804855854332;1633.1670847867672;1653.768472413863;1659.2035822805121;1664.4673704414472;1669.282208650292;1081.34578579958;1093.824988001916;1117.2626066795876;1127.8702949160952;1128.6219116596033;6103.450689437972;6227.595206311576;6307.3377295383325;6369.681515924185;6370.904436433457;6693.464522838161;6694.163229596301;6701.731930722716;6703.631300278434;6705.362990515893;6341.3341599132345;6343.0485427186295;6347.016212487072;6351.587146835441;6353.269374021954;3578.6958108560543;3614.403623402162;3615.8553657853918;3618.9276214475562;3620.909477263037;6864.965675171592;6995.930040699528;7006.054182685272;7009.1589009319205;7019.92980070203;6842.828929276808;6845.794626161223;6852.828679283058;6862.451003919675;6866.313368663194;6987.965060174666;6990.755323563651;7009.088818453569;7014.0531028310525;7015.228324884259;6684.83287917806;6698.296678848651;6698.732050718112;6706.765263215764;6706.83232919181;6461.224653041665;6600.273969863215;6613.437857782143;6622.1722284714415;6624.403803657694;6943.340382663639;6979.127609048869;6984.650767461505;6988.8951665724035;6989;4617.8383756568355;4629.213033784332;4631.4442266926835;4632.745199014086;4634.026854360487;6666.699998499982;6670.099536562502;6686.364795344434;6686.83282917931;6686.966565167143;6382.489400847828;6506.73973041092;6511.316311787384;6519.7392104315295;6520.706568204348;6488.740450381932;6491.415772580491;6505.121808555974;6505.934940650533;6511.967440162769;6349.269833969152;6383.776567820104;6395.328490508429;6406.295307516077;6410.583312084699;6526.282108968105;6536.215654121535;6545.476361890942;6557.639329836905;6560.179977502812;6082.5438092142385;6396.71214795326;6397.776077837253;6401.55189136756;6402.135711678864 23:13:04 INFO - PROCESS | 6569 | |5;yui.html;928.0626567167163;929.8140371925616;931.6925414613177;935.6117211357285;936.5317341329335;14934;15182.39270429183;15196.392144314228;17374.91312543439;17723.64552708945;15932.920335398307;16011.119388433632;16070.196490175504;16074.59813504663;16085.91957040216;763.0385714000372;879.0594064351147;882.201607545171;893.1738142218454;907.63694522191;879.7009016934242;879.7888506758396;883.1654086887894;886.0607755778863;886.3219636977717;909.5361365703473;909.8908131024253;910.5219759626183;916.0610374366295;918.2562124678998;786.2216405758315;913.4747520175893;924;948.2887834124407;950.8431108867029;687.2886562407933;691.7025678958046;694.2952902803659;695.5339922252103;696.2793508718503;15378.461753838563;15407.30667119971;15420.537383878502;15456.459023934221;15474;13937.512187073506;14307.28463576817;14317.78523322151;14331.140131592034;14413.063150895263;11709.882901170964;11714.062874969983;11985.340806255652;12051.276923384625;12215.75568488634;3968.6229808168177;3998.7000974926996;4001.9399709004388;4030.2141082488924;4077.4495443115097;60541;61237.387626123615;61564.692176539276;61952.07071893925;62597;11507.539698411969;11790.351530665896;11823.940880295544;12021.398930053463;12091.45588448522;20702.068406921724;20889.582208355747;20906.79093209079;20910.686339704916;21024.894875525526;8989.730308090768;9180.219681327162;9326.253899688008;9440;9572.282078844115;4842.806287748451;4884.755762211875;4916.582090522345;5095.235714642833;5412.404635490093;3594;3638.43604241343;3646.9452958205648;3648.5621725392593;3649.525561676965;684.5824047331124;691.5401258163365;697.2365260040248;701.6947627781931;704.4505285877024;699.0841996983967;747.4356860570343;836.9455985360933;838.9412741108064;851.1871163039283;9695.757606059906;9948.701538953697;10457.790844183073;10493.737656558647;10514.26400151982;816.14304979771;822.2517509066721;827.8634025385865;842.839860426517;855.7176131876466;4864.343313652612;4903.509649035068;4929.211326187793;4942.283368911488;4961.479044700327;66795.66602167055;68070;68142;68173.65913170403;69601.65199174073;53910.191347129825;60119;60787;61012.38987610067;61186.08220876691;49853;49911;50956.74521627442;54017.729911350194;54535.45464545383;9911.555232198585;10125.139363154214;10278.743031424274;10353.534090966075;10390.324628899098;39266.607333926295;40242.59757402389;40245;40909.38635920404;41514.37728434015;50101.74949125231;50766;50814;51269;52239.73880130727;12741.362931853186;12853.35733213317;13186.670333241746;13261.867381326063;13354.399052042487;13585.184888906697;14441.133531987694;14471.421143154577;14543.272836357928;15171.62070948191;12436.00511959023;12447.93776031114;12466.937665311978;12668.366581670694;12967.546135885199;13136.146150500186;14201.786973195203;14585.562433127023;14587.781183282046;14614.853851461774;13190.142640728322;13841.377138029015;13969.272598234675;14131.081479703786;14147.64630884236;10980.1215902726;11104.44477776124;11166.274192177483;11312.264702794291;11499.885001149882;10655.200859935381;11272.605458808903;11469.885301147215;11499.482523286304;11505.48225329879 23:13:04 INFO - PROCESS | 6569 | __end_tp_report 23:13:04 INFO - PROCESS | 6569 | __start_cc_report 23:13:04 INFO - PROCESS | 6569 | _x_x_mozilla_cycle_collect,787 23:13:04 INFO - PROCESS | 6569 | __end_cc_report 23:13:04 INFO - PROCESS | 6569 | __startTimestamp1466748784709__endTimestamp 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | ------- Summary: start ------- 23:13:04 INFO - PROCESS | 6569 | Number of tests: 6 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | [#0] dojo.html Cycles:165 Average:5338.16 Median:5508.86 stddev:595.67 (10.8%) stddev-sans-first:570.87 23:13:04 INFO - PROCESS | 6569 | Values: 3093.5 3104.0 3106.3 3131.8 3249.3 5292.2 5302.3 5308.4 5324.9 5347.1 5303.4 5312.1 5315.7 5316.3 5337.4 4838.3 4879.0 4926.2 4952.6 4975.2 4870.5 4915.5 4964.2 4967.7 4974.7 4898.6 4902.0 4969.9 4987.4 4997.0 4990.5 4997.3 5012.4 5018.9 5053.4 4787.5 4883.3 4903.0 4919.2 4963.7 5253.1 5322.4 5326.4 5329.5 5342.3 5598.8 5669.4 5673.0 5678.5 5679.0 5697.6 5714.0 5798.9 5848.9 5859.6 5343.2 5369.7 5390.0 5392.8 5394.2 5666.1 5828.8 5837.5 5839.6 5842.9 5612.9 5681.1 5715.2 5735.6 5738.1 5696.7 5707.2 5707.9 5715.9 5717.7 5495.9 5603.1 5612.9 5615.8 5634.9 5706.5 5737.9 5738.6 5739.1 5767.0 4366.0 4374.3 4392.6 4396.7 4411.5 3894.8 3898.3 3907.5 3923.1 3923.7 5434.3 5486.1 5487.0 5490.0 5504.3 5780.2 5790.3 5793.9 5796.1 5799.8 5440.7 5480.9 5488.1 5576.2 5592.6 4939.9 4948.7 4958.4 4958.4 4959.3 5947.9 5990.4 6000.7 6017.4 6038.8 5652.1 5683.5 5763.2 5772.7 5814.2 5984.9 5987.0 5988.8 5990.1 5991.6 5675.3 5683.0 5683.2 5685.7 5692.0 5652.5 5736.5 5811.1 5819.4 5839.3 5463.8 5482.5 5496.8 5506.1 5508.9 5508.1 5510.7 5510.9 5513.4 5562.7 5456.3 5554.0 5618.5 5643.0 5654.4 5645.4 5661.4 5667.4 5668.9 5670.7 5445.9 5492.5 5548.8 5555.7 5586.7 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | [#1] ext.html Cycles:180 Average:52474.31 Median:41670.67 stddev:95529.72 (229.2%) stddev-sans-first:95718.50 23:13:04 INFO - PROCESS | 6569 | Values: 664.5 672.8 693.9 741.0 749.9 32759.2 33141.2 33324.5 33336.8 40563.2 44206.3 44838.8 44897.8 44945.0 44979.6 8899.4 9094.6 9103.1 9103.1 9105.9 8818.9 8923.2 8933.1 8935.6 8936.6 8877.9 9172.7 9189.0 9189.1 9193.1 9095.7 9138.6 9141.7 9145.5 9149.8 9143.9 9247.5 9247.7 9248.9 9259.4 42821.8 43207.6 43235.0 43247.4 43282.8 3872.8 3950.3 4236.2 4240.0 4521.1 32800.0 33217.3 33424.2 34506.0 34948.3 4391.7 4455.3 4478.7 4524.4 4611.7 345869.0 346131.0 346502.0 346816.0 347032.0 41334.4 60042.7 60244.7 60630.0 60639.4 39383.2 39468.4 39490.4 39497.8 39517.4 17364.4 17442.4 17511.9 17529.4 17545.6 13535.0 13696.9 13698.3 13708.9 13715.0 9348.1 9353.0 9391.2 9428.1 9440.9 3578.2 3600.4 3620.3 3630.4 3651.3 1118.4 1174.4 1186.2 1203.4 1275.9 33906.2 34471.5 34677.7 34834.0 35194.5 1145.9 1188.5 1221.7 1235.0 1304.9 17954.6 18297.8 18340.4 18358.2 18395.6 429204.0 433237.0 434701.0 434863.0 435560.0 61785.7 62349.0 62523.1 62594.7 62655.4 1432.9 1485.0 1496.6 1546.9 1590.2 30919.2 31368.7 32185.7 32393.8 32753.3 46011.3 46474.5 46510.0 46550.3 46558.5 241216.0 244328.0 245282.0 245603.0 436154.0 30424.5 30703.0 30987.8 31174.5 31282.8 48706.0 50326.0 56004.0 57043.7 57535.4 42247.0 42706.0 43185.4 43228.8 43961.0 40496.0 41486.2 41544.2 41797.2 42675.1 41399.4 42300.6 42558.8 43226.6 43265.6 35503.3 36299.3 36642.3 36823.3 36872.3 29007.7 29102.0 29117.6 29325.3 29431.7 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | [#2] jquery.html Cycles:180 Average:28421.85 Median:11444.52 stddev:78942.82 (689.8%) stddev-sans-first:79136.27 23:13:04 INFO - PROCESS | 6569 | Values: 415.6 429.3 437.6 438.8 445.0 18747.3 19127.5 19482.4 19602.0 20015.8 20110.8 20180.4 20689.4 20912.0 20954.9 5412.7 5725.0 5773.2 5797.1 5805.0 4342.2 5676.2 5841.9 6097.5 6392.3 6360.3 6381.9 6389.0 6396.6 6400.0 5315.4 5541.5 5548.7 5550.1 6319.9 4016.0 4157.5 5400.7 5423.7 5497.7 14049.6 14186.6 14209.1 14279.1 20806.3 2391.5 2484.2 2521.7 2528.9 2727.0 10350.3 10498.7 10634.9 10925.1 11121.2 1923.6 1941.4 2001.4 2003.9 2025.4 80429.2 81785.0 82224.2 83051.6 83203.0 10650.3 10781.9 10951.0 11002.8 11449.1 14738.3 14760.6 14764.3 14814.0 14831.9 8525.9 8711.9 8773.0 8842.6 8911.2 8766.4 8831.5 8978.0 9085.2 9170.3 4494.9 4674.7 4752.9 5017.6 5080.7 1772.9 1985.8 2059.6 2082.8 2084.2 1012.3 1040.2 1103.8 1112.1 1112.8 17945.3 18538.7 18690.4 19441.3 19582.9 1076.6 1085.5 1096.3 1115.0 1179.2 10831.4 11144.9 11238.3 11243.3 11253.2 455745.0 457520.0 464726.0 505625.0 508714.0 54793.7 80133.0 88518.6 96484.5 96936.0 1127.6 1132.5 1189.8 1194.3 1229.5 17192.6 17717.3 17776.9 17917.2 18048.9 29978.3 34153.8 39659.0 40883.4 41080.8 60910.0 61041.4 61253.4 61565.0 62112.0 8900.8 8926.1 9065.5 9099.5 9189.4 12966.3 13802.8 14091.9 14172.6 14552.9 11965.0 12228.5 12312.0 12529.9 12775.5 10864.7 11315.3 11635.8 11763.0 11870.7 11719.6 11877.3 12143.6 12180.3 12906.7 8475.9 8801.8 8884.4 8933.8 9175.6 11549.8 11795.9 12153.6 12177.7 12724.7 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | [#3] mootools.html Cycles:180 Average:5593.94 Median:5139.27 stddev:3011.85 (58.6%) stddev-sans-first:3003.82 23:13:04 INFO - PROCESS | 6569 | Values: 1401.8 1501.8 1555.1 1719.5 1851.8 7558.8 8106.6 8239.3 8247.8 8252.4 8156.8 8333.6 8343.1 8347.0 8349.6 2335.0 2355.1 2357.1 2358.4 2359.0 2347.8 2351.4 2396.5 2400.3 2400.5 2356.0 2376.3 2378.0 2402.3 2411.1 2351.4 2384.0 2389.7 2391.1 2392.4 2266.9 2319.1 2319.7 2321.2 2327.4 7139.6 7321.0 8507.1 8553.1 8554.6 4999.0 5082.6 5097.0 5108.2 5112.7 3409.4 3437.6 3486.3 3556.5 3578.4 1118.1 1133.3 1157.2 1175.5 1176.5 10999.0 11000.8 11031.0 11312.3 11313.3 4270.7 4386.8 4393.0 4409.5 4446.1 9805.8 9818.5 9847.5 9862.2 9870.0 5098.6 5134.8 5136.8 5141.8 5145.4 4728.9 4729.1 4731.2 4735.0 4742.4 3678.7 3888.7 3890.5 3892.7 3907.8 1184.1 1195.6 1200.5 1208.7 1217.5 997.1 1010.7 1036.8 1058.7 1062.0 5767.2 5814.2 5902.1 5948.9 5966.6 1023.2 1038.4 1050.7 1056.1 1074.2 3716.6 4317.6 4320.3 4339.7 4359.3 9617.0 9775.9 9876.9 9887.8 9888.0 9650.5 9678.5 9773.1 9782.1 10110.3 7986.9 8005.0 8042.9 8100.6 8108.5 6047.2 6135.7 6193.1 6234.9 6250.5 9340.3 9381.1 9416.4 9584.4 9599.6 9483.7 9673.0 9763.2 9805.2 9813.7 7268.1 7281.8 7471.6 7496.4 7501.4 8293.5 8312.0 8315.3 8336.2 8369.2 7507.1 7592.4 7592.7 7654.0 7833.1 7523.6 7550.9 7594.6 7658.0 7679.3 7018.8 7049.0 7056.7 7064.6 7072.9 5122.2 5208.2 5224.4 5258.9 5323.1 4733.3 5062.7 5284.5 5306.7 5354.5 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | [#4] prototype.html Cycles:180 Average:5438.84 Median:6130.34 stddev:1630.68 (26.6%) stddev-sans-first:1590.04 23:13:04 INFO - PROCESS | 6569 | Values: 358.6 366.8 371.1 373.5 379.1 6041.4 6041.7 6043.6 6082.2 6154.4 6064.6 6084.4 6091.3 6092.9 6106.3 4498.0 4596.3 4704.2 4756.8 4762.1 4696.2 4703.9 4724.2 4754.5 4758.6 4681.7 4694.3 4697.5 4703.2 4707.8 4434.3 4507.0 4527.8 4573.1 4706.0 4142.4 4147.0 4155.9 4163.5 4167.5 5755.7 5774.5 5778.5 5779.0 5784.4 5397.9 5403.1 5473.2 5481.7 5503.2 6392.8 6405.5 6408.5 6408.7 6418.2 4364.2 4543.0 4546.1 4644.1 4648.8 6652.3 6660.7 6697.6 6711.6 6720.9 4652.8 4660.2 4660.7 4669.4 4677.2 4696.3 4709.7 4711.0 4720.4 4726.0 5412.0 5413.1 5421.2 5428.1 5428.7 6241.1 6480.9 6490.5 6503.2 6504.8 1633.2 1653.8 1659.2 1664.5 1669.3 1081.3 1093.8 1117.3 1127.9 1128.6 6103.5 6227.6 6307.3 6369.7 6370.9 6693.5 6694.2 6701.7 6703.6 6705.4 6341.3 6343.0 6347.0 6351.6 6353.3 3578.7 3614.4 3615.9 3618.9 3620.9 6865.0 6995.9 7006.1 7009.2 7019.9 6842.8 6845.8 6852.8 6862.5 6866.3 6988.0 6990.8 7009.1 7014.1 7015.2 6684.8 6698.3 6698.7 6706.8 6706.8 6461.2 6600.3 6613.4 6622.2 6624.4 6943.3 6979.1 6984.7 6988.9 6989.0 4617.8 4629.2 4631.4 4632.7 4634.0 6666.7 6670.1 6686.4 6686.8 6687.0 6382.5 6506.7 6511.3 6519.7 6520.7 6488.7 6491.4 6505.1 6505.9 6512.0 6349.3 6383.8 6395.3 6406.3 6410.6 6526.3 6536.2 6545.5 6557.6 6560.2 6082.5 6396.7 6397.8 6401.6 6402.1 23:13:04 INFO - PROCESS | 6569 | 23:13:04 INFO - PROCESS | 6569 | [#5] yui.html Cycles:180 Average:16235.73 Median:41211.88 stddev:18808.37 (45.6%) stddev-sans-first:18826.00 23:13:04 INFO - PROCESS | 6569 | Values: 928.1 929.8 931.7 935.6 936.5 14934.0 15182.4 15196.4 17374.9 17723.6 15932.9 16011.1 16070.2 16074.6 16085.9 763.0 879.1 882.2 893.2 907.6 879.7 879.8 883.2 886.1 886.3 909.5 909.9 910.5 916.1 918.3 786.2 913.5 924.0 948.3 950.8 687.3 691.7 694.3 695.5 696.3 15378.5 15407.3 15420.5 15456.5 15474.0 13937.5 14307.3 14317.8 14331.1 14413.1 11709.9 11714.1 11985.3 12051.3 12215.8 3968.6 3998.7 4001.9 4030.2 4077.4 60541.0 61237.4 61564.7 61952.1 62597.0 11507.5 11790.4 11823.9 12021.4 12091.5 20702.1 20889.6 20906.8 20910.7 21024.9 8989.7 9180.2 9326.3 9440.0 9572.3 4842.8 4884.8 4916.6 5095.2 5412.4 3594.0 3638.4 3646.9 3648.6 3649.5 684.6 691.5 697.2 701.7 704.5 699.1 747.4 836.9 838.9 851.2 9695.8 9948.7 10457.8 10493.7 10514.3 816.1 822.3 827.9 842.8 855.7 4864.3 4903.5 4929.2 4942.3 4961.5 66795.7 68070.0 68142.0 68173.7 69601.7 53910.2 60119.0 60787.0 61012.4 61186.1 49853.0 49911.0 50956.7 54017.7 54535.5 9911.6 10125.1 10278.7 10353.5 10390.3 39266.6 40242.6 40245.0 40909.4 41514.4 50101.7 50766.0 50814.0 51269.0 52239.7 12741.4 12853.4 13186.7 13261.9 13354.4 13585.2 14441.1 14471.4 14543.3 15171.6 12436.0 12447.9 12466.9 12668.4 12967.5 13136.1 14201.8 14585.6 14587.8 14614.9 13190.1 13841.4 13969.3 14131.1 14147.6 10980.1 11104.4 11166.3 11312.3 11499.9 10655.2 11272.6 11469.9 11499.5 11505.5 23:13:04 INFO - PROCESS | 6569 | -------- Summary: end -------- 23:13:04 INFO - PROCESS | 6569 | 23:13:05 INFO - TEST-INFO | 6569: exit 0 23:13:05 INFO - TEST-OK | dromaeo_css | took 1112422ms 23:13:05 INFO - TEST-START | kraken 23:13:05 INFO - operating with platform_type : linux_ 23:13:05 INFO - Initialising browser for kraken test... 23:13:05 INFO - TEST-INFO | started process 6757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPaZLyP/profile http://localhost:48593/getInfo.html) 23:13:10 INFO - PROCESS | 6757 | __metrics Screen width/height:1600/1200 23:13:10 INFO - PROCESS | 6757 | colorDepth:24 23:13:10 INFO - PROCESS | 6757 | Browser inner width/height: 1024/697 23:13:10 INFO - PROCESS | 6757 | __metrics 23:13:12 ERROR - PROCESS | 6757 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:13:13 INFO - TEST-INFO | 6757: exit 0 23:13:13 INFO - Browser initialized. 23:13:13 INFO - Running cycle 1/1 for kraken test... 23:13:13 INFO - TEST-INFO | started process 6848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPaZLyP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:24 INFO - PROCESS | 6848 | RSS: Main: 139653120 23:13:24 INFO - PROCESS | 6848 | 23:13:27 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:28 INFO - PROCESS | 6848 | RSS: Main: 197435392 23:13:28 INFO - PROCESS | 6848 | 23:13:30 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-dft) 23:13:31 INFO - PROCESS | 6848 | RSS: Main: 185278464 23:13:31 INFO - PROCESS | 6848 | 23:13:34 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-fft) 23:13:34 INFO - PROCESS | 6848 | RSS: Main: 274153472 23:13:34 INFO - PROCESS | 6848 | 23:13:36 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-oscillator) 23:13:37 INFO - PROCESS | 6848 | RSS: Main: 180711424 23:13:37 INFO - PROCESS | 6848 | 23:13:39 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:40 INFO - PROCESS | 6848 | RSS: Main: 179109888 23:13:40 INFO - PROCESS | 6848 | 23:13:43 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48593/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:43 INFO - PROCESS | 6848 | RSS: Main: 213594112 23:13:43 INFO - PROCESS | 6848 | 23:13:47 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48593/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:47 INFO - PROCESS | 6848 | RSS: Main: 213430272 23:13:47 INFO - PROCESS | 6848 | 23:13:50 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48593/tests/kraken/driver.html?testName=json-parse-financial) 23:13:51 INFO - PROCESS | 6848 | RSS: Main: 213696512 23:13:51 INFO - PROCESS | 6848 | 23:13:52 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:53 INFO - PROCESS | 6848 | RSS: Main: 196055040 23:13:53 INFO - PROCESS | 6848 | 23:13:54 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:55 INFO - PROCESS | 6848 | RSS: Main: 199131136 23:13:55 INFO - PROCESS | 6848 | 23:13:57 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:57 INFO - PROCESS | 6848 | RSS: Main: 209883136 23:13:57 INFO - PROCESS | 6848 | 23:14:00 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:00 INFO - PROCESS | 6848 | RSS: Main: 217186304 23:14:00 INFO - PROCESS | 6848 | 23:14:03 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:04 INFO - PROCESS | 6848 | RSS: Main: 212541440 23:14:04 INFO - PROCESS | 6848 | 23:14:05 INFO - PROCESS | 6848 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48593/tests/kraken/driver.html?testName=ai-astar) 23:14:06 INFO - PROCESS | 6848 | RSS: Main: 273989632 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | __start_tp_report 23:14:06 INFO - PROCESS | 6848 | _x_x_mozilla_page_load 23:14:06 INFO - PROCESS | 6848 | _x_x_mozilla_page_load_details 23:14:06 INFO - PROCESS | 6848 | |i|pagename|runs| 23:14:06 INFO - PROCESS | 6848 | |0;ai-astar;113;112;111;111;112;112;105;110;111;110 23:14:06 INFO - PROCESS | 6848 | |1;audio-beat-detection;151;125;160;182;126;152;152;130;189;127 23:14:06 INFO - PROCESS | 6848 | |2;audio-dft;161;160;160;162;162;160;162;161;159;160 23:14:06 INFO - PROCESS | 6848 | |3;audio-fft;75;76;74;176;73;73;75;73;153;76 23:14:06 INFO - PROCESS | 6848 | |4;audio-oscillator;92;92;150;91;92;91;140;92;92;149 23:14:06 INFO - PROCESS | 6848 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;116;116;116 23:14:06 INFO - PROCESS | 6848 | |6;imaging-darkroom;146;146;145;145;146;145;145;149;146;145 23:14:06 INFO - PROCESS | 6848 | |7;imaging-desaturate;95;94;95;94;95;94;94;95;95;94 23:14:06 INFO - PROCESS | 6848 | |8;json-parse-financial;53;54;56;53;54;54;57;74;52;52 23:14:06 INFO - PROCESS | 6848 | |9;json-stringify-tinderbox;57;58;58;58;58;58;57;58;58;58 23:14:06 INFO - PROCESS | 6848 | |10;stanford-crypto-aes;72;71;71;78;72;72;73;72;74;72 23:14:06 INFO - PROCESS | 6848 | |11;stanford-crypto-ccm;112;116;121;114;112;109;118;112;127;134 23:14:06 INFO - PROCESS | 6848 | |12;stanford-crypto-pbkdf2;157;163;155;156;156;161;157;160;156;157 23:14:06 INFO - PROCESS | 6848 | |13;stanford-crypto-sha256-iterative;69;65;66;66;65;66;64;65;65;64 23:14:06 INFO - PROCESS | 6848 | __end_tp_report 23:14:06 INFO - PROCESS | 6848 | __start_cc_report 23:14:06 INFO - PROCESS | 6848 | _x_x_mozilla_cycle_collect,1576 23:14:06 INFO - PROCESS | 6848 | __end_cc_report 23:14:06 INFO - PROCESS | 6848 | __startTimestamp1466748846133__endTimestamp 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | ------- Summary: start ------- 23:14:06 INFO - PROCESS | 6848 | Number of tests: 14 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.21 (2.0%) stddev-sans-first:2.19 23:14:06 INFO - PROCESS | 6848 | Values: 113.0 112.0 111.0 111.0 112.0 112.0 105.0 110.0 111.0 110.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:152.00 stddev:23.05 (15.2%) stddev-sans-first:24.44 23:14:06 INFO - PROCESS | 6848 | Values: 151.0 125.0 160.0 182.0 126.0 152.0 152.0 130.0 189.0 127.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 23:14:06 INFO - PROCESS | 6848 | Values: 161.0 160.0 160.0 162.0 162.0 160.0 162.0 161.0 159.0 160.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#3] audio-fft Cycles:10 Average:92.40 Median:74.50 stddev:38.40 (51.5%) stddev-sans-first:40.21 23:14:06 INFO - PROCESS | 6848 | Values: 75.0 76.0 74.0 176.0 73.0 73.0 75.0 73.0 153.0 76.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:92.00 stddev:26.51 (28.8%) stddev-sans-first:27.47 23:14:06 INFO - PROCESS | 6848 | Values: 92.0 92.0 150.0 91.0 92.0 91.0 140.0 92.0 92.0 149.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 23:14:06 INFO - PROCESS | 6848 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 116.0 116.0 116.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 23:14:06 INFO - PROCESS | 6848 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 149.0 146.0 145.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 23:14:06 INFO - PROCESS | 6848 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.00 stddev:6.56 (12.1%) stddev-sans-first:6.87 23:14:06 INFO - PROCESS | 6848 | Values: 53.0 54.0 56.0 53.0 54.0 54.0 57.0 74.0 52.0 52.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 23:14:06 INFO - PROCESS | 6848 | Values: 57.0 58.0 58.0 58.0 58.0 58.0 57.0 58.0 58.0 58.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:72.00 stddev:2.06 (2.9%) stddev-sans-first:2.17 23:14:06 INFO - PROCESS | 6848 | Values: 72.0 71.0 71.0 78.0 72.0 72.0 73.0 72.0 74.0 72.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:117.00 stddev:7.84 (6.7%) stddev-sans-first:8.05 23:14:06 INFO - PROCESS | 6848 | Values: 112.0 116.0 121.0 114.0 112.0 109.0 118.0 112.0 127.0 134.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:157.00 stddev:2.62 (1.7%) stddev-sans-first:2.76 23:14:06 INFO - PROCESS | 6848 | Values: 157.0 163.0 155.0 156.0 156.0 161.0 157.0 160.0 156.0 157.0 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - PROCESS | 6848 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.43 (2.2%) stddev-sans-first:0.78 23:14:06 INFO - PROCESS | 6848 | Values: 69.0 65.0 66.0 66.0 65.0 66.0 64.0 65.0 65.0 64.0 23:14:06 INFO - PROCESS | 6848 | -------- Summary: end -------- 23:14:06 INFO - PROCESS | 6848 | 23:14:06 INFO - TEST-INFO | 6848: exit 0 23:14:07 INFO - TEST-OK | kraken | took 61613ms 23:14:07 INFO - SUITE-END | took 1174s 23:14:07 INFO - Completed test suite (00:19:34) 23:14:07 INFO - javascript benchmark 23:14:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.4741094014016, 3103.968960310397, 3106.3476669899346, 3131.765117616178, 3249.2851572654017, 5292.232626269189, 5302.257683924254, 5308.389535203452, 5324.92012619811, 5347.064263753847, 5303.390110137336, 5312.096943519601, 5315.734213289339, 5316.308879845615, 5337.412884582693, 4838.250071238955, 4879.0, 4926.236433352836, 4952.62855285855, 4975.154223781948, 4870.4885986971385, 4915.5084491550915, 4964.205727083668, 4967.652264341497, 4974.676646017997, 4898.583620392271, 4901.975490122562, 4969.875753106165, 4987.401511818587, 4996.950030499703, 4990.451050384455, 4997.250412438127, 5012.423571289312, 5018.949810501885, 5053.418856831457, 4787.497312782178, 4883.267509873512, 4902.975485122552, 4919.163742163841, 4963.726995015273, 5253.08071087562, 5322.4411436799355, 5326.360836699582, 5329.493698098674, 5342.252084708144, 5598.832035038915, 5669.376368599451, 5672.971635141839, 5678.4605462480995, 5678.971605141989, 5697.572682048822, 5714.028615135396, 5798.942010579883, 5848.912266316009, 5859.619124756877, 5343.225232341328, 5369.731513424353, 5389.973050134763, 5392.78428862845, 5394.190871369247, 5666.065099258576, 5828.825135245949, 5837.532997360201, 5839.649621022752, 5842.912356314659, 5612.887742245132, 5681.119426488901, 5715.171300161536, 5735.627184233012, 5738.053221218535, 5696.743646535916, 5707.229524014288, 5707.914381284284, 5715.8571035724435, 5717.742701578439, 5495.873345964068, 5603.075492543766, 5612.85967850807, 5615.803446879339, 5634.915476267859, 5706.4864162225595, 5737.885242295214, 5738.626989245769, 5739.110437882052, 5767.0, 4366.0, 4374.343848422762, 4392.626626736763, 4396.714213576107, 4411.4926783420315, 3894.844206231719, 3898.317794385971, 3907.531096268466, 3923.0780766519847, 3923.725339226227, 5434.293541839615, 5486.1222204447095, 5487.0, 5490.039243132436, 5504.284443022461, 5780.21967034445, 5790.334111577138, 5793.8841223175305, 5796.101604251264, 5799.797007104731, 5440.673559586358, 5480.862978425571, 5488.094464413327, 5576.163575463713, 5592.5805564582815, 4939.851804445872, 4948.727819969864, 4958.380202474691, 4958.380202474691, 4959.2561115832195, 5947.940520594739, 5990.371011043778, 6000.729967151488, 6017.428344307284, 6038.758449662052, 5652.0674088774895, 5683.516901063291, 5763.193152958505, 5772.682502462405, 5814.186013958049, 5984.940150598438, 5987.042073268256, 5988.790392336247, 5990.131430942576, 5991.610545314541, 5675.290588676416, 5682.971585142213, 5683.175939488834, 5685.658860468385, 5691.971540142438, 5652.463016013472, 5736.4550367715, 5811.070228763378, 5819.447152520504, 5839.328477225174, 5463.836084917459, 5482.533984611353, 5496.835094947158, 5506.063969125178, 5508.862278443071, 5508.14623733322, 5510.6969116698965, 5510.889782204414, 5513.393526712139, 5562.694051827189, 5456.290682211287, 5553.972230138824, 5618.494335509824, 5643.012472817322, 5654.378018417889, 5645.435456454322, 5661.433856614306, 5667.4332566743, 5668.886622267449, 5670.716464176692, 5445.891082178414, 5492.505674489315, 5548.750306236309, 5555.666660000413, 5586.664800112007], "value": 5298.540058971055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.4684252597921, 672.7880717573964, 693.9201991770947, 740.9555426674403, 749.898763666905, 32759.1810204745, 33141.17147071324, 33324.50013249803, 33336.83331583345, 40563.18873622533, 44206.33690494645, 44838.775806120924, 44897.77551112248, 44945.0, 44979.550204497944, 8899.37704360695, 9094.59074341653, 9103.08969103091, 9103.135202155818, 9105.908940910605, 8818.86771698425, 8923.15230053144, 8933.062028487013, 8935.55322233889, 8936.597853096626, 8877.866831997526, 9172.724818255463, 9189.0, 9189.127032931894, 9193.08069193082, 9095.681651142211, 9138.63445462184, 9141.72574822753, 9145.45127292358, 9149.764781754444, 9143.862842057375, 9247.537623118817, 9247.72256832296, 9248.907510924939, 9259.398139121004, 42821.785891070656, 43207.56792432098, 43235.0, 43247.35128973068, 43282.78358608187, 3872.845086196549, 3950.2889479893606, 4236.237477254093, 4240.0, 4521.1409832131785, 32799.97209446019, 33217.3356532868, 33424.16439589005, 34506.0, 34948.30103397918, 4391.692581519295, 4455.287154055368, 4478.664100192466, 4524.411826462571, 4611.723296602215, 345869.0, 346131.0, 346502.0, 346816.0, 347031.9999999975, 41334.379984300256, 60042.69978650079, 60244.69877650672, 60630.0, 60639.39360606337, 39383.2123357537, 39468.407973880414, 39490.407643885366, 39497.802510987836, 39517.40723889144, 17364.39224627132, 17442.389516366868, 17511.912440437973, 17529.386471473437, 17545.56136096608, 13535.0, 13696.93151534236, 13698.315084245747, 13708.86291137076, 13715.0, 9348.1119293667, 9353.0, 9391.15479606825, 9428.057194280516, 9440.858387124199, 3578.248567800739, 3600.369935261319, 3620.330238905811, 3630.364686179908, 3651.2514934438377, 1118.369012024453, 1174.4186627619383, 1186.2467333243453, 1203.3501908969233, 1275.9234445933273, 33906.15234619154, 34471.4829277561, 34677.65322346795, 34834.0, 35194.47208291878, 1145.9228325374122, 1188.4906169165113, 1221.6762557922157, 1234.975300493985, 1304.9320658935835, 17954.640907182045, 18297.817021829876, 18340.449786506426, 18358.173882175335, 18395.63208735818, 429204.0, 433237.0, 434701.0, 434863.0, 435560.0, 61785.69107154435, 62349.0, 62523.062154067724, 62594.68702656458, 62655.37344626587, 1432.9498467553585, 1484.970300593982, 1496.6408062064809, 1546.9226538673022, 1590.236686390539, 30919.2270193247, 31368.68631313749, 32185.678143219204, 32393.838030809697, 32753.34493310073, 46011.3098303519, 46474.53525464837, 46510.0, 46550.30174547452, 46558.53441465542, 241216.0, 244328.0, 245282.0, 245603.0, 436154.0, 30424.543631845983, 30703.0, 30987.84506077455, 31174.532382013833, 31282.843585781924, 48706.0, 50326.0, 56004.0, 57043.71478142583, 57535.42464575468, 42247.0, 42706.0, 43185.35221971736, 43228.78385608052, 43961.0, 40495.987600310225, 41486.17027659369, 41544.169116618104, 41797.16405671809, 42675.146497070506, 41399.37900931428, 42300.57699422966, 42558.787206063775, 43226.567734323515, 43265.567344326155, 35503.28993420169, 36299.27401451903, 36642.26715465623, 36823.26353472969, 36872.26255474929, 29007.7099229005, 29102.0, 29117.563236551046, 29325.26686832846, 29431.705682943753], "value": 19440.824597790426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.62801292842926, 429.3216717586214, 437.5689945403778, 438.7985043211253, 444.9644028477722, 18747.3438429655, 19127.46980241581, 19482.41552753418, 19602.0, 20015.799842001576, 20110.798892011077, 20180.39458816238, 20689.379318620428, 20912.0, 20954.89522552385, 5412.675239485634, 5724.971375143118, 5773.249477567911, 5797.072468405056, 5804.970975145118, 4342.240107981106, 5676.233708449368, 5841.8831623367505, 6097.5426842986735, 6392.264889537693, 6360.332165122665, 6381.872362552746, 6389.0, 6396.616203027833, 6399.968000160016, 5315.415304316522, 5541.501264886139, 5548.667079975195, 5550.084236101038, 6319.936800631981, 4015.959840401617, 4157.501099868035, 5400.675959442446, 5423.728813559306, 5497.670139791585, 14049.64875878101, 14186.645333866632, 14209.076410033314, 14279.071860329046, 20806.271780487612, 2391.5336509380677, 2484.1802205272215, 2521.735217802141, 2528.898844046236, 2726.9590956135676, 10350.327228730108, 10498.685039448828, 10634.915874396416, 10925.125989920787, 11121.16591255651, 1923.6248931458372, 1941.4175747275901, 2001.3695685859054, 2003.9098240579208, 2025.3518873960338, 80429.19570804275, 81785.0, 82224.17775822285, 83051.58474207591, 83203.0, 10650.307729997525, 10781.892181078088, 10951.0, 11002.834957475645, 11449.141314401453, 14738.336774845158, 14760.630984225265, 14764.26178691061, 14814.037087589271, 14831.92584037073, 8525.872111918326, 8711.912880871238, 8772.956135219283, 8842.602082906285, 8911.2425443838, 8766.430182038148, 8831.514266715263, 8978.0, 9085.182333590008, 9170.266378689688, 4494.9325760113625, 4674.672772905932, 4752.904941901143, 5017.623678224075, 5080.669756465818, 1772.9028033243071, 1985.8312043476178, 2059.618970490464, 2082.7708952015264, 2084.1871670048695, 1012.3318609717551, 1040.1626690514058, 1103.784761971424, 1112.1380929779486, 1112.8497652816766, 17945.282188712565, 18538.721919171225, 18690.439286821416, 19441.31955381555, 19582.90208548948, 1076.612419528969, 1085.5006696919347, 1096.3476731344838, 1115.0299239661547, 1179.1804695736553, 10831.350118992885, 11144.944275278573, 11238.325700458, 11243.269187502787, 11253.212275140826, 455745.0, 457520.0, 464726.0, 505625.0, 508714.0, 54793.72603136959, 80133.0, 88518.55740721384, 96484.51757741306, 96936.0, 1127.5997021057406, 1132.541320765108, 1189.8274750161352, 1194.3490797515376, 1229.5266322465736, 17192.570185744957, 17717.291308348038, 17776.91111544486, 17917.193726282087, 18048.90975545114, 29978.25054373658, 34153.829230853684, 39659.0, 40883.38674919819, 41080.794596026826, 60910.0, 61041.38958610357, 61253.38746612477, 61565.0, 62112.0, 8900.777480563038, 8926.107389261022, 9065.546722663972, 9099.54502274897, 9189.402688825205, 12966.286854223108, 13802.792958105838, 14091.859081409055, 14172.574822755334, 14552.85447145515, 11965.04279657608, 12228.510859565518, 12312.0, 12529.93735031319, 12775.48898044105, 10864.728381790519, 11315.321080735182, 11635.767284654428, 11763.0, 11870.703232419259, 11719.648410547697, 11877.346745929057, 12143.574974875837, 12180.330081845583, 12906.67733306675, 8475.915240847513, 8801.823963520566, 8884.422512536665, 8933.776655583662, 9175.587098580447, 11549.826752598885, 11795.941020294844, 12153.574624888086, 12177.695557610776, 12724.681882953], "value": 9357.432087815027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.8457969623346, 1501.759718445049, 1555.1291276884945, 1719.4927496388564, 1851.8055604161555, 7558.848823023543, 8106.635201415936, 8239.340852731782, 8247.752567422973, 8252.422330436872, 8156.796080098001, 8333.58332083395, 8343.08226095129, 8347.0, 8349.62426690799, 2334.9883250583725, 2355.0579768092816, 2357.139644029934, 2358.422186564294, 2358.9764102358927, 2347.776961188693, 2351.3651314145172, 2396.496735685508, 2400.327908185711, 2400.543896659638, 2356.02225076593, 2376.2514807835564, 2378.0368950575044, 2402.255300856731, 2411.0958390603523, 2351.3651314145254, 2384.0, 2389.653500242464, 2391.0555330644384, 2392.437777122375, 2266.875321857297, 2319.0607803839303, 2319.7100362454694, 2321.1991862807304, 2327.359976006595, 7139.643017849139, 7320.96339518299, 8507.106753790888, 8553.144685531397, 8554.572271386469, 4998.9500104999215, 5082.593392528625, 5097.0, 5108.157154069574, 5112.744362781846, 3409.3692666856464, 3437.5874895012507, 3486.2504561519395, 3556.5376501054957, 3578.405655899478, 1118.0943435816932, 1133.2916926920675, 1157.1784033336342, 1175.4651633506735, 1176.4999875053068, 10999.0, 11000.779984400348, 11031.0, 11312.264702794291, 11313.264637798598, 4270.743755374688, 4386.824527018884, 4392.956070439254, 4409.536998615164, 4446.088551846864, 9805.754856128511, 9818.459984700767, 9847.50762461874, 9862.211023118134, 9870.012998700216, 5098.59211263098, 5134.794608215704, 5136.768845401966, 5141.76862041209, 5145.3568303962, 4728.881777955578, 4729.125111854318, 4731.195696731495, 4735.029318989667, 4742.359781429532, 3678.7424880258127, 3888.650021498079, 3890.463267009515, 3892.746971446847, 3907.769052748375, 1184.1474138620179, 1195.6413076077142, 1200.5257923120319, 1208.6555331730415, 1217.5008246618843, 997.0777031246068, 1010.6917390196061, 1036.828923227674, 1058.6718117383637, 1062.0229388962173, 5767.163761254678, 5814.208521922929, 5902.055671092605, 5948.851278718067, 5966.612170208922, 1023.2223510132204, 1038.3925403638805, 1050.6847945616285, 1056.1234175634206, 1074.248026381536, 3716.591174970751, 4317.56824317572, 4320.265554855682, 4339.696221264481, 4359.302511598193, 9616.95191524038, 9775.853362199572, 9876.851847222297, 9887.752806179904, 9888.011198880198, 9650.517474126265, 9678.516074196263, 9773.07155820196, 9782.119609235204, 10110.342827716175, 7986.920130798734, 8005.039395272488, 8042.919570804334, 8100.554469504116, 8108.513489190667, 6047.213862197887, 6135.6932153393045, 6193.102000210034, 6234.937650623617, 6250.531210159347, 9340.34617576763, 9381.061893810564, 9416.435013899189, 9584.424934503952, 9599.616015359587, 9483.715488535356, 9672.95163524206, 9763.170130538983, 9805.235057689684, 9813.705588832347, 7268.055152830098, 7281.8179545509665, 7471.626418679153, 7496.362809161283, 7501.399888009056, 8293.50716870969, 8311.95844020776, 8315.293200077818, 8336.166383361615, 8369.204925532309, 7507.099148102263, 7592.4305677075545, 7592.696292148473, 7654.0, 7833.09919359281, 7523.586202758901, 7550.8867366990635, 7594.582297973665, 7657.961710191414, 7679.308862202429, 7018.789436316919, 7049.0, 7056.682449289691, 7064.646767661699, 7072.858542829217, 5122.154844450624, 5208.218767184952, 5224.399194092728, 5258.921116183337, 5323.0684630190335, 4733.313669517832, 5062.721550314768, 5284.497972692588, 5306.681599103912, 5354.518093371616], "value": 4567.603140980305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.5571818803777, 366.8165917041479, 371.0649164106451, 373.52189197826783, 379.07127537533034, 6041.395860413956, 6041.697915104243, 6043.637381757087, 6082.209312789337, 6154.3537928517535, 6064.605800622957, 6084.361142080084, 6091.299500557438, 6092.939070609293, 6106.328303886569, 4497.977510112445, 4596.310553416981, 4704.153252414564, 4756.833510827122, 4762.119007983517, 4696.201645720219, 4703.90592188156, 4724.220503616899, 4754.524547545235, 4758.571728544431, 4681.69568978017, 4694.2723877799, 4697.486844538173, 4703.2239680452685, 4707.799511124658, 4434.312681534351, 4507.0, 4527.7736113194205, 4573.062522182944, 4706.035262771141, 4142.420061191436, 4146.963259185204, 4155.91688166238, 4163.521195062546, 4167.541570427251, 5755.683437410982, 5774.451427114417, 5778.479936805666, 5779.0, 5784.421557844224, 5397.865053373658, 5403.108487099624, 5473.2063850741415, 5481.671099734029, 5503.229547863302, 6392.776252831175, 6405.455536279422, 6408.455281301049, 6408.711607977652, 6418.229812422493, 4364.236258654754, 4543.0, 4546.113507865967, 4644.117617652635, 4648.83729069481, 6652.268250492442, 6660.666966651648, 6697.631630260334, 6711.597304161766, 6720.865582688368, 4652.767361631905, 4660.161170989254, 4660.650451216173, 4669.4396672399525, 4677.22825733757, 4696.295555666609, 4709.7174169549935, 4710.9764451177525, 4720.362751028636, 4726.031163611451, 5411.972940135274, 5413.079776438015, 5421.241026256327, 5428.131498960148, 5428.701421421781, 6241.095041219089, 6480.935190648128, 6490.513211509156, 6503.154589903377, 6504.804855854332, 1633.1670847867672, 1653.768472413863, 1659.2035822805121, 1664.4673704414472, 1669.282208650292, 1081.34578579958, 1093.824988001916, 1117.2626066795876, 1127.8702949160952, 1128.6219116596033, 6103.450689437972, 6227.595206311576, 6307.3377295383325, 6369.681515924185, 6370.904436433457, 6693.464522838161, 6694.163229596301, 6701.731930722716, 6703.631300278434, 6705.362990515893, 6341.3341599132345, 6343.0485427186295, 6347.016212487072, 6351.587146835441, 6353.269374021954, 3578.6958108560543, 3614.403623402162, 3615.8553657853918, 3618.9276214475562, 3620.909477263037, 6864.965675171592, 6995.930040699528, 7006.054182685272, 7009.1589009319205, 7019.92980070203, 6842.828929276808, 6845.794626161223, 6852.828679283058, 6862.451003919675, 6866.313368663194, 6987.965060174666, 6990.755323563651, 7009.088818453569, 7014.0531028310525, 7015.228324884259, 6684.83287917806, 6698.296678848651, 6698.732050718112, 6706.765263215764, 6706.83232919181, 6461.224653041665, 6600.273969863215, 6613.437857782143, 6622.1722284714415, 6624.403803657694, 6943.340382663639, 6979.127609048869, 6984.650767461505, 6988.8951665724035, 6989.0, 4617.8383756568355, 4629.213033784332, 4631.4442266926835, 4632.745199014086, 4634.026854360487, 6666.699998499982, 6670.099536562502, 6686.364795344434, 6686.83282917931, 6686.966565167143, 6382.489400847828, 6506.73973041092, 6511.316311787384, 6519.7392104315295, 6520.706568204348, 6488.740450381932, 6491.415772580491, 6505.121808555974, 6505.934940650533, 6511.967440162769, 6349.269833969152, 6383.776567820104, 6395.328490508429, 6406.295307516077, 6410.583312084699, 6526.282108968105, 6536.215654121535, 6545.476361890942, 6557.639329836905, 6560.179977502812, 6082.5438092142385, 6396.71214795326, 6397.776077837253, 6401.55189136756, 6402.135711678864], "value": 4917.174244917026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.0626567167163, 929.8140371925616, 931.6925414613177, 935.6117211357285, 936.5317341329335, 14934.0, 15182.39270429183, 15196.392144314228, 17374.91312543439, 17723.64552708945, 15932.920335398307, 16011.119388433632, 16070.196490175504, 16074.59813504663, 16085.91957040216, 763.0385714000372, 879.0594064351147, 882.201607545171, 893.1738142218454, 907.63694522191, 879.7009016934242, 879.7888506758396, 883.1654086887894, 886.0607755778863, 886.3219636977717, 909.5361365703473, 909.8908131024253, 910.5219759626183, 916.0610374366295, 918.2562124678998, 786.2216405758315, 913.4747520175893, 924.0, 948.2887834124407, 950.8431108867029, 687.2886562407933, 691.7025678958046, 694.2952902803659, 695.5339922252103, 696.2793508718503, 15378.461753838563, 15407.30667119971, 15420.537383878502, 15456.459023934221, 15474.0, 13937.512187073506, 14307.28463576817, 14317.78523322151, 14331.140131592034, 14413.063150895263, 11709.882901170964, 11714.062874969983, 11985.340806255652, 12051.276923384625, 12215.75568488634, 3968.6229808168177, 3998.7000974926996, 4001.9399709004388, 4030.2141082488924, 4077.4495443115097, 60541.0, 61237.387626123615, 61564.692176539276, 61952.07071893925, 62597.0, 11507.539698411969, 11790.351530665896, 11823.940880295544, 12021.398930053463, 12091.45588448522, 20702.068406921724, 20889.582208355747, 20906.79093209079, 20910.686339704916, 21024.894875525526, 8989.730308090768, 9180.219681327162, 9326.253899688008, 9440.0, 9572.282078844115, 4842.806287748451, 4884.755762211875, 4916.582090522345, 5095.235714642833, 5412.404635490093, 3594.0, 3638.43604241343, 3646.9452958205648, 3648.5621725392593, 3649.525561676965, 684.5824047331124, 691.5401258163365, 697.2365260040248, 701.6947627781931, 704.4505285877024, 699.0841996983967, 747.4356860570343, 836.9455985360933, 838.9412741108064, 851.1871163039283, 9695.757606059906, 9948.701538953697, 10457.790844183073, 10493.737656558647, 10514.26400151982, 816.14304979771, 822.2517509066721, 827.8634025385865, 842.839860426517, 855.7176131876466, 4864.343313652612, 4903.509649035068, 4929.211326187793, 4942.283368911488, 4961.479044700327, 66795.66602167055, 68070.0, 68142.0, 68173.65913170403, 69601.65199174073, 53910.191347129825, 60119.0, 60787.0, 61012.38987610067, 61186.08220876691, 49853.0, 49911.0, 50956.74521627442, 54017.729911350194, 54535.45464545383, 9911.555232198585, 10125.139363154214, 10278.743031424274, 10353.534090966075, 10390.324628899098, 39266.607333926295, 40242.59757402389, 40245.0, 40909.38635920404, 41514.37728434015, 50101.74949125231, 50766.0, 50814.0, 51269.0, 52239.73880130727, 12741.362931853186, 12853.35733213317, 13186.670333241746, 13261.867381326063, 13354.399052042487, 13585.184888906697, 14441.133531987694, 14471.421143154577, 14543.272836357928, 15171.62070948191, 12436.00511959023, 12447.93776031114, 12466.937665311978, 12668.366581670694, 12967.546135885199, 13136.146150500186, 14201.786973195203, 14585.562433127023, 14587.781183282046, 14614.853851461774, 13190.142640728322, 13841.377138029015, 13969.272598234675, 14131.081479703786, 14147.64630884236, 10980.1215902726, 11104.44477776124, 11166.274192177483, 11312.264702794291, 11499.885001149882, 10655.200859935381, 11272.605458808903, 11469.885301147215, 11499.482523286304, 11505.48225329879], "value": 7378.035310633676, "unit": "score"}], "name": "dromaeo_css", "value": 7366.05995851564, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 111.0, 112.0, 112.0, 105.0, 110.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 160.0, 182.0, 126.0, 152.0, 152.0, 130.0, 189.0, 127.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 162.0, 160.0, 162.0, 161.0, 159.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 176.0, 73.0, 73.0, 75.0, 73.0, 153.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 91.0, 92.0, 91.0, 140.0, 92.0, 92.0, 149.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 116.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 149.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 56.0, 53.0, 54.0, 54.0, 57.0, 74.0, 52.0, 52.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 78.0, 72.0, 72.0, 73.0, 72.0, 74.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 121.0, 114.0, 112.0, 109.0, 118.0, 112.0, 127.0, 134.0], "value": 117.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 163.0, 155.0, 156.0, 156.0, 161.0, 157.0, 160.0, 156.0, 157.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1505.7, "alertThreshold": 2.0}]} 23:14:07 INFO - Return code: 0 23:14:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:07 ERROR - # TBPL SUCCESS # 23:14:07 INFO - Running post-action listener: _resource_record_post_action 23:14:07 INFO - Running post-run listener: _resource_record_post_run 23:14:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 471302144; Read time: 0; Write time: 734028 23:14:08 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 233480192; Read time: 0; Write time: 520420 23:14:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 216571904; Read time: 0; Write time: 208256 23:14:08 INFO - Running post-run listener: _upload_blobber_files 23:14:08 INFO - Blob upload gear active. 23:14:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:14:08 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 23:14:08 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'] 23:14:08 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 23:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:09 INFO - (blobuploader) - INFO - Done attempting. 23:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:10 INFO - (blobuploader) - INFO - Done attempting. 23:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:10 INFO - Return code: 0 23:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c39d8601efa1dc6bc307487728db99134a61f1d52af5a52444ddff1747516f0d194e6a5f71579f164c7cd25f3fe8a6800561300bc768948fe0e182469dcd2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0e44555a834dc5e10b6ed998b53e5cd72b43b731adf261e9a9cb8950d52bf327a791416f0c4b9ff73cd4b1313b160b14dca6e6c65fe9b17a2a767c914badb5b"} 23:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:14:10 INFO - Contents: 23:14:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c39d8601efa1dc6bc307487728db99134a61f1d52af5a52444ddff1747516f0d194e6a5f71579f164c7cd25f3fe8a6800561300bc768948fe0e182469dcd2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0e44555a834dc5e10b6ed998b53e5cd72b43b731adf261e9a9cb8950d52bf327a791416f0c4b9ff73cd4b1313b160b14dca6e6c65fe9b17a2a767c914badb5b"} 23:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 23:14:10 INFO - Copying logs to upload dir... 23:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 23:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.344325 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-23 23:14:10.411179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 23:14:10.414555) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c39d8601efa1dc6bc307487728db99134a61f1d52af5a52444ddff1747516f0d194e6a5f71579f164c7cd25f3fe8a6800561300bc768948fe0e182469dcd2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0e44555a834dc5e10b6ed998b53e5cd72b43b731adf261e9a9cb8950d52bf327a791416f0c4b9ff73cd4b1313b160b14dca6e6c65fe9b17a2a767c914badb5b"} build_url:https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/dntH06m9Ty-Wnm8qwmtCCw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c39d8601efa1dc6bc307487728db99134a61f1d52af5a52444ddff1747516f0d194e6a5f71579f164c7cd25f3fe8a6800561300bc768948fe0e182469dcd2aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0e44555a834dc5e10b6ed998b53e5cd72b43b731adf261e9a9cb8950d52bf327a791416f0c4b9ff73cd4b1313b160b14dca6e6c65fe9b17a2a767c914badb5b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 23:14:10.444689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 23:14:10.445230) ========= 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=5cf47e208febbcd81da23b2e0000026f-1466738842.841379-1286036754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 23:14:10.528348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 23:14:10.529198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 23:14:10.529893) ========= ========= Total master_lag: 0.22 =========