builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0152 starttime: 1463531768.85 results: success (0) buildid: 20160517161854 builduid: 1bc274a47c334b54828779b0cf9588e5 revision: 63933fe5bb3f0148c2c276a941f8baa92acf4987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:08.852693) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:08.853113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:08.853705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:08.919468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:08.919749) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zEEJBf9S9b/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-17 17:36:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.15M=0.001s 2016-05-17 17:36:09 (8.15 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.721085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:09.657510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:09.657835) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zEEJBf9S9b/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020516 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:09.706547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:09.706907) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 63933fe5bb3f0148c2c276a941f8baa92acf4987 --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 63933fe5bb3f0148c2c276a941f8baa92acf4987 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zEEJBf9S9b/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-17 17:36:09,781 truncating revision to first 12 chars 2016-05-17 17:36:09,781 Setting DEBUG logging. 2016-05-17 17:36:09,781 attempt 1/10 2016-05-17 17:36:09,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/63933fe5bb3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 17:36:10,506 unpacking tar archive at: mozilla-beta-63933fe5bb3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.978426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:10.703280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:10.703622) ========= script_repo_revision: 63933fe5bb3f0148c2c276a941f8baa92acf4987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:10.704006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:10.704295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:10.717979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-17 17:36:10.718400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_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/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zEEJBf9S9b/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:36:10 INFO - MultiFileLogger online at 20160517 17:36:10 in /builds/slave/test 17:36:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:36:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:10 INFO - {'append_to_log': False, 17:36:10 INFO - 'base_work_dir': '/builds/slave/test', 17:36:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:36:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:10 INFO - 'branch': 'Mozilla-Beta', 17:36:10 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:10 INFO - 'config_files': ('talos/mac_config.py',), 17:36:10 INFO - 'default_actions': ('clobber', 17:36:10 INFO - 'read-buildbot-config', 17:36:10 INFO - 'download-and-extract', 17:36:10 INFO - 'populate-webroot', 17:36:10 INFO - 'create-virtualenv', 17:36:10 INFO - 'install', 17:36:10 INFO - 'run-tests'), 17:36:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:10 INFO - 'download_minidump_stackwalk': True, 17:36:10 INFO - 'download_symbols': 'ondemand', 17:36:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:10 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:10 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:10 INFO - 'installer_path': 'installer.exe', 17:36:10 INFO - 'log_level': 'info', 17:36:10 INFO - 'log_name': 'talos', 17:36:10 INFO - 'log_to_console': True, 17:36:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:36:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:36:10 INFO - 'opt_config_files': (), 17:36:10 INFO - 'pip_index': False, 17:36:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:10 INFO - 'cmd': ('bash', 17:36:10 INFO - '-c', 17:36:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:10 INFO - 'enabled': True, 17:36:10 INFO - 'halt_on_failure': False, 17:36:10 INFO - 'name': 'check_screen_resolution'},), 17:36:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:10 INFO - 'cmd': ('bash', 17:36:10 INFO - '-c', 17:36:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:10 INFO - 'enabled': True, 17:36:10 INFO - 'halt_on_failure': False, 17:36:10 INFO - 'name': 'check_screen_resolution'},), 17:36:10 INFO - 'run_cmd_checks_enabled': True, 17:36:10 INFO - 'sps_profile': False, 17:36:10 INFO - 'sps_profile_interval': 0, 17:36:10 INFO - 'suite': 'dromaeojs', 17:36:10 INFO - 'system_bits': '32', 17:36:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:10 INFO - 'title': 't-yosemite-r7-0152', 17:36:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:10 INFO - 'use_talos_json': True, 17:36:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:10 INFO - 'work_dir': 'build'} 17:36:10 INFO - ##### 17:36:10 INFO - ##### Running clobber step. 17:36:10 INFO - ##### 17:36:10 INFO - Running pre-action listener: _resource_record_pre_action 17:36:10 INFO - Running main action method: clobber 17:36:10 INFO - rmtree: /builds/slave/test/build 17:36:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:11 INFO - Running post-action listener: _resource_record_post_action 17:36:11 INFO - ##### 17:36:11 INFO - ##### Running read-buildbot-config step. 17:36:11 INFO - ##### 17:36:11 INFO - Running pre-action listener: _resource_record_pre_action 17:36:11 INFO - Running main action method: read_buildbot_config 17:36:11 INFO - Using buildbot properties: 17:36:11 INFO - { 17:36:11 INFO - "project": "", 17:36:11 INFO - "product": "firefox", 17:36:11 INFO - "script_repo_revision": "production", 17:36:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:36:11 INFO - "repository": "", 17:36:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:36:11 INFO - "buildid": "20160517161854", 17:36:11 INFO - "pgo_build": "False", 17:36:11 INFO - "basedir": "/builds/slave/test", 17:36:11 INFO - "buildnumber": 7, 17:36:11 INFO - "slavename": "t-yosemite-r7-0152", 17:36:11 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:36:11 INFO - "platform": "yosemite_r7", 17:36:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:36:11 INFO - "branch": "mozilla-beta", 17:36:11 INFO - "repo_path": "releases/mozilla-beta", 17:36:11 INFO - "revision": "63933fe5bb3f0148c2c276a941f8baa92acf4987", 17:36:11 INFO - "stage_platform": "macosx64", 17:36:11 INFO - "builduid": "1bc274a47c334b54828779b0cf9588e5", 17:36:11 INFO - "slavebuilddir": "test" 17:36:11 INFO - } 17:36:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 17:36:11 INFO - Running post-action listener: _resource_record_post_action 17:36:11 INFO - ##### 17:36:11 INFO - ##### Running download-and-extract step. 17:36:11 INFO - ##### 17:36:11 INFO - Running pre-action listener: _resource_record_pre_action 17:36:11 INFO - Running main action method: download_and_extract 17:36:11 INFO - mkdir: /builds/slave/test/build/tests 17:36:11 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')]} 17:36:11 INFO - https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:36:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 17:36:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 17:36:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 17:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 17:36:16 INFO - Downloaded 1241 bytes. 17:36:16 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 17:36:16 INFO - Using the following test package requirements: 17:36:16 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 17:36:16 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 17:36:16 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 17:36:16 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:36:16 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 17:36:16 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 17:36:16 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 17:36:16 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 17:36:16 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 17:36:16 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 17:36:16 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 17:36:16 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 17:36:16 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 17:36:16 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')]} 17:36:16 INFO - https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 17:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 17:36:18 INFO - Downloaded 17747733 bytes. 17:36:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:36:21 INFO - Return code: 0 17:36:21 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 17:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:21 INFO - https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:36:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:36:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 17:36:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 17:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 17:36:34 INFO - Downloaded 17747733 bytes. 17:36:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:36:37 INFO - Return code: 0 17:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:37 INFO - https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 17:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 17:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 17:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 17:36:39 INFO - Downloaded 10845194 bytes. 17:36:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:36:39 INFO - Return code: 0 17:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:39 INFO - https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 17:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 17:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 17:36:44 INFO - Downloaded 88289537 bytes. 17:36:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:36:44 INFO - mkdir: /builds/slave/test/properties 17:36:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:44 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:44 INFO - Contents: 17:36:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 17:36:45 INFO - Running post-action listener: _resource_record_post_action 17:36:45 INFO - Running post-action listener: set_extra_try_arguments 17:36:45 INFO - ##### 17:36:45 INFO - ##### Running populate-webroot step. 17:36:45 INFO - ##### 17:36:45 INFO - Running pre-action listener: _resource_record_pre_action 17:36:45 INFO - Running main action method: populate_webroot 17:36:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:45 INFO - '--tppagecycles', 17:36:45 INFO - '7'], 17:36:45 INFO - 'tests': ['tsvgm']}}, 17:36:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:36:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:36:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'tests': ['damp', 'tps']}, 17:36:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['damp', 'tps']}, 17:36:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:36:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:45 INFO - 'other': {'tests': ['a11yr', 17:36:45 INFO - 'ts_paint', 17:36:45 INFO - 'tpaint', 17:36:45 INFO - 'sessionrestore', 17:36:45 INFO - 'sessionrestore_no_auto_restore', 17:36:45 INFO - 'tabpaint']}, 17:36:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['a11yr', 17:36:45 INFO - 'ts_paint', 17:36:45 INFO - 'tpaint', 17:36:45 INFO - 'sessionrestore', 17:36:45 INFO - 'sessionrestore_no_auto_restore', 17:36:45 INFO - 'tabpaint']}, 17:36:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['a11yr', 17:36:45 INFO - 'ts_paint', 17:36:45 INFO - 'tpaint', 17:36:45 INFO - 'sessionrestore', 17:36:45 INFO - 'sessionrestore_no_auto_restore', 17:36:45 INFO - 'tabpaint']}, 17:36:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['a11yr', 17:36:45 INFO - 'ts_paint', 17:36:45 INFO - 'tpaint', 17:36:45 INFO - 'sessionrestore', 17:36:45 INFO - 'sessionrestore_no_auto_restore', 17:36:45 INFO - 'tabpaint']}, 17:36:45 INFO - 'other_l64': {'tests': ['a11yr', 17:36:45 INFO - 'ts_paint', 17:36:45 INFO - 'tpaint', 17:36:45 INFO - 'sessionrestore', 17:36:45 INFO - 'sessionrestore_no_auto_restore', 17:36:45 INFO - 'tabpaint']}, 17:36:45 INFO - 'other_nol64': {'tests': ['a11yr', 17:36:45 INFO - 'ts_paint', 17:36:45 INFO - 'tpaint', 17:36:45 INFO - 'sessionrestore', 17:36:45 INFO - 'sessionrestore_no_auto_restore', 17:36:45 INFO - 'tabpaint']}, 17:36:45 INFO - 'svgr': {'tests': ['tsvgx', 17:36:45 INFO - 'tsvgr_opacity', 17:36:45 INFO - 'tart', 17:36:45 INFO - 'tscrollx', 17:36:45 INFO - 'cart']}, 17:36:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['tsvgx', 17:36:45 INFO - 'tsvgr_opacity', 17:36:45 INFO - 'tart', 17:36:45 INFO - 'tscrollx', 17:36:45 INFO - 'cart']}, 17:36:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'tests': ['tp5o']}, 17:36:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'talos_options': ['--e10s'], 17:36:45 INFO - 'tests': ['tp5o']}, 17:36:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'talos_options': ['--xperf_path', 17:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:45 INFO - 'tests': ['tp5n']}, 17:36:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:45 INFO - 'talos_options': ['--e10s', 17:36:45 INFO - '--xperf_path', 17:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:45 INFO - 'tests': ['tp5n']}}, 17:36:45 INFO - 'talos.zip': {'path': '', 17:36:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:45 INFO - Running post-action listener: _resource_record_post_action 17:36:45 INFO - ##### 17:36:45 INFO - ##### Running create-virtualenv step. 17:36:45 INFO - ##### 17:36:45 INFO - Running pre-action listener: _resource_record_pre_action 17:36:45 INFO - Running main action method: create_virtualenv 17:36:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:45 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 17:36:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:45 INFO - Using real prefix '/tools/python27' 17:36:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:46 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:48 INFO - Installing pip.................done. 17:36:48 INFO - Return code: 0 17:36:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:48 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')]} 17:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 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')]} 17:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 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 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:36:48 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 17:36:48 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 17:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:48 INFO - 'HOME': '/Users/cltbld', 17:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:48 INFO - 'LOGNAME': 'cltbld', 17:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:48 INFO - 'MOZ_NO_REMOTE': '1', 17:36:48 INFO - 'NO_EM_RESTART': '1', 17:36:48 INFO - 'PAGER': '/bin/cat', 17:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:48 INFO - 'PWD': '/builds/slave/test', 17:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:48 INFO - 'SHELL': '/bin/bash', 17:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:36:48 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:48 INFO - 'USER': 'cltbld', 17:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:48 INFO - 'XPC_FLAGS': '0x0', 17:36:48 INFO - 'XPC_SERVICE_NAME': '0', 17:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:49 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 17:36:49 INFO - Cleaning up... 17:36:49 INFO - Return code: 0 17:36:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:49 INFO - 'HOME': '/Users/cltbld', 17:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:49 INFO - 'LOGNAME': 'cltbld', 17:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:49 INFO - 'MOZ_NO_REMOTE': '1', 17:36:49 INFO - 'NO_EM_RESTART': '1', 17:36:49 INFO - 'PAGER': '/bin/cat', 17:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:49 INFO - 'PWD': '/builds/slave/test', 17:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:49 INFO - 'SHELL': '/bin/bash', 17:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:36:49 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:49 INFO - 'USER': 'cltbld', 17:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:49 INFO - 'XPC_FLAGS': '0x0', 17:36:49 INFO - 'XPC_SERVICE_NAME': '0', 17:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:49 INFO - Downloading/unpacking psutil>=0.7.1 17:36:49 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 17:36:49 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 17:36:49 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 17:36:49 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 17:36:49 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 17:36:49 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 17:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:52 INFO - Installing collected packages: psutil 17:36:52 INFO - Running setup.py install for psutil 17:36:52 INFO - building 'psutil._psutil_osx' extension 17:36:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:36:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:36:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:36:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:36:53 INFO - building 'psutil._psutil_posix' extension 17:36:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:36:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:36:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:36:53 INFO - ^ 17:36:53 INFO - 1 warning generated. 17:36:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:53 INFO - Successfully installed psutil 17:36:53 INFO - Cleaning up... 17:36:53 INFO - Return code: 0 17:36:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', '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 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:36: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:36: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 mozsystemmonitor==0.0.0 17:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:53 INFO - 'HOME': '/Users/cltbld', 17:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:53 INFO - 'LOGNAME': 'cltbld', 17:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:53 INFO - 'MOZ_NO_REMOTE': '1', 17:36:53 INFO - 'NO_EM_RESTART': '1', 17:36:53 INFO - 'PAGER': '/bin/cat', 17:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:53 INFO - 'PWD': '/builds/slave/test', 17:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:53 INFO - 'SHELL': '/bin/bash', 17:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:36:53 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:53 INFO - 'USER': 'cltbld', 17:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:53 INFO - 'XPC_FLAGS': '0x0', 17:36:53 INFO - 'XPC_SERVICE_NAME': '0', 17:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:36:56 INFO - Installing collected packages: mozsystemmonitor 17:36:56 INFO - Running setup.py install for mozsystemmonitor 17:36:56 INFO - Successfully installed mozsystemmonitor 17:36:56 INFO - Cleaning up... 17:36:56 INFO - Return code: 0 17:36:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', '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 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36: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 blobuploader==1.2.4 17:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:56 INFO - 'HOME': '/Users/cltbld', 17:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:56 INFO - 'LOGNAME': 'cltbld', 17:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:56 INFO - 'MOZ_NO_REMOTE': '1', 17:36:56 INFO - 'NO_EM_RESTART': '1', 17:36:56 INFO - 'PAGER': '/bin/cat', 17:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:56 INFO - 'PWD': '/builds/slave/test', 17:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:56 INFO - 'SHELL': '/bin/bash', 17:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:36:56 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:56 INFO - 'USER': 'cltbld', 17:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:56 INFO - 'XPC_FLAGS': '0x0', 17:36:56 INFO - 'XPC_SERVICE_NAME': '0', 17:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:37:00 INFO - Downloading docopt-0.6.1.tar.gz 17:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:37:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:37:00 INFO - Running setup.py install for blobuploader 17:37:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:37:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:37:00 INFO - Running setup.py install for requests 17:37:01 INFO - Running setup.py install for docopt 17:37:01 INFO - Successfully installed blobuploader requests docopt 17:37:01 INFO - Cleaning up... 17:37:01 INFO - Return code: 0 17:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:01 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 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:37:01 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 17:37:01 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 17:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:01 INFO - 'HOME': '/Users/cltbld', 17:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:01 INFO - 'LOGNAME': 'cltbld', 17:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:01 INFO - 'MOZ_NO_REMOTE': '1', 17:37:01 INFO - 'NO_EM_RESTART': '1', 17:37:01 INFO - 'PAGER': '/bin/cat', 17:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:01 INFO - 'PWD': '/builds/slave/test', 17:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:01 INFO - 'SHELL': '/bin/bash', 17:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:37:01 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:01 INFO - 'USER': 'cltbld', 17:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:01 INFO - 'XPC_FLAGS': '0x0', 17:37:01 INFO - 'XPC_SERVICE_NAME': '0', 17:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:01 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MtYxz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:01 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-9dI2EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:01 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-7gvKlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:01 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-5czdCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-6mnIH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-xgv5g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-5jnEWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-xwaiCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-0mCkZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-jtGbr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-kxJibQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-YLfJD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Fyy2Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:02 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-BqT0Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:03 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GZRdtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:03 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-V8fZhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:03 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-sHW86u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:37:03 INFO - Running setup.py install for manifestparser 17:37:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:37:03 INFO - Running setup.py install for mozcrash 17:37:03 INFO - Running setup.py install for mozdebug 17:37:03 INFO - Running setup.py install for mozdevice 17:37:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:37:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:37:03 INFO - Running setup.py install for mozfile 17:37:04 INFO - Running setup.py install for mozhttpd 17:37:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Running setup.py install for mozinfo 17:37:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Running setup.py install for mozInstall 17:37:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Running setup.py install for mozleak 17:37:04 INFO - Running setup.py install for mozlog 17:37:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Running setup.py install for moznetwork 17:37:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:37:04 INFO - Running setup.py install for mozprocess 17:37:05 INFO - Running setup.py install for mozprofile 17:37:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozrunner 17:37:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Running setup.py install for mozscreenshot 17:37:05 INFO - Running setup.py install for moztest 17:37:05 INFO - Running setup.py install for mozversion 17:37:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:37:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:37:05 INFO - Cleaning up... 17:37:05 INFO - Return code: 0 17:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:37: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 17:37: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 17:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:05 INFO - 'HOME': '/Users/cltbld', 17:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:05 INFO - 'LOGNAME': 'cltbld', 17:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:05 INFO - 'MOZ_NO_REMOTE': '1', 17:37:05 INFO - 'NO_EM_RESTART': '1', 17:37:05 INFO - 'PAGER': '/bin/cat', 17:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:05 INFO - 'PWD': '/builds/slave/test', 17:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:05 INFO - 'SHELL': '/bin/bash', 17:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:37:05 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:05 INFO - 'USER': 'cltbld', 17:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:05 INFO - 'XPC_FLAGS': '0x0', 17:37:05 INFO - 'XPC_SERVICE_NAME': '0', 17:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-lgXCOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:06 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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-HoAQvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37: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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-oL6Zyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37: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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-nN0P_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37: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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-V5cPve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37: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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-hd5lS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37: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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-C_xQWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37: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)) 17:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:06 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-SOOzRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-awSySw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-_xpxAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Tn2SWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-yNyZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-FhwGv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-PJhL08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:07 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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-8sGRHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37: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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-n3zIje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37: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)) 17:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:07 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-95tYJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 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)) 17:37:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:11 INFO - Downloading blessings-1.6.tar.gz 17:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:37:11 INFO - Installing collected packages: blessings 17:37:11 INFO - Running setup.py install for blessings 17:37:11 INFO - Successfully installed blessings 17:37:11 INFO - Cleaning up... 17:37:11 INFO - Return code: 0 17:37:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:37:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:12 INFO - Reading from file tmpfile_stdout 17:37:12 INFO - Current package versions: 17:37:12 INFO - blessings == 1.6 17:37:12 INFO - blobuploader == 1.2.4 17:37:12 INFO - docopt == 0.6.1 17:37:12 INFO - manifestparser == 1.1 17:37:12 INFO - mozInstall == 1.12 17:37:12 INFO - mozcrash == 0.17 17:37:12 INFO - mozdebug == 0.1 17:37:12 INFO - mozdevice == 0.48 17:37:12 INFO - mozfile == 1.2 17:37:12 INFO - mozhttpd == 0.7 17:37:12 INFO - mozinfo == 0.9 17:37:12 INFO - mozleak == 0.1 17:37:12 INFO - mozlog == 3.1 17:37:12 INFO - moznetwork == 0.27 17:37:12 INFO - mozprocess == 0.22 17:37:12 INFO - mozprofile == 0.28 17:37:12 INFO - mozrunner == 6.11 17:37:12 INFO - mozscreenshot == 0.1 17:37:12 INFO - mozsystemmonitor == 0.0 17:37:12 INFO - moztest == 0.7 17:37:12 INFO - mozversion == 1.4 17:37:12 INFO - psutil == 3.1.1 17:37:12 INFO - requests == 1.2.3 17:37:12 INFO - wsgiref == 0.1.2 17:37:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:12 INFO - 'HOME': '/Users/cltbld', 17:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:12 INFO - 'LOGNAME': 'cltbld', 17:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:12 INFO - 'MOZ_NO_REMOTE': '1', 17:37:12 INFO - 'NO_EM_RESTART': '1', 17:37:12 INFO - 'PAGER': '/bin/cat', 17:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:12 INFO - 'PWD': '/builds/slave/test', 17:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:12 INFO - 'SHELL': '/bin/bash', 17:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:37:12 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:12 INFO - 'USER': 'cltbld', 17:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:12 INFO - 'XPC_FLAGS': '0x0', 17:37:12 INFO - 'XPC_SERVICE_NAME': '0', 17:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:37:12 INFO - Cleaning up... 17:37:12 INFO - Return code: 0 17:37:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:12 INFO - 'HOME': '/Users/cltbld', 17:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:12 INFO - 'LOGNAME': 'cltbld', 17:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:12 INFO - 'MOZ_NO_REMOTE': '1', 17:37:12 INFO - 'NO_EM_RESTART': '1', 17:37:12 INFO - 'PAGER': '/bin/cat', 17:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:12 INFO - 'PWD': '/builds/slave/test', 17:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:12 INFO - 'SHELL': '/bin/bash', 17:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:37:12 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:12 INFO - 'USER': 'cltbld', 17:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:12 INFO - 'XPC_FLAGS': '0x0', 17:37:12 INFO - 'XPC_SERVICE_NAME': '0', 17:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:12 INFO - Downloading/unpacking jsonschema 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:37:15 INFO - Downloading/unpacking functools32 (from jsonschema) 17:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:37:15 INFO - warning: no files found matching '*.txt' 17:37:15 INFO - no previously-included directories found matching 'build' 17:37:15 INFO - no previously-included directories found matching 'dist' 17:37:15 INFO - no previously-included directories found matching '.git*' 17:37:15 INFO - Installing collected packages: jsonschema, functools32 17:37:15 INFO - Running setup.py install for functools32 17:37:15 INFO - warning: no files found matching '*.txt' 17:37:15 INFO - no previously-included directories found matching 'build' 17:37:15 INFO - no previously-included directories found matching 'dist' 17:37:15 INFO - no previously-included directories found matching '.git*' 17:37:15 INFO - Successfully installed jsonschema functools32 17:37:15 INFO - Cleaning up... 17:37:15 INFO - Return code: 0 17:37:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10970ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097134c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f979bf006c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:15 INFO - 'HOME': '/Users/cltbld', 17:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:15 INFO - 'LOGNAME': 'cltbld', 17:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:15 INFO - 'MOZ_NO_REMOTE': '1', 17:37:15 INFO - 'NO_EM_RESTART': '1', 17:37:15 INFO - 'PAGER': '/bin/cat', 17:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:15 INFO - 'PWD': '/builds/slave/test', 17:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:15 INFO - 'SHELL': '/bin/bash', 17:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:37:15 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:15 INFO - 'USER': 'cltbld', 17:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:15 INFO - 'XPC_FLAGS': '0x0', 17:37:15 INFO - 'XPC_SERVICE_NAME': '0', 17:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:16 INFO - Downloading/unpacking flake8 17:37:16 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 17:37:16 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 17:37:16 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 17:37:16 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 17:37:16 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 17:37:16 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 17:37:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:37:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:37:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 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 17:37:18 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 17:37:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:37:19 INFO - no previously-included directories found matching 'docs/_build' 17:37:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:37:19 INFO - Running setup.py install for pep8 17:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:37:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:37:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:37:19 INFO - no previously-included directories found matching 'docs/_build' 17:37:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:37:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:37:20 INFO - Cleaning up... 17:37:20 INFO - Return code: 0 17:37:20 INFO - Running post-action listener: _resource_record_post_action 17:37:20 INFO - Running post-action listener: _start_resource_monitoring 17:37:20 INFO - Starting resource monitoring. 17:37:20 INFO - ##### 17:37:20 INFO - ##### Running install step. 17:37:20 INFO - ##### 17:37:20 INFO - Running pre-action listener: _resource_record_pre_action 17:37:20 INFO - Running main action method: install 17:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:20 INFO - Reading from file tmpfile_stdout 17:37:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:20 INFO - Reading from file tmpfile_stdout 17:37:20 INFO - Output received: 17:37:20 INFO - Usage: mozinstall [options] installer 17:37:20 INFO - Options: 17:37:20 INFO - -h, --help show this help message and exit 17:37:20 INFO - -d DEST, --destination=DEST 17:37:20 INFO - Directory to install application into. [default: 17:37:20 INFO - "/builds/slave/test"] 17:37:20 INFO - --app=APP Application being installed. [default: firefox] 17:37:20 INFO - mkdir: /builds/slave/test/build/application 17:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 17:37:43 INFO - Reading from file tmpfile_stdout 17:37:43 INFO - Output received: 17:37:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:37:43 INFO - Running post-action listener: _resource_record_post_action 17:37:43 INFO - ##### 17:37:43 INFO - ##### Running run-tests step. 17:37:43 INFO - ##### 17:37:43 INFO - Running pre-action listener: _resource_record_pre_action 17:37:43 INFO - Running main action method: run_tests 17:37:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:43 INFO - 2016-05-17 17:37:43.157 screenresolution[1940:11477] starting screenresolution argv=screenresolution get 17:37:43 INFO - 2016-05-17 17:37:43.160 screenresolution[1940:11477] Display 0: 1600x1200x32@60 17:37:43 INFO - 2016-05-17 17:37:43.166 screenresolution[1941:11480] starting screenresolution argv=screenresolution list 17:37:43 INFO - Available Modes on Display 0 17:37:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:43 INFO - Intel Iris: 17:37:43 INFO - Chipset Model: Intel Iris 17:37:43 INFO - Type: GPU 17:37:43 INFO - Bus: Built-In 17:37:43 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:43 INFO - Vendor: Intel (0x8086) 17:37:43 INFO - Device ID: 0x0a2e 17:37:43 INFO - Revision ID: 0x0009 17:37:43 INFO - Displays: 17:37:43 INFO - Display: 17:37:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:43 INFO - Display Serial Number: 1600x1200 60 17:37:43 INFO - Main Display: Yes 17:37:43 INFO - Mirror: Off 17:37:43 INFO - Online: Yes 17:37:43 INFO - Rotation: Supported 17:37:43 INFO - Return code: 0 17:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:43 INFO - Python 2.7.3 17:37:43 INFO - Return code: 0 17:37:43 INFO - grabbing minidump binary from tooltool 17:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:43 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095b0d30>, '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 0x109414db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095a7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:43 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:37:43 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:37:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:43 INFO - Return code: 0 17:37:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:37:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:37:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:37:44 INFO - Return code: 0 17:37:44 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.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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 17:37:44 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.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --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 17:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zEEJBf9S9b/Render', 17:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:44 INFO - 'HOME': '/Users/cltbld', 17:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:44 INFO - 'LOGNAME': 'cltbld', 17:37:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:44 INFO - 'MOZ_NO_REMOTE': '1', 17:37:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:44 INFO - 'NO_EM_RESTART': '1', 17:37:44 INFO - 'PAGER': '/bin/cat', 17:37:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:44 INFO - 'PWD': '/builds/slave/test', 17:37:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:44 INFO - 'SHELL': '/bin/bash', 17:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners', 17:37:44 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 17:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:44 INFO - 'USER': 'cltbld', 17:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:44 INFO - 'XPC_FLAGS': '0x0', 17:37:44 INFO - 'XPC_SERVICE_NAME': '0', 17:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:44 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.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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 17:37:44 INFO - mozversion application_buildid: 20160517161854 17:37:44 INFO - mozversion application_changeset: 63933fe5bb3f0148c2c276a941f8baa92acf4987 17:37:44 INFO - mozversion application_display_name: Firefox 17:37:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:44 INFO - mozversion application_name: Firefox 17:37:44 INFO - mozversion application_remotingname: firefox 17:37:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:37:44 INFO - mozversion application_vendor: Mozilla 17:37:44 INFO - mozversion application_version: 47.0 17:37:44 INFO - mozversion platform_buildid: 20160517161854 17:37:44 INFO - mozversion platform_changeset: 63933fe5bb3f0148c2c276a941f8baa92acf4987 17:37:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:37:44 INFO - mozversion platform_version: 47.0 17:37:44 INFO - using testdate: 1463531864 17:37:44 INFO - actual date: 1463531864 17:37:44 INFO - starting webserver on 'localhost:49676' 17:37:44 INFO - SUITE-START | Running 2 tests 17:37:44 INFO - TEST-START | dromaeo_css 17:37:44 INFO - operating with platform_type : mac_ 17:37:44 INFO - Initialising browser for dromaeo_css test... 17:37:44 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpTBJv4Q/profile http://localhost:49676/getInfo.html) 17:37:47 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 17:37:47 INFO - PROCESS | 1959 | colorDepth:24 17:37:47 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 17:37:47 INFO - PROCESS | 1959 | __metrics 17:37:47 INFO - PROCESS | 1959 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:37:47 INFO - PROCESS | 1959 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:47 INFO - TEST-INFO | 1959: exit 0 17:37:47 INFO - Browser initialized. 17:37:47 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:47 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpTBJv4Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:59 INFO - PROCESS | 1962 | RSS: Main: 156778496 17:37:59 INFO - PROCESS | 1962 | 17:38:50 INFO - PROCESS | 1962 | 1463531930188 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] 17:41:00 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:49676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49676/tests/dromaeo/cssquery-ext.html) 17:41:01 INFO - PROCESS | 1962 | RSS: Main: 278622208 17:41:01 INFO - PROCESS | 1962 | 17:44:03 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:49676/tests/dromaeo/cssquery-ext.html (next: http://localhost:49676/tests/dromaeo/cssquery-jquery.html) 17:44:04 INFO - PROCESS | 1962 | RSS: Main: 290054144 17:44:04 INFO - PROCESS | 1962 | 17:47:06 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:49676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49676/tests/dromaeo/cssquery-mootools.html) 17:47:06 INFO - PROCESS | 1962 | RSS: Main: 296288256 17:47:06 INFO - PROCESS | 1962 | 17:50:08 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:49676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49676/tests/dromaeo/cssquery-prototype.html) 17:50:09 INFO - PROCESS | 1962 | RSS: Main: 252243968 17:50:09 INFO - PROCESS | 1962 | 17:53:12 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:49676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49676/tests/dromaeo/cssquery-yui.html) 17:53:12 INFO - PROCESS | 1962 | RSS: Main: 255467520 17:53:12 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:49676/tests/dromaeo/cssquery-yui.html (next: http://localhost:49676/tests/dromaeo/cssquery-dojo.html) 17:56:15 INFO - PROCESS | 1962 | RSS: Main: 301408256 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | __start_tp_report 17:56:15 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 17:56:15 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 17:56:15 INFO - PROCESS | 1962 | |i|pagename|runs| 17:56:15 INFO - PROCESS | 1962 | |0;dojo.html;3075.0006247969386;3543.6633519815614;3629.219717760681;3640.5449318835135;3698.7225958053154;5880.088586269135;5908.497777688896;5910.852228694284;5918.615290006147;5921.88156236875;5881.411858814116;5920.733566989485;5928.02187639039;5929.822105336847;5957.791477298296;5248.632595718302;5279.2872962150195;5321.574274058085;5328.946710532884;5380.408155102936;5382.838514844541;5396.43337449568;5400.270963419947;5400.513953744162;5403.918941215885;5329.706866122362;5382.730863456831;5388.380336261341;5411.648242864201;5421.186821976716;5408.4050754416985;5413.106837371829;5436.592255580847;5452.591055670801;5500.862478438031;5146.408163061258;5328.92006619901;5333.919991200135;5360.839174824761;5373.194020896896;5756.33802112754;5815.970920145414;5833.7958171464215;5863.179154918314;5894.233749612523;6195.039768835838;6250.468710159642;6268.435840774307;6283.968580157116;6288.088227207029;6208.81373558794;6230.221222347207;6242.157308763304;6271.153394291758;6296.212973378328;5089.770960306758;6041.577089603729;6072.210612620331;6085.421884920926;6125.754969801247;6261.154744109578;6337.049442583557;6441.935580644227;6457.547971642034;6474.223093228843;6292.653904035231;6314.778982735582;6319.684015799192;6321.96839015802;6325.082862984841;6322.462590679844;6331.620102793847;6339.873202536016;6342.651154186564;6346.30190679025;5905.586608937333;6185.8144255672405;6202.131701561785;6270.059491076284;6289.276733175652;6222.28443728977;6263.342349053284;6266.091416744546;6286.151369565142;6291.716872740738;4962.082014827269;5000.524950129732;5008.57427118699;5011.674241174385;5025.7989680412375;4216.536181020086;4388.912221755547;4402.647788176938;4539.931901021488;4560.817567297271;6076.4531192192035;6084.330723620398;6087.026075827846;6095.207623009069;6108.144859719643;6304.243490781136;6311.526635502356;6326.557141000086;6339.587926784744;6343.048542718537;5917.763289468373;5957.553183511254;6008.549358798107;6066.848328791727;6079.148919151322;5474.616776825584;5499.917501237484;5503.394626591072;5512.448755124536;5515.200295957064;6484.870302593922;6521.771737989147;6542.509311801634;6546.18172728409;6550.934490655032;6185.41238582334;6257.749690012349;6310.716017779303;6313.589616674902;6355.682215889279;6543.738250469928;6574.76988305407;6576.44100251484;6583.210014798255;6588.176477940257;6136.028952951454;6265.655388953469;6280.497560195082;6293.339199383999;6309.242890853127;5489.725513724218;6229.2524897010835;6283.151774510383;6285.528585356208;6320.5575609706875;5590.916136258041;6272.843178920563;6279.811605651837;6281.905771413524;6284.465820405317;6123.663198524124;6207.36187120481;6216.689165541795;6279.748810047729;6307.873842523216;6172.69136543162;6230.43926046658;6232.688365581794;6235.189425374672;6236.03341482071;6281.214848143982;6282.717277722422;6299.905501417391;6306.873862522815;6309.873802523832;5990.910136348046;6062.060380640832;6120.326764056039;6220.440160385587;6229.314775374614 17:56:15 INFO - PROCESS | 1962 | |1;ext.html;476.397357342961;595.9154339102832;620.6555361774214;669.5237002409687;671.8276607320225;31450;39589.80205098974;39750.80124599373;39762.8011859941;39819.800900995455;42709.7864510677;43318.35022474665;43420.13159736803;43434.565654343445;43523.69428917138;9722.756931076708;9964.352317099401;9973.750656233617;9978.550965206547;9981.600735970553;9761.170300524464;9911.157551608121;9930.801383972317;9931.652392166276;9944.353617014907;9881.703548893545;10074.496275186248;10084.848727269096;10104.494775261244;10112.94943525285;9983.950080249624;10055.949720251425;10059.39643621385;10061.496925153713;10066.899331006669;9885.159761420287;10009.799804003878;10014.64948726791;10020;10024.749381265454;42242.577574224175;42543.57456425427;42759.57240427587;42834.57165428337;42858.35712464315;3227.1770698471973;3404.217030083095;3878.4376265441633;3883.4951456310782;3978.761274323521;28320.291992700142;29291.70708292911;29359.70640293591;29446.411071778657;29529.261768455744;2730.24918147509;2750.642416485864;2811.522041252992;2812.226637674635;2830.0943698016645;498221.9999999964;502411;504129;504130.4793476009;505572;67469.98795018079;67598.26812123104;67645;67675.66162169256;67817.66091169513;71920;81112;82155.5892220547;82391.5880420594;82477;19151.425457236306;19260.903695481433;19365.4190374289;19384.515387115152;19392.806071939383;14724.484643037442;14826.777598336033;14849.257537123101;14858;14875.107493550422;22887.313380598607;23217.883910580676;23253.883730581238;23263;23306;7953;8905.040891004099;9047.869016372953;9152.54237288133;9241.584128714225;894.6555576103248;1029.4286670897723;1034.9482525873675;1049.7165765243342;1156.410230782307;30286;30508.389832203677;30652.540211896838;31433;31495.527567086512;1159.3336819302376;1161.703765539799;1211.4185191108318;1275.2603489975793;1324.8410190777167;15674.529764107096;15752.92123539375;15933.760993585105;15943.920280398524;16230.675386492205;567822;572272;573081;574954;575240;62018.37981620126;62512;62576.374236257965;62628.37371626226;62790.74418511604;1423.7864320351823;1443.603009172465;1495.6186172525936;1543.8224604170439;1566.4125952767483;24773.876130619232;29702.257443564085;29762.404751904407;30141.945031923777;30423.239419014702;31218.843905780326;44893.326600101675;45024.54975450334;45816.312755308034;48901.75549122231;379590;380615;380762;381520;381943;30312.69687303099;34828.477572836935;35393.46909796304;35515.75694850668;35969.100772480895;43522;44425.77787111044;44693.329600055375;44779.776101119285;45508.54491455043;34923.65076349204;36318.72884449032;36502.26995460129;36569.45145822868;37445;36327.27345453129;36525.63474365223;36826.81586592157;36982;37102.814485927396;36932.44601330929;37468.43797342988;37758.81120594379;38558;38798;31169.688303117586;32863.342733145684;33979.66020339864;34096;34117;23211.535769284183;25224.74775252224;25366.239012829643;25454.363640909127;25778.09776657808 17:56:15 INFO - PROCESS | 1962 | |2;jquery.html;379.78352339166673;381.8472610955616;383.1819066293464;389.27594673906526;390.6113417149936;19640.60718785625;21085.578288434222;21247.15011399546;21312.93435328235;21346;22159.667604985938;22227.110915563357;22464.663030054562;22501.54996900061;22518.54962900741;5753.597248192628;5813.825585232428;6075.66583837891;6080.209572755558;6083.939160608404;5881.794137205177;5965.940340596582;5978.342382337939;6001.909971350433;6004.909926351086;5747.511461525754;5931.051031834907;5934.97032514839;5942.435468630495;6022.909656355137;5804.854878628026;5941.732622032019;5953.404659534055;6002.579819412643;6024.337322894478;5925.081612350093;5926.822195334147;5926.940730592682;5947.197128387699;5961.970190149065;14318.71362572753;14469.34887930035;19867;25992.09027684041;27122.64386780653;2188.5723405953167;2213.435573928654;2236.4520692430297;2347.460084180631;2708.756211940935;10002.199824014135;10098.29311948164;10167.288289819715;10680.14558835299;10758.515866786014;1800.9369672061414;1815.936442224529;1856.2574970011967;1887.2733997410958;1959.5688948431323;113040;117661.23508147385;119099.8090019106;120842;121039.3948030263;11696.70758231034;11753.412329383496;11773.88226117745;11793.88206117945;11799.469023893773;12285.75428491443;14574.781378279335;14643.85356146425;14644.707105858037;14654.413823447156;7420.5547667140145;9065.093490651014;9086.772830679154;9132.634694612274;9201.585928633227;9247.306452016126;9262.67580634688;9264.378733721573;9267.72196834096;9372.015938326515;3937.055106774411;4587.288970209623;4589.33454649074;4600.148972440109;4606.470255920612;1916.1664675866043;1968.8031196880197;1976.436715536094;2000.3598848368674;2001.039501039509;862.5514732339149;901.8511945529045;943.6555657185078;951.5908159491485;986.9259805514615;19546.51133721668;20460.48848778763;20470.874101924535;20482.180712771322;20963.79036209649;969.6703120938914;974.0757405695163;987.3039507147444;1012.6455740490917;1028.8662473878499;8661.566921654017;11118.722031949266;11239.381833999209;11253.774924501464;11254.831177532344;687046;688365;700502;703846;710967.4451627709;82524;113003.30495042581;114928;115531.11761976374;122445;995.4127065031666;1012.832882574367;1024.533837104116;1027.3938376357985;1030.7989941961396;17720.291188352323;18058.916465012142;18348.816511835244;18356.541086472946;18540.907295463436;50899;51379.48620513747;51481.48518514767;51484.712882178246;51645.22532162096;75317.6234118826;75377.86933195897;76118.61940690261;76192;78449.21550784419;8023.719169829028;8075.959620201861;8163.83672326562;8307.460015098999;8356.6239519223;9392.483413412328;11931.582394616147;12624.74750505003;13022.4139913706;13537.052406331462;11214.271072380268;11490.310581365145;11798.410079496163;11807.881921181022;11883.643490695293;9356.345055846297;11152;11536.769264614828;11583.247088939192;11723.41382930833;11523.250988685708;11679.941600292284;11797.764044718886;11931.164818462625;12128.332941688292;8092.514449133071;8190.549519776231;8240.464369815943;8261.215184557457;8301.875471867806;8820.29437644974;11217.149170386794;11394.430278486208;11487.597934072268;11850.111241657083 17:56:15 INFO - PROCESS | 1962 | |3;mootools.html;1514.401811284542;1640.7538869169625;1661.8421249981254;2009.9899500502495;2083.1354987680106;8399.622017009235;8984.595693193805;9139.36024478285;9140.451572905631;9140.954295228532;8806;9076;9082.90917090829;9087.863682044775;9093.681721139745;2561.679790026247;2579.21333993132;2580.2775222937607;2583.534963706532;2586.379268975451;2512.5477414065463;2586.3921978335075;2588.534063868503;2590.4819036192835;2617.9869100654564;2569.0622922633197;2583.6253743207226;2605.7394260573888;2610.673665791776;2612.05965852293;2208.6466165413617;2567.473667898076;2577.6777902762155;2589.7539733725266;2609.1389841352307;2560.129555950986;2592.4815036992677;2598.428345763929;2607.191770551135;2614.503244383561;9114.361994660376;9166;9185.954070229605;9194.402363846395;9210;5659.943400565983;5758.337791154029;5762.798302059407;5807.925533776265;5809.099589563624;3647.58052823926;3760.5863355030924;3808.428735689641;3818.16000479894;3824.1778017726324;1065.7016035510069;1083.8753543342539;1085.0885256384674;1095.6001059613263;1122.5004872831594;12487.063470239678;12499.625011249676;12510.74978500434;12511.311877846714;12575.559855405018;4986.825461108916;5044.394672639307;5105.387353517527;5129.692218466904;5160.432352441228;9812.871519775175;10396.324238924446;10409.895901041044;10427.5828966842;10434.478276086165;5370.113931201387;5767.250257466587;5811.4479124483105;5815.621984570989;5829.446202610745;4712.010477799632;4743.217369134054;4772.522747725269;4781.976090119527;5246.239295302236;4078.5921407858978;4095.832687684055;4168.6665066794585;4173;4188.81150348235;1349.8515163332027;1372.663697394125;1374.793780932848;1385;1385.9445622175201;1428.9142651440948;1445.3206992713408;1452.7094581083825;1466.5893549806071;1480.9333579988927;8567.228949394459;8634.913650863537;8637.222649961534;8640.481571105627;8656.307495400353;533.6504589493887;540.351578106274;548.366636534803;552.3565046720606;554.9833504994857;6414.8717025659225;6452.451541619015;6503.2521260054755;6519.989401642753;6532.804015879531;10652.520636571218;11016.06363459099;11187.440627968568;11209.887901121048;11401.258918170292;10442.947785261025;10764.192685548614;11148.163887708291;11190.776184476264;11243.494042768096;8479.109693482218;8692.217700406994;8701.956490217635;8709.390342676079;8711.303095752324;8380.12008739098;8385.28725058377;8438;8481.745547633582;8529.402941794015;9665.226781857295;9814.65648702292;9868.013198680075;9948.005199479994;10114.79770404573;10197.490125493547;10292.639757608447;10593.099586534923;10604;10616.469176541297;7143.142822861082;7326.743563975236;7739.110002349802;7873.960630197042;7932.6033698316005;8011.479253848481;8095.502332068586;8326.45878017927;8527.829443411221;8583.141685831368;7492.1384040836;7595.886061708969;7612.3910087194;7712.537247765152;7757.340626046849;7335.559866408033;7363.521371111075;7410.073740782403;7455.142658594331;7458.701651933862;7957.641906114123;7965.761027169194;8008.599570021592;8010.919890801018;8023.037235531773;7144.714211431485;7282.96358518204;7293.489455738048;7350.338469537767;7356.44826638015;7400.740974065882;7401.33387995083;7476.887846682413;7477;7477.214892436215 17:56:15 INFO - PROCESS | 1962 | |4;prototype.html;335.8253708071802;340.08177919617026;347.9043263102647;348.25299732074717;354.7339495378466;6636.270010298869;6674;6698.832529186767;6712.731490740377;6715.42918851897;6655.035019922108;6660.267370589243;6672.165979252593;6682.031105489701;6686.598804071759;4339.891502712426;4657.534246575349;4852.611791056707;4866.294387313837;4876.439209490918;4872.7563621818945;4876.097921884445;4936.778449697633;4944.728039957801;4993.450720420751;4867.51324867514;4877.170880950247;4908.631852611051;4910.75446227689;4911.887888208069;4169.520505141917;4866.807632130115;4937.925931111036;4964.677295975786;4967.950320496785;4070.5522392536795;4160.5007399112;4264.48826140862;4274.5939135782055;4276.3157894737005;6185.257769067695;6201.937980620181;6250.874982500324;6305.612765191697;6368.840778980516;5822.184894114827;5827.679477628729;5834.474897259267;5838;5848.853778655525;7020.052292940439;7027.156741191038;7029.718811247595;7030.4727145463785;7035.577865328046;4591.8979444932975;4754.595859351959;4771.093492236464;4787.8563643090765;4790.664653474259;6615.239247486553;7075.0448689426785;7331.486795924234;7338.669759860819;7397.593132377717;4883.340748998839;4894.241392584155;4894.828680996148;4901.9019619608125;4903.41159060915;4980.5019498049905;4985.302057711923;4988.925166122439;4990.675606085665;5000.999800040006;5832.212651292021;5833.125031245262;5836.328822185418;5843.094320380348;5845.064789633639;6729.798106056826;6993.195782484978;7039.718411263594;7041.3310735480045;7051.964740176369;1710.4013595241565;1713.126305584161;1728.3777839977597;1734.1502663694698;1741.1120328632235;1130.2483848240827;1130.2483848240993;1151.4818331750746;1154.417019405195;1161.0421402343102;6415.582987105823;6577.6711164441585;6658;6659.600423974577;6729.49528785343;7354.338109570057;7360.07999000125;7362.558246505227;7374.262573742582;7380.151282602462;6656.36764507371;6690.197176338773;6692.933070669328;6707.195136583641;6711.161104861892;3846;3877.747946383476;3879.553851307079;3880.0299925018744;3896.7661940283674;6275.937240627627;7397.445191610651;7680.577568233689;7746.535207887432;7753.728619498291;7536.057992750906;7591.810204744926;7607.239276072349;7620.847583048308;7625.618719064025;7708.229177082247;7711.151773304932;7715.1899050600005;7718.073831140075;7731.304182623591;7380.96309518449;7381;7383.630818459163;7387.150477695134;7396.55620662762;7034.413208121744;7172.031775710212;7239.058922340273;7267.709291628275;7287.161976372573;6966.79099627012;7087.893681594884;7724.92275077242;7749.690012399441;7774.533527988338;4629.791659375269;4682.1103990241745;4684.437867455791;4691.765411729468;4693.788779504862;7299.5620262784405;7305.817354566178;7311.853762924606;7313.232110628307;7319.926800731924;6860.279670634512;7085.716571337089;7129.394001509722;7148.785536433916;7156.856862862818;7095.609741464269;7137.892931606134;7153.570785752871;7160.641967901688;7163.964180179274;6984.371406573433;6991.370776630128;6992.510524263253;6994.790156295319;7004.299570042955;6838.589684618939;7136.179339375831;7150.356467917913;7150.892736609059;7158.284171583008;6737.629430381376;6835.213950395768;6990.685419156049;7000.824979375557;7000.964995174992 17:56:15 INFO - PROCESS | 1962 | |5;yui.html;639.3957709964083;722.9783106506804;766.6933226709316;802.8916096326994;835.3025223938012;15301.2349382531;15647.295871685774;15660.216989150555;15676.921615391935;15704.371825126995;14385.064970776892;14487.348069336878;14505.274736263198;14507.492237771654;16344.264508097134;975.1905918088005;982.8378317577591;992.4194346307419;994.4878387630376;994.5623925472805;992.3500107429645;995.2336700740426;996.3424140067557;998.0817647764038;1000.8548760429734;1039.230969082877;1042.280826229899;1043.2957753516384;1043.7547176413536;1044.2742294105599;1035.880873699519;1038.3717850700332;1039.4490919812436;1040.4381633917712;1042.7601651620132;758.4387553210639;760.4866714967375;760.7983884270673;761.1741260732113;761.7333933123418;13015.544455944091;15689.215539223107;15729.528114156594;15730.056196628238;15740;12527.060470464752;12781.552645657357;12903.677268115192;13130.343482825916;13147.276899770604;10172.898271017342;10228;10304;10579.259451838374;10613.734656633645;3547.5388199534154;3560.661737134994;3607.603163651996;3666.7249956253386;3808.219315040438;63859;74931.25068749297;81524.59237703832;82837;82978;9840.901590984142;9880.308378413441;9913.30606857513;9943.701688949342;9994.350367226107;22227.66658500124;22269.888650556968;22275.443113922283;22285.777142228693;22357.888210558842;7692.499987500794;7712.807179820549;7836.882446763303;7997.600119994094;8066.395020373496;4188.748675079505;4250.766207858597;4273.1240095780295;4312.029793296483;4575.2450845610765;3588.3720348939355;3646.890593282206;3651.707863370924;3652.1052342176336;3668.4680721295795;639.1563136659564;648.3548868875499;651.5211319680031;652.9477641788741;655.1319501660224;622.4056026494686;623.554158776477;626.9090981807612;639.8112556795757;660.1846719301659;7446.404287656975;8151.592420378957;8910.955445222733;8924.955375223082;9069;531.3358302122347;577.9566532510079;595.2767387624058;609.0498821837947;618.8669436071266;3915.8629447969756;3979.323515002399;4040.959590404117;4125.938110928339;4160.646345060703;89986.55006725056;91488;93891;94546.0545394551;95677.52161239149;68936.62126757538;79150;79248;79562;81507;68631.999999999;70871.64564177147;71859;73763;74148.18036827589;8663.960324760817;8738.519381434082;8857.955710221666;8885.333599980157;8939.910600893907;40090.79954600208;50525.49474505208;50565.74717126391;51262.97474050573;51477.48522514727;67598;69671.65164174147;70868.64565677139;71391.28608714054;71628.28371716216;11206.719832004264;11252.26860254081;11602.825957610812;11641.301521908712;11657.183997120459;11974.58088966882;12142.210756300812;12201.633950981484;12238;12394.194377365442;11608.12939029593;11777.646670599896;11995.700107497383;11995.76008479843;12208.572699955459;9887.604495820375;11924.701882453008;11930.284182949052;11972.221805582609;12018.939905300418;11400.48697808584;11425.714357141138;11561.710957226136;11562.94218528902;12357.949574286285;9926.900730992598;9968.551415186479;10146.543405546621;10204.285700000928;10265.794684106128;8581.35639827003;9862.950685246527;9962.50187490608;10119.645812396531;10131.037551432602 17:56:15 INFO - PROCESS | 1962 | __end_tp_report 17:56:15 INFO - PROCESS | 1962 | __start_cc_report 17:56:15 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,1047 17:56:15 INFO - PROCESS | 1962 | __end_cc_report 17:56:15 INFO - PROCESS | 1962 | __startTimestamp1463532975549__endTimestamp 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | ------- Summary: start ------- 17:56:15 INFO - PROCESS | 1962 | Number of tests: 6 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | [#0] dojo.html Cycles:165 Average:5879.48 Median:6136.03 stddev:645.19 (10.5%) stddev-sans-first:608.50 17:56:15 INFO - PROCESS | 1962 | Values: 3075.0 3543.7 3629.2 3640.5 3698.7 5880.1 5908.5 5910.9 5918.6 5921.9 5881.4 5920.7 5928.0 5929.8 5957.8 5248.6 5279.3 5321.6 5328.9 5380.4 5382.8 5396.4 5400.3 5400.5 5403.9 5329.7 5382.7 5388.4 5411.6 5421.2 5408.4 5413.1 5436.6 5452.6 5500.9 5146.4 5328.9 5333.9 5360.8 5373.2 5756.3 5816.0 5833.8 5863.2 5894.2 6195.0 6250.5 6268.4 6284.0 6288.1 6208.8 6230.2 6242.2 6271.2 6296.2 5089.8 6041.6 6072.2 6085.4 6125.8 6261.2 6337.0 6441.9 6457.5 6474.2 6292.7 6314.8 6319.7 6322.0 6325.1 6322.5 6331.6 6339.9 6342.7 6346.3 5905.6 6185.8 6202.1 6270.1 6289.3 6222.3 6263.3 6266.1 6286.2 6291.7 4962.1 5000.5 5008.6 5011.7 5025.8 4216.5 4388.9 4402.6 4539.9 4560.8 6076.5 6084.3 6087.0 6095.2 6108.1 6304.2 6311.5 6326.6 6339.6 6343.0 5917.8 5957.6 6008.5 6066.8 6079.1 5474.6 5499.9 5503.4 5512.4 5515.2 6484.9 6521.8 6542.5 6546.2 6550.9 6185.4 6257.7 6310.7 6313.6 6355.7 6543.7 6574.8 6576.4 6583.2 6588.2 6136.0 6265.7 6280.5 6293.3 6309.2 5489.7 6229.3 6283.2 6285.5 6320.6 5590.9 6272.8 6279.8 6281.9 6284.5 6123.7 6207.4 6216.7 6279.7 6307.9 6172.7 6230.4 6232.7 6235.2 6236.0 6281.2 6282.7 6299.9 6306.9 6309.9 5990.9 6062.1 6120.3 6220.4 6229.3 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | [#1] ext.html Cycles:180 Average:64274.48 Median:36698.13 stddev:130836.53 (356.5%) stddev-sans-first:131115.88 17:56:15 INFO - PROCESS | 1962 | Values: 476.4 595.9 620.7 669.5 671.8 31450.0 39589.8 39750.8 39762.8 39819.8 42709.8 43318.4 43420.1 43434.6 43523.7 9722.8 9964.4 9973.8 9978.6 9981.6 9761.2 9911.2 9930.8 9931.7 9944.4 9881.7 10074.5 10084.8 10104.5 10112.9 9984.0 10055.9 10059.4 10061.5 10066.9 9885.2 10009.8 10014.6 10020.0 10024.7 42242.6 42543.6 42759.6 42834.6 42858.4 3227.2 3404.2 3878.4 3883.5 3978.8 28320.3 29291.7 29359.7 29446.4 29529.3 2730.2 2750.6 2811.5 2812.2 2830.1 498222.0 502411.0 504129.0 504130.5 505572.0 67470.0 67598.3 67645.0 67675.7 67817.7 71920.0 81112.0 82155.6 82391.6 82477.0 19151.4 19260.9 19365.4 19384.5 19392.8 14724.5 14826.8 14849.3 14858.0 14875.1 22887.3 23217.9 23253.9 23263.0 23306.0 7953.0 8905.0 9047.9 9152.5 9241.6 894.7 1029.4 1034.9 1049.7 1156.4 30286.0 30508.4 30652.5 31433.0 31495.5 1159.3 1161.7 1211.4 1275.3 1324.8 15674.5 15752.9 15933.8 15943.9 16230.7 567822.0 572272.0 573081.0 574954.0 575240.0 62018.4 62512.0 62576.4 62628.4 62790.7 1423.8 1443.6 1495.6 1543.8 1566.4 24773.9 29702.3 29762.4 30141.9 30423.2 31218.8 44893.3 45024.5 45816.3 48901.8 379590.0 380615.0 380762.0 381520.0 381943.0 30312.7 34828.5 35393.5 35515.8 35969.1 43522.0 44425.8 44693.3 44779.8 45508.5 34923.7 36318.7 36502.3 36569.5 37445.0 36327.3 36525.6 36826.8 36982.0 37102.8 36932.4 37468.4 37758.8 38558.0 38798.0 31169.7 32863.3 33979.7 34096.0 34117.0 23211.5 25224.7 25366.2 25454.4 25778.1 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | [#2] jquery.html Cycles:180 Average:37188.61 Median:22510.05 stddev:115341.91 (512.4%) stddev-sans-first:115632.35 17:56:15 INFO - PROCESS | 1962 | Values: 379.8 381.8 383.2 389.3 390.6 19640.6 21085.6 21247.2 21312.9 21346.0 22159.7 22227.1 22464.7 22501.5 22518.5 5753.6 5813.8 6075.7 6080.2 6083.9 5881.8 5965.9 5978.3 6001.9 6004.9 5747.5 5931.1 5935.0 5942.4 6022.9 5804.9 5941.7 5953.4 6002.6 6024.3 5925.1 5926.8 5926.9 5947.2 5962.0 14318.7 14469.3 19867.0 25992.1 27122.6 2188.6 2213.4 2236.5 2347.5 2708.8 10002.2 10098.3 10167.3 10680.1 10758.5 1800.9 1815.9 1856.3 1887.3 1959.6 113040.0 117661.2 119099.8 120842.0 121039.4 11696.7 11753.4 11773.9 11793.9 11799.5 12285.8 14574.8 14643.9 14644.7 14654.4 7420.6 9065.1 9086.8 9132.6 9201.6 9247.3 9262.7 9264.4 9267.7 9372.0 3937.1 4587.3 4589.3 4600.1 4606.5 1916.2 1968.8 1976.4 2000.4 2001.0 862.6 901.9 943.7 951.6 986.9 19546.5 20460.5 20470.9 20482.2 20963.8 969.7 974.1 987.3 1012.6 1028.9 8661.6 11118.7 11239.4 11253.8 11254.8 687046.0 688365.0 700502.0 703846.0 710967.4 82524.0 113003.3 114928.0 115531.1 122445.0 995.4 1012.8 1024.5 1027.4 1030.8 17720.3 18058.9 18348.8 18356.5 18540.9 50899.0 51379.5 51481.5 51484.7 51645.2 75317.6 75377.9 76118.6 76192.0 78449.2 8023.7 8076.0 8163.8 8307.5 8356.6 9392.5 11931.6 12624.7 13022.4 13537.1 11214.3 11490.3 11798.4 11807.9 11883.6 9356.3 11152.0 11536.8 11583.2 11723.4 11523.3 11679.9 11797.8 11931.2 12128.3 8092.5 8190.5 8240.5 8261.2 8301.9 8820.3 11217.1 11394.4 11487.6 11850.1 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | [#3] mootools.html Cycles:180 Average:6297.08 Median:2951.88 stddev:3324.17 (112.6%) stddev-sans-first:3314.06 17:56:15 INFO - PROCESS | 1962 | Values: 1514.4 1640.8 1661.8 2010.0 2083.1 8399.6 8984.6 9139.4 9140.5 9141.0 8806.0 9076.0 9082.9 9087.9 9093.7 2561.7 2579.2 2580.3 2583.5 2586.4 2512.5 2586.4 2588.5 2590.5 2618.0 2569.1 2583.6 2605.7 2610.7 2612.1 2208.6 2567.5 2577.7 2589.8 2609.1 2560.1 2592.5 2598.4 2607.2 2614.5 9114.4 9166.0 9186.0 9194.4 9210.0 5659.9 5758.3 5762.8 5807.9 5809.1 3647.6 3760.6 3808.4 3818.2 3824.2 1065.7 1083.9 1085.1 1095.6 1122.5 12487.1 12499.6 12510.7 12511.3 12575.6 4986.8 5044.4 5105.4 5129.7 5160.4 9812.9 10396.3 10409.9 10427.6 10434.5 5370.1 5767.3 5811.4 5815.6 5829.4 4712.0 4743.2 4772.5 4782.0 5246.2 4078.6 4095.8 4168.7 4173.0 4188.8 1349.9 1372.7 1374.8 1385.0 1385.9 1428.9 1445.3 1452.7 1466.6 1480.9 8567.2 8634.9 8637.2 8640.5 8656.3 533.7 540.4 548.4 552.4 555.0 6414.9 6452.5 6503.3 6520.0 6532.8 10652.5 11016.1 11187.4 11209.9 11401.3 10442.9 10764.2 11148.2 11190.8 11243.5 8479.1 8692.2 8702.0 8709.4 8711.3 8380.1 8385.3 8438.0 8481.7 8529.4 9665.2 9814.7 9868.0 9948.0 10114.8 10197.5 10292.6 10593.1 10604.0 10616.5 7143.1 7326.7 7739.1 7874.0 7932.6 8011.5 8095.5 8326.5 8527.8 8583.1 7492.1 7595.9 7612.4 7712.5 7757.3 7335.6 7363.5 7410.1 7455.1 7458.7 7957.6 7965.8 8008.6 8010.9 8023.0 7144.7 7283.0 7293.5 7350.3 7356.4 7400.7 7401.3 7476.9 7477.0 7477.2 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | [#4] prototype.html Cycles:180 Average:5841.26 Median:6673.08 stddev:1827.88 (27.4%) stddev-sans-first:1785.69 17:56:15 INFO - PROCESS | 1962 | Values: 335.8 340.1 347.9 348.3 354.7 6636.3 6674.0 6698.8 6712.7 6715.4 6655.0 6660.3 6672.2 6682.0 6686.6 4339.9 4657.5 4852.6 4866.3 4876.4 4872.8 4876.1 4936.8 4944.7 4993.5 4867.5 4877.2 4908.6 4910.8 4911.9 4169.5 4866.8 4937.9 4964.7 4968.0 4070.6 4160.5 4264.5 4274.6 4276.3 6185.3 6201.9 6250.9 6305.6 6368.8 5822.2 5827.7 5834.5 5838.0 5848.9 7020.1 7027.2 7029.7 7030.5 7035.6 4591.9 4754.6 4771.1 4787.9 4790.7 6615.2 7075.0 7331.5 7338.7 7397.6 4883.3 4894.2 4894.8 4901.9 4903.4 4980.5 4985.3 4988.9 4990.7 5001.0 5832.2 5833.1 5836.3 5843.1 5845.1 6729.8 6993.2 7039.7 7041.3 7052.0 1710.4 1713.1 1728.4 1734.2 1741.1 1130.2 1130.2 1151.5 1154.4 1161.0 6415.6 6577.7 6658.0 6659.6 6729.5 7354.3 7360.1 7362.6 7374.3 7380.2 6656.4 6690.2 6692.9 6707.2 6711.2 3846.0 3877.7 3879.6 3880.0 3896.8 6275.9 7397.4 7680.6 7746.5 7753.7 7536.1 7591.8 7607.2 7620.8 7625.6 7708.2 7711.2 7715.2 7718.1 7731.3 7381.0 7381.0 7383.6 7387.2 7396.6 7034.4 7172.0 7239.1 7267.7 7287.2 6966.8 7087.9 7724.9 7749.7 7774.5 4629.8 4682.1 4684.4 4691.8 4693.8 7299.6 7305.8 7311.9 7313.2 7319.9 6860.3 7085.7 7129.4 7148.8 7156.9 7095.6 7137.9 7153.6 7160.6 7164.0 6984.4 6991.4 6992.5 6994.8 7004.3 6838.6 7136.2 7150.4 7150.9 7158.3 6737.6 6835.2 6990.7 7000.8 7001.0 17:56:15 INFO - PROCESS | 1962 | 17:56:15 INFO - PROCESS | 1962 | [#5] yui.html Cycles:180 Average:18524.76 Median:27550.37 stddev:25690.57 (93.2%) stddev-sans-first:25727.54 17:56:15 INFO - PROCESS | 1962 | Values: 639.4 723.0 766.7 802.9 835.3 15301.2 15647.3 15660.2 15676.9 15704.4 14385.1 14487.3 14505.3 14507.5 16344.3 975.2 982.8 992.4 994.5 994.6 992.4 995.2 996.3 998.1 1000.9 1039.2 1042.3 1043.3 1043.8 1044.3 1035.9 1038.4 1039.4 1040.4 1042.8 758.4 760.5 760.8 761.2 761.7 13015.5 15689.2 15729.5 15730.1 15740.0 12527.1 12781.6 12903.7 13130.3 13147.3 10172.9 10228.0 10304.0 10579.3 10613.7 3547.5 3560.7 3607.6 3666.7 3808.2 63859.0 74931.3 81524.6 82837.0 82978.0 9840.9 9880.3 9913.3 9943.7 9994.4 22227.7 22269.9 22275.4 22285.8 22357.9 7692.5 7712.8 7836.9 7997.6 8066.4 4188.7 4250.8 4273.1 4312.0 4575.2 3588.4 3646.9 3651.7 3652.1 3668.5 639.2 648.4 651.5 652.9 655.1 622.4 623.6 626.9 639.8 660.2 7446.4 8151.6 8911.0 8925.0 9069.0 531.3 578.0 595.3 609.0 618.9 3915.9 3979.3 4041.0 4125.9 4160.6 89986.6 91488.0 93891.0 94546.1 95677.5 68936.6 79150.0 79248.0 79562.0 81507.0 68632.0 70871.6 71859.0 73763.0 74148.2 8664.0 8738.5 8858.0 8885.3 8939.9 40090.8 50525.5 50565.7 51263.0 51477.5 67598.0 69671.7 70868.6 71391.3 71628.3 11206.7 11252.3 11602.8 11641.3 11657.2 11974.6 12142.2 12201.6 12238.0 12394.2 11608.1 11777.6 11995.7 11995.8 12208.6 9887.6 11924.7 11930.3 11972.2 12018.9 11400.5 11425.7 11561.7 11562.9 12357.9 9926.9 9968.6 10146.5 10204.3 10265.8 8581.4 9863.0 9962.5 10119.6 10131.0 17:56:15 INFO - PROCESS | 1962 | -------- Summary: end -------- 17:56:15 INFO - PROCESS | 1962 | 17:56:16 INFO - TEST-INFO | 1962: exit 0 17:56:16 INFO - TEST-OK | dromaeo_css | took 1111190ms 17:56:16 INFO - TEST-START | kraken 17:56:16 INFO - operating with platform_type : mac_ 17:56:16 INFO - Initialising browser for kraken test... 17:56:16 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpWivPyT/profile http://localhost:49676/getInfo.html) 17:56:18 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 17:56:18 INFO - PROCESS | 1965 | colorDepth:24 17:56:18 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 17:56:18 INFO - PROCESS | 1965 | __metrics 17:56:18 INFO - PROCESS | 1965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:56:18 INFO - PROCESS | 1965 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:56:18 INFO - TEST-INFO | 1965: exit 0 17:56:18 INFO - Browser initialized. 17:56:18 INFO - Running cycle 1/1 for kraken test... 17:56:18 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpWivPyT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:30 INFO - PROCESS | 1968 | RSS: Main: 156614656 17:56:30 INFO - PROCESS | 1968 | 17:56:33 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49676/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:34 INFO - PROCESS | 1968 | RSS: Main: 212791296 17:56:34 INFO - PROCESS | 1968 | 17:56:36 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49676/tests/kraken/driver.html?testName=audio-dft) 17:56:37 INFO - PROCESS | 1968 | RSS: Main: 222998528 17:56:37 INFO - PROCESS | 1968 | 17:56:40 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49676/tests/kraken/driver.html?testName=audio-fft) 17:56:41 INFO - PROCESS | 1968 | RSS: Main: 212373504 17:56:41 INFO - PROCESS | 1968 | 17:56:42 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49676/tests/kraken/driver.html?testName=audio-oscillator) 17:56:43 INFO - PROCESS | 1968 | RSS: Main: 214695936 17:56:43 INFO - PROCESS | 1968 | 17:56:45 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:46 INFO - PROCESS | 1968 | RSS: Main: 214331392 17:56:46 INFO - PROCESS | 1968 | 17:56:49 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49676/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:49 INFO - PROCESS | 1968 | RSS: Main: 214372352 17:56:49 INFO - PROCESS | 1968 | 17:56:52 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49676/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:53 INFO - PROCESS | 1968 | RSS: Main: 214515712 17:56:53 INFO - PROCESS | 1968 | 17:56:55 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49676/tests/kraken/driver.html?testName=json-parse-financial) 17:56:56 INFO - PROCESS | 1968 | RSS: Main: 214867968 17:56:56 INFO - PROCESS | 1968 | 17:56:57 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:58 INFO - PROCESS | 1968 | RSS: Main: 249483264 17:56:58 INFO - PROCESS | 1968 | 17:57:00 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:57:00 INFO - PROCESS | 1968 | RSS: Main: 250486784 17:57:00 INFO - PROCESS | 1968 | 17:57:03 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:57:03 INFO - PROCESS | 1968 | RSS: Main: 255549440 17:57:03 INFO - PROCESS | 1968 | 17:57:06 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:57:06 INFO - PROCESS | 1968 | RSS: Main: 256790528 17:57:06 INFO - PROCESS | 1968 | 17:57:09 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:57:09 INFO - PROCESS | 1968 | RSS: Main: 257011712 17:57:09 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49676/tests/kraken/driver.html?testName=ai-astar) 17:57:11 INFO - PROCESS | 1968 | RSS: Main: 320274432 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | __start_tp_report 17:57:11 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 17:57:11 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 17:57:11 INFO - PROCESS | 1968 | |i|pagename|runs| 17:57:11 INFO - PROCESS | 1968 | |0;ai-astar;112;112;163;155;112;113;119;111;111;110 17:57:11 INFO - PROCESS | 1968 | |1;audio-beat-detection;154;122;145;168;144;143;118;151;153;117 17:57:11 INFO - PROCESS | 1968 | |2;audio-dft;186;184;186;184;186;186;183;186;186;181 17:57:11 INFO - PROCESS | 1968 | |3;audio-fft;74;75;72;117;52;52;63;81;157;45 17:57:11 INFO - PROCESS | 1968 | |4;audio-oscillator;90;94;131;81;77;83;115;76;79;116 17:57:11 INFO - PROCESS | 1968 | |5;imaging-gaussian-blur;90;84;88;85;97;127;121;85;88;83 17:57:11 INFO - PROCESS | 1968 | |6;imaging-darkroom;93;94;95;94;94;94;94;95;93;94 17:57:11 INFO - PROCESS | 1968 | |7;imaging-desaturate;86;86;88;86;86;87;85;87;88;84 17:57:11 INFO - PROCESS | 1968 | |8;json-parse-financial;54;58;57;57;57;57;58;57;53;54 17:57:11 INFO - PROCESS | 1968 | |9;json-stringify-tinderbox;60;65;74;63;79;92;92;70;67;67 17:57:11 INFO - PROCESS | 1968 | |10;stanford-crypto-aes;93;95;101;78;80;82;77;81;82;83 17:57:11 INFO - PROCESS | 1968 | |11;stanford-crypto-ccm;120;118;119;123;127;136;112;115;117;125 17:57:11 INFO - PROCESS | 1968 | |12;stanford-crypto-pbkdf2;135;124;132;131;117;134;169;169;133;133 17:57:11 INFO - PROCESS | 1968 | |13;stanford-crypto-sha256-iterative;67;65;67;64;65;64;64;66;64;64 17:57:11 INFO - PROCESS | 1968 | __end_tp_report 17:57:11 INFO - PROCESS | 1968 | __start_cc_report 17:57:11 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1231 17:57:11 INFO - PROCESS | 1968 | __end_cc_report 17:57:11 INFO - PROCESS | 1968 | __startTimestamp1463533031764__endTimestamp 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | ------- Summary: start ------- 17:57:11 INFO - PROCESS | 1968 | Number of tests: 14 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#0] ai-astar Cycles:10 Average:121.80 Median:112.50 stddev:19.85 (17.6%) stddev-sans-first:20.73 17:57:11 INFO - PROCESS | 1968 | Values: 112.0 112.0 163.0 155.0 112.0 113.0 119.0 111.0 111.0 110.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:148.00 stddev:17.11 (11.6%) stddev-sans-first:17.54 17:57:11 INFO - PROCESS | 1968 | Values: 154.0 122.0 145.0 168.0 144.0 143.0 118.0 151.0 153.0 117.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#2] audio-dft Cycles:10 Average:184.80 Median:186.00 stddev:1.75 (0.9%) stddev-sans-first:1.80 17:57:11 INFO - PROCESS | 1968 | Values: 186.0 184.0 186.0 184.0 186.0 186.0 183.0 186.0 186.0 181.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#3] audio-fft Cycles:10 Average:78.80 Median:67.50 stddev:34.14 (50.6%) stddev-sans-first:36.17 17:57:11 INFO - PROCESS | 1968 | Values: 74.0 75.0 72.0 117.0 52.0 52.0 63.0 81.0 157.0 45.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:80.00 stddev:19.54 (24.4%) stddev-sans-first:20.67 17:57:11 INFO - PROCESS | 1968 | Values: 90.0 94.0 131.0 81.0 77.0 83.0 115.0 76.0 79.0 116.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:86.50 stddev:15.96 (18.4%) stddev-sans-first:16.83 17:57:11 INFO - PROCESS | 1968 | Values: 90.0 84.0 88.0 85.0 97.0 127.0 121.0 85.0 88.0 83.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:57:11 INFO - PROCESS | 1968 | Values: 93.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 93.0 94.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 17:57:11 INFO - PROCESS | 1968 | Values: 86.0 86.0 88.0 86.0 86.0 87.0 85.0 87.0 88.0 84.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.81 (3.2%) stddev-sans-first:1.74 17:57:11 INFO - PROCESS | 1968 | Values: 54.0 58.0 57.0 57.0 57.0 57.0 58.0 57.0 53.0 54.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:72.00 stddev:11.42 (15.9%) stddev-sans-first:11.11 17:57:11 INFO - PROCESS | 1968 | Values: 60.0 65.0 74.0 63.0 79.0 92.0 92.0 70.0 67.0 67.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:82.00 stddev:8.13 (9.9%) stddev-sans-first:8.12 17:57:11 INFO - PROCESS | 1968 | Values: 93.0 95.0 101.0 78.0 80.0 82.0 77.0 81.0 82.0 83.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.50 stddev:6.89 (5.7%) stddev-sans-first:7.30 17:57:11 INFO - PROCESS | 1968 | Values: 120.0 118.0 119.0 123.0 127.0 136.0 112.0 115.0 117.0 125.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:133.50 stddev:17.38 (13.0%) stddev-sans-first:18.41 17:57:11 INFO - PROCESS | 1968 | Values: 135.0 124.0 132.0 131.0 117.0 134.0 169.0 169.0 133.0 133.0 17:57:11 INFO - PROCESS | 1968 | 17:57:11 INFO - PROCESS | 1968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.09 17:57:11 INFO - PROCESS | 1968 | Values: 67.0 65.0 67.0 64.0 65.0 64.0 64.0 66.0 64.0 64.0 17:57:11 INFO - PROCESS | 1968 | -------- Summary: end -------- 17:57:11 INFO - PROCESS | 1968 | 17:57:12 INFO - TEST-INFO | 1968: exit 0 17:57:12 INFO - TEST-OK | kraken | took 56424ms 17:57:12 INFO - SUITE-END | took 1167s 17:57:12 INFO - Completed test suite (00:19:28) 17:57:12 INFO - javascript benchmark 17:57:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3075.0006247969386, 3543.6633519815614, 3629.219717760681, 3640.5449318835135, 3698.7225958053154, 5880.088586269135, 5908.497777688896, 5910.852228694284, 5918.615290006147, 5921.88156236875, 5881.411858814116, 5920.733566989485, 5928.02187639039, 5929.822105336847, 5957.791477298296, 5248.632595718302, 5279.2872962150195, 5321.574274058085, 5328.946710532884, 5380.408155102936, 5382.838514844541, 5396.43337449568, 5400.270963419947, 5400.513953744162, 5403.918941215885, 5329.706866122362, 5382.730863456831, 5388.380336261341, 5411.648242864201, 5421.186821976716, 5408.4050754416985, 5413.106837371829, 5436.592255580847, 5452.591055670801, 5500.862478438031, 5146.408163061258, 5328.92006619901, 5333.919991200135, 5360.839174824761, 5373.194020896896, 5756.33802112754, 5815.970920145414, 5833.7958171464215, 5863.179154918314, 5894.233749612523, 6195.039768835838, 6250.468710159642, 6268.435840774307, 6283.968580157116, 6288.088227207029, 6208.81373558794, 6230.221222347207, 6242.157308763304, 6271.153394291758, 6296.212973378328, 5089.770960306758, 6041.577089603729, 6072.210612620331, 6085.421884920926, 6125.754969801247, 6261.154744109578, 6337.049442583557, 6441.935580644227, 6457.547971642034, 6474.223093228843, 6292.653904035231, 6314.778982735582, 6319.684015799192, 6321.96839015802, 6325.082862984841, 6322.462590679844, 6331.620102793847, 6339.873202536016, 6342.651154186564, 6346.30190679025, 5905.586608937333, 6185.8144255672405, 6202.131701561785, 6270.059491076284, 6289.276733175652, 6222.28443728977, 6263.342349053284, 6266.091416744546, 6286.151369565142, 6291.716872740738, 4962.082014827269, 5000.524950129732, 5008.57427118699, 5011.674241174385, 5025.7989680412375, 4216.536181020086, 4388.912221755547, 4402.647788176938, 4539.931901021488, 4560.817567297271, 6076.4531192192035, 6084.330723620398, 6087.026075827846, 6095.207623009069, 6108.144859719643, 6304.243490781136, 6311.526635502356, 6326.557141000086, 6339.587926784744, 6343.048542718537, 5917.763289468373, 5957.553183511254, 6008.549358798107, 6066.848328791727, 6079.148919151322, 5474.616776825584, 5499.917501237484, 5503.394626591072, 5512.448755124536, 5515.200295957064, 6484.870302593922, 6521.771737989147, 6542.509311801634, 6546.18172728409, 6550.934490655032, 6185.41238582334, 6257.749690012349, 6310.716017779303, 6313.589616674902, 6355.682215889279, 6543.738250469928, 6574.76988305407, 6576.44100251484, 6583.210014798255, 6588.176477940257, 6136.028952951454, 6265.655388953469, 6280.497560195082, 6293.339199383999, 6309.242890853127, 5489.725513724218, 6229.2524897010835, 6283.151774510383, 6285.528585356208, 6320.5575609706875, 5590.916136258041, 6272.843178920563, 6279.811605651837, 6281.905771413524, 6284.465820405317, 6123.663198524124, 6207.36187120481, 6216.689165541795, 6279.748810047729, 6307.873842523216, 6172.69136543162, 6230.43926046658, 6232.688365581794, 6235.189425374672, 6236.03341482071, 6281.214848143982, 6282.717277722422, 6299.905501417391, 6306.873862522815, 6309.873802523832, 5990.910136348046, 6062.060380640832, 6120.326764056039, 6220.440160385587, 6229.314775374614], "unit": "score", "name": "dojo.html", "value": 5838.930784535575}, {"lowerIsBetter": false, "replicates": [476.397357342961, 595.9154339102832, 620.6555361774214, 669.5237002409687, 671.8276607320225, 31450.0, 39589.80205098974, 39750.80124599373, 39762.8011859941, 39819.800900995455, 42709.7864510677, 43318.35022474665, 43420.13159736803, 43434.565654343445, 43523.69428917138, 9722.756931076708, 9964.352317099401, 9973.750656233617, 9978.550965206547, 9981.600735970553, 9761.170300524464, 9911.157551608121, 9930.801383972317, 9931.652392166276, 9944.353617014907, 9881.703548893545, 10074.496275186248, 10084.848727269096, 10104.494775261244, 10112.94943525285, 9983.950080249624, 10055.949720251425, 10059.39643621385, 10061.496925153713, 10066.899331006669, 9885.159761420287, 10009.799804003878, 10014.64948726791, 10020.0, 10024.749381265454, 42242.577574224175, 42543.57456425427, 42759.57240427587, 42834.57165428337, 42858.35712464315, 3227.1770698471973, 3404.217030083095, 3878.4376265441633, 3883.4951456310782, 3978.761274323521, 28320.291992700142, 29291.70708292911, 29359.70640293591, 29446.411071778657, 29529.261768455744, 2730.24918147509, 2750.642416485864, 2811.522041252992, 2812.226637674635, 2830.0943698016645, 498221.9999999964, 502411.0, 504129.0, 504130.4793476009, 505572.0, 67469.98795018079, 67598.26812123104, 67645.0, 67675.66162169256, 67817.66091169513, 71920.0, 81112.0, 82155.5892220547, 82391.5880420594, 82477.0, 19151.425457236306, 19260.903695481433, 19365.4190374289, 19384.515387115152, 19392.806071939383, 14724.484643037442, 14826.777598336033, 14849.257537123101, 14858.0, 14875.107493550422, 22887.313380598607, 23217.883910580676, 23253.883730581238, 23263.0, 23306.0, 7953.0, 8905.040891004099, 9047.869016372953, 9152.54237288133, 9241.584128714225, 894.6555576103248, 1029.4286670897723, 1034.9482525873675, 1049.7165765243342, 1156.410230782307, 30286.0, 30508.389832203677, 30652.540211896838, 31433.0, 31495.527567086512, 1159.3336819302376, 1161.703765539799, 1211.4185191108318, 1275.2603489975793, 1324.8410190777167, 15674.529764107096, 15752.92123539375, 15933.760993585105, 15943.920280398524, 16230.675386492205, 567822.0, 572272.0, 573081.0, 574954.0, 575240.0, 62018.37981620126, 62512.0, 62576.374236257965, 62628.37371626226, 62790.74418511604, 1423.7864320351823, 1443.603009172465, 1495.6186172525936, 1543.8224604170439, 1566.4125952767483, 24773.876130619232, 29702.257443564085, 29762.404751904407, 30141.945031923777, 30423.239419014702, 31218.843905780326, 44893.326600101675, 45024.54975450334, 45816.312755308034, 48901.75549122231, 379590.0, 380615.0, 380762.0, 381520.0, 381943.0, 30312.69687303099, 34828.477572836935, 35393.46909796304, 35515.75694850668, 35969.100772480895, 43522.0, 44425.77787111044, 44693.329600055375, 44779.776101119285, 45508.54491455043, 34923.65076349204, 36318.72884449032, 36502.26995460129, 36569.45145822868, 37445.0, 36327.27345453129, 36525.63474365223, 36826.81586592157, 36982.0, 37102.814485927396, 36932.44601330929, 37468.43797342988, 37758.81120594379, 38558.0, 38798.0, 31169.688303117586, 32863.342733145684, 33979.66020339864, 34096.0, 34117.0, 23211.535769284183, 25224.74775252224, 25366.239012829643, 25454.363640909127, 25778.09776657808], "unit": "score", "name": "ext.html", "value": 20624.575056441758}, {"lowerIsBetter": false, "replicates": [379.78352339166673, 381.8472610955616, 383.1819066293464, 389.27594673906526, 390.6113417149936, 19640.60718785625, 21085.578288434222, 21247.15011399546, 21312.93435328235, 21346.0, 22159.667604985938, 22227.110915563357, 22464.663030054562, 22501.54996900061, 22518.54962900741, 5753.597248192628, 5813.825585232428, 6075.66583837891, 6080.209572755558, 6083.939160608404, 5881.794137205177, 5965.940340596582, 5978.342382337939, 6001.909971350433, 6004.909926351086, 5747.511461525754, 5931.051031834907, 5934.97032514839, 5942.435468630495, 6022.909656355137, 5804.854878628026, 5941.732622032019, 5953.404659534055, 6002.579819412643, 6024.337322894478, 5925.081612350093, 5926.822195334147, 5926.940730592682, 5947.197128387699, 5961.970190149065, 14318.71362572753, 14469.34887930035, 19867.0, 25992.09027684041, 27122.64386780653, 2188.5723405953167, 2213.435573928654, 2236.4520692430297, 2347.460084180631, 2708.756211940935, 10002.199824014135, 10098.29311948164, 10167.288289819715, 10680.14558835299, 10758.515866786014, 1800.9369672061414, 1815.936442224529, 1856.2574970011967, 1887.2733997410958, 1959.5688948431323, 113040.0, 117661.23508147385, 119099.8090019106, 120842.0, 121039.3948030263, 11696.70758231034, 11753.412329383496, 11773.88226117745, 11793.88206117945, 11799.469023893773, 12285.75428491443, 14574.781378279335, 14643.85356146425, 14644.707105858037, 14654.413823447156, 7420.5547667140145, 9065.093490651014, 9086.772830679154, 9132.634694612274, 9201.585928633227, 9247.306452016126, 9262.67580634688, 9264.378733721573, 9267.72196834096, 9372.015938326515, 3937.055106774411, 4587.288970209623, 4589.33454649074, 4600.148972440109, 4606.470255920612, 1916.1664675866043, 1968.8031196880197, 1976.436715536094, 2000.3598848368674, 2001.039501039509, 862.5514732339149, 901.8511945529045, 943.6555657185078, 951.5908159491485, 986.9259805514615, 19546.51133721668, 20460.48848778763, 20470.874101924535, 20482.180712771322, 20963.79036209649, 969.6703120938914, 974.0757405695163, 987.3039507147444, 1012.6455740490917, 1028.8662473878499, 8661.566921654017, 11118.722031949266, 11239.381833999209, 11253.774924501464, 11254.831177532344, 687046.0, 688365.0, 700502.0, 703846.0, 710967.4451627709, 82524.0, 113003.30495042581, 114928.0, 115531.11761976374, 122445.0, 995.4127065031666, 1012.832882574367, 1024.533837104116, 1027.3938376357985, 1030.7989941961396, 17720.291188352323, 18058.916465012142, 18348.816511835244, 18356.541086472946, 18540.907295463436, 50899.0, 51379.48620513747, 51481.48518514767, 51484.712882178246, 51645.22532162096, 75317.6234118826, 75377.86933195897, 76118.61940690261, 76192.0, 78449.21550784419, 8023.719169829028, 8075.959620201861, 8163.83672326562, 8307.460015098999, 8356.6239519223, 9392.483413412328, 11931.582394616147, 12624.74750505003, 13022.4139913706, 13537.052406331462, 11214.271072380268, 11490.310581365145, 11798.410079496163, 11807.881921181022, 11883.643490695293, 9356.345055846297, 11152.0, 11536.769264614828, 11583.247088939192, 11723.41382930833, 11523.250988685708, 11679.941600292284, 11797.764044718886, 11931.164818462625, 12128.332941688292, 8092.514449133071, 8190.549519776231, 8240.464369815943, 8261.215184557457, 8301.875471867806, 8820.29437644974, 11217.149170386794, 11394.430278486208, 11487.597934072268, 11850.111241657083], "unit": "score", "name": "jquery.html", "value": 9639.157037980181}, {"lowerIsBetter": false, "replicates": [1514.401811284542, 1640.7538869169625, 1661.8421249981254, 2009.9899500502495, 2083.1354987680106, 8399.622017009235, 8984.595693193805, 9139.36024478285, 9140.451572905631, 9140.954295228532, 8806.0, 9076.0, 9082.90917090829, 9087.863682044775, 9093.681721139745, 2561.679790026247, 2579.21333993132, 2580.2775222937607, 2583.534963706532, 2586.379268975451, 2512.5477414065463, 2586.3921978335075, 2588.534063868503, 2590.4819036192835, 2617.9869100654564, 2569.0622922633197, 2583.6253743207226, 2605.7394260573888, 2610.673665791776, 2612.05965852293, 2208.6466165413617, 2567.473667898076, 2577.6777902762155, 2589.7539733725266, 2609.1389841352307, 2560.129555950986, 2592.4815036992677, 2598.428345763929, 2607.191770551135, 2614.503244383561, 9114.361994660376, 9166.0, 9185.954070229605, 9194.402363846395, 9210.0, 5659.943400565983, 5758.337791154029, 5762.798302059407, 5807.925533776265, 5809.099589563624, 3647.58052823926, 3760.5863355030924, 3808.428735689641, 3818.16000479894, 3824.1778017726324, 1065.7016035510069, 1083.8753543342539, 1085.0885256384674, 1095.6001059613263, 1122.5004872831594, 12487.063470239678, 12499.625011249676, 12510.74978500434, 12511.311877846714, 12575.559855405018, 4986.825461108916, 5044.394672639307, 5105.387353517527, 5129.692218466904, 5160.432352441228, 9812.871519775175, 10396.324238924446, 10409.895901041044, 10427.5828966842, 10434.478276086165, 5370.113931201387, 5767.250257466587, 5811.4479124483105, 5815.621984570989, 5829.446202610745, 4712.010477799632, 4743.217369134054, 4772.522747725269, 4781.976090119527, 5246.239295302236, 4078.5921407858978, 4095.832687684055, 4168.6665066794585, 4173.0, 4188.81150348235, 1349.8515163332027, 1372.663697394125, 1374.793780932848, 1385.0, 1385.9445622175201, 1428.9142651440948, 1445.3206992713408, 1452.7094581083825, 1466.5893549806071, 1480.9333579988927, 8567.228949394459, 8634.913650863537, 8637.222649961534, 8640.481571105627, 8656.307495400353, 533.6504589493887, 540.351578106274, 548.366636534803, 552.3565046720606, 554.9833504994857, 6414.8717025659225, 6452.451541619015, 6503.2521260054755, 6519.989401642753, 6532.804015879531, 10652.520636571218, 11016.06363459099, 11187.440627968568, 11209.887901121048, 11401.258918170292, 10442.947785261025, 10764.192685548614, 11148.163887708291, 11190.776184476264, 11243.494042768096, 8479.109693482218, 8692.217700406994, 8701.956490217635, 8709.390342676079, 8711.303095752324, 8380.12008739098, 8385.28725058377, 8438.0, 8481.745547633582, 8529.402941794015, 9665.226781857295, 9814.65648702292, 9868.013198680075, 9948.005199479994, 10114.79770404573, 10197.490125493547, 10292.639757608447, 10593.099586534923, 10604.0, 10616.469176541297, 7143.142822861082, 7326.743563975236, 7739.110002349802, 7873.960630197042, 7932.6033698316005, 8011.479253848481, 8095.502332068586, 8326.45878017927, 8527.829443411221, 8583.141685831368, 7492.1384040836, 7595.886061708969, 7612.3910087194, 7712.537247765152, 7757.340626046849, 7335.559866408033, 7363.521371111075, 7410.073740782403, 7455.142658594331, 7458.701651933862, 7957.641906114123, 7965.761027169194, 8008.599570021592, 8010.919890801018, 8023.037235531773, 7144.714211431485, 7282.96358518204, 7293.489455738048, 7350.338469537767, 7356.44826638015, 7400.740974065882, 7401.33387995083, 7476.887846682413, 7477.0, 7477.214892436215], "unit": "score", "name": "mootools.html", "value": 5064.676975682399}, {"lowerIsBetter": false, "replicates": [335.8253708071802, 340.08177919617026, 347.9043263102647, 348.25299732074717, 354.7339495378466, 6636.270010298869, 6674.0, 6698.832529186767, 6712.731490740377, 6715.42918851897, 6655.035019922108, 6660.267370589243, 6672.165979252593, 6682.031105489701, 6686.598804071759, 4339.891502712426, 4657.534246575349, 4852.611791056707, 4866.294387313837, 4876.439209490918, 4872.7563621818945, 4876.097921884445, 4936.778449697633, 4944.728039957801, 4993.450720420751, 4867.51324867514, 4877.170880950247, 4908.631852611051, 4910.75446227689, 4911.887888208069, 4169.520505141917, 4866.807632130115, 4937.925931111036, 4964.677295975786, 4967.950320496785, 4070.5522392536795, 4160.5007399112, 4264.48826140862, 4274.5939135782055, 4276.3157894737005, 6185.257769067695, 6201.937980620181, 6250.874982500324, 6305.612765191697, 6368.840778980516, 5822.184894114827, 5827.679477628729, 5834.474897259267, 5838.0, 5848.853778655525, 7020.052292940439, 7027.156741191038, 7029.718811247595, 7030.4727145463785, 7035.577865328046, 4591.8979444932975, 4754.595859351959, 4771.093492236464, 4787.8563643090765, 4790.664653474259, 6615.239247486553, 7075.0448689426785, 7331.486795924234, 7338.669759860819, 7397.593132377717, 4883.340748998839, 4894.241392584155, 4894.828680996148, 4901.9019619608125, 4903.41159060915, 4980.5019498049905, 4985.302057711923, 4988.925166122439, 4990.675606085665, 5000.999800040006, 5832.212651292021, 5833.125031245262, 5836.328822185418, 5843.094320380348, 5845.064789633639, 6729.798106056826, 6993.195782484978, 7039.718411263594, 7041.3310735480045, 7051.964740176369, 1710.4013595241565, 1713.126305584161, 1728.3777839977597, 1734.1502663694698, 1741.1120328632235, 1130.2483848240827, 1130.2483848240993, 1151.4818331750746, 1154.417019405195, 1161.0421402343102, 6415.582987105823, 6577.6711164441585, 6658.0, 6659.600423974577, 6729.49528785343, 7354.338109570057, 7360.07999000125, 7362.558246505227, 7374.262573742582, 7380.151282602462, 6656.36764507371, 6690.197176338773, 6692.933070669328, 6707.195136583641, 6711.161104861892, 3846.0, 3877.747946383476, 3879.553851307079, 3880.0299925018744, 3896.7661940283674, 6275.937240627627, 7397.445191610651, 7680.577568233689, 7746.535207887432, 7753.728619498291, 7536.057992750906, 7591.810204744926, 7607.239276072349, 7620.847583048308, 7625.618719064025, 7708.229177082247, 7711.151773304932, 7715.1899050600005, 7718.073831140075, 7731.304182623591, 7380.96309518449, 7381.0, 7383.630818459163, 7387.150477695134, 7396.55620662762, 7034.413208121744, 7172.031775710212, 7239.058922340273, 7267.709291628275, 7287.161976372573, 6966.79099627012, 7087.893681594884, 7724.92275077242, 7749.690012399441, 7774.533527988338, 4629.791659375269, 4682.1103990241745, 4684.437867455791, 4691.765411729468, 4693.788779504862, 7299.5620262784405, 7305.817354566178, 7311.853762924606, 7313.232110628307, 7319.926800731924, 6860.279670634512, 7085.716571337089, 7129.394001509722, 7148.785536433916, 7156.856862862818, 7095.609741464269, 7137.892931606134, 7153.570785752871, 7160.641967901688, 7163.964180179274, 6984.371406573433, 6991.370776630128, 6992.510524263253, 6994.790156295319, 7004.299570042955, 6838.589684618939, 7136.179339375831, 7150.356467917913, 7150.892736609059, 7158.284171583008, 6737.629430381376, 6835.213950395768, 6990.685419156049, 7000.824979375557, 7000.964995174992], "unit": "score", "name": "prototype.html", "value": 5237.797412957172}, {"lowerIsBetter": false, "replicates": [639.3957709964083, 722.9783106506804, 766.6933226709316, 802.8916096326994, 835.3025223938012, 15301.2349382531, 15647.295871685774, 15660.216989150555, 15676.921615391935, 15704.371825126995, 14385.064970776892, 14487.348069336878, 14505.274736263198, 14507.492237771654, 16344.264508097134, 975.1905918088005, 982.8378317577591, 992.4194346307419, 994.4878387630376, 994.5623925472805, 992.3500107429645, 995.2336700740426, 996.3424140067557, 998.0817647764038, 1000.8548760429734, 1039.230969082877, 1042.280826229899, 1043.2957753516384, 1043.7547176413536, 1044.2742294105599, 1035.880873699519, 1038.3717850700332, 1039.4490919812436, 1040.4381633917712, 1042.7601651620132, 758.4387553210639, 760.4866714967375, 760.7983884270673, 761.1741260732113, 761.7333933123418, 13015.544455944091, 15689.215539223107, 15729.528114156594, 15730.056196628238, 15740.0, 12527.060470464752, 12781.552645657357, 12903.677268115192, 13130.343482825916, 13147.276899770604, 10172.898271017342, 10228.0, 10304.0, 10579.259451838374, 10613.734656633645, 3547.5388199534154, 3560.661737134994, 3607.603163651996, 3666.7249956253386, 3808.219315040438, 63859.0, 74931.25068749297, 81524.59237703832, 82837.0, 82978.0, 9840.901590984142, 9880.308378413441, 9913.30606857513, 9943.701688949342, 9994.350367226107, 22227.66658500124, 22269.888650556968, 22275.443113922283, 22285.777142228693, 22357.888210558842, 7692.499987500794, 7712.807179820549, 7836.882446763303, 7997.600119994094, 8066.395020373496, 4188.748675079505, 4250.766207858597, 4273.1240095780295, 4312.029793296483, 4575.2450845610765, 3588.3720348939355, 3646.890593282206, 3651.707863370924, 3652.1052342176336, 3668.4680721295795, 639.1563136659564, 648.3548868875499, 651.5211319680031, 652.9477641788741, 655.1319501660224, 622.4056026494686, 623.554158776477, 626.9090981807612, 639.8112556795757, 660.1846719301659, 7446.404287656975, 8151.592420378957, 8910.955445222733, 8924.955375223082, 9069.0, 531.3358302122347, 577.9566532510079, 595.2767387624058, 609.0498821837947, 618.8669436071266, 3915.8629447969756, 3979.323515002399, 4040.959590404117, 4125.938110928339, 4160.646345060703, 89986.55006725056, 91488.0, 93891.0, 94546.0545394551, 95677.52161239149, 68936.62126757538, 79150.0, 79248.0, 79562.0, 81507.0, 68631.999999999, 70871.64564177147, 71859.0, 73763.0, 74148.18036827589, 8663.960324760817, 8738.519381434082, 8857.955710221666, 8885.333599980157, 8939.910600893907, 40090.79954600208, 50525.49474505208, 50565.74717126391, 51262.97474050573, 51477.48522514727, 67598.0, 69671.65164174147, 70868.64565677139, 71391.28608714054, 71628.28371716216, 11206.719832004264, 11252.26860254081, 11602.825957610812, 11641.301521908712, 11657.183997120459, 11974.58088966882, 12142.210756300812, 12201.633950981484, 12238.0, 12394.194377365442, 11608.12939029593, 11777.646670599896, 11995.700107497383, 11995.76008479843, 12208.572699955459, 9887.604495820375, 11924.701882453008, 11930.284182949052, 11972.221805582609, 12018.939905300418, 11400.48697808584, 11425.714357141138, 11561.710957226136, 11562.94218528902, 12357.949574286285, 9926.900730992598, 9968.551415186479, 10146.543405546621, 10204.285700000928, 10265.794684106128, 8581.35639827003, 9862.950685246527, 9962.50187490608, 10119.645812396531, 10131.037551432602], "unit": "score", "name": "yui.html", "value": 7173.897305453931}], "name": "dromaeo_css", "value": 7775.134732902463}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 163.0, 155.0, 112.0, 113.0, 119.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 121.8}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 145.0, 168.0, 144.0, 143.0, 118.0, 151.0, 153.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 186.0, 184.0, 186.0, 186.0, 183.0, 186.0, 186.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 72.0, 117.0, 52.0, 52.0, 63.0, 81.0, 157.0, 45.0], "unit": "score", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 131.0, 81.0, 77.0, 83.0, 115.0, 76.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 88.0, 85.0, 97.0, 127.0, 121.0, 85.0, 88.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.0}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 86.0, 86.0, 87.0, 85.0, 87.0, 88.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [60.0, 65.0, 74.0, 63.0, 79.0, 92.0, 92.0, 70.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.9}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 101.0, 78.0, 80.0, 82.0, 77.0, 81.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 119.0, 123.0, 127.0, 136.0, 112.0, 115.0, 117.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [135.0, 124.0, 132.0, 131.0, 117.0, 134.0, 169.0, 169.0, 133.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 67.0, 64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1434.4}]} 17:57:13 INFO - Return code: 0 17:57:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:57:13 INFO - # TBPL SUCCESS # 17:57:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:57:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:57:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:57:13 INFO - 2016-05-17 17:57:13.083 screenresolution[1972:13623] starting screenresolution argv=screenresolution get 17:57:13 INFO - 2016-05-17 17:57:13.086 screenresolution[1972:13623] Display 0: 1600x1200x32@60 17:57:13 INFO - 2016-05-17 17:57:13.092 screenresolution[1973:13625] starting screenresolution argv=screenresolution list 17:57:13 INFO - Available Modes on Display 0 17:57:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:57:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:57:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:57:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:57:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:57:13 INFO - Intel Iris: 17:57:13 INFO - Chipset Model: Intel Iris 17:57:13 INFO - Type: GPU 17:57:13 INFO - Bus: Built-In 17:57:13 INFO - VRAM (Dynamic, Max): 1536 MB 17:57:13 INFO - Vendor: Intel (0x8086) 17:57:13 INFO - Device ID: 0x0a2e 17:57:13 INFO - Revision ID: 0x0009 17:57:13 INFO - Displays: 17:57:13 INFO - Display: 17:57:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:57:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:57:13 INFO - Display Serial Number: 1600x1200 60 17:57:13 INFO - Main Display: Yes 17:57:13 INFO - Mirror: Off 17:57:13 INFO - Online: Yes 17:57:13 INFO - Rotation: Supported 17:57:13 INFO - Return code: 0 17:57:13 INFO - Running post-action listener: _resource_record_post_action 17:57:13 INFO - Running post-run listener: _resource_record_post_run 17:57:14 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 110592; Write bytes: 509837312; Read time: 2; Write time: 1600 17:57:14 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 194882048; Write bytes: 194543616; Read time: 17992; Write time: 345 17:57:14 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 110592; Write bytes: 303656960; Read time: 2; Write time: 1211 17:57:14 INFO - Running post-run listener: _upload_blobber_files 17:57:14 INFO - Blob upload gear active. 17:57:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:57:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:57:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:57:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:57:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:57:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:15 INFO - (blobuploader) - INFO - Done attempting. 17:57:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:57:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:57:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:16 INFO - (blobuploader) - INFO - Done attempting. 17:57:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:16 INFO - Return code: 0 17:57:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdbf3c5c06084eb0c59ff8536d248734e9b79de6018e284f993f35d6303c76668fbbce3fa36805259304c9c2e01c16defdf8a936ed5c873c88cb61c758293e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f201b80d149d600b86a791a0d16a701a37fdce12720cbfe474364f6fa2a78e206d8558bb7874ed8c735399963bacaeab7be139d25bbb5c0a8fe543d4dcf0f3db"} 17:57:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:16 INFO - Contents: 17:57:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdbf3c5c06084eb0c59ff8536d248734e9b79de6018e284f993f35d6303c76668fbbce3fa36805259304c9c2e01c16defdf8a936ed5c873c88cb61c758293e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f201b80d149d600b86a791a0d16a701a37fdce12720cbfe474364f6fa2a78e206d8558bb7874ed8c735399963bacaeab7be139d25bbb5c0a8fe543d4dcf0f3db"} 17:57:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:16 INFO - Copying logs to upload dir... 17:57:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.966141 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-17 17:57:16.717544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 17:57:16.721033) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zEEJBf9S9b/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdbf3c5c06084eb0c59ff8536d248734e9b79de6018e284f993f35d6303c76668fbbce3fa36805259304c9c2e01c16defdf8a936ed5c873c88cb61c758293e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f201b80d149d600b86a791a0d16a701a37fdce12720cbfe474364f6fa2a78e206d8558bb7874ed8c735399963bacaeab7be139d25bbb5c0a8fe543d4dcf0f3db"} build_url:https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011079 build_url: 'https://queue.taskcluster.net/v1/task/FWKSK6puT7-3MthR0jpsqw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bdbf3c5c06084eb0c59ff8536d248734e9b79de6018e284f993f35d6303c76668fbbce3fa36805259304c9c2e01c16defdf8a936ed5c873c88cb61c758293e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f201b80d149d600b86a791a0d16a701a37fdce12720cbfe474364f6fa2a78e206d8558bb7874ed8c735399963bacaeab7be139d25bbb5c0a8fe543d4dcf0f3db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 17:57:16.749843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:57:16.750200) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zEEJBf9S9b/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.rOiOxKtXAu/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005138 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:57:16.800014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 17:57:16.800327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 17:57:16.800677) ========= ========= Total master_lag: 0.16 =========