builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1466719825.91 results: success (0) buildid: 20160623122823 builduid: b5460e7bfd014a1ea1343355595f8464 revision: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.913069) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.913681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.914072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.951413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:25.951840) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 15:10:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2016-06-23 15:10:26 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.096627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.097107) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019239 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.149148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.149827) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13b02b96281e550c3cdbdf4eaed034aa1edefd69 --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 13b02b96281e550c3cdbdf4eaed034aa1edefd69 --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=a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 15:10:26,773 truncating revision to first 12 chars 2016-06-23 15:10:26,773 Setting DEBUG logging. 2016-06-23 15:10:26,773 attempt 1/10 2016-06-23 15:10:26,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13b02b96281e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 15:10:27,233 unpacking tar archive at: mozilla-beta-13b02b96281e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.943412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.943770) ========= script_repo_revision: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.944245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.944560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 15:10:26.955241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-23 15:10:26.955530) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:10:27 INFO - MultiFileLogger online at 20160623 15:10:27 in /builds/slave/test 15:10:27 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 15:10:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:27 INFO - {'append_to_log': False, 15:10:27 INFO - 'base_work_dir': '/builds/slave/test', 15:10:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:10:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:27 INFO - 'branch': 'Mozilla-Beta', 15:10:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:27 INFO - 'config_files': ('talos/linux_config.py',), 15:10:27 INFO - 'default_actions': ('clobber', 15:10:27 INFO - 'read-buildbot-config', 15:10:27 INFO - 'download-and-extract', 15:10:27 INFO - 'populate-webroot', 15:10:27 INFO - 'create-virtualenv', 15:10:27 INFO - 'install', 15:10:27 INFO - 'run-tests'), 15:10:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:27 INFO - 'download_minidump_stackwalk': True, 15:10:27 INFO - 'download_symbols': 'ondemand', 15:10:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:27 INFO - 'installer_path': 'installer.exe', 15:10:27 INFO - 'log_level': 'info', 15:10:27 INFO - 'log_name': 'talos', 15:10:27 INFO - 'log_to_console': True, 15:10:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:10:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:10:27 INFO - 'opt_config_files': (), 15:10:27 INFO - 'pip_index': False, 15:10:27 INFO - 'sps_profile': False, 15:10:27 INFO - 'sps_profile_interval': 0, 15:10:27 INFO - 'suite': 'dromaeojs', 15:10:27 INFO - 'system_bits': '32', 15:10:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:27 INFO - 'title': 'talos-linux64-ix-064', 15:10:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:27 INFO - 'use_talos_json': True, 15:10:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:27 INFO - 'work_dir': 'build'} 15:10:27 INFO - ##### 15:10:27 INFO - ##### Running clobber step. 15:10:27 INFO - ##### 15:10:27 INFO - Running pre-action listener: _resource_record_pre_action 15:10:27 INFO - Running main action method: clobber 15:10:27 INFO - rmtree: /builds/slave/test/build 15:10:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:28 INFO - Running post-action listener: _resource_record_post_action 15:10:28 INFO - ##### 15:10:28 INFO - ##### Running read-buildbot-config step. 15:10:28 INFO - ##### 15:10:28 INFO - Running pre-action listener: _resource_record_pre_action 15:10:28 INFO - Running main action method: read_buildbot_config 15:10:28 INFO - Using buildbot properties: 15:10:28 INFO - { 15:10:28 INFO - "project": "", 15:10:28 INFO - "product": "firefox", 15:10:28 INFO - "script_repo_revision": "production", 15:10:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:10:28 INFO - "repository": "", 15:10:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:10:28 INFO - "buildid": "20160623122823", 15:10:28 INFO - "pgo_build": "True", 15:10:28 INFO - "basedir": "/builds/slave/test", 15:10:28 INFO - "buildnumber": 71, 15:10:28 INFO - "slavename": "talos-linux64-ix-064", 15:10:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:10:28 INFO - "platform": "ubuntu64_hw", 15:10:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:10:28 INFO - "branch": "mozilla-beta", 15:10:28 INFO - "repo_path": "releases/mozilla-beta", 15:10:28 INFO - "revision": "13b02b96281e550c3cdbdf4eaed034aa1edefd69", 15:10:28 INFO - "stage_platform": "linux64-pgo", 15:10:28 INFO - "builduid": "b5460e7bfd014a1ea1343355595f8464", 15:10:28 INFO - "slavebuilddir": "test" 15:10:28 INFO - } 15:10:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:10:28 INFO - Running post-action listener: _resource_record_post_action 15:10:28 INFO - ##### 15:10:28 INFO - ##### Running download-and-extract step. 15:10:28 INFO - ##### 15:10:28 INFO - Running pre-action listener: _resource_record_pre_action 15:10:28 INFO - Running main action method: download_and_extract 15:10:28 INFO - mkdir: /builds/slave/test/build/tests 15:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:28 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:36 INFO - Downloaded 1327 bytes. 15:10:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:10:36 INFO - Using the following test package requirements: 15:10:36 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:10:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:10:36 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:10:36 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'jsshell-linux-x86_64.zip'], 15:10:36 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:10:36 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:10:36 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:10:36 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:10:36 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:10:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:10:36 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:10:36 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:10:36 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')]} 15:10:36 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:43 INFO - Downloaded 24186833 bytes. 15:10:43 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'] 15:10:43 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 15:10:44 INFO - Return code: 0 15:10:44 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 15:10:44 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')]} 15:10:44 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:46 INFO - Downloaded 24186833 bytes. 15:10:46 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'] 15:10:46 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 15:10:47 INFO - Return code: 0 15:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:47 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:48 INFO - Downloaded 10840145 bytes. 15:10:48 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'] 15:10:48 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 15:10:49 INFO - Return code: 0 15:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:49 INFO - https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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 15:10:50 INFO - Downloaded 56012995 bytes. 15:10:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:50 INFO - mkdir: /builds/slave/test/properties 15:10:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:50 INFO - Contents: 15:10:50 INFO - build_url:https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:10:51 INFO - Running post-action listener: _resource_record_post_action 15:10:51 INFO - Running post-action listener: set_extra_try_arguments 15:10:51 INFO - ##### 15:10:51 INFO - ##### Running populate-webroot step. 15:10:51 INFO - ##### 15:10:51 INFO - Running pre-action listener: _resource_record_pre_action 15:10:51 INFO - Running main action method: populate_webroot 15:10:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:51 INFO - '--tppagecycles', 15:10:51 INFO - '7'], 15:10:51 INFO - 'tests': ['tsvgm']}}, 15:10:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['damp', 'tps']}, 15:10:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'tests': ['damp', 'tps']}, 15:10:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['dromaeo_dom']}, 15:10:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['a11yr', 15:10:51 INFO - 'ts_paint', 15:10:51 INFO - 'tpaint', 15:10:51 INFO - 'sessionrestore', 15:10:51 INFO - 'sessionrestore_no_auto_restore', 15:10:51 INFO - 'tabpaint']}, 15:10:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:51 INFO - 'ts_paint', 15:10:51 INFO - 'tpaint', 15:10:51 INFO - 'sessionrestore', 15:10:51 INFO - 'sessionrestore_no_auto_restore', 15:10:51 INFO - 'tabpaint']}, 15:10:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:10:51 INFO - 'ts_paint', 15:10:51 INFO - 'tpaint', 15:10:51 INFO - 'sessionrestore', 15:10:51 INFO - 'sessionrestore_no_auto_restore', 15:10:51 INFO - 'tabpaint']}, 15:10:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:10:51 INFO - 'ts_paint', 15:10:51 INFO - 'tpaint', 15:10:51 INFO - 'sessionrestore', 15:10:51 INFO - 'sessionrestore_no_auto_restore', 15:10:51 INFO - 'tabpaint']}, 15:10:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['a11yr', 15:10:51 INFO - 'ts_paint', 15:10:51 INFO - 'tpaint', 15:10:51 INFO - 'sessionrestore', 15:10:51 INFO - 'sessionrestore_no_auto_restore', 15:10:51 INFO - 'tabpaint']}, 15:10:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['a11yr', 15:10:51 INFO - 'ts_paint', 15:10:51 INFO - 'tpaint', 15:10:51 INFO - 'sessionrestore', 15:10:51 INFO - 'sessionrestore_no_auto_restore', 15:10:51 INFO - 'tabpaint']}, 15:10:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['tsvgx', 15:10:51 INFO - 'tsvgr_opacity', 15:10:51 INFO - 'tart', 15:10:51 INFO - 'tscrollx', 15:10:51 INFO - 'cart']}, 15:10:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:51 INFO - 'tsvgr_opacity', 15:10:51 INFO - 'tart', 15:10:51 INFO - 'tscrollx', 15:10:51 INFO - 'cart']}, 15:10:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'talos_options': ['--disable-e10s'], 15:10:51 INFO - 'tests': ['tp5o']}, 15:10:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'tests': ['tp5o']}, 15:10:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'talos_options': ['--disable-e10s', 15:10:51 INFO - '--xperf_path', 15:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:51 INFO - 'tests': ['tp5n']}, 15:10:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:51 INFO - 'talos_options': ['--xperf_path', 15:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:51 INFO - 'tests': ['tp5n']}}, 15:10:51 INFO - 'talos.zip': {'path': '', 15:10:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:51 INFO - Running post-action listener: _resource_record_post_action 15:10:51 INFO - ##### 15:10:51 INFO - ##### Running create-virtualenv step. 15:10:51 INFO - ##### 15:10:51 INFO - Running pre-action listener: _resource_record_pre_action 15:10:51 INFO - Running main action method: create_virtualenv 15:10:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:51 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 15:10:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:51 INFO - Using real prefix '/usr' 15:10:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:53 INFO - Installing pip.................done. 15:10:53 INFO - Return code: 0 15:10:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:10:53 INFO - Using env: {'DISPLAY': ':0', 15:10:53 INFO - 'HOME': '/home/cltbld', 15:10:53 INFO - 'LANG': 'en_US.UTF-8', 15:10:53 INFO - 'LANGUAGE': 'en_US:en', 15:10:53 INFO - 'LOGNAME': 'cltbld', 15:10:53 INFO - 'MAIL': '/var/mail/cltbld', 15:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:53 INFO - 'MOZ_NO_REMOTE': '1', 15:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:53 INFO - 'NO_EM_RESTART': '1', 15:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:53 INFO - 'PWD': '/builds/slave/test', 15:10:53 INFO - 'SHELL': '/bin/bash', 15:10:53 INFO - 'SHLVL': '1', 15:10:53 INFO - 'TERM': 'linux', 15:10:53 INFO - 'TMOUT': '86400', 15:10:53 INFO - 'USER': 'cltbld', 15:10:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:53 INFO - '_': '/tools/buildbot/bin/python'} 15:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:54 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 15:10:54 INFO - Cleaning up... 15:10:54 INFO - Return code: 0 15:10:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:10:54 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')]} 15:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 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')]} 15:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:54 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 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:10:54 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 15:10:54 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 15:10:54 INFO - Using env: {'DISPLAY': ':0', 15:10:54 INFO - 'HOME': '/home/cltbld', 15:10:54 INFO - 'LANG': 'en_US.UTF-8', 15:10:54 INFO - 'LANGUAGE': 'en_US:en', 15:10:54 INFO - 'LOGNAME': 'cltbld', 15:10:54 INFO - 'MAIL': '/var/mail/cltbld', 15:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:54 INFO - 'MOZ_NO_REMOTE': '1', 15:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:54 INFO - 'NO_EM_RESTART': '1', 15:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:54 INFO - 'PWD': '/builds/slave/test', 15:10:54 INFO - 'SHELL': '/bin/bash', 15:10:54 INFO - 'SHLVL': '1', 15:10:54 INFO - 'TERM': 'linux', 15:10:54 INFO - 'TMOUT': '86400', 15:10:54 INFO - 'USER': 'cltbld', 15:10:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:54 INFO - '_': '/tools/buildbot/bin/python'} 15:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:54 INFO - Downloading/unpacking psutil>=0.7.1 15:10:54 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 15:10:54 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 15:10:54 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 15:10:54 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 15:10:54 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 15:10:54 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 15:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:56 INFO - Installing collected packages: psutil 15:10:56 INFO - Running setup.py install for psutil 15:10:56 INFO - building 'psutil._psutil_linux' extension 15:10:56 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 15:10:56 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 15:10:56 INFO - building 'psutil._psutil_posix' extension 15:10:56 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 15:10:56 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 15:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:56 INFO - Successfully installed psutil 15:10:56 INFO - Cleaning up... 15:10:56 INFO - Return code: 0 15:10:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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')]} 15:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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', '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 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:10: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:10: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 mozsystemmonitor==0.0.0 15:10:56 INFO - Using env: {'DISPLAY': ':0', 15:10:56 INFO - 'HOME': '/home/cltbld', 15:10:56 INFO - 'LANG': 'en_US.UTF-8', 15:10:56 INFO - 'LANGUAGE': 'en_US:en', 15:10:56 INFO - 'LOGNAME': 'cltbld', 15:10:56 INFO - 'MAIL': '/var/mail/cltbld', 15:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:56 INFO - 'MOZ_NO_REMOTE': '1', 15:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:56 INFO - 'NO_EM_RESTART': '1', 15:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:56 INFO - 'PWD': '/builds/slave/test', 15:10:56 INFO - 'SHELL': '/bin/bash', 15:10:56 INFO - 'SHLVL': '1', 15:10:56 INFO - 'TERM': 'linux', 15:10:56 INFO - 'TMOUT': '86400', 15:10:56 INFO - 'USER': 'cltbld', 15:10:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:56 INFO - '_': '/tools/buildbot/bin/python'} 15:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:10:58 INFO - Installing collected packages: mozsystemmonitor 15:10:58 INFO - Running setup.py install for mozsystemmonitor 15:10:58 INFO - Successfully installed mozsystemmonitor 15:10:58 INFO - Cleaning up... 15:10:59 INFO - Return code: 0 15:10:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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')]} 15:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10: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', '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 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:10: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 blobuploader==1.2.4 15:10:59 INFO - Using env: {'DISPLAY': ':0', 15:10:59 INFO - 'HOME': '/home/cltbld', 15:10:59 INFO - 'LANG': 'en_US.UTF-8', 15:10:59 INFO - 'LANGUAGE': 'en_US:en', 15:10:59 INFO - 'LOGNAME': 'cltbld', 15:10:59 INFO - 'MAIL': '/var/mail/cltbld', 15:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:59 INFO - 'MOZ_NO_REMOTE': '1', 15:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:59 INFO - 'NO_EM_RESTART': '1', 15:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:59 INFO - 'PWD': '/builds/slave/test', 15:10:59 INFO - 'SHELL': '/bin/bash', 15:10:59 INFO - 'SHLVL': '1', 15:10:59 INFO - 'TERM': 'linux', 15:10:59 INFO - 'TMOUT': '86400', 15:10:59 INFO - 'USER': 'cltbld', 15:10:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:59 INFO - '_': '/tools/buildbot/bin/python'} 15:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:11:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:11:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:11:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 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 15:11:01 INFO - Downloading docopt-0.6.1.tar.gz 15:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:11:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:11:01 INFO - Running setup.py install for blobuploader 15:11:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:11:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:11:02 INFO - Running setup.py install for requests 15:11:02 INFO - Running setup.py install for docopt 15:11:02 INFO - Successfully installed blobuploader requests docopt 15:11:02 INFO - Cleaning up... 15:11:02 INFO - Return code: 0 15:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:02 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')]} 15:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:02 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')]} 15:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:02 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 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:11:02 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 15:11:02 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 15:11:02 INFO - Using env: {'DISPLAY': ':0', 15:11:02 INFO - 'HOME': '/home/cltbld', 15:11:02 INFO - 'LANG': 'en_US.UTF-8', 15:11:02 INFO - 'LANGUAGE': 'en_US:en', 15:11:02 INFO - 'LOGNAME': 'cltbld', 15:11:02 INFO - 'MAIL': '/var/mail/cltbld', 15:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:02 INFO - 'MOZ_NO_REMOTE': '1', 15:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:02 INFO - 'NO_EM_RESTART': '1', 15:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:02 INFO - 'PWD': '/builds/slave/test', 15:11:02 INFO - 'SHELL': '/bin/bash', 15:11:02 INFO - 'SHLVL': '1', 15:11:02 INFO - 'TERM': 'linux', 15:11:02 INFO - 'TMOUT': '86400', 15:11:02 INFO - 'USER': 'cltbld', 15:11:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:02 INFO - '_': '/tools/buildbot/bin/python'} 15:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:02 INFO - Running setup.py (path:/tmp/pip-pexjev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:02 INFO - Running setup.py (path:/tmp/pip-iMB7zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:02 INFO - Running setup.py (path:/tmp/pip-34LJXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:02 INFO - Running setup.py (path:/tmp/pip-IaeMwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:03 INFO - Running setup.py (path:/tmp/pip-SZ4flq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:03 INFO - Running setup.py (path:/tmp/pip-dC1NXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:03 INFO - Running setup.py (path:/tmp/pip-s_6gPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:03 INFO - Running setup.py (path:/tmp/pip-YuEtAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:03 INFO - Running setup.py (path:/tmp/pip-rUg4nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:03 INFO - Running setup.py (path:/tmp/pip-vq_F7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:03 INFO - Running setup.py (path:/tmp/pip-1hVARl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:03 INFO - Running setup.py (path:/tmp/pip-ZOLCMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:03 INFO - Running setup.py (path:/tmp/pip-WCv80A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:03 INFO - Running setup.py (path:/tmp/pip-F3LNJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:03 INFO - Running setup.py (path:/tmp/pip-0A9ZiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:03 INFO - Running setup.py (path:/tmp/pip-uBKdg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:03 INFO - Running setup.py (path:/tmp/pip-uMUPaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:11:03 INFO - Running setup.py install for manifestparser 15:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Running setup.py install for mozcrash 15:11:04 INFO - Running setup.py install for mozdebug 15:11:04 INFO - Running setup.py install for mozdevice 15:11:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Running setup.py install for mozfile 15:11:04 INFO - Running setup.py install for mozhttpd 15:11:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Running setup.py install for mozinfo 15:11:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Running setup.py install for mozInstall 15:11:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Running setup.py install for mozleak 15:11:04 INFO - Running setup.py install for mozlog 15:11:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:11:04 INFO - Running setup.py install for moznetwork 15:11:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:11:05 INFO - Running setup.py install for mozprocess 15:11:05 INFO - Running setup.py install for mozprofile 15:11:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:11:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:11:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:11:05 INFO - Running setup.py install for mozrunner 15:11:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:11:05 INFO - Running setup.py install for mozscreenshot 15:11:05 INFO - Running setup.py install for moztest 15:11:05 INFO - Running setup.py install for mozversion 15:11:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:11:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:11:05 INFO - Cleaning up... 15:11:05 INFO - Return code: 0 15:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:05 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 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:11:05 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 15:11:05 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 15:11:05 INFO - Using env: {'DISPLAY': ':0', 15:11:05 INFO - 'HOME': '/home/cltbld', 15:11:05 INFO - 'LANG': 'en_US.UTF-8', 15:11:05 INFO - 'LANGUAGE': 'en_US:en', 15:11:05 INFO - 'LOGNAME': 'cltbld', 15:11:05 INFO - 'MAIL': '/var/mail/cltbld', 15:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:05 INFO - 'MOZ_NO_REMOTE': '1', 15:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:05 INFO - 'NO_EM_RESTART': '1', 15:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:05 INFO - 'PWD': '/builds/slave/test', 15:11:05 INFO - 'SHELL': '/bin/bash', 15:11:05 INFO - 'SHLVL': '1', 15:11:05 INFO - 'TERM': 'linux', 15:11:05 INFO - 'TMOUT': '86400', 15:11:05 INFO - 'USER': 'cltbld', 15:11:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:05 INFO - '_': '/tools/buildbot/bin/python'} 15:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:05 INFO - Running setup.py (path:/tmp/pip-xLodjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:05 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)) 15:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:05 INFO - Running setup.py (path:/tmp/pip-c58Abt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:06 INFO - Running setup.py (path:/tmp/pip-kL_WyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:06 INFO - Running setup.py (path:/tmp/pip-YoShbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:06 INFO - Running setup.py (path:/tmp/pip-PabifY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:06 INFO - Running setup.py (path:/tmp/pip-AnldsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:06 INFO - Running setup.py (path:/tmp/pip-9tZjSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:06 INFO - Running setup.py (path:/tmp/pip-kHpPKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:06 INFO - Running setup.py (path:/tmp/pip-mqmZXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:06 INFO - Running setup.py (path:/tmp/pip-dk3Fzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:06 INFO - Running setup.py (path:/tmp/pip-awoxK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:06 INFO - Running setup.py (path:/tmp/pip-lT2iDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:06 INFO - Running setup.py (path:/tmp/pip-c14FHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:06 INFO - Running setup.py (path:/tmp/pip-C4i_RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:06 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)) 15:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:06 INFO - Running setup.py (path:/tmp/pip-Buh7ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:07 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)) 15:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:07 INFO - Running setup.py (path:/tmp/pip-hntjvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:07 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)) 15:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:07 INFO - Running setup.py (path:/tmp/pip-pkZLed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:07 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)) 15:11:07 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)) 15:11:07 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)) 15:11:07 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)) 15:11:07 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)) 15:11:07 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)) 15:11:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:09 INFO - Downloading blessings-1.6.tar.gz 15:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:11:09 INFO - Installing collected packages: blessings 15:11:09 INFO - Running setup.py install for blessings 15:11:09 INFO - Successfully installed blessings 15:11:09 INFO - Cleaning up... 15:11:09 INFO - Return code: 0 15:11:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:09 INFO - Reading from file tmpfile_stdout 15:11:09 INFO - Current package versions: 15:11:09 INFO - argparse == 1.2.1 15:11:09 INFO - blessings == 1.6 15:11:09 INFO - blobuploader == 1.2.4 15:11:09 INFO - docopt == 0.6.1 15:11:09 INFO - manifestparser == 1.1 15:11:09 INFO - mozInstall == 1.12 15:11:09 INFO - mozcrash == 0.17 15:11:09 INFO - mozdebug == 0.1 15:11:09 INFO - mozdevice == 0.48 15:11:09 INFO - mozfile == 1.2 15:11:09 INFO - mozhttpd == 0.7 15:11:09 INFO - mozinfo == 0.9 15:11:09 INFO - mozleak == 0.1 15:11:09 INFO - mozlog == 3.1 15:11:09 INFO - moznetwork == 0.27 15:11:09 INFO - mozprocess == 0.22 15:11:09 INFO - mozprofile == 0.28 15:11:09 INFO - mozrunner == 6.11 15:11:09 INFO - mozscreenshot == 0.1 15:11:09 INFO - mozsystemmonitor == 0.0 15:11:09 INFO - moztest == 0.7 15:11:09 INFO - mozversion == 1.4 15:11:09 INFO - psutil == 3.1.1 15:11:09 INFO - requests == 1.2.3 15:11:09 INFO - wsgiref == 0.1.2 15:11:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 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 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:11:09 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 15:11:09 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 15:11:09 INFO - Using env: {'DISPLAY': ':0', 15:11:09 INFO - 'HOME': '/home/cltbld', 15:11:09 INFO - 'LANG': 'en_US.UTF-8', 15:11:09 INFO - 'LANGUAGE': 'en_US:en', 15:11:09 INFO - 'LOGNAME': 'cltbld', 15:11:09 INFO - 'MAIL': '/var/mail/cltbld', 15:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:09 INFO - 'MOZ_NO_REMOTE': '1', 15:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:09 INFO - 'NO_EM_RESTART': '1', 15:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:09 INFO - 'PWD': '/builds/slave/test', 15:11:09 INFO - 'SHELL': '/bin/bash', 15:11:09 INFO - 'SHLVL': '1', 15:11:09 INFO - 'TERM': 'linux', 15:11:09 INFO - 'TMOUT': '86400', 15:11:09 INFO - 'USER': 'cltbld', 15:11:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:09 INFO - '_': '/tools/buildbot/bin/python'} 15:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 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)) 15:11:09 INFO - Cleaning up... 15:11:09 INFO - Return code: 0 15:11:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:11:09 INFO - Using env: {'DISPLAY': ':0', 15:11:09 INFO - 'HOME': '/home/cltbld', 15:11:09 INFO - 'LANG': 'en_US.UTF-8', 15:11:09 INFO - 'LANGUAGE': 'en_US:en', 15:11:09 INFO - 'LOGNAME': 'cltbld', 15:11:09 INFO - 'MAIL': '/var/mail/cltbld', 15:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:09 INFO - 'MOZ_NO_REMOTE': '1', 15:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:09 INFO - 'NO_EM_RESTART': '1', 15:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:09 INFO - 'PWD': '/builds/slave/test', 15:11:09 INFO - 'SHELL': '/bin/bash', 15:11:09 INFO - 'SHLVL': '1', 15:11:09 INFO - 'TERM': 'linux', 15:11:09 INFO - 'TMOUT': '86400', 15:11:09 INFO - 'USER': 'cltbld', 15:11:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:09 INFO - '_': '/tools/buildbot/bin/python'} 15:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:09 INFO - Downloading/unpacking jsonschema 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:11:11 INFO - Downloading/unpacking functools32 (from jsonschema) 15:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:12 INFO - Downloading functools32-3.2.3-2.tar.gz 15:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:11:12 INFO - warning: no files found matching '*.txt' 15:11:12 INFO - no previously-included directories found matching 'build' 15:11:12 INFO - no previously-included directories found matching 'dist' 15:11:12 INFO - no previously-included directories found matching '.git*' 15:11:12 INFO - Installing collected packages: jsonschema, functools32 15:11:12 INFO - Running setup.py install for functools32 15:11:12 INFO - warning: no files found matching '*.txt' 15:11:12 INFO - no previously-included directories found matching 'build' 15:11:12 INFO - no previously-included directories found matching 'dist' 15:11:12 INFO - no previously-included directories found matching '.git*' 15:11:12 INFO - Successfully installed jsonschema functools32 15:11:12 INFO - Cleaning up... 15:11:12 INFO - Return code: 0 15:11:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18553af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', '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 15:11: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', 'flake8'] in /builds/slave/test/build 15:11: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 flake8 15:11:12 INFO - Using env: {'DISPLAY': ':0', 15:11:12 INFO - 'HOME': '/home/cltbld', 15:11:12 INFO - 'LANG': 'en_US.UTF-8', 15:11:12 INFO - 'LANGUAGE': 'en_US:en', 15:11:12 INFO - 'LOGNAME': 'cltbld', 15:11:12 INFO - 'MAIL': '/var/mail/cltbld', 15:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:12 INFO - 'MOZ_NO_REMOTE': '1', 15:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:12 INFO - 'NO_EM_RESTART': '1', 15:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:12 INFO - 'PWD': '/builds/slave/test', 15:11:12 INFO - 'SHELL': '/bin/bash', 15:11:12 INFO - 'SHLVL': '1', 15:11:12 INFO - 'TERM': 'linux', 15:11:12 INFO - 'TMOUT': '86400', 15:11:12 INFO - 'USER': 'cltbld', 15:11:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:12 INFO - '_': '/tools/buildbot/bin/python'} 15:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:12 INFO - Downloading/unpacking flake8 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:11:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:11:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:15 INFO - no previously-included directories found matching 'docs/_build' 15:11:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:11:15 INFO - Running setup.py install for pep8 15:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:11:15 INFO - no previously-included directories found matching 'docs/_build' 15:11:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:11:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:11:15 INFO - Cleaning up... 15:11:15 INFO - Return code: 0 15:11:15 INFO - Running post-action listener: _resource_record_post_action 15:11:15 INFO - Running post-action listener: _start_resource_monitoring 15:11:15 INFO - Starting resource monitoring. 15:11:15 INFO - ##### 15:11:15 INFO - ##### Running install step. 15:11:15 INFO - ##### 15:11:15 INFO - Running pre-action listener: _resource_record_pre_action 15:11:15 INFO - Running main action method: install 15:11:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:15 INFO - Reading from file tmpfile_stdout 15:11:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:15 INFO - Reading from file tmpfile_stdout 15:11:15 INFO - Output received: 15:11:15 INFO - Usage: mozinstall [options] installer 15:11:15 INFO - Options: 15:11:15 INFO - -h, --help show this help message and exit 15:11:15 INFO - -d DEST, --destination=DEST 15:11:15 INFO - Directory to install application into. [default: 15:11:15 INFO - "/builds/slave/test"] 15:11:15 INFO - --app=APP Application being installed. [default: firefox] 15:11:15 INFO - mkdir: /builds/slave/test/build/application 15:11:15 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'] 15:11:15 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 15:11:28 INFO - Reading from file tmpfile_stdout 15:11:28 INFO - Output received: 15:11:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:11:28 INFO - Running post-action listener: _resource_record_post_action 15:11:28 INFO - ##### 15:11:28 INFO - ##### Running run-tests step. 15:11:28 INFO - ##### 15:11:28 INFO - Running pre-action listener: _resource_record_pre_action 15:11:28 INFO - Running main action method: run_tests 15:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:28 INFO - Python 2.7.3 15:11:28 INFO - Return code: 0 15:11:28 INFO - grabbing minidump binary from tooltool 15:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:28 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 0x1b45410>, '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 0x1b46310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b467a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:28 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 15:11:28 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 15:11:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:29 INFO - Return code: 0 15:11:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:11:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:11:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:11:29 INFO - Return code: 0 15:11:29 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/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 15:11:29 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/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 15:11:29 INFO - Using env: {'DISPLAY': ':0', 15:11:29 INFO - 'HOME': '/home/cltbld', 15:11:29 INFO - 'LANG': 'en_US.UTF-8', 15:11:29 INFO - 'LANGUAGE': 'en_US:en', 15:11:29 INFO - 'LOGNAME': 'cltbld', 15:11:29 INFO - 'MAIL': '/var/mail/cltbld', 15:11:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:29 INFO - 'MOZ_NO_REMOTE': '1', 15:11:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:29 INFO - 'NO_EM_RESTART': '1', 15:11:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:29 INFO - 'PWD': '/builds/slave/test', 15:11:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:29 INFO - 'SHELL': '/bin/bash', 15:11:29 INFO - 'SHLVL': '1', 15:11:29 INFO - 'TERM': 'linux', 15:11:29 INFO - 'TMOUT': '86400', 15:11:29 INFO - 'USER': 'cltbld', 15:11:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433', 15:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:29 INFO - '_': '/tools/buildbot/bin/python'} 15:11:29 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/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 15:11:30 INFO - mozversion application_buildid: 20160623122823 15:11:30 INFO - mozversion application_changeset: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 15:11:30 INFO - mozversion application_display_name: Firefox 15:11:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:30 INFO - mozversion application_name: Firefox 15:11:30 INFO - mozversion application_remotingname: firefox 15:11:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:11:30 INFO - mozversion application_vendor: Mozilla 15:11:30 INFO - mozversion application_version: 48.0 15:11:30 INFO - mozversion platform_buildid: 20160623122823 15:11:30 INFO - mozversion platform_changeset: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 15:11:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:11:30 INFO - mozversion platform_version: 48.0 15:11:30 INFO - using testdate: 1466719890 15:11:30 INFO - actual date: 1466719890 15:11:30 INFO - starting webserver on 'localhost:44158' 15:11:30 INFO - SUITE-START | Running 2 tests 15:11:30 INFO - TEST-START | dromaeo_css 15:11:30 INFO - operating with platform_type : linux_ 15:11:30 INFO - Initialising browser for dromaeo_css test... 15:11:30 INFO - TEST-INFO | started process 22290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprE4kwR/profile http://localhost:44158/getInfo.html) 15:11:34 INFO - PROCESS | 22290 | __metrics Screen width/height:1600/1200 15:11:34 INFO - PROCESS | 22290 | colorDepth:24 15:11:34 INFO - PROCESS | 22290 | Browser inner width/height: 1024/697 15:11:34 INFO - PROCESS | 22290 | __metrics 15:11:35 ERROR - PROCESS | 22290 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:11:36 INFO - TEST-INFO | 22290: exit 0 15:11:36 INFO - Browser initialized. 15:11:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:36 INFO - TEST-INFO | started process 22383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprE4kwR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:48 INFO - PROCESS | 22383 | RSS: Main: 140201984 15:11:48 INFO - PROCESS | 22383 | 15:12:39 INFO - PROCESS | 22383 | 1466719959245 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] 15:14:46 INFO - PROCESS | 22383 | Cycle 1(1): loaded http://localhost:44158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44158/tests/dromaeo/cssquery-ext.html) 15:14:47 INFO - PROCESS | 22383 | RSS: Main: 250273792 15:14:47 INFO - PROCESS | 22383 | 15:17:50 INFO - PROCESS | 22383 | Cycle 1(1): loaded http://localhost:44158/tests/dromaeo/cssquery-ext.html (next: http://localhost:44158/tests/dromaeo/cssquery-jquery.html) 15:17:50 INFO - PROCESS | 22383 | RSS: Main: 226537472 15:17:50 INFO - PROCESS | 22383 | 15:20:52 INFO - PROCESS | 22383 | Cycle 1(1): loaded http://localhost:44158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44158/tests/dromaeo/cssquery-mootools.html) 15:20:53 INFO - PROCESS | 22383 | RSS: Main: 218152960 15:20:53 INFO - PROCESS | 22383 | 15:23:54 INFO - PROCESS | 22383 | Cycle 1(1): loaded http://localhost:44158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44158/tests/dromaeo/cssquery-prototype.html) 15:23:55 INFO - PROCESS | 22383 | RSS: Main: 217235456 15:23:55 INFO - PROCESS | 22383 | 15:26:58 INFO - PROCESS | 22383 | Cycle 1(1): loaded http://localhost:44158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44158/tests/dromaeo/cssquery-yui.html) 15:26:58 INFO - PROCESS | 22383 | RSS: Main: 208715776 15:26:58 INFO - PROCESS | 22383 | 15:30:00 INFO - PROCESS | 22383 | Cycle 1(1): loaded http://localhost:44158/tests/dromaeo/cssquery-yui.html (next: http://localhost:44158/tests/dromaeo/cssquery-dojo.html) 15:30:01 INFO - PROCESS | 22383 | RSS: Main: 238567424 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | __start_tp_report 15:30:01 INFO - PROCESS | 22383 | _x_x_mozilla_page_load 15:30:01 INFO - PROCESS | 22383 | _x_x_mozilla_page_load_details 15:30:01 INFO - PROCESS | 22383 | |i|pagename|runs| 15:30:01 INFO - PROCESS | 22383 | |0;dojo.html;3338.315645292715;3368.141124013378;3389.8644054237825;3393.8133402662875;3422.0760394693434;5527.861803454911;5579.4699503547145;5581.162825576165;5596.132599447082;5618.325800903892;5567.248421463101;5608.495235428811;5610.775568977247;5612.102063669814;5627.549796016319;4962.206047032476;5022.799088036474;5029.7736601853;5138.640295179339;5181.326427564431;4998.425181104165;5066.316047333618;5067.594592432597;5068.5438310552045;5070.264811602316;5004.199328107504;5051.217061355477;5075.086484432801;5075.162598171298;5112.846614601549;5018.5232402921665;5038.29463875056;5041.067402530543;5046.369203849519;5066.569341605949;4905.411350637911;4960.355153830015;4967.180415231483;4979.900401991976;4980.178270585349;5371.462853714636;5375.247465354853;5411.080116380185;5411.350637923435;5411.675299482044;6011.849703757397;6018.638881667114;6027.939720602782;6032.45707886288;6042.9395706042815;5953.434423729739;5998.28020637522;6007.579469437142;6035.547333949971;6064.605800622945;5511.448855114497;5527.50252477275;5544.695041772701;5546.528545073714;5556.6943818089585;5978.282606087298;6052.969735151296;6058.818235452944;6058.848528786727;6060.33336333003;5766.481016708516;5814.912776308359;5821.330546987066;5821.825345239649;5824.825255242349;5913.172155898178;5951.137085122719;5956.761729530857;5962.731677074542;5965.075413310944;5823.563232757476;5853.239078919713;5890.175375447441;5901.940980590225;5912.733926973297;6002.939970600325;6011.27864656244;6016.037434010537;6022.518198544106;6051.213342265477;4556.157110934488;4561.133384656904;4563.178627846953;4578.771061446914;4589.33454649074;3978.4430179774854;4015.437838702584;4032.495938007749;4067.044244602516;4095.6518695910586;5666.036773748473;5684.403137670485;5691.573132015115;5692.23154874095;5716.114002329646;5918.970405147947;5981.581289309794;5988.850278742979;5989.580729348903;5992.490638295706;5489.984352894728;5623.606347555714;5660.179274005246;5668.121441176624;5756;4972.428170760337;4978.726170060609;4986.252062190701;4996.225585034325;4998.775055122528;6190.071489276645;6191.071339299141;6193.38066193377;6196.318404975449;6202.224721909762;5792.681402522901;5883.882322353444;5951.166836642873;5958.702064896651;5990.430909063632;6166.1705437142555;6170.938290617216;6183.721732521957;6195.31851496326;6204.937950620436;5870.559708022;5878.970605146947;5888.617239879394;5888.911666324922;5922.200502932049;5893.351731309638;6023.036314189709;6086.939130608637;6100.78647247362;6118.847028824315;5847.94152058474;5871.94128058714;5880.14737863016;5888.263967004124;5893.381194974638;5780.595358325045;5814.127880817911;5855.765769369177;5877.4122587740885;5885.087811389241;5675.26221591207;5734.885302294014;5737.139429085671;5747.166660834239;5758.654480731169;5846.386129456516;5869.236999190078;5897.587168898308;5898.764049438146;5919.230500034968;5578.246936663661;5756.3380211276235;5761.078227483583;5771.8557036074435;5787.7395517200985 15:30:01 INFO - PROCESS | 22383 | |1;ext.html;639.692947385255;662.1160750398218;670.2961890015484;720.6828995242097;727.0439372225524;31968.520472192908;32677;38062.23875522488;38896.41655375172;39019;46184.769076154655;47046;47150.056998860004;47277.527224727826;47336;7969.9203007970045;8853.11468853116;9026.097390260955;9037.999999999967;9042.321825863053;8184.386171037196;10578.418186999712;10853.348799072042;10855.891441085567;10858.23992320538;10505.159587233004;10564.577416903314;10578.52396642153;10583.629572964948;10584;10491.213159013067;10530.47347632623;10553.41956192409;10567.68296951085;10572.471376431185;10540.894591054068;10671.893281067245;10686.839697404544;10689.572417103383;10690.358578485315;41755.582444175474;42258.78870605658;42286.36570451415;42291;42301.57698423007;3644.344018076745;3716.981415092934;3942.56631770505;3966.1671049079728;4249.32010878258;29346.853265733534;29629.407411851644;29694;30019.249518761986;31178;3507.14075051614;3517.9824100879587;3521.2253304273017;3592.6227746086547;3637.7089832813576;221475;222038;224754;224931.99999999837;225264;38895;39254.2149157021;39330.213395731924;60232.69883650641;61268.69365653143;37466.250674986346;37496.81251593779;37603;37646.247075058345;37654.811725941196;17278.740818887727;17434.302627894995;17443.21505532254;17450.82549174492;17451.912740436215;13465.394057267447;14166.220857852917;14476.927615362067;14656.487022954145;14710.264486775832;9154.542272886329;9204.769880752901;9205.309601779893;9246.90753092474;9251.259899208047;3463.913402164966;3530.593981692087;3560.608333083359;3583.51622530955;3588.515550400715;1085.7068591480256;1129.76274982253;1149.7240662241002;1150.8216226484908;1168.7311918258847;32806.83596582049;33006.17484562857;33703.83148084293;37168.81415592959;37644.247115057544;1223.853137623491;1238.851337839447;1245.850497940253;1277.9552715655093;1307.895368370528;16250.51248462548;16277;16550.586235343973;16631.584210394594;16684.916575417046;198651;199236;200427;200607;200678;58312.70843645839;59051.704741476016;59063.40936590579;59068.704656476446;59077.70461147753;1389.305347326337;1502.9624259393602;1527.938882444712;1535.777312289734;1625.1061915946182;28765.71234287714;31374.179561046454;31619.683803161675;31995.520067198544;32353.35293294168;50405.24392134047;51006.48993510017;51242.74378628083;51273;51318.23022654738;355427;356028;356943;358329;359215;24778.628320574844;30269.394612108073;30273.394532108792;30545.389092218476;32028.679713203503;46014;46208.53791462177;46358;46809;47050.82372940704;38232;38332;38741.41887871628;39026.804865975486;39094.4135837957;37300.81349593234;37893;38162.42756358601;38259.42610860783;38338.0415489615;39604.405933910435;40279;40336.79831600823;40471;40634.79682601686;34117.31765364728;34305.31389372249;34568;34821;35205.471917921765;26979;27071.72928270692;27203.86398067997;27249.455010899273;27367 15:30:01 INFO - PROCESS | 22383 | |2;jquery.html;426.7247625281693;433.3326676917549;433.8112920879416;435.779931134777;444.45776153093215;18650.440486785403;18667.786593871406;18972.241110355568;19357.322493712723;19398.612027759435;18680.81319186811;18688.532786680305;19783.5054123647;19789.604207915832;19808.603827923434;5577.8047768327915;5754.65472071675;5839.153322768196;5847.0352391855295;5997.490213331872;5778;5799.246098007253;5818.970905145468;5869;6243.344448832852;6579.374959378852;6627.569208001489;6642.402183803457;6647.867042659168;6653.866922661544;5892.941070589282;6035.758569657209;6450.032495125745;6540.672966351687;6545.869082618345;5824.184614154022;5867.8533036674;5869.589128760988;5890.49930755882;5896.911546326808;14549.636259093502;19560;22800.54398912029;23978.640320395207;23991.880040599684;2451.6077427611494;2464.2853572463964;2513.5349960257226;2577.1624222127884;2654.2568080937176;10779.137668986463;10816.621418250323;11144.777104457946;11156.776864462747;13145.342732863413;2037.6230397376385;2121.586290673319;2130.925417610392;2136;2199.0104452996216;75993.62003190003;78351;79282;79450.60274698648;79674.6016269915;11455.140864435201;11793.29240245588;11812.645620631394;11848.822267665992;11975.221610595283;16652.250648720594;16766.74849877253;16821.243044063045;16833.915830421014;16846.157692115346;9216.677416290398;9306.348555601178;9362.485063321446;9452.57463414148;9460.195883349992;9407.623695052258;9415.340926135243;9444.433333999981;9484.33609647318;9484.715458536255;5092.872678183075;5188.014277287379;5201.7399130044105;5207.557357624569;5274.7890084396195;2111.556573119631;2112.123468760478;2119.364190742771;2137.6900349449243;2167.978320216809;960.7790208252002;989.8317286061387;1003.4380746781679;1059.4014381874217;1093.775775965925;18901.905490472458;19266;19590.608187836162;19778.60442791136;19805.60388792216;1050.7425680708122;1060.1253965478356;1065.7655315830505;1077.272840832435;1088.216484131424;10565.735856603493;11080.667579972614;11082.61210857616;11118.110551155889;11153.72115697114;496911;509962;516202;532634;535007;69156;82844.58577707193;84031.15968840355;89632;94146;1089.5315014543664;1090.7218659241842;1104.7403860092872;1112.4159816096615;1117.7876203521305;17050.955855418884;17336.133193340534;17364.652706946043;17674.204660790554;17811.910940445214;37696.62303376931;38588.22823543457;39022.80488597539;39746.20507589774;39878.800605997945;55964.720176398856;56703.71648141733;57165.14252286136;57341.713291433276;57397;8801.339899507691;9233.907660923305;9251.306152038489;9331.113544213289;9357.438553686801;13278.601641950758;13862.584122476343;13912.403019761872;14025.859741402455;14527;6452.096706461005;10063.849042264519;11024.338539687644;12219.69450763738;12589.559365422532;12227.14409991292;12318.322492263012;12324.137310388187;12664.6833829155;12882.48470061187;12548.556915954781;12598.244105353708;12713.237205767684;12799.360031998176;12923.28921909304;8884.511351875708;8935.419197752126;9014.594343254437;9313.720588382359;9458.668946586837;11298.322100673986;11380.374079425712;11486.712832179262;11496.88503114958;11552.133589980953 15:30:01 INFO - PROCESS | 22383 | |3;mootools.html;1450.615586869479;1597.952061438157;1598.1449924290507;1813.8367546920774;1922.8942408167545;7733.767986960386;8386.203310685483;8590.012148602913;8602.139786021395;8605.096464871192;8440.240378365947;8631.352648551352;8641.049484556694;8646.394752367336;8676.826463470727;2473.2085732565542;2493.0651005872796;2495.563276426627;2497.313238859319;2500.6374075759004;2390.366552863484;2494.0148641286683;2497.950040999179;2498;2502.3744063984004;2423.660687503742;2456.9631455528092;2461.544614246361;2463.7659422354845;2466.3094333586537;2414.6619473273754;2434.8904299306487;2443.6823212982285;2470.1601455505033;2470.72821989581;2372.6796882420826;2429.477662302613;2431.7203521595065;2433.7444568320248;2452.901883924641;8361.289290410261;8616.698415555426;8766.868496972551;8827.426217295919;8829.42608730437;5490.121580547133;5565.41563135873;5597.63615365;5598.188262701926;5606.35526914406;3656;3669.082729317671;3734.5705243897028;3739.5699494558203;3810.5236845394325;1148.4544841200363;1200.0579545057176;1218.275126299859;1223.3516236394726;1243.0676992255808;11951.88048119525;12380.071494637848;12416.379181041002;12449.190802597803;12477.31374774387;4531.320301954733;4713.95286047142;4741.668083234141;4794.7842347094465;4822.831200907952;9760.023997600325;9815.705528834147;9828.361156524947;9835.901640983642;9854.556544955494;5504.284443022381;5516.972415137899;5523.585731070186;5525.613207075547;5535.8892822144135;4434.490033646108;4514.909701806011;4902.607791376681;5018.121828679967;5154.768035438339;3948.269570129478;3967.3652215645357;4015.0765323975065;4047.332190188586;4062.1266427718183;1194.2118201986648;1224.4918358880964;1225.503671013241;1237.8824011718873;1238.8575313838844;1008.2287050406445;1011.3881101933372;1015.2487159502062;1024.4979959819784;1027.6916924922493;5774;5796;5834.183214349994;5908.172855800191;6139.969300153471;916.1840932516129;945.5839430650492;988.8071825993862;1011.1051719228535;1027.9155490957112;3869.96130038696;3895.941560876589;3913.3347330953807;3942.940855887164;3953.703472239536;10147.086762191439;10399.32404393712;10477.371357718408;10512.526936287886;10516.894831051592;10382.169426445866;10382.221333399873;10447.84328235077;10818.29681070728;10882.401467919182;8308.958455207685;8324.500529968222;8325.542095184823;8423.536705481134;8441.07148213696;5728.169415434655;5770.480656740913;5796.478316951495;5798.942010580009;5870.295564532284;9643.807123857343;9700.805983880424;9805.21558275322;9815.822101347883;9822.607095716377;9659.130678238993;9864.457454840052;9941.204703623838;10235.692929212135;10270.178385728974;6500.6424646643;6683.832904177434;6982.546134501241;7249.963750181215;7377.741779037708;8184.54984975832;8191.262786349257;8241.217084376975;8262.297704694927;8262.876056859272;7287;7411.66647500853;7523.172451030273;7540.1328847181085;7661.1572726998875;7354.73769764296;7383.556986580607;7394.667239974322;7485.962570187115;7513;6989.580625162506;7135.5361901476235;7157.033800436874;7167.390771784457;7182.748603798842;5170.922436163536;5219.8434046978655;5296.2055691646565;5334;5367.409584945731;5387.003404370204;5398.055340315351;5415.133578627559;5440.483154100354;5491.368492623399 15:30:01 INFO - PROCESS | 22383 | |4;prototype.html;368.554049599984;368.7953185981779;369.49563845351105;369.918617904061;373.9663430291273;6093.360197179293;6146.907796383058;6147.907781383272;6161.969190154055;6181.752729890804;5949.1373750806215;6175.166352542406;6182.1345011698395;6184.381561843813;6200.131981522579;4672.766361681919;4736.218523943545;4746.976265118669;4749.097671442432;4766.165920963835;4709.246520556711;4730.5269473052595;4733.952660473403;4737.976310118444;4753.928691069619;4576.427946506687;4679.485256621769;4721.2918062290755;4728.101660684476;4742.407199100113;4759.357486739315;4764.571188593043;4766.594839438651;4768.976155119202;4786.808527658907;4211.747295162269;4223.387608796707;4224.767637779921;4225.028243503981;4231.069164783743;5912;5913.172155898178;5927.940720592782;5929.377415371367;6002;5645.717714114319;5646.54827613794;5649.124385720179;5650.378458369576;5674.858128546778;6494.870102597922;6609.636469994149;6613.404793568602;6624.701888415033;6629.303923088103;4718.386609740746;4755.83354582588;4759.547842954914;4766.976165119187;4771.665983381165;6927.58434493932;6950.200726916419;6951.7219311228;6952.895706564405;6953.89569156458;4872.634552408584;4875.585575226146;4877.585405240523;4885.8045678173185;4887.804487820447;4940.061388336205;4950.6782059166035;4953.479884612136;4953.628477864175;4955.529224723646;5515.917261241085;5626.549876009909;5629.099344105005;5630;5639.689817060019;6683.699233534503;6695.330466953265;6695.631740254333;6697.196336439659;6702.932970670231;1703.838135377162;1724.7844019497563;1726.4734256052025;1727.6976529107355;1732.3330517750758;1102.8841971593029;1134.2910680824484;1136.4033882211904;1137.9544818207344;1156.392893730798;6310.7475700971445;6419.74321027163;6449.064885591563;6583.63789991555;6596.142501474777;6948.478864085214;6965.860682786316;6966.407855332353;6984.126984126984;6988.965055174692;6501.804945851632;6506.219253689493;6506.837329066811;6508.739650414025;6511.023346497968;3604.9098772530897;3694.039549717093;3731.6641502264924;3736.308782875177;3739.3456145174487;7193.208747037822;7227.49407541467;7229.92770072303;7239.384652304613;7240.891386629205;7037.190723066913;7040.401565866959;7047.859042819115;7070.92929070713;7093.255208203168;7216.458765592602;7227.9400370894045;7240.927590724025;7246.347828695442;7247.383972362198;6762.323767623198;6949.617771022642;6954.478414119062;6959.130108736408;6968.094147760961;6867.828304292233;6884.382170189901;6887.793366199022;6889.448844092361;6903.275156108737;7251.166115896739;7257.455690823103;7258.709651613876;7259.673314700745;7263.527870688388;4732.834350797705;4764.880877978078;4767;4775.5224477551965;4777.9044419112115;6965;6977.092977913042;6977.755778547929;6986.266442023514;6989.8951515726285;6556.606603603799;6776.628180136912;6784.457243420416;6795.626240556817;6796.184457865088;6713.395794378529;6729.394354508117;6753.628550429577;6758.695858686469;6763.425108865801;6639.070530125883;6642.368974947372;6648.501362397743;6655.134832471747;6655.767048153485;6603.405693487609;6804.965975170093;6811.250762416229;6822.249552549315;6823.931760682528;6273.337565545043;6453.193350831146;6571.934280657323;6642.6014439133805;6647.767328143492 15:30:01 INFO - PROCESS | 22383 | |5;yui.html;727.1274470635236;778.9561986937505;787.4487858499051;794.8887155798186;862.5988915154452;12671.049671274668;12727;12801.871981280185;12816.359182040907;13155.605331840035;13186.274754888478;13203.339833008335;13216.207027578352;13241.470341186365;13253.536126235584;736.7310931510001;750.0362034785302;751.4514404484702;752.1012390193721;887.5562218890555;898.2679116520048;898.3980732908934;905.4567259644226;906.4742449379377;906.9818603627923;941.3551717073826;942.3733217410414;946.7585765629755;949.5632009275741;950.5627411390768;770.2259229474398;930.1256818590571;941.4163218804351;946.1673727120091;946.2477330522252;696.6238231355062;697.159922293635;698.3819319901872;699.1330749870175;699.1540236314066;12707.110502264844;12785.424655890507;12895.806562901564;12922.547710830077;12934.094613377067;13048.608541743763;13574.049816512848;13651.044426890121;13943;14318;11526.654200374001;11613.477393517313;11708.473118709679;11721.23811952229;12054.879451205463;3871.690264778811;3875.476810630557;3938.6061393860386;3955.782431966241;3986.382110772835;54467.99999999961;58476;59167;59429.108563371585;59577;11596.304221746723;11641;11841;11905.166638335233;11942.522299108112;20660.173593056108;20670.276540321018;20682.482937926674;20801.271955481487;20804;8393.328533717287;8486.533240671699;8848.203661670352;8888.466691998501;9047.592858321259;4816.662833601615;4978.4025916890205;4988.90022199554;5009.799608015712;5092.38891333035;3544.379733546619;3586.6234045425376;3592.515010473605;3593.4609808528407;3602.7838329700303;604.1511676095093;645.8611398549334;658.6969993802809;663.7179198840473;664.2062735031687;676.0636518421923;686.8969654551757;721.156247190788;774.6901239504243;775.5579319787666;8900.8664870027;9100;9285.62857485693;9342.673006444878;9361.251099911991;746.1121265693807;750.6246876561719;756.8334966307403;767.6929228308721;777.8211011467395;4064.7561146331313;4307.246231909403;4351.173277077345;4376;4427.313766366218;58534.41465585375;60653.09020364698;60824.08763868546;60866.391336086956;63118;49891.25163122556;49920;53545.1968220477;53697.1945420819;54528;48787.26819097788;48859.267110993365;49225;49227.26159107616;49367.75316123468;9480.516902554935;9544.618215271312;9577.760555985877;9622.422654640744;9653.758656033375;37066;37351.81324093471;37586.62413375831;38914.4162837552;39559.60440395559;42407.575924240366;42472.36291455692;45288;47479.762601186776;48349.132069435065;11394.601188958346;11421.543138274708;11482.712932176762;11679.124065695276;11729.648110556696;12712.809307860574;12723.300218488072;12837.293948832903;13025.153365031243;13166.868331316948;11875.584354547549;11945.641630751092;12065.276083435023;12312.445939932904;12323.50705971751;11937.582184623843;12169.817452738393;12185.147039707135;12187.695307617381;12291.44688489038;12015.279083254683;12082.758344832879;12094.697632559257;12109.939450303045;12122.636320910387;10207.59169633236;10209.693709188736;10251.794964100825;10270.486475676036;10454.738631533968;10600.681979540626;10709.3574385534;10869.619563315246;10890.782184356427;10973.945130274298 15:30:01 INFO - PROCESS | 22383 | __end_tp_report 15:30:01 INFO - PROCESS | 22383 | __start_cc_report 15:30:01 INFO - PROCESS | 22383 | _x_x_mozilla_cycle_collect,822 15:30:01 INFO - PROCESS | 22383 | __end_cc_report 15:30:01 INFO - PROCESS | 22383 | __startTimestamp1466721001038__endTimestamp 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | ------- Summary: start ------- 15:30:01 INFO - PROCESS | 22383 | Number of tests: 6 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | [#0] dojo.html Cycles:165 Average:5533.88 Median:5761.08 stddev:624.27 (10.8%) stddev-sans-first:601.96 15:30:01 INFO - PROCESS | 22383 | Values: 3338.3 3368.1 3389.9 3393.8 3422.1 5527.9 5579.5 5581.2 5596.1 5618.3 5567.2 5608.5 5610.8 5612.1 5627.5 4962.2 5022.8 5029.8 5138.6 5181.3 4998.4 5066.3 5067.6 5068.5 5070.3 5004.2 5051.2 5075.1 5075.2 5112.8 5018.5 5038.3 5041.1 5046.4 5066.6 4905.4 4960.4 4967.2 4979.9 4980.2 5371.5 5375.2 5411.1 5411.4 5411.7 6011.8 6018.6 6027.9 6032.5 6042.9 5953.4 5998.3 6007.6 6035.5 6064.6 5511.4 5527.5 5544.7 5546.5 5556.7 5978.3 6053.0 6058.8 6058.8 6060.3 5766.5 5814.9 5821.3 5821.8 5824.8 5913.2 5951.1 5956.8 5962.7 5965.1 5823.6 5853.2 5890.2 5901.9 5912.7 6002.9 6011.3 6016.0 6022.5 6051.2 4556.2 4561.1 4563.2 4578.8 4589.3 3978.4 4015.4 4032.5 4067.0 4095.7 5666.0 5684.4 5691.6 5692.2 5716.1 5919.0 5981.6 5988.9 5989.6 5992.5 5490.0 5623.6 5660.2 5668.1 5756.0 4972.4 4978.7 4986.3 4996.2 4998.8 6190.1 6191.1 6193.4 6196.3 6202.2 5792.7 5883.9 5951.2 5958.7 5990.4 6166.2 6170.9 6183.7 6195.3 6204.9 5870.6 5879.0 5888.6 5888.9 5922.2 5893.4 6023.0 6086.9 6100.8 6118.8 5847.9 5871.9 5880.1 5888.3 5893.4 5780.6 5814.1 5855.8 5877.4 5885.1 5675.3 5734.9 5737.1 5747.2 5758.7 5846.4 5869.2 5897.6 5898.8 5919.2 5578.2 5756.3 5761.1 5771.9 5787.7 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | [#1] ext.html Cycles:180 Average:43780.47 Median:19361.73 stddev:70482.55 (364.0%) stddev-sans-first:70605.84 15:30:01 INFO - PROCESS | 22383 | Values: 639.7 662.1 670.3 720.7 727.0 31968.5 32677.0 38062.2 38896.4 39019.0 46184.8 47046.0 47150.1 47277.5 47336.0 7969.9 8853.1 9026.1 9038.0 9042.3 8184.4 10578.4 10853.3 10855.9 10858.2 10505.2 10564.6 10578.5 10583.6 10584.0 10491.2 10530.5 10553.4 10567.7 10572.5 10540.9 10671.9 10686.8 10689.6 10690.4 41755.6 42258.8 42286.4 42291.0 42301.6 3644.3 3717.0 3942.6 3966.2 4249.3 29346.9 29629.4 29694.0 30019.2 31178.0 3507.1 3518.0 3521.2 3592.6 3637.7 221475.0 222038.0 224754.0 224932.0 225264.0 38895.0 39254.2 39330.2 60232.7 61268.7 37466.3 37496.8 37603.0 37646.2 37654.8 17278.7 17434.3 17443.2 17450.8 17451.9 13465.4 14166.2 14476.9 14656.5 14710.3 9154.5 9204.8 9205.3 9246.9 9251.3 3463.9 3530.6 3560.6 3583.5 3588.5 1085.7 1129.8 1149.7 1150.8 1168.7 32806.8 33006.2 33703.8 37168.8 37644.2 1223.9 1238.9 1245.9 1278.0 1307.9 16250.5 16277.0 16550.6 16631.6 16684.9 198651.0 199236.0 200427.0 200607.0 200678.0 58312.7 59051.7 59063.4 59068.7 59077.7 1389.3 1503.0 1527.9 1535.8 1625.1 28765.7 31374.2 31619.7 31995.5 32353.4 50405.2 51006.5 51242.7 51273.0 51318.2 355427.0 356028.0 356943.0 358329.0 359215.0 24778.6 30269.4 30273.4 30545.4 32028.7 46014.0 46208.5 46358.0 46809.0 47050.8 38232.0 38332.0 38741.4 39026.8 39094.4 37300.8 37893.0 38162.4 38259.4 38338.0 39604.4 40279.0 40336.8 40471.0 40634.8 34117.3 34305.3 34568.0 34821.0 35205.5 26979.0 27071.7 27203.9 27249.5 27367.0 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | [#2] jquery.html Cycles:180 Average:29667.81 Median:23985.26 stddev:85043.81 (354.6%) stddev-sans-first:85254.03 15:30:01 INFO - PROCESS | 22383 | Values: 426.7 433.3 433.8 435.8 444.5 18650.4 18667.8 18972.2 19357.3 19398.6 18680.8 18688.5 19783.5 19789.6 19808.6 5577.8 5754.7 5839.2 5847.0 5997.5 5778.0 5799.2 5819.0 5869.0 6243.3 6579.4 6627.6 6642.4 6647.9 6653.9 5892.9 6035.8 6450.0 6540.7 6545.9 5824.2 5867.9 5869.6 5890.5 5896.9 14549.6 19560.0 22800.5 23978.6 23991.9 2451.6 2464.3 2513.5 2577.2 2654.3 10779.1 10816.6 11144.8 11156.8 13145.3 2037.6 2121.6 2130.9 2136.0 2199.0 75993.6 78351.0 79282.0 79450.6 79674.6 11455.1 11793.3 11812.6 11848.8 11975.2 16652.3 16766.7 16821.2 16833.9 16846.2 9216.7 9306.3 9362.5 9452.6 9460.2 9407.6 9415.3 9444.4 9484.3 9484.7 5092.9 5188.0 5201.7 5207.6 5274.8 2111.6 2112.1 2119.4 2137.7 2168.0 960.8 989.8 1003.4 1059.4 1093.8 18901.9 19266.0 19590.6 19778.6 19805.6 1050.7 1060.1 1065.8 1077.3 1088.2 10565.7 11080.7 11082.6 11118.1 11153.7 496911.0 509962.0 516202.0 532634.0 535007.0 69156.0 82844.6 84031.2 89632.0 94146.0 1089.5 1090.7 1104.7 1112.4 1117.8 17051.0 17336.1 17364.7 17674.2 17811.9 37696.6 38588.2 39022.8 39746.2 39878.8 55964.7 56703.7 57165.1 57341.7 57397.0 8801.3 9233.9 9251.3 9331.1 9357.4 13278.6 13862.6 13912.4 14025.9 14527.0 6452.1 10063.8 11024.3 12219.7 12589.6 12227.1 12318.3 12324.1 12664.7 12882.5 12548.6 12598.2 12713.2 12799.4 12923.3 8884.5 8935.4 9014.6 9313.7 9458.7 11298.3 11380.4 11486.7 11496.9 11552.1 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | [#3] mootools.html Cycles:180 Average:5755.76 Median:5258.02 stddev:3151.09 (59.9%) stddev-sans-first:3143.31 15:30:01 INFO - PROCESS | 22383 | Values: 1450.6 1598.0 1598.1 1813.8 1922.9 7733.8 8386.2 8590.0 8602.1 8605.1 8440.2 8631.4 8641.0 8646.4 8676.8 2473.2 2493.1 2495.6 2497.3 2500.6 2390.4 2494.0 2498.0 2498.0 2502.4 2423.7 2457.0 2461.5 2463.8 2466.3 2414.7 2434.9 2443.7 2470.2 2470.7 2372.7 2429.5 2431.7 2433.7 2452.9 8361.3 8616.7 8766.9 8827.4 8829.4 5490.1 5565.4 5597.6 5598.2 5606.4 3656.0 3669.1 3734.6 3739.6 3810.5 1148.5 1200.1 1218.3 1223.4 1243.1 11951.9 12380.1 12416.4 12449.2 12477.3 4531.3 4714.0 4741.7 4794.8 4822.8 9760.0 9815.7 9828.4 9835.9 9854.6 5504.3 5517.0 5523.6 5525.6 5535.9 4434.5 4514.9 4902.6 5018.1 5154.8 3948.3 3967.4 4015.1 4047.3 4062.1 1194.2 1224.5 1225.5 1237.9 1238.9 1008.2 1011.4 1015.2 1024.5 1027.7 5774.0 5796.0 5834.2 5908.2 6140.0 916.2 945.6 988.8 1011.1 1027.9 3870.0 3895.9 3913.3 3942.9 3953.7 10147.1 10399.3 10477.4 10512.5 10516.9 10382.2 10382.2 10447.8 10818.3 10882.4 8309.0 8324.5 8325.5 8423.5 8441.1 5728.2 5770.5 5796.5 5798.9 5870.3 9643.8 9700.8 9805.2 9815.8 9822.6 9659.1 9864.5 9941.2 10235.7 10270.2 6500.6 6683.8 6982.5 7250.0 7377.7 8184.5 8191.3 8241.2 8262.3 8262.9 7287.0 7411.7 7523.2 7540.1 7661.2 7354.7 7383.6 7394.7 7486.0 7513.0 6989.6 7135.5 7157.0 7167.4 7182.7 5170.9 5219.8 5296.2 5334.0 5367.4 5387.0 5398.1 5415.1 5440.5 5491.4 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | [#4] prototype.html Cycles:180 Average:5613.40 Median:6292.04 stddev:1695.13 (26.9%) stddev-sans-first:1653.54 15:30:01 INFO - PROCESS | 22383 | Values: 368.6 368.8 369.5 369.9 374.0 6093.4 6146.9 6147.9 6162.0 6181.8 5949.1 6175.2 6182.1 6184.4 6200.1 4672.8 4736.2 4747.0 4749.1 4766.2 4709.2 4730.5 4734.0 4738.0 4753.9 4576.4 4679.5 4721.3 4728.1 4742.4 4759.4 4764.6 4766.6 4769.0 4786.8 4211.7 4223.4 4224.8 4225.0 4231.1 5912.0 5913.2 5927.9 5929.4 6002.0 5645.7 5646.5 5649.1 5650.4 5674.9 6494.9 6609.6 6613.4 6624.7 6629.3 4718.4 4755.8 4759.5 4767.0 4771.7 6927.6 6950.2 6951.7 6952.9 6953.9 4872.6 4875.6 4877.6 4885.8 4887.8 4940.1 4950.7 4953.5 4953.6 4955.5 5515.9 5626.5 5629.1 5630.0 5639.7 6683.7 6695.3 6695.6 6697.2 6702.9 1703.8 1724.8 1726.5 1727.7 1732.3 1102.9 1134.3 1136.4 1138.0 1156.4 6310.7 6419.7 6449.1 6583.6 6596.1 6948.5 6965.9 6966.4 6984.1 6989.0 6501.8 6506.2 6506.8 6508.7 6511.0 3604.9 3694.0 3731.7 3736.3 3739.3 7193.2 7227.5 7229.9 7239.4 7240.9 7037.2 7040.4 7047.9 7070.9 7093.3 7216.5 7227.9 7240.9 7246.3 7247.4 6762.3 6949.6 6954.5 6959.1 6968.1 6867.8 6884.4 6887.8 6889.4 6903.3 7251.2 7257.5 7258.7 7259.7 7263.5 4732.8 4764.9 4767.0 4775.5 4777.9 6965.0 6977.1 6977.8 6986.3 6989.9 6556.6 6776.6 6784.5 6795.6 6796.2 6713.4 6729.4 6753.6 6758.7 6763.4 6639.1 6642.4 6648.5 6655.1 6655.8 6603.4 6805.0 6811.3 6822.2 6823.9 6273.3 6453.2 6571.9 6642.6 6647.8 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - PROCESS | 22383 | [#5] yui.html Cycles:180 Average:14830.29 Median:4401.66 stddev:17140.52 (389.4%) stddev-sans-first:17155.88 15:30:01 INFO - PROCESS | 22383 | Values: 727.1 779.0 787.4 794.9 862.6 12671.0 12727.0 12801.9 12816.4 13155.6 13186.3 13203.3 13216.2 13241.5 13253.5 736.7 750.0 751.5 752.1 887.6 898.3 898.4 905.5 906.5 907.0 941.4 942.4 946.8 949.6 950.6 770.2 930.1 941.4 946.2 946.2 696.6 697.2 698.4 699.1 699.2 12707.1 12785.4 12895.8 12922.5 12934.1 13048.6 13574.0 13651.0 13943.0 14318.0 11526.7 11613.5 11708.5 11721.2 12054.9 3871.7 3875.5 3938.6 3955.8 3986.4 54468.0 58476.0 59167.0 59429.1 59577.0 11596.3 11641.0 11841.0 11905.2 11942.5 20660.2 20670.3 20682.5 20801.3 20804.0 8393.3 8486.5 8848.2 8888.5 9047.6 4816.7 4978.4 4988.9 5009.8 5092.4 3544.4 3586.6 3592.5 3593.5 3602.8 604.2 645.9 658.7 663.7 664.2 676.1 686.9 721.2 774.7 775.6 8900.9 9100.0 9285.6 9342.7 9361.3 746.1 750.6 756.8 767.7 777.8 4064.8 4307.2 4351.2 4376.0 4427.3 58534.4 60653.1 60824.1 60866.4 63118.0 49891.3 49920.0 53545.2 53697.2 54528.0 48787.3 48859.3 49225.0 49227.3 49367.8 9480.5 9544.6 9577.8 9622.4 9653.8 37066.0 37351.8 37586.6 38914.4 39559.6 42407.6 42472.4 45288.0 47479.8 48349.1 11394.6 11421.5 11482.7 11679.1 11729.6 12712.8 12723.3 12837.3 13025.2 13166.9 11875.6 11945.6 12065.3 12312.4 12323.5 11937.6 12169.8 12185.1 12187.7 12291.4 12015.3 12082.8 12094.7 12109.9 12122.6 10207.6 10209.7 10251.8 10270.5 10454.7 10600.7 10709.4 10869.6 10890.8 10973.9 15:30:01 INFO - PROCESS | 22383 | -------- Summary: end -------- 15:30:01 INFO - PROCESS | 22383 | 15:30:01 INFO - TEST-INFO | 22383: exit 0 15:30:01 INFO - TEST-OK | dromaeo_css | took 1111579ms 15:30:01 INFO - TEST-START | kraken 15:30:01 INFO - operating with platform_type : linux_ 15:30:01 INFO - Initialising browser for kraken test... 15:30:01 INFO - TEST-INFO | started process 22582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMmeyQ/profile http://localhost:44158/getInfo.html) 15:30:05 INFO - PROCESS | 22582 | __metrics Screen width/height:1600/1200 15:30:05 INFO - PROCESS | 22582 | colorDepth:24 15:30:05 INFO - PROCESS | 22582 | Browser inner width/height: 1024/697 15:30:05 INFO - PROCESS | 22582 | __metrics 15:30:07 ERROR - PROCESS | 22582 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:30:07 INFO - TEST-INFO | 22582: exit 0 15:30:07 INFO - Browser initialized. 15:30:07 INFO - Running cycle 1/1 for kraken test... 15:30:07 INFO - TEST-INFO | started process 22676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMmeyQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:19 INFO - PROCESS | 22676 | RSS: Main: 139542528 15:30:19 INFO - PROCESS | 22676 | 15:30:22 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44158/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:22 INFO - PROCESS | 22676 | RSS: Main: 197337088 15:30:22 INFO - PROCESS | 22676 | 15:30:25 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44158/tests/kraken/driver.html?testName=audio-dft) 15:30:26 INFO - PROCESS | 22676 | RSS: Main: 184819712 15:30:26 INFO - PROCESS | 22676 | 15:30:28 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44158/tests/kraken/driver.html?testName=audio-fft) 15:30:29 INFO - PROCESS | 22676 | RSS: Main: 273936384 15:30:29 INFO - PROCESS | 22676 | 15:30:31 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44158/tests/kraken/driver.html?testName=audio-oscillator) 15:30:32 INFO - PROCESS | 22676 | RSS: Main: 180879360 15:30:32 INFO - PROCESS | 22676 | 15:30:34 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:35 INFO - PROCESS | 22676 | RSS: Main: 178356224 15:30:35 INFO - PROCESS | 22676 | 15:30:37 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44158/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:38 INFO - PROCESS | 22676 | RSS: Main: 213147648 15:30:38 INFO - PROCESS | 22676 | 15:30:41 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44158/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:42 INFO - PROCESS | 22676 | RSS: Main: 213565440 15:30:42 INFO - PROCESS | 22676 | 15:30:45 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44158/tests/kraken/driver.html?testName=json-parse-financial) 15:30:45 INFO - PROCESS | 22676 | RSS: Main: 213139456 15:30:45 INFO - PROCESS | 22676 | 15:30:47 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:47 INFO - PROCESS | 22676 | RSS: Main: 196419584 15:30:47 INFO - PROCESS | 22676 | 15:30:49 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:50 INFO - PROCESS | 22676 | RSS: Main: 200355840 15:30:50 INFO - PROCESS | 22676 | 15:30:52 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:52 INFO - PROCESS | 22676 | RSS: Main: 209170432 15:30:52 INFO - PROCESS | 22676 | 15:30:55 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:55 INFO - PROCESS | 22676 | RSS: Main: 215863296 15:30:55 INFO - PROCESS | 22676 | 15:30:58 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:59 INFO - PROCESS | 22676 | RSS: Main: 213422080 15:30:59 INFO - PROCESS | 22676 | 15:31:00 INFO - PROCESS | 22676 | Cycle 1(1): loaded http://localhost:44158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44158/tests/kraken/driver.html?testName=ai-astar) 15:31:01 INFO - PROCESS | 22676 | RSS: Main: 274042880 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | __start_tp_report 15:31:01 INFO - PROCESS | 22676 | _x_x_mozilla_page_load 15:31:01 INFO - PROCESS | 22676 | _x_x_mozilla_page_load_details 15:31:01 INFO - PROCESS | 22676 | |i|pagename|runs| 15:31:01 INFO - PROCESS | 22676 | |0;ai-astar;111;111;109;110;109;112;106;109;109;110 15:31:01 INFO - PROCESS | 22676 | |1;audio-beat-detection;153;138;171;175;130;154;152;123;181;125 15:31:01 INFO - PROCESS | 22676 | |2;audio-dft;160;161;162;161;165;160;161;162;161;161 15:31:01 INFO - PROCESS | 22676 | |3;audio-fft;76;77;75;181;74;85;76;76;175;76 15:31:01 INFO - PROCESS | 22676 | |4;audio-oscillator;92;92;148;92;91;92;153;92;92;157 15:31:01 INFO - PROCESS | 22676 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;117;116 15:31:01 INFO - PROCESS | 22676 | |6;imaging-darkroom;145;145;146;145;146;146;145;145;146;145 15:31:01 INFO - PROCESS | 22676 | |7;imaging-desaturate;94;95;94;94;95;95;94;95;94;94 15:31:01 INFO - PROCESS | 22676 | |8;json-parse-financial;54;54;53;54;55;54;57;78;52;53 15:31:01 INFO - PROCESS | 22676 | |9;json-stringify-tinderbox;59;61;59;59;60;59;59;59;59;58 15:31:01 INFO - PROCESS | 22676 | |10;stanford-crypto-aes;74;73;73;73;76;74;73;74;74;75 15:31:01 INFO - PROCESS | 22676 | |11;stanford-crypto-ccm;117;120;126;116;116;114;125;117;129;132 15:31:01 INFO - PROCESS | 22676 | |12;stanford-crypto-pbkdf2;161;160;163;157;161;159;164;167;161;163 15:31:01 INFO - PROCESS | 22676 | |13;stanford-crypto-sha256-iterative;67;69;67;67;68;69;69;67;68;69 15:31:01 INFO - PROCESS | 22676 | __end_tp_report 15:31:01 INFO - PROCESS | 22676 | __start_cc_report 15:31:01 INFO - PROCESS | 22676 | _x_x_mozilla_cycle_collect,1586 15:31:01 INFO - PROCESS | 22676 | __end_cc_report 15:31:01 INFO - PROCESS | 22676 | __startTimestamp1466721061087__endTimestamp 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | ------- Summary: start ------- 15:31:01 INFO - PROCESS | 22676 | Number of tests: 14 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.67 15:31:01 INFO - PROCESS | 22676 | Values: 111.0 111.0 109.0 110.0 109.0 112.0 106.0 109.0 109.0 110.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:153.50 stddev:20.96 (13.7%) stddev-sans-first:22.21 15:31:01 INFO - PROCESS | 22676 | Values: 153.0 138.0 171.0 175.0 130.0 154.0 152.0 123.0 181.0 125.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 15:31:01 INFO - PROCESS | 22676 | Values: 160.0 161.0 162.0 161.0 165.0 160.0 161.0 162.0 161.0 161.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#3] audio-fft Cycles:10 Average:97.10 Median:76.00 stddev:42.77 (56.3%) stddev-sans-first:44.67 15:31:01 INFO - PROCESS | 22676 | Values: 76.0 77.0 75.0 181.0 74.0 85.0 76.0 76.0 175.0 76.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.00 stddev:29.45 (32.0%) stddev-sans-first:30.50 15:31:01 INFO - PROCESS | 22676 | Values: 92.0 92.0 148.0 92.0 91.0 92.0 153.0 92.0 92.0 157.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:31:01 INFO - PROCESS | 22676 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:31:01 INFO - PROCESS | 22676 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:31:01 INFO - PROCESS | 22676 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:54.00 stddev:7.71 (14.3%) stddev-sans-first:8.12 15:31:01 INFO - PROCESS | 22676 | Values: 54.0 54.0 53.0 54.0 55.0 54.0 57.0 78.0 52.0 53.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 15:31:01 INFO - PROCESS | 22676 | Values: 59.0 61.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 58.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 15:31:01 INFO - PROCESS | 22676 | Values: 74.0 73.0 73.0 73.0 76.0 74.0 73.0 74.0 74.0 75.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.50 stddev:6.30 (5.1%) stddev-sans-first:6.50 15:31:01 INFO - PROCESS | 22676 | Values: 117.0 120.0 126.0 116.0 116.0 114.0 125.0 117.0 129.0 132.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.96 15:31:01 INFO - PROCESS | 22676 | Values: 161.0 160.0 163.0 157.0 161.0 159.0 164.0 167.0 161.0 163.0 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - PROCESS | 22676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 15:31:01 INFO - PROCESS | 22676 | Values: 67.0 69.0 67.0 67.0 68.0 69.0 69.0 67.0 68.0 69.0 15:31:01 INFO - PROCESS | 22676 | -------- Summary: end -------- 15:31:01 INFO - PROCESS | 22676 | 15:31:01 INFO - TEST-INFO | 22676: exit 0 15:31:01 INFO - TEST-OK | kraken | took 60260ms 15:31:01 INFO - SUITE-END | took 1171s 15:31:02 INFO - Completed test suite (00:19:32) 15:31:02 INFO - javascript benchmark 15:31:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.315645292715, 3368.141124013378, 3389.8644054237825, 3393.8133402662875, 3422.0760394693434, 5527.861803454911, 5579.4699503547145, 5581.162825576165, 5596.132599447082, 5618.325800903892, 5567.248421463101, 5608.495235428811, 5610.775568977247, 5612.102063669814, 5627.549796016319, 4962.206047032476, 5022.799088036474, 5029.7736601853, 5138.640295179339, 5181.326427564431, 4998.425181104165, 5066.316047333618, 5067.594592432597, 5068.5438310552045, 5070.264811602316, 5004.199328107504, 5051.217061355477, 5075.086484432801, 5075.162598171298, 5112.846614601549, 5018.5232402921665, 5038.29463875056, 5041.067402530543, 5046.369203849519, 5066.569341605949, 4905.411350637911, 4960.355153830015, 4967.180415231483, 4979.900401991976, 4980.178270585349, 5371.462853714636, 5375.247465354853, 5411.080116380185, 5411.350637923435, 5411.675299482044, 6011.849703757397, 6018.638881667114, 6027.939720602782, 6032.45707886288, 6042.9395706042815, 5953.434423729739, 5998.28020637522, 6007.579469437142, 6035.547333949971, 6064.605800622945, 5511.448855114497, 5527.50252477275, 5544.695041772701, 5546.528545073714, 5556.6943818089585, 5978.282606087298, 6052.969735151296, 6058.818235452944, 6058.848528786727, 6060.33336333003, 5766.481016708516, 5814.912776308359, 5821.330546987066, 5821.825345239649, 5824.825255242349, 5913.172155898178, 5951.137085122719, 5956.761729530857, 5962.731677074542, 5965.075413310944, 5823.563232757476, 5853.239078919713, 5890.175375447441, 5901.940980590225, 5912.733926973297, 6002.939970600325, 6011.27864656244, 6016.037434010537, 6022.518198544106, 6051.213342265477, 4556.157110934488, 4561.133384656904, 4563.178627846953, 4578.771061446914, 4589.33454649074, 3978.4430179774854, 4015.437838702584, 4032.495938007749, 4067.044244602516, 4095.6518695910586, 5666.036773748473, 5684.403137670485, 5691.573132015115, 5692.23154874095, 5716.114002329646, 5918.970405147947, 5981.581289309794, 5988.850278742979, 5989.580729348903, 5992.490638295706, 5489.984352894728, 5623.606347555714, 5660.179274005246, 5668.121441176624, 5756.0, 4972.428170760337, 4978.726170060609, 4986.252062190701, 4996.225585034325, 4998.775055122528, 6190.071489276645, 6191.071339299141, 6193.38066193377, 6196.318404975449, 6202.224721909762, 5792.681402522901, 5883.882322353444, 5951.166836642873, 5958.702064896651, 5990.430909063632, 6166.1705437142555, 6170.938290617216, 6183.721732521957, 6195.31851496326, 6204.937950620436, 5870.559708022, 5878.970605146947, 5888.617239879394, 5888.911666324922, 5922.200502932049, 5893.351731309638, 6023.036314189709, 6086.939130608637, 6100.78647247362, 6118.847028824315, 5847.94152058474, 5871.94128058714, 5880.14737863016, 5888.263967004124, 5893.381194974638, 5780.595358325045, 5814.127880817911, 5855.765769369177, 5877.4122587740885, 5885.087811389241, 5675.26221591207, 5734.885302294014, 5737.139429085671, 5747.166660834239, 5758.654480731169, 5846.386129456516, 5869.236999190078, 5897.587168898308, 5898.764049438146, 5919.230500034968, 5578.246936663661, 5756.3380211276235, 5761.078227483583, 5771.8557036074435, 5787.7395517200985], "value": 5492.984085503546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.692947385255, 662.1160750398218, 670.2961890015484, 720.6828995242097, 727.0439372225524, 31968.520472192908, 32677.0, 38062.23875522488, 38896.41655375172, 39019.0, 46184.769076154655, 47046.0, 47150.056998860004, 47277.527224727826, 47336.0, 7969.9203007970045, 8853.11468853116, 9026.097390260955, 9037.999999999967, 9042.321825863053, 8184.386171037196, 10578.418186999712, 10853.348799072042, 10855.891441085567, 10858.23992320538, 10505.159587233004, 10564.577416903314, 10578.52396642153, 10583.629572964948, 10584.0, 10491.213159013067, 10530.47347632623, 10553.41956192409, 10567.68296951085, 10572.471376431185, 10540.894591054068, 10671.893281067245, 10686.839697404544, 10689.572417103383, 10690.358578485315, 41755.582444175474, 42258.78870605658, 42286.36570451415, 42291.0, 42301.57698423007, 3644.344018076745, 3716.981415092934, 3942.56631770505, 3966.1671049079728, 4249.32010878258, 29346.853265733534, 29629.407411851644, 29694.0, 30019.249518761986, 31178.0, 3507.14075051614, 3517.9824100879587, 3521.2253304273017, 3592.6227746086547, 3637.7089832813576, 221475.0, 222038.0, 224754.0, 224931.99999999837, 225264.0, 38895.0, 39254.2149157021, 39330.213395731924, 60232.69883650641, 61268.69365653143, 37466.250674986346, 37496.81251593779, 37603.0, 37646.247075058345, 37654.811725941196, 17278.740818887727, 17434.302627894995, 17443.21505532254, 17450.82549174492, 17451.912740436215, 13465.394057267447, 14166.220857852917, 14476.927615362067, 14656.487022954145, 14710.264486775832, 9154.542272886329, 9204.769880752901, 9205.309601779893, 9246.90753092474, 9251.259899208047, 3463.913402164966, 3530.593981692087, 3560.608333083359, 3583.51622530955, 3588.515550400715, 1085.7068591480256, 1129.76274982253, 1149.7240662241002, 1150.8216226484908, 1168.7311918258847, 32806.83596582049, 33006.17484562857, 33703.83148084293, 37168.81415592959, 37644.247115057544, 1223.853137623491, 1238.851337839447, 1245.850497940253, 1277.9552715655093, 1307.895368370528, 16250.51248462548, 16277.0, 16550.586235343973, 16631.584210394594, 16684.916575417046, 198651.0, 199236.0, 200427.0, 200607.0, 200678.0, 58312.70843645839, 59051.704741476016, 59063.40936590579, 59068.704656476446, 59077.70461147753, 1389.305347326337, 1502.9624259393602, 1527.938882444712, 1535.777312289734, 1625.1061915946182, 28765.71234287714, 31374.179561046454, 31619.683803161675, 31995.520067198544, 32353.35293294168, 50405.24392134047, 51006.48993510017, 51242.74378628083, 51273.0, 51318.23022654738, 355427.0, 356028.0, 356943.0, 358329.0, 359215.0, 24778.628320574844, 30269.394612108073, 30273.394532108792, 30545.389092218476, 32028.679713203503, 46014.0, 46208.53791462177, 46358.0, 46809.0, 47050.82372940704, 38232.0, 38332.0, 38741.41887871628, 39026.804865975486, 39094.4135837957, 37300.81349593234, 37893.0, 38162.42756358601, 38259.42610860783, 38338.0415489615, 39604.405933910435, 40279.0, 40336.79831600823, 40471.0, 40634.79682601686, 34117.31765364728, 34305.31389372249, 34568.0, 34821.0, 35205.471917921765, 26979.0, 27071.72928270692, 27203.86398067997, 27249.455010899273, 27367.0], "value": 18549.998154697838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7247625281693, 433.3326676917549, 433.8112920879416, 435.779931134777, 444.45776153093215, 18650.440486785403, 18667.786593871406, 18972.241110355568, 19357.322493712723, 19398.612027759435, 18680.81319186811, 18688.532786680305, 19783.5054123647, 19789.604207915832, 19808.603827923434, 5577.8047768327915, 5754.65472071675, 5839.153322768196, 5847.0352391855295, 5997.490213331872, 5778.0, 5799.246098007253, 5818.970905145468, 5869.0, 6243.344448832852, 6579.374959378852, 6627.569208001489, 6642.402183803457, 6647.867042659168, 6653.866922661544, 5892.941070589282, 6035.758569657209, 6450.032495125745, 6540.672966351687, 6545.869082618345, 5824.184614154022, 5867.8533036674, 5869.589128760988, 5890.49930755882, 5896.911546326808, 14549.636259093502, 19560.0, 22800.54398912029, 23978.640320395207, 23991.880040599684, 2451.6077427611494, 2464.2853572463964, 2513.5349960257226, 2577.1624222127884, 2654.2568080937176, 10779.137668986463, 10816.621418250323, 11144.777104457946, 11156.776864462747, 13145.342732863413, 2037.6230397376385, 2121.586290673319, 2130.925417610392, 2136.0, 2199.0104452996216, 75993.62003190003, 78351.0, 79282.0, 79450.60274698648, 79674.6016269915, 11455.140864435201, 11793.29240245588, 11812.645620631394, 11848.822267665992, 11975.221610595283, 16652.250648720594, 16766.74849877253, 16821.243044063045, 16833.915830421014, 16846.157692115346, 9216.677416290398, 9306.348555601178, 9362.485063321446, 9452.57463414148, 9460.195883349992, 9407.623695052258, 9415.340926135243, 9444.433333999981, 9484.33609647318, 9484.715458536255, 5092.872678183075, 5188.014277287379, 5201.7399130044105, 5207.557357624569, 5274.7890084396195, 2111.556573119631, 2112.123468760478, 2119.364190742771, 2137.6900349449243, 2167.978320216809, 960.7790208252002, 989.8317286061387, 1003.4380746781679, 1059.4014381874217, 1093.775775965925, 18901.905490472458, 19266.0, 19590.608187836162, 19778.60442791136, 19805.60388792216, 1050.7425680708122, 1060.1253965478356, 1065.7655315830505, 1077.272840832435, 1088.216484131424, 10565.735856603493, 11080.667579972614, 11082.61210857616, 11118.110551155889, 11153.72115697114, 496911.0, 509962.0, 516202.0, 532634.0, 535007.0, 69156.0, 82844.58577707193, 84031.15968840355, 89632.0, 94146.0, 1089.5315014543664, 1090.7218659241842, 1104.7403860092872, 1112.4159816096615, 1117.7876203521305, 17050.955855418884, 17336.133193340534, 17364.652706946043, 17674.204660790554, 17811.910940445214, 37696.62303376931, 38588.22823543457, 39022.80488597539, 39746.20507589774, 39878.800605997945, 55964.720176398856, 56703.71648141733, 57165.14252286136, 57341.713291433276, 57397.0, 8801.339899507691, 9233.907660923305, 9251.306152038489, 9331.113544213289, 9357.438553686801, 13278.601641950758, 13862.584122476343, 13912.403019761872, 14025.859741402455, 14527.0, 6452.096706461005, 10063.849042264519, 11024.338539687644, 12219.69450763738, 12589.559365422532, 12227.14409991292, 12318.322492263012, 12324.137310388187, 12664.6833829155, 12882.48470061187, 12548.556915954781, 12598.244105353708, 12713.237205767684, 12799.360031998176, 12923.28921909304, 8884.511351875708, 8935.419197752126, 9014.594343254437, 9313.720588382359, 9458.668946586837, 11298.322100673986, 11380.374079425712, 11486.712832179262, 11496.88503114958, 11552.133589980953], "value": 9626.742570093144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.615586869479, 1597.952061438157, 1598.1449924290507, 1813.8367546920774, 1922.8942408167545, 7733.767986960386, 8386.203310685483, 8590.012148602913, 8602.139786021395, 8605.096464871192, 8440.240378365947, 8631.352648551352, 8641.049484556694, 8646.394752367336, 8676.826463470727, 2473.2085732565542, 2493.0651005872796, 2495.563276426627, 2497.313238859319, 2500.6374075759004, 2390.366552863484, 2494.0148641286683, 2497.950040999179, 2498.0, 2502.3744063984004, 2423.660687503742, 2456.9631455528092, 2461.544614246361, 2463.7659422354845, 2466.3094333586537, 2414.6619473273754, 2434.8904299306487, 2443.6823212982285, 2470.1601455505033, 2470.72821989581, 2372.6796882420826, 2429.477662302613, 2431.7203521595065, 2433.7444568320248, 2452.901883924641, 8361.289290410261, 8616.698415555426, 8766.868496972551, 8827.426217295919, 8829.42608730437, 5490.121580547133, 5565.41563135873, 5597.63615365, 5598.188262701926, 5606.35526914406, 3656.0, 3669.082729317671, 3734.5705243897028, 3739.5699494558203, 3810.5236845394325, 1148.4544841200363, 1200.0579545057176, 1218.275126299859, 1223.3516236394726, 1243.0676992255808, 11951.88048119525, 12380.071494637848, 12416.379181041002, 12449.190802597803, 12477.31374774387, 4531.320301954733, 4713.95286047142, 4741.668083234141, 4794.7842347094465, 4822.831200907952, 9760.023997600325, 9815.705528834147, 9828.361156524947, 9835.901640983642, 9854.556544955494, 5504.284443022381, 5516.972415137899, 5523.585731070186, 5525.613207075547, 5535.8892822144135, 4434.490033646108, 4514.909701806011, 4902.607791376681, 5018.121828679967, 5154.768035438339, 3948.269570129478, 3967.3652215645357, 4015.0765323975065, 4047.332190188586, 4062.1266427718183, 1194.2118201986648, 1224.4918358880964, 1225.503671013241, 1237.8824011718873, 1238.8575313838844, 1008.2287050406445, 1011.3881101933372, 1015.2487159502062, 1024.4979959819784, 1027.6916924922493, 5774.0, 5796.0, 5834.183214349994, 5908.172855800191, 6139.969300153471, 916.1840932516129, 945.5839430650492, 988.8071825993862, 1011.1051719228535, 1027.9155490957112, 3869.96130038696, 3895.941560876589, 3913.3347330953807, 3942.940855887164, 3953.703472239536, 10147.086762191439, 10399.32404393712, 10477.371357718408, 10512.526936287886, 10516.894831051592, 10382.169426445866, 10382.221333399873, 10447.84328235077, 10818.29681070728, 10882.401467919182, 8308.958455207685, 8324.500529968222, 8325.542095184823, 8423.536705481134, 8441.07148213696, 5728.169415434655, 5770.480656740913, 5796.478316951495, 5798.942010580009, 5870.295564532284, 9643.807123857343, 9700.805983880424, 9805.21558275322, 9815.822101347883, 9822.607095716377, 9659.130678238993, 9864.457454840052, 9941.204703623838, 10235.692929212135, 10270.178385728974, 6500.6424646643, 6683.832904177434, 6982.546134501241, 7249.963750181215, 7377.741779037708, 8184.54984975832, 8191.262786349257, 8241.217084376975, 8262.297704694927, 8262.876056859272, 7287.0, 7411.66647500853, 7523.172451030273, 7540.1328847181085, 7661.1572726998875, 7354.73769764296, 7383.556986580607, 7394.667239974322, 7485.962570187115, 7513.0, 6989.580625162506, 7135.5361901476235, 7157.033800436874, 7167.390771784457, 7182.748603798842, 5170.922436163536, 5219.8434046978655, 5296.2055691646565, 5334.0, 5367.409584945731, 5387.003404370204, 5398.055340315351, 5415.133578627559, 5440.483154100354, 5491.368492623399], "value": 4682.078341863638, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.554049599984, 368.7953185981779, 369.49563845351105, 369.918617904061, 373.9663430291273, 6093.360197179293, 6146.907796383058, 6147.907781383272, 6161.969190154055, 6181.752729890804, 5949.1373750806215, 6175.166352542406, 6182.1345011698395, 6184.381561843813, 6200.131981522579, 4672.766361681919, 4736.218523943545, 4746.976265118669, 4749.097671442432, 4766.165920963835, 4709.246520556711, 4730.5269473052595, 4733.952660473403, 4737.976310118444, 4753.928691069619, 4576.427946506687, 4679.485256621769, 4721.2918062290755, 4728.101660684476, 4742.407199100113, 4759.357486739315, 4764.571188593043, 4766.594839438651, 4768.976155119202, 4786.808527658907, 4211.747295162269, 4223.387608796707, 4224.767637779921, 4225.028243503981, 4231.069164783743, 5912.0, 5913.172155898178, 5927.940720592782, 5929.377415371367, 6002.0, 5645.717714114319, 5646.54827613794, 5649.124385720179, 5650.378458369576, 5674.858128546778, 6494.870102597922, 6609.636469994149, 6613.404793568602, 6624.701888415033, 6629.303923088103, 4718.386609740746, 4755.83354582588, 4759.547842954914, 4766.976165119187, 4771.665983381165, 6927.58434493932, 6950.200726916419, 6951.7219311228, 6952.895706564405, 6953.89569156458, 4872.634552408584, 4875.585575226146, 4877.585405240523, 4885.8045678173185, 4887.804487820447, 4940.061388336205, 4950.6782059166035, 4953.479884612136, 4953.628477864175, 4955.529224723646, 5515.917261241085, 5626.549876009909, 5629.099344105005, 5630.0, 5639.689817060019, 6683.699233534503, 6695.330466953265, 6695.631740254333, 6697.196336439659, 6702.932970670231, 1703.838135377162, 1724.7844019497563, 1726.4734256052025, 1727.6976529107355, 1732.3330517750758, 1102.8841971593029, 1134.2910680824484, 1136.4033882211904, 1137.9544818207344, 1156.392893730798, 6310.7475700971445, 6419.74321027163, 6449.064885591563, 6583.63789991555, 6596.142501474777, 6948.478864085214, 6965.860682786316, 6966.407855332353, 6984.126984126984, 6988.965055174692, 6501.804945851632, 6506.219253689493, 6506.837329066811, 6508.739650414025, 6511.023346497968, 3604.9098772530897, 3694.039549717093, 3731.6641502264924, 3736.308782875177, 3739.3456145174487, 7193.208747037822, 7227.49407541467, 7229.92770072303, 7239.384652304613, 7240.891386629205, 7037.190723066913, 7040.401565866959, 7047.859042819115, 7070.92929070713, 7093.255208203168, 7216.458765592602, 7227.9400370894045, 7240.927590724025, 7246.347828695442, 7247.383972362198, 6762.323767623198, 6949.617771022642, 6954.478414119062, 6959.130108736408, 6968.094147760961, 6867.828304292233, 6884.382170189901, 6887.793366199022, 6889.448844092361, 6903.275156108737, 7251.166115896739, 7257.455690823103, 7258.709651613876, 7259.673314700745, 7263.527870688388, 4732.834350797705, 4764.880877978078, 4767.0, 4775.5224477551965, 4777.9044419112115, 6965.0, 6977.092977913042, 6977.755778547929, 6986.266442023514, 6989.8951515726285, 6556.606603603799, 6776.628180136912, 6784.457243420416, 6795.626240556817, 6796.184457865088, 6713.395794378529, 6729.394354508117, 6753.628550429577, 6758.695858686469, 6763.425108865801, 6639.070530125883, 6642.368974947372, 6648.501362397743, 6655.134832471747, 6655.767048153485, 6603.405693487609, 6804.965975170093, 6811.250762416229, 6822.249552549315, 6823.931760682528, 6273.337565545043, 6453.193350831146, 6571.934280657323, 6642.6014439133805, 6647.767328143492], "value": 5067.689984887452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.1274470635236, 778.9561986937505, 787.4487858499051, 794.8887155798186, 862.5988915154452, 12671.049671274668, 12727.0, 12801.871981280185, 12816.359182040907, 13155.605331840035, 13186.274754888478, 13203.339833008335, 13216.207027578352, 13241.470341186365, 13253.536126235584, 736.7310931510001, 750.0362034785302, 751.4514404484702, 752.1012390193721, 887.5562218890555, 898.2679116520048, 898.3980732908934, 905.4567259644226, 906.4742449379377, 906.9818603627923, 941.3551717073826, 942.3733217410414, 946.7585765629755, 949.5632009275741, 950.5627411390768, 770.2259229474398, 930.1256818590571, 941.4163218804351, 946.1673727120091, 946.2477330522252, 696.6238231355062, 697.159922293635, 698.3819319901872, 699.1330749870175, 699.1540236314066, 12707.110502264844, 12785.424655890507, 12895.806562901564, 12922.547710830077, 12934.094613377067, 13048.608541743763, 13574.049816512848, 13651.044426890121, 13943.0, 14318.0, 11526.654200374001, 11613.477393517313, 11708.473118709679, 11721.23811952229, 12054.879451205463, 3871.690264778811, 3875.476810630557, 3938.6061393860386, 3955.782431966241, 3986.382110772835, 54467.99999999961, 58476.0, 59167.0, 59429.108563371585, 59577.0, 11596.304221746723, 11641.0, 11841.0, 11905.166638335233, 11942.522299108112, 20660.173593056108, 20670.276540321018, 20682.482937926674, 20801.271955481487, 20804.0, 8393.328533717287, 8486.533240671699, 8848.203661670352, 8888.466691998501, 9047.592858321259, 4816.662833601615, 4978.4025916890205, 4988.90022199554, 5009.799608015712, 5092.38891333035, 3544.379733546619, 3586.6234045425376, 3592.515010473605, 3593.4609808528407, 3602.7838329700303, 604.1511676095093, 645.8611398549334, 658.6969993802809, 663.7179198840473, 664.2062735031687, 676.0636518421923, 686.8969654551757, 721.156247190788, 774.6901239504243, 775.5579319787666, 8900.8664870027, 9100.0, 9285.62857485693, 9342.673006444878, 9361.251099911991, 746.1121265693807, 750.6246876561719, 756.8334966307403, 767.6929228308721, 777.8211011467395, 4064.7561146331313, 4307.246231909403, 4351.173277077345, 4376.0, 4427.313766366218, 58534.41465585375, 60653.09020364698, 60824.08763868546, 60866.391336086956, 63118.0, 49891.25163122556, 49920.0, 53545.1968220477, 53697.1945420819, 54528.0, 48787.26819097788, 48859.267110993365, 49225.0, 49227.26159107616, 49367.75316123468, 9480.516902554935, 9544.618215271312, 9577.760555985877, 9622.422654640744, 9653.758656033375, 37066.0, 37351.81324093471, 37586.62413375831, 38914.4162837552, 39559.60440395559, 42407.575924240366, 42472.36291455692, 45288.0, 47479.762601186776, 48349.132069435065, 11394.601188958346, 11421.543138274708, 11482.712932176762, 11679.124065695276, 11729.648110556696, 12712.809307860574, 12723.300218488072, 12837.293948832903, 13025.153365031243, 13166.868331316948, 11875.584354547549, 11945.641630751092, 12065.276083435023, 12312.445939932904, 12323.50705971751, 11937.582184623843, 12169.817452738393, 12185.147039707135, 12187.695307617381, 12291.44688489038, 12015.279083254683, 12082.758344832879, 12094.697632559257, 12109.939450303045, 12122.636320910387, 10207.59169633236, 10209.693709188736, 10251.794964100825, 10270.486475676036, 10454.738631533968, 10600.681979540626, 10709.3574385534, 10869.619563315246, 10890.782184356427, 10973.945130274298], "value": 6829.562540766349, "unit": "score"}], "name": "dromaeo_css", "value": 7360.118270104298, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 109.0, 110.0, 109.0, 112.0, 106.0, 109.0, 109.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 138.0, 171.0, 175.0, 130.0, 154.0, 152.0, 123.0, 181.0, 125.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 165.0, 160.0, 161.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 181.0, 74.0, 85.0, 76.0, 76.0, 175.0, 76.0], "value": 97.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 91.0, 92.0, 153.0, 92.0, 92.0, 157.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 55.0, 54.0, 57.0, 78.0, 52.0, 53.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 76.0, 74.0, 73.0, 74.0, 74.0, 75.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 126.0, 116.0, 116.0, 114.0, 125.0, 117.0, 129.0, 132.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 157.0, 161.0, 159.0, 164.0, 167.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 68.0, 69.0, 69.0, 67.0, 68.0, 69.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1525.1000000000001, "alertThreshold": 2.0}]} 15:31:02 INFO - Return code: 0 15:31:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:31:02 ERROR - # TBPL SUCCESS # 15:31:02 INFO - Running post-action listener: _resource_record_post_action 15:31:02 INFO - Running post-run listener: _resource_record_post_run 15:31:03 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 461488128; Read time: 0; Write time: 412796 15:31:03 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 242446336; Read time: 0; Write time: 302280 15:31:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 219041792; Read time: 0; Write time: 110516 15:31:03 INFO - Running post-run listener: _upload_blobber_files 15:31:03 INFO - Blob upload gear active. 15:31:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:31:03 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 15:31:03 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'] 15:31:03 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 15:31:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:04 INFO - (blobuploader) - INFO - Done attempting. 15:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:05 INFO - (blobuploader) - INFO - Done attempting. 15:31:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:05 INFO - Return code: 0 15:31:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b0a20bddb94ea131ff5a4cfd37b5125c4107ea038b45affdac189aa82607d0cd18b7244f6f67fa1e43009f34d08022b2008b66c954d00faceb9ba1410f7f06c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d312d6bbdfc9acb3f5f9a3e2636be5e90e51996de9ba4926d529150eade1fc3b6d600424c9dbaa6b30242963a5084bf18fb9e9600cc06e2bc980901872862577"} 15:31:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:05 INFO - Contents: 15:31:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2b0a20bddb94ea131ff5a4cfd37b5125c4107ea038b45affdac189aa82607d0cd18b7244f6f67fa1e43009f34d08022b2008b66c954d00faceb9ba1410f7f06c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d312d6bbdfc9acb3f5f9a3e2636be5e90e51996de9ba4926d529150eade1fc3b6d600424c9dbaa6b30242963a5084bf18fb9e9600cc06e2bc980901872862577"} 15:31:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:31:05 INFO - Copying logs to upload dir... 15:31:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:31:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.945790 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-23 15:31:04.919763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 15:31:04.923015) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433 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/2b0a20bddb94ea131ff5a4cfd37b5125c4107ea038b45affdac189aa82607d0cd18b7244f6f67fa1e43009f34d08022b2008b66c954d00faceb9ba1410f7f06c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d312d6bbdfc9acb3f5f9a3e2636be5e90e51996de9ba4926d529150eade1fc3b6d600424c9dbaa6b30242963a5084bf18fb9e9600cc06e2bc980901872862577"} build_url:https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/RE-n3tqoRu-sDgp4ZFPrlg/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/2b0a20bddb94ea131ff5a4cfd37b5125c4107ea038b45affdac189aa82607d0cd18b7244f6f67fa1e43009f34d08022b2008b66c954d00faceb9ba1410f7f06c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d312d6bbdfc9acb3f5f9a3e2636be5e90e51996de9ba4926d529150eade1fc3b6d600424c9dbaa6b30242963a5084bf18fb9e9600cc06e2bc980901872862577"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 15:31:04.951748) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:31:04.952138) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466713925.128638-574021433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 15:31:05.033850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 15:31:05.034224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 15:31:05.034596) ========= ========= Total master_lag: 0.18 =========