builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0070 starttime: 1467433143.72 results: success (0) buildid: 20160701192722 builduid: 52584d8b7e0a403084a0345bf9df883d revision: e8999eb7311ec1063176e4a836388b763fb91942 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:03.724422) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:03.724868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:03.725158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:03.861817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:03.862090) ========= 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.XjuIels4kG/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.WtMNyu2ayw/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-07-01 21:19:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-07-01 21:19:04 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.659736 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:04.560095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:04.560420) ========= 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.XjuIels4kG/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.WtMNyu2ayw/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.030136 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:04.620759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 21:19:04.621072) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e8999eb7311ec1063176e4a836388b763fb91942 --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 e8999eb7311ec1063176e4a836388b763fb91942 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XjuIels4kG/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.WtMNyu2ayw/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-07-01 21:19:04,695 truncating revision to first 12 chars 2016-07-01 21:19:04,695 Setting DEBUG logging. 2016-07-01 21:19:04,695 attempt 1/10 2016-07-01 21:19:04,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e8999eb7311e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 21:19:06,391 unpacking tar archive at: mozilla-beta-e8999eb7311e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.958951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 21:19:06.601267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:06.601570) ========= script_repo_revision: e8999eb7311ec1063176e4a836388b763fb91942 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:06.601955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:06.602234) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 21:19:06.620124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-07-01 21:19:06.620389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.XjuIels4kG/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.WtMNyu2ayw/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:19:06 INFO - MultiFileLogger online at 20160701 21:19:06 in /builds/slave/test 21:19:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:19:06 INFO - {'append_to_log': False, 21:19:06 INFO - 'base_work_dir': '/builds/slave/test', 21:19:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:19:06 INFO - 'branch': 'Mozilla-Beta', 21:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 21:19:06 INFO - 'config_files': ('talos/mac_config.py',), 21:19:06 INFO - 'default_actions': ('clobber', 21:19:06 INFO - 'read-buildbot-config', 21:19:06 INFO - 'download-and-extract', 21:19:06 INFO - 'populate-webroot', 21:19:06 INFO - 'create-virtualenv', 21:19:06 INFO - 'install', 21:19:06 INFO - 'run-tests'), 21:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:19:06 INFO - 'download_minidump_stackwalk': True, 21:19:06 INFO - 'download_symbols': 'ondemand', 21:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 21:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 21:19:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:19:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:19:06 INFO - 'installer_path': 'installer.exe', 21:19:06 INFO - 'log_level': 'info', 21:19:06 INFO - 'log_name': 'talos', 21:19:06 INFO - 'log_to_console': True, 21:19:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:19:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:19:06 INFO - 'opt_config_files': (), 21:19:06 INFO - 'pip_index': False, 21:19:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:19:06 INFO - 'cmd': ('bash', 21:19:06 INFO - '-c', 21:19:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:19:06 INFO - 'enabled': True, 21:19:06 INFO - 'halt_on_failure': False, 21:19:06 INFO - 'name': 'check_screen_resolution'},), 21:19:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:19:06 INFO - 'cmd': ('bash', 21:19:06 INFO - '-c', 21:19:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:19:06 INFO - 'enabled': True, 21:19:06 INFO - 'halt_on_failure': False, 21:19:06 INFO - 'name': 'check_screen_resolution'},), 21:19:06 INFO - 'run_cmd_checks_enabled': True, 21:19:06 INFO - 'sps_profile': False, 21:19:06 INFO - 'sps_profile_interval': 0, 21:19:06 INFO - 'suite': 'dromaeojs-e10s', 21:19:06 INFO - 'system_bits': '32', 21:19:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:19:06 INFO - 'title': 't-yosemite-r7-0070', 21:19:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:19:06 INFO - 'use_talos_json': True, 21:19:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:19:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:19:06 INFO - 'work_dir': 'build'} 21:19:06 INFO - ##### 21:19:06 INFO - ##### Running clobber step. 21:19:06 INFO - ##### 21:19:06 INFO - Running pre-action listener: _resource_record_pre_action 21:19:06 INFO - Running main action method: clobber 21:19:06 INFO - rmtree: /builds/slave/test/build 21:19:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:19:08 INFO - Running post-action listener: _resource_record_post_action 21:19:08 INFO - ##### 21:19:08 INFO - ##### Running read-buildbot-config step. 21:19:08 INFO - ##### 21:19:08 INFO - Running pre-action listener: _resource_record_pre_action 21:19:08 INFO - Running main action method: read_buildbot_config 21:19:08 INFO - Using buildbot properties: 21:19:08 INFO - { 21:19:08 INFO - "project": "", 21:19:08 INFO - "product": "firefox", 21:19:08 INFO - "script_repo_revision": "production", 21:19:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 21:19:08 INFO - "repository": "", 21:19:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 21:19:08 INFO - "buildid": "20160701192722", 21:19:08 INFO - "pgo_build": "False", 21:19:08 INFO - "basedir": "/builds/slave/test", 21:19:08 INFO - "buildnumber": 18, 21:19:08 INFO - "slavename": "t-yosemite-r7-0070", 21:19:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:19:08 INFO - "platform": "yosemite_r7", 21:19:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:19:08 INFO - "branch": "mozilla-beta", 21:19:08 INFO - "repo_path": "releases/mozilla-beta", 21:19:08 INFO - "revision": "e8999eb7311ec1063176e4a836388b763fb91942", 21:19:08 INFO - "stage_platform": "macosx64", 21:19:08 INFO - "builduid": "52584d8b7e0a403084a0345bf9df883d", 21:19:08 INFO - "slavebuilddir": "test" 21:19:08 INFO - } 21:19:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 21:19:08 INFO - Running post-action listener: _resource_record_post_action 21:19:08 INFO - ##### 21:19:08 INFO - ##### Running download-and-extract step. 21:19:08 INFO - ##### 21:19:08 INFO - Running pre-action listener: _resource_record_pre_action 21:19:08 INFO - Running main action method: download_and_extract 21:19:08 INFO - mkdir: /builds/slave/test/build/tests 21:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:08 INFO - https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:19:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 21:19:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 21:19:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 21:19:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 21:19:34 INFO - Downloaded 1165 bytes. 21:19:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 21:19:34 INFO - Using the following test package requirements: 21:19:34 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 21:19:34 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 21:19:34 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 21:19:34 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:19:34 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 21:19:34 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 21:19:34 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 21:19:34 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 21:19:34 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 21:19:34 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 21:19:34 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 21:19:34 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 21:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:34 INFO - https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 21:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 21:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 21:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 21:19:37 INFO - Downloaded 18351341 bytes. 21:19:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:19:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:19:40 INFO - Return code: 0 21:19:40 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 21:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:40 INFO - https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 21:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 21:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 21:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 21:19:45 INFO - Downloaded 18351341 bytes. 21:19:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:19:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:19:49 INFO - Return code: 0 21:19: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')]} 21:19:49 INFO - https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:19:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 21:19:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 21:19:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 21:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 21:19:50 INFO - Downloaded 10840145 bytes. 21:19:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:19:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:19:50 INFO - Return code: 0 21:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:50 INFO - https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 21:19:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 21:19:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 21:19:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 21:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 21:19:53 INFO - Downloaded 86194211 bytes. 21:19:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 21:19:53 INFO - mkdir: /builds/slave/test/properties 21:19:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:19:53 INFO - Writing to file /builds/slave/test/properties/build_url 21:19:53 INFO - Contents: 21:19:53 INFO - build_url:https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 21:19:54 INFO - Running post-action listener: _resource_record_post_action 21:19:54 INFO - Running post-action listener: set_extra_try_arguments 21:19:54 INFO - ##### 21:19:54 INFO - ##### Running populate-webroot step. 21:19:54 INFO - ##### 21:19:54 INFO - Running pre-action listener: _resource_record_pre_action 21:19:54 INFO - Running main action method: populate_webroot 21:19:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:19:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:19:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:19:54 INFO - '--tppagecycles', 21:19:54 INFO - '7'], 21:19:54 INFO - 'tests': ['tsvgm']}}, 21:19:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:19:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:19:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:19:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:19:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['damp', 'tps']}, 21:19:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'tests': ['damp', 'tps']}, 21:19:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['dromaeo_dom']}, 21:19:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:19:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['a11yr', 21:19:54 INFO - 'ts_paint', 21:19:54 INFO - 'tpaint', 21:19:54 INFO - 'sessionrestore', 21:19:54 INFO - 'sessionrestore_no_auto_restore', 21:19:54 INFO - 'tabpaint']}, 21:19:54 INFO - 'other-e10s': {'tests': ['a11yr', 21:19:54 INFO - 'ts_paint', 21:19:54 INFO - 'tpaint', 21:19:54 INFO - 'sessionrestore', 21:19:54 INFO - 'sessionrestore_no_auto_restore', 21:19:54 INFO - 'tabpaint']}, 21:19:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:19:54 INFO - 'ts_paint', 21:19:54 INFO - 'tpaint', 21:19:54 INFO - 'sessionrestore', 21:19:54 INFO - 'sessionrestore_no_auto_restore', 21:19:54 INFO - 'tabpaint']}, 21:19:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:19:54 INFO - 'ts_paint', 21:19:54 INFO - 'tpaint', 21:19:54 INFO - 'sessionrestore', 21:19:54 INFO - 'sessionrestore_no_auto_restore', 21:19:54 INFO - 'tabpaint']}, 21:19:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['a11yr', 21:19:54 INFO - 'ts_paint', 21:19:54 INFO - 'tpaint', 21:19:54 INFO - 'sessionrestore', 21:19:54 INFO - 'sessionrestore_no_auto_restore', 21:19:54 INFO - 'tabpaint']}, 21:19:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['a11yr', 21:19:54 INFO - 'ts_paint', 21:19:54 INFO - 'tpaint', 21:19:54 INFO - 'sessionrestore', 21:19:54 INFO - 'sessionrestore_no_auto_restore', 21:19:54 INFO - 'tabpaint']}, 21:19:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['tsvgx', 21:19:54 INFO - 'tsvgr_opacity', 21:19:54 INFO - 'tart', 21:19:54 INFO - 'tscrollx', 21:19:54 INFO - 'cart']}, 21:19:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:19:54 INFO - 'tsvgr_opacity', 21:19:54 INFO - 'tart', 21:19:54 INFO - 'tscrollx', 21:19:54 INFO - 'cart']}, 21:19:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'talos_options': ['--disable-e10s'], 21:19:54 INFO - 'tests': ['tp5o']}, 21:19:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'tests': ['tp5o']}, 21:19:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'talos_options': ['--disable-e10s', 21:19:54 INFO - '--xperf_path', 21:19:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:54 INFO - 'tests': ['tp5n']}, 21:19:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:54 INFO - 'talos_options': ['--xperf_path', 21:19:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:54 INFO - 'tests': ['tp5n']}}, 21:19:54 INFO - 'talos.zip': {'path': '', 21:19:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:19:54 INFO - Running post-action listener: _resource_record_post_action 21:19:54 INFO - ##### 21:19:54 INFO - ##### Running create-virtualenv step. 21:19:54 INFO - ##### 21:19:54 INFO - Running pre-action listener: _resource_record_pre_action 21:19:54 INFO - Running main action method: create_virtualenv 21:19:54 INFO - Creating virtualenv /builds/slave/test/build/venv 21:19:54 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 21:19:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:19:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:19:54 INFO - Using real prefix '/tools/python27' 21:19:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:19:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:19:58 INFO - Installing pip.................done. 21:19:58 INFO - Return code: 0 21:19:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:19:58 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')]} 21:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:58 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')]} 21:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:58 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:19:58 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 21:19:58 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 21:19:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:19:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:19:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:19:58 INFO - 'HOME': '/Users/cltbld', 21:19:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:19:58 INFO - 'LOGNAME': 'cltbld', 21:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:58 INFO - 'MOZ_NO_REMOTE': '1', 21:19:58 INFO - 'NO_EM_RESTART': '1', 21:19:58 INFO - 'PAGER': '/bin/cat', 21:19:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:58 INFO - 'PWD': '/builds/slave/test', 21:19:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:19:58 INFO - 'SHELL': '/bin/bash', 21:19:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:19:58 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:19:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:19:58 INFO - 'USER': 'cltbld', 21:19:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:19:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:58 INFO - 'XPC_FLAGS': '0x0', 21:19:58 INFO - 'XPC_SERVICE_NAME': '0', 21:19:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:58 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 21:19:58 INFO - Cleaning up... 21:19:58 INFO - Return code: 0 21:19:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:19:58 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')]} 21:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:58 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')]} 21:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:58 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:19:58 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 21:19:58 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 21:19:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:19:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:19:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:19:58 INFO - 'HOME': '/Users/cltbld', 21:19:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:19:58 INFO - 'LOGNAME': 'cltbld', 21:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:58 INFO - 'MOZ_NO_REMOTE': '1', 21:19:58 INFO - 'NO_EM_RESTART': '1', 21:19:58 INFO - 'PAGER': '/bin/cat', 21:19:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:58 INFO - 'PWD': '/builds/slave/test', 21:19:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:19:58 INFO - 'SHELL': '/bin/bash', 21:19:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:19:58 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:19:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:19:58 INFO - 'USER': 'cltbld', 21:19:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:19:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:58 INFO - 'XPC_FLAGS': '0x0', 21:19:58 INFO - 'XPC_SERVICE_NAME': '0', 21:19:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:58 INFO - Downloading/unpacking psutil>=0.7.1 21:19:58 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 21:19:58 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 21:19:58 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 21:19:58 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 21:19:58 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 21:19:58 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 21:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:02 INFO - Installing collected packages: psutil 21:20:02 INFO - Running setup.py install for psutil 21:20:02 INFO - building 'psutil._psutil_osx' extension 21:20:02 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 21:20:02 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 21:20:02 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 21:20:02 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 21:20:02 INFO - building 'psutil._psutil_posix' extension 21:20:02 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 21:20:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:20:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:20:03 INFO - ^ 21:20:03 INFO - 1 warning generated. 21:20:03 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 21:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:03 INFO - Successfully installed psutil 21:20:03 INFO - Cleaning up... 21:20:03 INFO - Return code: 0 21:20:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:20:03 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')]} 21:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:03 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')]} 21:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:03 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:03 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 21:20:03 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 21:20:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:03 INFO - 'HOME': '/Users/cltbld', 21:20:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:03 INFO - 'LOGNAME': 'cltbld', 21:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:03 INFO - 'MOZ_NO_REMOTE': '1', 21:20:03 INFO - 'NO_EM_RESTART': '1', 21:20:03 INFO - 'PAGER': '/bin/cat', 21:20:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:03 INFO - 'PWD': '/builds/slave/test', 21:20:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:03 INFO - 'SHELL': '/bin/bash', 21:20:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:03 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:03 INFO - 'USER': 'cltbld', 21:20:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:03 INFO - 'XPC_FLAGS': '0x0', 21:20:03 INFO - 'XPC_SERVICE_NAME': '0', 21:20:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:20:03 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 21:20:03 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 21:20:03 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 21:20:03 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 21:20:03 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 21:20:03 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 21:20:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:20:06 INFO - Installing collected packages: mozsystemmonitor 21:20:06 INFO - Running setup.py install for mozsystemmonitor 21:20:06 INFO - Successfully installed mozsystemmonitor 21:20:06 INFO - Cleaning up... 21:20:06 INFO - Return code: 0 21:20:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:20:06 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')]} 21:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:06 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')]} 21:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:06 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:06 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 21:20:06 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 21:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:06 INFO - 'HOME': '/Users/cltbld', 21:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:06 INFO - 'LOGNAME': 'cltbld', 21:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:06 INFO - 'MOZ_NO_REMOTE': '1', 21:20:06 INFO - 'NO_EM_RESTART': '1', 21:20:06 INFO - 'PAGER': '/bin/cat', 21:20:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:06 INFO - 'PWD': '/builds/slave/test', 21:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:06 INFO - 'SHELL': '/bin/bash', 21:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:06 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:06 INFO - 'USER': 'cltbld', 21:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:06 INFO - 'XPC_FLAGS': '0x0', 21:20:06 INFO - 'XPC_SERVICE_NAME': '0', 21:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:20:06 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 21:20:06 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 21:20:06 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 21:20:06 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 21:20:06 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 21:20:06 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 21:20:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:20:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:20:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:10 INFO - Downloading docopt-0.6.1.tar.gz 21:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:20:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:20:10 INFO - Running setup.py install for blobuploader 21:20:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:20:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:20:10 INFO - Running setup.py install for requests 21:20:10 INFO - Running setup.py install for docopt 21:20:10 INFO - Successfully installed blobuploader requests docopt 21:20:10 INFO - Cleaning up... 21:20:11 INFO - Return code: 0 21:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:11 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:11 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 21:20:11 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 21:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:11 INFO - 'HOME': '/Users/cltbld', 21:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:11 INFO - 'LOGNAME': 'cltbld', 21:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:11 INFO - 'MOZ_NO_REMOTE': '1', 21:20:11 INFO - 'NO_EM_RESTART': '1', 21:20:11 INFO - 'PAGER': '/bin/cat', 21:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:11 INFO - 'PWD': '/builds/slave/test', 21:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:11 INFO - 'SHELL': '/bin/bash', 21:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:11 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:11 INFO - 'USER': 'cltbld', 21:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:11 INFO - 'XPC_FLAGS': '0x0', 21:20:11 INFO - 'XPC_SERVICE_NAME': '0', 21:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:20:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-NaEo32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:20:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-2zRccN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:20:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-aVzd8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:20:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mtehFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-i91aK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-0j1Wzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-08u95G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-D8EWzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-3fAxaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-DfI_93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-DJg850-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-b6vCUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:20:12 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-h3nn89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:20:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-pWK47F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-HFJj_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:20:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-jrbKDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:20:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xcon1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:20:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:20:13 INFO - Running setup.py install for manifestparser 21:20:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:20:13 INFO - Running setup.py install for mozcrash 21:20:13 INFO - Running setup.py install for mozdebug 21:20:13 INFO - Running setup.py install for mozdevice 21:20:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Running setup.py install for mozfile 21:20:14 INFO - Running setup.py install for mozhttpd 21:20:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Running setup.py install for mozinfo 21:20:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Running setup.py install for mozInstall 21:20:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Running setup.py install for mozleak 21:20:14 INFO - Running setup.py install for mozlog 21:20:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:20:14 INFO - Running setup.py install for moznetwork 21:20:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:20:15 INFO - Running setup.py install for mozprocess 21:20:15 INFO - Running setup.py install for mozprofile 21:20:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:20:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:20:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:20:15 INFO - Running setup.py install for mozrunner 21:20:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:20:15 INFO - Running setup.py install for mozscreenshot 21:20:15 INFO - Running setup.py install for moztest 21:20:15 INFO - Running setup.py install for mozversion 21:20:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:20:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:20:16 INFO - Cleaning up... 21:20:16 INFO - Return code: 0 21:20:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:16 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:16 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 21:20:16 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 21:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:16 INFO - 'HOME': '/Users/cltbld', 21:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:16 INFO - 'LOGNAME': 'cltbld', 21:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:16 INFO - 'MOZ_NO_REMOTE': '1', 21:20:16 INFO - 'NO_EM_RESTART': '1', 21:20:16 INFO - 'PAGER': '/bin/cat', 21:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:16 INFO - 'PWD': '/builds/slave/test', 21:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:16 INFO - 'SHELL': '/bin/bash', 21:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:16 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:16 INFO - 'USER': 'cltbld', 21:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:16 INFO - 'XPC_FLAGS': '0x0', 21:20:16 INFO - 'XPC_SERVICE_NAME': '0', 21:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-nNaCe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:20:16 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)) 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-gfdeQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:20:16 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)) 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-0AcSUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:20:16 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)) 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-rATref-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:20:16 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)) 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xqvcJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:20:16 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)) 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8FaqCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:20:16 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)) 21:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:20:16 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-2__8_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hgSE5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-W7KXRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hYt_9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-RhPoa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5nsycp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-i2iIZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hyFweF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JWjeio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-s6C9G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:20:17 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)) 21:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:20:17 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xAPUQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:20:18 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)) 21:20:18 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)) 21:20:18 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)) 21:20:18 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)) 21:20:18 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)) 21:20:18 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)) 21:20:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:20: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 21:20: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 21:20: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 21:20: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 21:20: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 21:20: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 21:20:20 INFO - Downloading blessings-1.6.tar.gz 21:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:20:20 INFO - Installing collected packages: blessings 21:20:20 INFO - Running setup.py install for blessings 21:20:20 INFO - Successfully installed blessings 21:20:20 INFO - Cleaning up... 21:20:20 INFO - Return code: 0 21:20:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:21 INFO - Reading from file tmpfile_stdout 21:20:21 INFO - Current package versions: 21:20:21 INFO - blessings == 1.6 21:20:21 INFO - blobuploader == 1.2.4 21:20:21 INFO - docopt == 0.6.1 21:20:21 INFO - manifestparser == 1.1 21:20:21 INFO - mozInstall == 1.12 21:20:21 INFO - mozcrash == 0.17 21:20:21 INFO - mozdebug == 0.1 21:20:21 INFO - mozdevice == 0.48 21:20:21 INFO - mozfile == 1.2 21:20:21 INFO - mozhttpd == 0.7 21:20:21 INFO - mozinfo == 0.9 21:20:21 INFO - mozleak == 0.1 21:20:21 INFO - mozlog == 3.1 21:20:21 INFO - moznetwork == 0.27 21:20:21 INFO - mozprocess == 0.22 21:20:21 INFO - mozprofile == 0.28 21:20:21 INFO - mozrunner == 6.11 21:20:21 INFO - mozscreenshot == 0.1 21:20:21 INFO - mozsystemmonitor == 0.0 21:20:21 INFO - moztest == 0.7 21:20:21 INFO - mozversion == 1.4 21:20:21 INFO - psutil == 3.1.1 21:20:21 INFO - requests == 1.2.3 21:20:21 INFO - wsgiref == 0.1.2 21:20:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:21 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:21 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 21:20:21 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 21:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:21 INFO - 'HOME': '/Users/cltbld', 21:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:21 INFO - 'LOGNAME': 'cltbld', 21:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:21 INFO - 'MOZ_NO_REMOTE': '1', 21:20:21 INFO - 'NO_EM_RESTART': '1', 21:20:21 INFO - 'PAGER': '/bin/cat', 21:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:21 INFO - 'PWD': '/builds/slave/test', 21:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:21 INFO - 'SHELL': '/bin/bash', 21:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:21 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:21 INFO - 'USER': 'cltbld', 21:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:21 INFO - 'XPC_FLAGS': '0x0', 21:20:21 INFO - 'XPC_SERVICE_NAME': '0', 21:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 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)) 21:20:21 INFO - Cleaning up... 21:20:21 INFO - Return code: 0 21:20:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:21 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 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:21 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 21:20:21 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 21:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:21 INFO - 'HOME': '/Users/cltbld', 21:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:21 INFO - 'LOGNAME': 'cltbld', 21:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:21 INFO - 'MOZ_NO_REMOTE': '1', 21:20:21 INFO - 'NO_EM_RESTART': '1', 21:20:21 INFO - 'PAGER': '/bin/cat', 21:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:21 INFO - 'PWD': '/builds/slave/test', 21:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:21 INFO - 'SHELL': '/bin/bash', 21:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:21 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:21 INFO - 'USER': 'cltbld', 21:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:21 INFO - 'XPC_FLAGS': '0x0', 21:20:21 INFO - 'XPC_SERVICE_NAME': '0', 21:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:21 INFO - Downloading/unpacking jsonschema 21:20:21 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 21:20:21 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 21:20:21 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 21:20:21 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 21:20:21 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 21:20:21 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 21:20:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:20:24 INFO - Downloading/unpacking functools32 (from jsonschema) 21:20:24 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 21:20:24 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 21:20:24 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 21:20:24 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 21:20:24 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 21:20:24 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 21:20:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:20:24 INFO - warning: no files found matching '*.txt' 21:20:24 INFO - no previously-included directories found matching 'build' 21:20:24 INFO - no previously-included directories found matching 'dist' 21:20:24 INFO - no previously-included directories found matching '.git*' 21:20:24 INFO - Installing collected packages: jsonschema, functools32 21:20:24 INFO - Running setup.py install for functools32 21:20:24 INFO - warning: no files found matching '*.txt' 21:20:24 INFO - no previously-included directories found matching 'build' 21:20:24 INFO - no previously-included directories found matching 'dist' 21:20:24 INFO - no previously-included directories found matching '.git*' 21:20:24 INFO - Successfully installed jsonschema functools32 21:20:24 INFO - Cleaning up... 21:20:24 INFO - Return code: 0 21:20:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:20:24 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')]} 21:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:24 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')]} 21:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1e7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8ea5cd1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, '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.XjuIels4kG/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.WtMNyu2ayw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 21:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:25 INFO - 'HOME': '/Users/cltbld', 21:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:25 INFO - 'LOGNAME': 'cltbld', 21:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:25 INFO - 'MOZ_NO_REMOTE': '1', 21:20:25 INFO - 'NO_EM_RESTART': '1', 21:20:25 INFO - 'PAGER': '/bin/cat', 21:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:25 INFO - 'PWD': '/builds/slave/test', 21:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:25 INFO - 'SHELL': '/bin/bash', 21:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:25 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:25 INFO - 'USER': 'cltbld', 21:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:25 INFO - 'XPC_FLAGS': '0x0', 21:20:25 INFO - 'XPC_SERVICE_NAME': '0', 21:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:25 INFO - Downloading/unpacking flake8 21:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:20:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:20:27 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 21:20:27 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 21:20:27 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 21:20:27 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 21:20:27 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 21:20:27 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 21:20:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:20:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:20:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:20:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:20:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:20:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:20:29 INFO - no previously-included directories found matching 'docs/_build' 21:20:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:20:29 INFO - Running setup.py install for pep8 21:20:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:20:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:20:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:20:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:20:29 INFO - no previously-included directories found matching 'docs/_build' 21:20:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:20:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:20:29 INFO - Cleaning up... 21:20:29 INFO - Return code: 0 21:20:29 INFO - Running post-action listener: _resource_record_post_action 21:20:29 INFO - Running post-action listener: _start_resource_monitoring 21:20:29 INFO - Starting resource monitoring. 21:20:29 INFO - ##### 21:20:29 INFO - ##### Running install step. 21:20:29 INFO - ##### 21:20:29 INFO - Running pre-action listener: _resource_record_pre_action 21:20:29 INFO - Running main action method: install 21:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:29 INFO - Reading from file tmpfile_stdout 21:20:29 INFO - Detecting whether we're running mozinstall >=1.0... 21:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:20:29 INFO - Reading from file tmpfile_stdout 21:20:29 INFO - Output received: 21:20:29 INFO - Usage: mozinstall [options] installer 21:20:29 INFO - Options: 21:20:29 INFO - -h, --help show this help message and exit 21:20:29 INFO - -d DEST, --destination=DEST 21:20:29 INFO - Directory to install application into. [default: 21:20:29 INFO - "/builds/slave/test"] 21:20:29 INFO - --app=APP Application being installed. [default: firefox] 21:20:29 INFO - mkdir: /builds/slave/test/build/application 21:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 21:20:51 INFO - Reading from file tmpfile_stdout 21:20:51 INFO - Output received: 21:20:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:20:51 INFO - Running post-action listener: _resource_record_post_action 21:20:51 INFO - ##### 21:20:51 INFO - ##### Running run-tests step. 21:20:51 INFO - ##### 21:20:51 INFO - Running pre-action listener: _resource_record_pre_action 21:20:51 INFO - Running main action method: run_tests 21:20:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:20:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:20:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:20:52 INFO - 2016-07-01 21:20:52.010 screenresolution[1644:7901] starting screenresolution argv=screenresolution get 21:20:52 INFO - 2016-07-01 21:20:52.013 screenresolution[1644:7901] Display 0: 1600x1200x32@60 21:20:52 INFO - 2016-07-01 21:20:52.018 screenresolution[1645:7903] starting screenresolution argv=screenresolution list 21:20:52 INFO - Available Modes on Display 0 21:20:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:20:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:20:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:20:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:20:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:20:52 INFO - Intel Iris: 21:20:52 INFO - Chipset Model: Intel Iris 21:20:52 INFO - Type: GPU 21:20:52 INFO - Bus: Built-In 21:20:52 INFO - VRAM (Dynamic, Max): 1536 MB 21:20:52 INFO - Vendor: Intel (0x8086) 21:20:52 INFO - Device ID: 0x0a2e 21:20:52 INFO - Revision ID: 0x0009 21:20:52 INFO - Displays: 21:20:52 INFO - Display: 21:20:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:20:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:20:52 INFO - Display Serial Number: 1600x1200 60 21:20:52 INFO - Main Display: Yes 21:20:52 INFO - Mirror: Off 21:20:52 INFO - Online: Yes 21:20:52 INFO - Rotation: Supported 21:20:52 INFO - Return code: 0 21:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:20:52 INFO - Python 2.7.3 21:20:52 INFO - Return code: 0 21:20:52 INFO - grabbing minidump binary from tooltool 21:20:52 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')]} 21:20:52 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 0x10b076e00>, '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 0x10aedfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b071b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:20:52 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 21:20:52 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 21:20:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:20:52 INFO - Return code: 0 21:20:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:20:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:20:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:20:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:20:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:20:53 INFO - Return code: 0 21:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:20:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XjuIels4kG/Render', 21:20:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:20:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:20:53 INFO - 'HOME': '/Users/cltbld', 21:20:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:20:53 INFO - 'LOGNAME': 'cltbld', 21:20:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:20:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:53 INFO - 'MOZ_NO_REMOTE': '1', 21:20:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:20:53 INFO - 'NO_EM_RESTART': '1', 21:20:53 INFO - 'PAGER': '/bin/cat', 21:20:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:53 INFO - 'PWD': '/builds/slave/test', 21:20:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:20:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:20:53 INFO - 'SHELL': '/bin/bash', 21:20:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtMNyu2ayw/Listeners', 21:20:53 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 21:20:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:20:53 INFO - 'USER': 'cltbld', 21:20:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:20:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:53 INFO - 'XPC_FLAGS': '0x0', 21:20:53 INFO - 'XPC_SERVICE_NAME': '0', 21:20:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:20:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:20:53 INFO - mozversion application_buildid: 20160701192722 21:20:53 INFO - mozversion application_changeset: e8999eb7311ec1063176e4a836388b763fb91942 21:20:53 INFO - mozversion application_display_name: Firefox 21:20:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:20:53 INFO - mozversion application_name: Firefox 21:20:53 INFO - mozversion application_remotingname: firefox 21:20:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:20:53 INFO - mozversion application_vendor: Mozilla 21:20:53 INFO - mozversion application_version: 48.0 21:20:53 INFO - mozversion platform_buildid: 20160701192722 21:20:53 INFO - mozversion platform_changeset: e8999eb7311ec1063176e4a836388b763fb91942 21:20:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:20:53 INFO - mozversion platform_version: 48.0 21:20:53 INFO - using testdate: 1467433253 21:20:53 INFO - actual date: 1467433253 21:20:53 INFO - starting webserver on 'localhost:49275' 21:20:53 INFO - SUITE-START | Running 2 tests 21:20:53 INFO - TEST-START | dromaeo_css 21:20:53 INFO - operating with platform_type : mac_ 21:20:53 INFO - Initialising browser for dromaeo_css test... 21:20:53 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmp2aMilV/profile http://localhost:49275/getInfo.html) 21:20:56 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 21:20:56 INFO - PROCESS | 1663 | colorDepth:24 21:20:56 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 21:20:56 INFO - PROCESS | 1663 | __metrics 21:20:56 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:20:57 INFO - TEST-INFO | 1663: exit 0 21:20:57 INFO - Browser initialized. 21:20:57 INFO - Running cycle 1/1 for dromaeo_css test... 21:20:57 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmp2aMilV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:09 INFO - PROCESS | 1668 | RSS: Main: 171585536 21:21:09 INFO - PROCESS | 1668 | 21:21:58 INFO - PROCESS | 1668 | 1467433318836 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] 21:24:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 21:24:10 INFO - PROCESS | 1668 | RSS: Main: 181796864 21:24:10 INFO - PROCESS | 1668 | 21:27:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 21:27:13 INFO - PROCESS | 1668 | RSS: Main: 192655360 21:27:13 INFO - PROCESS | 1668 | 21:30:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 21:30:15 INFO - PROCESS | 1668 | RSS: Main: 194793472 21:30:15 INFO - PROCESS | 1668 | 21:33:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 21:33:17 INFO - PROCESS | 1668 | RSS: Main: 198488064 21:33:17 INFO - PROCESS | 1668 | 21:36:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 21:36:21 INFO - PROCESS | 1668 | RSS: Main: 197677056 21:36:21 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 21:39:23 INFO - PROCESS | 1668 | RSS: Main: 202559488 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | __start_tp_report 21:39:23 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 21:39:23 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 21:39:23 INFO - PROCESS | 1668 | |i|pagename|runs| 21:39:23 INFO - PROCESS | 1668 | |0;dojo.html;3623.927521449571;3649.817509124544;3689.723270754691;3692.1877187018863;3711.610280920503;6010.8497287567725;6028.306744724358;6028.85451764165;6069.115765909815;6070.180525629039;6008.729607167677;6024.608400453967;6044.939550604493;6053.303870054945;6062.575619706622;5302.443243459429;5372.328458942632;5381.757820898049;5381.838544843661;5479;5290.550303224211;5371.543418809406;5393.325834270716;5398.13629819229;5474.069408200616;5341.65279256849;5387.24578559002;5389.78440862365;5412.99859525987;5482.533984611313;5362.276092727471;5438.374586922515;5453.7818487260465;5465.6447330923365;5472.50747432733;5306.177542480922;5373.623846330758;5376.166694162411;5444.128939369722;5451.563874889999;5624.493795558378;5814.447627475383;5869.7945571904775;5945.91081133779;5980.581359304851;6274.341194174592;6314.747410103636;6319.620822750604;6326.715297811609;6327.841803954938;5343.706096164709;6316.08416779569;6325.430711236011;6364.586301890362;6387.329330420285;4941.827036053721;5966.70166491678;6085.726142323561;6094.847628809227;6189.876202475925;6436.581622194542;6528.314526974599;6537.313582073813;6537.673116344164;6545.9018114728315;5347.919781203285;6276.686165691697;6302.905456418157;6328.905066424008;6330.746770129235;6288.874222515616;6364;6402.103705481236;6432.903506447314;6439.356064393523;6278.717457714414;6284.183056202664;6292.276388215322;6297.779577714849;6299.937000630027;6186.969065154645;6298.685065746694;6304.779332723333;6313.084602732578;6316.526260530479;4993.226049962262;5137.255098010767;5139.897202055938;5146.716930568779;5152.227165925141;4581.152486789888;4610.400647915817;4634.0500197460115;4641.95358046422;4652.674312798072;5869.972754767899;6080.908786368208;6144.754209831646;6206.224221972254;6211.16149319836;6303.842403939847;6357.936420635734;6360.872782544323;6397.912354899679;6431.485481161496;6181.072839074175;6187.195664563668;6213.130161777355;6216.627002379872;6250.812475625738;5424.077906755861;5555.2500412444615;5608.186812912105;5646.20953066571;5684.943150568524;6596.670166491656;6657.40083392497;6668.466522678174;6686.231083425371;6688.297728738413;6413.230412350548;6435.420812126931;6436.195475565554;6442.774502892376;6481.319461456667;6470.741170353133;6587.077809106825;6647.235567909753;6676.83307917306;6682.46540276767;6293.276273228637;6335.1130841683125;6343.111964324906;6343.873122537431;6369.90445143314;6367.3314301997625;6393.200849893763;6412.583182093149;6414.5189110815945;6427.871442571216;6170.6914654268;6187.195664563578;6213.65824879636;6280.309165991828;6294.370562943669;6207.689615519115;6276.843078923063;6277.937220627735;6286.968565157145;6288.308286088618;6119.938800612115;6222.09779581949;6252.781152659635;6253.2496100466415;6254.655993920378;6093.725782339717;6183.5671502994355;6215.81352559424;6230.408111229426;6247.687615619292;6230.875382492234;6251.531135164972;6260.280067792262;6274.560780745304;6275.466585340298 21:39:23 INFO - PROCESS | 1668 | |1;ext.html;558.5978095771045;580.7909152705025;586.3579380578266;609.9512039036877;626.1922120464598;33467.33065338692;40012.79993600028;40072.39891401631;40161.59838401611;40165.59834401655;43321.78339108308;43424;43707.78146109273;44162;44174.33738493917;9681.419114853095;9742.1719153872;9837.360571562862;9907.603695852158;9910.752231194241;8617;9888.505574721272;9936.701898943043;9991.900080999207;10035.29752917296;9898.208143348551;9902.207823374149;9904.207663386911;9971.401715897033;10002.099811017008;9932.155766759834;9999.35004224723;10010.349327293776;10022.749431264203;10024.949875250613;9659;9814.411135331831;9819.459929703864;9837.704868853945;9849.409035457895;39364;39508.20983580312;39513;39877.60122398768;39969.80015099935;3340.916477088068;3469.028671971852;3469.271452994874;3499.965000349989;3514.437689969618;27378.315542111406;28707.425851482854;29340.826366945297;30663.38673226523;31327;2753.765929895961;2789.330560665446;2801.145650576573;2816.7183281671873;2848.088611644275;414453;415869.6826063492;416615;418917.81082189095;420772;37402.06494837651;38485.230295394496;62652.373476265566;62843;63039.369606304266;36439.27121457609;36499;36601.45097823535;37179.4423083654;37434.06414839651;15527.922360388126;16447.91776041136;16455.588610284838;16622.25199866009;16651.6669666606;13995.37020834065;14021;14068.648283792987;14150.080244784056;14161.150330980174;8464.703735369232;8522.403431759842;8539.975202975682;8585;8615.526146061902;3533.505309256706;3564.198055437506;3566.661167189113;3573.3210689968823;3579.46308053794;1000.2897942460788;1008.8196809732631;1029.3206483720708;1093.1965005720788;1152.4698638626157;24612.50774984526;30355.392892142034;30723.69276307253;31159.84420077885;31339.843300783807;1039.4594810698395;1110.2394859521253;1120.8094623913955;1174.2836869509592;1215;12202.38988050594;15653.686926261411;15891.443799466962;15975.920120399323;16257.918710406373;611609;703014;707068;723583;725700;60389.09416358758;60542.697286514165;61399.07901381483;61516;61547.6922615384;1556.750919852818;1563.4137198550316;1572.088188850464;1575.070708282119;1579.8104227492774;30884.536731949487;31612.367752645278;31653.84173079212;31894;32253.193670158435;55334;56070.43929560652;56178.43821561895;56236.71881640566;56275.59311017257;471645.28354716016;481920;483351;483597;484568;27534.586981194898;28723;28822.279443014093;28990.85504572548;29007.98472053468;45680.77159614181;47087.529124708315;47099.82250443629;47866.52133478621;48875.51124488709;38969.83090507289;39440.01399965024;39512.20975580415;40612.79693601513;41161;36911.815440922626;37238.8138059308;37278.627213727515;37757.81121094377;37885.05287367838;34091;36692.266154677294;36722.26555468929;39240.803795980835;40035.59964400319;31871.36257274888;33346.666533334355;33383.33233335368;33629;33723.32553348968;24792;25159;25519;25965.48069038571;26274.73725262723 21:39:23 INFO - PROCESS | 1668 | |2;jquery.html;389.6006593241927;411.12225398773626;413.5203164329379;414.9751014939106;424.5436156132159;20563.794362056375;20839.47901302468;20879.895600521995;21284.36146915595;21959.121635134616;20978.790212097912;21178.57642847146;21382.89308553459;21394.57210855786;21450.463738406546;5949.643021418718;5961.8807623847715;6241.407066328691;6243;6264.21697287839;6051.152838602599;6089.939100608982;6139.447449729523;6169.845753856167;6225.0351195564535;4963.801447942096;6021.909671354933;6026.517878569726;6045;6075.362086980847;6019.127226552169;6037.879242415149;6097.237845269341;6110.114033465167;6160.7535698572;4268.509121451042;5262.710550919698;5266.289050978107;5346;5373.59698022646;26085.73914260852;26621.467570648478;26705.732942670715;26807.865960670268;27006.5949010765;2236.6868638390474;2420.9394765131015;2496.213692686798;2603.153974958146;2698.446818402223;14458.855411445857;15291.617709557238;15298.923505382401;15371;15730.528084157493;1727.06738361286;1805.6840052990674;1826.2603645523584;1833.5416145963509;1862.022438219932;103786;103811.96188038174;104063.95936040694;106461.46769266181;108543.45728271308;11399.658010259705;11780.352080635475;11919.642410727693;11925.522979080739;11948.103892207946;15040.947133700754;15111.773323400157;15145.772813407808;15227.543173704586;15268.465603703817;7602.50583712057;9220;9259.907400926038;9315.928668203243;9368.203702685212;7653.655585498666;9339.579718912666;9393.389429687048;9398.2951278653;9495.90504094964;4775.379200703956;4814.9518504815205;4825.420949486014;4855.660103792771;4856.538628830255;2007.5483016321211;2064.7935206479233;2073.243266207823;2110.51458164623;2114.534802343482;945.5508633399218;962.8940816510178;994.955227014786;999.9050090241416;1085.5766251162054;20110.89944550268;20249.39251822448;20383.694244586342;20448;20802.063907124215;1004.638330201127;1010.1716592394166;1036.9429681367446;1040.9375437473775;1051.9631812886512;9378.48418336998;11048.392338421303;11219.990200881959;11349.716257093638;11361.431928403546;510270;514709;517107;585176;641938;79604;80114.99712507117;81621;130118;132513;1039.8752149741929;1067.6263307842348;1069.983950240747;1079.0450451350612;1079.8434227037035;18271.1777969989;19066.142023608692;19173.90413047926;19227.230910763414;19428.611427771648;50810.90767898246;51612.22581661203;51862;52562.47437525729;53759.19361209507;64476.065718028534;72194.63902680454;74972.62513687396;76382.6180869092;76401.61799190969;7789.454738168501;8021.358291336795;8031.959840200761;8072.313853322534;8149.796255093433;11661.475233614678;11709.297442153498;12647.177933434297;12662.556810511587;12762.42569084412;9242.630294788134;10732.839007415052;10927.398993055458;11062.889371106186;11280.943595282299;10435.828252562795;10658.840117398091;10788.838167427652;11060.612878549213;11077.556897724;9017.774555636162;11184.94407527957;11307.604233851776;11384.715382115513;11539.249948753304;8025.8394832104195;8126.228008339198;8150.184981501802;8238.794030149054;8344.87482687748;10635.14918806478;10876.619318323821;11169.106471482424;11209.215354925076;11278.37968911685 21:39:23 INFO - PROCESS | 1668 | |3;mootools.html;1464.1507925403266;1646.497818165459;1923.9706756885062;2061.8453615978806;2068.896555172243;7500.849983000344;8255.504669719807;9135.223506001981;9187.402818816781;9277.628894844214;8267.718503631932;8459.069502354752;8869.157430044135;8953.955230223855;8966.596503157358;2544.414784599543;2557.514072326252;2565.422779874523;2569.9100531481404;2575.84544927305;2506.8997240110375;2553.3871870751072;2553.399951011511;2574.781143602796;2575.2016874768788;2535.695716514021;2544.75824796644;2564.064116597447;2574.2405990232833;2579.5872660374343;2544.592865141578;2558.8592627405487;2573.099415204673;2576.9742302576924;2579.858107804089;2328.5459335429596;2549.8852551635223;2575.7553032461888;2585.082295784988;2587.4178309880313;7606.695732170707;9137.680181193626;9283.164515193665;9290.02454742249;9321.906780932171;5621.494065534081;5673.602847800656;5722.9984752668115;5774.7112644368035;5835.44563266489;3649.562052553684;3771.9434208486896;3806.90482737931;3820.5290962979175;3822.7515211511163;895.2122132523402;1047.089032541686;1085.4355735017825;1088.6407485529755;1090.5910283643634;12122.575709850113;12143;12524.561640342545;12526.185797923106;12609.243445393306;4231.534531201565;4923.040007198562;5007.624428167902;5045.032437349437;5128;10469.581216751398;10549.736256593493;10550.736231594117;10605.416702081306;10606.946965265279;5546.195801608744;5588.6646801192055;5652.858678532987;5658.91511627326;5725.883452726762;4578.1301552705545;5028.371453568304;5055.393352797688;5096.413912400048;5154.123798954187;4187.497500299984;4208.8316467340965;4232.195882782262;4273.9358909616385;4303.913921721548;1401.4814518628173;1417.4188582681052;1425.0737020936267;1427.1793718611839;1430.4778755754076;931.6040682709821;964.0167029629879;980.4705459052175;1001.329109496639;1008.4788029925187;5847;6039.516838652898;6219.440250377488;6266.655333956676;6278.058291256257;423.8325861284837;465.73220398271127;475.93812804335215;1041.073444634276;1118.5078565431347;3791.5829258781514;3982.5021872265966;4027.1744292419985;4053.6757059435176;4134.565870583606;10748.462576871125;10956.561737530568;11144.888551114547;11170.273932194545;11209.831852522218;10815;10977.012068913837;11009.339439633648;11037.503312350964;11045.779084418427;8338.749837504885;8558.786030349167;8669.826603467895;8708.34687398435;8750.824983500293;5031.823886163967;5656.8020119295625;5823.155642431739;5857.707114644336;5873.911891321548;9793.167580755715;9862.358946668444;9907.058829411195;9998.700038998843;10043.949780251052;10152.695419137437;10221.33561318512;10223.977602239716;10255.846162307422;10275;5749.453801888814;6909.827254318682;7611.657475413509;7713.1129920057665;7780.688772449265;7380.96309518449;8398.076211616839;8483.406161568631;8517.616707248313;8560.058393576826;7508.737194198176;7613.9238607613215;7638.961805190938;7686.3082322591235;7695.115061767969;7481.476296659182;7494.325510704063;7535.8116047099265;7538.811529711801;7649.04386951631;7153.141623005273;7254.746083887038;7261.636918154177;7291.890621640786;7345;5022.698638081727;5051.6716413433005;5103.948960510347;5189.76646050921;5241.187615919539;4925.039617274597;5194.3247377840635;5195.480451954774;5201.1678131498775;5243.318368612056 21:39:23 INFO - PROCESS | 1668 | |4;prototype.html;275.621021095993;322.157557985867;342.8902751119643;344.42481056635415;347.4198089191051;6784.2198147213085;6856.897146542806;6964.025036494889;7016.754413595519;7017.578945263288;6895.620740859264;6912.205096413914;6921.273266307041;6929.579436215577;7004.544704594197;5112.846614601549;5138.614603904713;5143.922841157386;5145.588352931756;5149.897002059956;5118.61610379223;5144.588432925357;5154.098032844256;5161.200013997836;5165.845024649267;5071.619628527875;5079.542841144296;5079.746012699368;5080.745962701869;5098.062736160254;4888.193448081062;5077.898442031175;5079.568236699885;5083.262926875583;5097.847064588068;3607.8376473058775;4360.803763830635;4376.7811609419405;4383.539728328511;4408.559144085598;5201.609879259033;6593.637349945751;6603.240627327871;6717.496187785936;6719.798406047827;6042.093685947099;6044.304904935901;6058.93968555501;6067.7269522871575;6092.390760923872;7401.00086488328;7434.591097489636;7438.739644112484;7456.254374562554;7463.701451941915;4760.214564596838;4939.3578834751615;4947.406311242674;4953.702777833341;4968.031233909389;7092.787216383465;7887.974563306733;7934.3255823255095;7943.205679432069;7996.520643680938;5010.473900240495;5031.572316353151;5054.848354549369;5056.988602279559;5065.189569668835;5143.485651434901;5155.510226528474;5156.123459011977;5160.535551800356;5161.638685291993;6045;6046.909296360558;6053.818385448443;6055.303640081447;6067.635941843503;7259.4918355715645;7447.404207663374;7500.399968002546;7524.2851929066655;7532.698692052366;1477.7044591081826;1759.551314414816;1809.095452273863;1814.782226132846;1822.3348477805505;1078.2721662877527;1130.9547618095185;1131.8189089745601;1147.3821911105301;1155.78040172367;7007.334303241184;7067.363937245673;7086.255943126001;7103.183133939559;7140.892886606705;7638.579878106646;7725.768226953201;7749.7287594933905;7752.379809615217;7756.883646745303;6350.555461117678;7018.929810701828;7055.788326350218;7095.148582170173;7104.11198600175;3978.562358140602;4068.7558746475306;4100.753954762724;4106.219818234586;4107.424960505532;8025.759227223192;8065.475744076616;8077.313428358538;8089.47418417801;8132.2680958714;7961.203879612109;7971.441999060126;7986.920130798734;8010.078840933251;8024.478408903403;8079.192080791874;8091.959540202261;8092.595370231465;8102.675892964216;8113.269805717396;7438.40492760567;7673.309402153833;7680.193579674277;7684.269994350528;7705.152433232228;7522.5862577558755;7562.697492100255;7565.924340756522;7577.355924746238;7619.847603048019;8029.518228906284;8054.31538319226;8062.032556093306;8072.192780721881;8097.352211822922;5045.571126454292;5054.2671312660195;5059.974700126476;5066.82266120684;5071.847844564669;7439.070116235471;7605.353544948742;7640.808979775327;7649.426293027934;7675.232476752503;6303.716332765129;7374.520656157332;7407.66665500043;7408.222136675571;7436.628168591657;6632.933670663231;7301.598412087386;7339.082614673166;7346.889796653161;7355.742549010973;6363.93636063652;6667.866462701256;7013;7213.495055346076;7238.927610724036;5550.722463876709;7334.376577990931;7383.483156179231;7441.367483763941;7452.366548843409;7013.368796808311;7252.854942901007;7441.441891858024;7445.069366329209;7450.96274518624 21:39:23 INFO - PROCESS | 1668 | |5;yui.html;770.7302444144549;777.9844403111938;779.8050487378156;794.122494643419;796.9163237860024;13750.58748237552;14622.683958443751;15177;15585;15585.84414155858;14348.282585870717;14361.856381436182;14386.496472623461;14396.784048239284;14456.92771536141;765.3876898481207;935.5275585829181;944.8252073366415;974.7904200596905;975.1223898491344;959.1271942532297;964.6720115160844;972.2999440402899;973.0998826085878;976.1214906584061;997.7854761226334;998.3859926145404;1028.8559601655775;1044.94775261237;1053.9209559283047;1027.8201314769922;1027.9383237005804;1032.8708911386077;1035.4201647077662;1035.989640103597;654.4175683641563;764.6826566974698;767.6123557603374;771.5062360089547;781.4256521456725;15282.235888205656;15419.460318888898;15501.302441390164;15535.844641553553;15615.609609759847;13117.737645247136;13186.142900711424;13268.93365533166;13335.73328533424;13347.265900375476;10338.741531461774;10354.948225258826;10355;10381.480925953672;10752.462376881203;3064.9693503064905;3559.0924314299946;3606.8196590170387;3608.260306637133;3841.058940559553;77699.44601108003;80722.5963870177;80962;82150;82972.75540866831;9125.863112053325;9619.951900240594;9651.179649729711;9784.461854597923;10351.861295257515;21295.68056479154;21465;21491.14035438565;21542.35372938814;21615.56768864614;6518.380753828379;7571.659275332623;7788.532688038736;7790;7841.529508229524;4241.833252072138;4252.149570085995;4278.422412974209;4286.7856607169515;4422;3697.8335974881193;3765;3767.849286028583;3787.5833658297565;3788.412796016622;670.7115940145686;683.9555428897205;684.993060201503;686.9210040845267;697.6372286411038;625.8998560230341;626.8777588370315;627.3663599764179;631.2897989761518;650.1515522243518;8359.749207523784;8482.363822713321;8513.872291915626;8523;8788.824223515621;560.8205374280191;560.834553806628;599.487438240307;624.4380057947883;628.9433950944345;3334.4164771165433;3913.7064720146104;4020.798960051986;4170.854020109282;4213.894652633709;91481;92728.53635731777;93837;94921;95117.52441237749;80051.59974200209;80128.79806802902;80657.38685226263;81386.37227255422;81620.59189704132;73458.53082938312;73978.52042959111;74170;74247;75256.99999999891;7851.293383595504;7933.3653307736395;8007.879881801894;8050.637721302673;8186.386021048326;49318.75340623417;50586.2412063812;50642;50694.74652626713;50952.98094038173;39343.606563933994;50452;64381;68034.31965680279;69082.85502869844;8985.775355616162;9902.455364954996;10138.442385668564;10284.897151028394;10305.381677099398;11045.944770276097;11047.464390567435;11217.326960382403;11258.268212566158;11340.716482088013;8944.776380590538;10553.841692374774;10691;10724.678259652223;11180.720481988015;10227.130693891102;10450.477476126316;10586.735331616772;10846.67459976202;10881.292715973437;8850.513221772606;9137.680181193626;9698.321117521706;11337.603183888525;11873.228240164362;9726.124648781644;9841.015898410387;9846.966068562984;9905.653302134391;10080.84878726805;9727.124558789743;9914.801703965735;9950.651727189514;10138.188944884245;10150.695479135638 21:39:23 INFO - PROCESS | 1668 | __end_tp_report 21:39:23 INFO - PROCESS | 1668 | __start_cc_report 21:39:23 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,406 21:39:23 INFO - PROCESS | 1668 | __end_cc_report 21:39:23 INFO - PROCESS | 1668 | __startTimestamp1467434363458__endTimestamp 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | ------- Summary: start ------- 21:39:23 INFO - PROCESS | 1668 | Number of tests: 6 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5943.66 Median:6213.66 stddev:631.62 (10.2%) stddev-sans-first:606.78 21:39:23 INFO - PROCESS | 1668 | Values: 3623.9 3649.8 3689.7 3692.2 3711.6 6010.8 6028.3 6028.9 6069.1 6070.2 6008.7 6024.6 6044.9 6053.3 6062.6 5302.4 5372.3 5381.8 5381.8 5479.0 5290.6 5371.5 5393.3 5398.1 5474.1 5341.7 5387.2 5389.8 5413.0 5482.5 5362.3 5438.4 5453.8 5465.6 5472.5 5306.2 5373.6 5376.2 5444.1 5451.6 5624.5 5814.4 5869.8 5945.9 5980.6 6274.3 6314.7 6319.6 6326.7 6327.8 5343.7 6316.1 6325.4 6364.6 6387.3 4941.8 5966.7 6085.7 6094.8 6189.9 6436.6 6528.3 6537.3 6537.7 6545.9 5347.9 6276.7 6302.9 6328.9 6330.7 6288.9 6364.0 6402.1 6432.9 6439.4 6278.7 6284.2 6292.3 6297.8 6299.9 6187.0 6298.7 6304.8 6313.1 6316.5 4993.2 5137.3 5139.9 5146.7 5152.2 4581.2 4610.4 4634.1 4642.0 4652.7 5870.0 6080.9 6144.8 6206.2 6211.2 6303.8 6357.9 6360.9 6397.9 6431.5 6181.1 6187.2 6213.1 6216.6 6250.8 5424.1 5555.3 5608.2 5646.2 5684.9 6596.7 6657.4 6668.5 6686.2 6688.3 6413.2 6435.4 6436.2 6442.8 6481.3 6470.7 6587.1 6647.2 6676.8 6682.5 6293.3 6335.1 6343.1 6343.9 6369.9 6367.3 6393.2 6412.6 6414.5 6427.9 6170.7 6187.2 6213.7 6280.3 6294.4 6207.7 6276.8 6277.9 6287.0 6288.3 6119.9 6222.1 6252.8 6253.2 6254.7 6093.7 6183.6 6215.8 6230.4 6247.7 6230.9 6251.5 6260.3 6274.6 6275.5 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:66090.77 Median:37340.35 stddev:145839.90 (390.6%) stddev-sans-first:146166.02 21:39:23 INFO - PROCESS | 1668 | Values: 558.6 580.8 586.4 610.0 626.2 33467.3 40012.8 40072.4 40161.6 40165.6 43321.8 43424.0 43707.8 44162.0 44174.3 9681.4 9742.2 9837.4 9907.6 9910.8 8617.0 9888.5 9936.7 9991.9 10035.3 9898.2 9902.2 9904.2 9971.4 10002.1 9932.2 9999.4 10010.3 10022.7 10024.9 9659.0 9814.4 9819.5 9837.7 9849.4 39364.0 39508.2 39513.0 39877.6 39969.8 3340.9 3469.0 3469.3 3500.0 3514.4 27378.3 28707.4 29340.8 30663.4 31327.0 2753.8 2789.3 2801.1 2816.7 2848.1 414453.0 415869.7 416615.0 418917.8 420772.0 37402.1 38485.2 62652.4 62843.0 63039.4 36439.3 36499.0 36601.5 37179.4 37434.1 15527.9 16447.9 16455.6 16622.3 16651.7 13995.4 14021.0 14068.6 14150.1 14161.2 8464.7 8522.4 8540.0 8585.0 8615.5 3533.5 3564.2 3566.7 3573.3 3579.5 1000.3 1008.8 1029.3 1093.2 1152.5 24612.5 30355.4 30723.7 31159.8 31339.8 1039.5 1110.2 1120.8 1174.3 1215.0 12202.4 15653.7 15891.4 15975.9 16257.9 611609.0 703014.0 707068.0 723583.0 725700.0 60389.1 60542.7 61399.1 61516.0 61547.7 1556.8 1563.4 1572.1 1575.1 1579.8 30884.5 31612.4 31653.8 31894.0 32253.2 55334.0 56070.4 56178.4 56236.7 56275.6 471645.3 481920.0 483351.0 483597.0 484568.0 27534.6 28723.0 28822.3 28990.9 29008.0 45680.8 47087.5 47099.8 47866.5 48875.5 38969.8 39440.0 39512.2 40612.8 41161.0 36911.8 37238.8 37278.6 37757.8 37885.1 34091.0 36692.3 36722.3 39240.8 40035.6 31871.4 33346.7 33383.3 33629.0 33723.3 24792.0 25159.0 25519.0 25965.5 26274.7 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:32787.25 Median:2328.81 stddev:92287.91 (3962.9%) stddev-sans-first:92514.74 21:39:23 INFO - PROCESS | 1668 | Values: 389.6 411.1 413.5 415.0 424.5 20563.8 20839.5 20879.9 21284.4 21959.1 20978.8 21178.6 21382.9 21394.6 21450.5 5949.6 5961.9 6241.4 6243.0 6264.2 6051.2 6089.9 6139.4 6169.8 6225.0 4963.8 6021.9 6026.5 6045.0 6075.4 6019.1 6037.9 6097.2 6110.1 6160.8 4268.5 5262.7 5266.3 5346.0 5373.6 26085.7 26621.5 26705.7 26807.9 27006.6 2236.7 2420.9 2496.2 2603.2 2698.4 14458.9 15291.6 15298.9 15371.0 15730.5 1727.1 1805.7 1826.3 1833.5 1862.0 103786.0 103812.0 104064.0 106461.5 108543.5 11399.7 11780.4 11919.6 11925.5 11948.1 15040.9 15111.8 15145.8 15227.5 15268.5 7602.5 9220.0 9259.9 9315.9 9368.2 7653.7 9339.6 9393.4 9398.3 9495.9 4775.4 4815.0 4825.4 4855.7 4856.5 2007.5 2064.8 2073.2 2110.5 2114.5 945.6 962.9 995.0 999.9 1085.6 20110.9 20249.4 20383.7 20448.0 20802.1 1004.6 1010.2 1036.9 1040.9 1052.0 9378.5 11048.4 11220.0 11349.7 11361.4 510270.0 514709.0 517107.0 585176.0 641938.0 79604.0 80115.0 81621.0 130118.0 132513.0 1039.9 1067.6 1070.0 1079.0 1079.8 18271.2 19066.1 19173.9 19227.2 19428.6 50810.9 51612.2 51862.0 52562.5 53759.2 64476.1 72194.6 74972.6 76382.6 76401.6 7789.5 8021.4 8032.0 8072.3 8149.8 11661.5 11709.3 12647.2 12662.6 12762.4 9242.6 10732.8 10927.4 11062.9 11280.9 10435.8 10658.8 10788.8 11060.6 11077.6 9017.8 11184.9 11307.6 11384.7 11539.2 8025.8 8126.2 8150.2 8238.8 8344.9 10635.1 10876.6 11169.1 11209.2 11278.4 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5885.82 Median:4966.33 stddev:3264.96 (65.7%) stddev-sans-first:3257.21 21:39:23 INFO - PROCESS | 1668 | Values: 1464.2 1646.5 1924.0 2061.8 2068.9 7500.8 8255.5 9135.2 9187.4 9277.6 8267.7 8459.1 8869.2 8954.0 8966.6 2544.4 2557.5 2565.4 2569.9 2575.8 2506.9 2553.4 2553.4 2574.8 2575.2 2535.7 2544.8 2564.1 2574.2 2579.6 2544.6 2558.9 2573.1 2577.0 2579.9 2328.5 2549.9 2575.8 2585.1 2587.4 7606.7 9137.7 9283.2 9290.0 9321.9 5621.5 5673.6 5723.0 5774.7 5835.4 3649.6 3771.9 3806.9 3820.5 3822.8 895.2 1047.1 1085.4 1088.6 1090.6 12122.6 12143.0 12524.6 12526.2 12609.2 4231.5 4923.0 5007.6 5045.0 5128.0 10469.6 10549.7 10550.7 10605.4 10606.9 5546.2 5588.7 5652.9 5658.9 5725.9 4578.1 5028.4 5055.4 5096.4 5154.1 4187.5 4208.8 4232.2 4273.9 4303.9 1401.5 1417.4 1425.1 1427.2 1430.5 931.6 964.0 980.5 1001.3 1008.5 5847.0 6039.5 6219.4 6266.7 6278.1 423.8 465.7 475.9 1041.1 1118.5 3791.6 3982.5 4027.2 4053.7 4134.6 10748.5 10956.6 11144.9 11170.3 11209.8 10815.0 10977.0 11009.3 11037.5 11045.8 8338.7 8558.8 8669.8 8708.3 8750.8 5031.8 5656.8 5823.2 5857.7 5873.9 9793.2 9862.4 9907.1 9998.7 10043.9 10152.7 10221.3 10224.0 10255.8 10275.0 5749.5 6909.8 7611.7 7713.1 7780.7 7381.0 8398.1 8483.4 8517.6 8560.1 7508.7 7613.9 7639.0 7686.3 7695.1 7481.5 7494.3 7535.8 7538.8 7649.0 7153.1 7254.7 7261.6 7291.9 7345.0 5022.7 5051.7 5103.9 5189.8 5241.2 4925.0 5194.3 5195.5 5201.2 5243.3 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6096.79 Median:6925.43 stddev:1938.25 (28.0%) stddev-sans-first:1893.80 21:39:23 INFO - PROCESS | 1668 | Values: 275.6 322.2 342.9 344.4 347.4 6784.2 6856.9 6964.0 7016.8 7017.6 6895.6 6912.2 6921.3 6929.6 7004.5 5112.8 5138.6 5143.9 5145.6 5149.9 5118.6 5144.6 5154.1 5161.2 5165.8 5071.6 5079.5 5079.7 5080.7 5098.1 4888.2 5077.9 5079.6 5083.3 5097.8 3607.8 4360.8 4376.8 4383.5 4408.6 5201.6 6593.6 6603.2 6717.5 6719.8 6042.1 6044.3 6058.9 6067.7 6092.4 7401.0 7434.6 7438.7 7456.3 7463.7 4760.2 4939.4 4947.4 4953.7 4968.0 7092.8 7888.0 7934.3 7943.2 7996.5 5010.5 5031.6 5054.8 5057.0 5065.2 5143.5 5155.5 5156.1 5160.5 5161.6 6045.0 6046.9 6053.8 6055.3 6067.6 7259.5 7447.4 7500.4 7524.3 7532.7 1477.7 1759.6 1809.1 1814.8 1822.3 1078.3 1131.0 1131.8 1147.4 1155.8 7007.3 7067.4 7086.3 7103.2 7140.9 7638.6 7725.8 7749.7 7752.4 7756.9 6350.6 7018.9 7055.8 7095.1 7104.1 3978.6 4068.8 4100.8 4106.2 4107.4 8025.8 8065.5 8077.3 8089.5 8132.3 7961.2 7971.4 7986.9 8010.1 8024.5 8079.2 8092.0 8092.6 8102.7 8113.3 7438.4 7673.3 7680.2 7684.3 7705.2 7522.6 7562.7 7565.9 7577.4 7619.8 8029.5 8054.3 8062.0 8072.2 8097.4 5045.6 5054.3 5060.0 5066.8 5071.8 7439.1 7605.4 7640.8 7649.4 7675.2 6303.7 7374.5 7407.7 7408.2 7436.6 6632.9 7301.6 7339.1 7346.9 7355.7 6363.9 6667.9 7013.0 7213.5 7238.9 5550.7 7334.4 7383.5 7441.4 7452.4 7013.4 7252.9 7441.4 7445.1 7451.0 21:39:23 INFO - PROCESS | 1668 | 21:39:23 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18250.06 Median:611.96 stddev:25863.99 (4226.4%) stddev-sans-first:25903.25 21:39:23 INFO - PROCESS | 1668 | Values: 770.7 778.0 779.8 794.1 796.9 13750.6 14622.7 15177.0 15585.0 15585.8 14348.3 14361.9 14386.5 14396.8 14456.9 765.4 935.5 944.8 974.8 975.1 959.1 964.7 972.3 973.1 976.1 997.8 998.4 1028.9 1044.9 1053.9 1027.8 1027.9 1032.9 1035.4 1036.0 654.4 764.7 767.6 771.5 781.4 15282.2 15419.5 15501.3 15535.8 15615.6 13117.7 13186.1 13268.9 13335.7 13347.3 10338.7 10354.9 10355.0 10381.5 10752.5 3065.0 3559.1 3606.8 3608.3 3841.1 77699.4 80722.6 80962.0 82150.0 82972.8 9125.9 9620.0 9651.2 9784.5 10351.9 21295.7 21465.0 21491.1 21542.4 21615.6 6518.4 7571.7 7788.5 7790.0 7841.5 4241.8 4252.1 4278.4 4286.8 4422.0 3697.8 3765.0 3767.8 3787.6 3788.4 670.7 684.0 685.0 686.9 697.6 625.9 626.9 627.4 631.3 650.2 8359.7 8482.4 8513.9 8523.0 8788.8 560.8 560.8 599.5 624.4 628.9 3334.4 3913.7 4020.8 4170.9 4213.9 91481.0 92728.5 93837.0 94921.0 95117.5 80051.6 80128.8 80657.4 81386.4 81620.6 73458.5 73978.5 74170.0 74247.0 75257.0 7851.3 7933.4 8007.9 8050.6 8186.4 49318.8 50586.2 50642.0 50694.7 50953.0 39343.6 50452.0 64381.0 68034.3 69082.9 8985.8 9902.5 10138.4 10284.9 10305.4 11045.9 11047.5 11217.3 11258.3 11340.7 8944.8 10553.8 10691.0 10724.7 11180.7 10227.1 10450.5 10586.7 10846.7 10881.3 8850.5 9137.7 9698.3 11337.6 11873.2 9726.1 9841.0 9847.0 9905.7 10080.8 9727.1 9914.8 9950.7 10138.2 10150.7 21:39:23 INFO - PROCESS | 1668 | -------- Summary: end -------- 21:39:23 INFO - PROCESS | 1668 | 21:39:24 INFO - TEST-INFO | 1668: exit 0 21:39:24 INFO - TEST-OK | dromaeo_css | took 1110431ms 21:39:24 INFO - TEST-START | kraken 21:39:24 INFO - operating with platform_type : mac_ 21:39:24 INFO - Initialising browser for kraken test... 21:39:24 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpJ7j62b/profile http://localhost:49275/getInfo.html) 21:39:26 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 21:39:26 INFO - PROCESS | 1676 | colorDepth:24 21:39:26 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 21:39:26 INFO - PROCESS | 1676 | __metrics 21:39:27 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:39:27 INFO - TEST-INFO | 1676: exit 0 21:39:27 INFO - Browser initialized. 21:39:27 INFO - Running cycle 1/1 for kraken test... 21:39:27 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpJ7j62b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:39 INFO - PROCESS | 1680 | RSS: Main: 171511808 21:39:39 INFO - PROCESS | 1680 | 21:39:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 21:39:42 INFO - PROCESS | 1680 | RSS: Main: 183889920 21:39:42 INFO - PROCESS | 1680 | 21:39:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 21:39:46 INFO - PROCESS | 1680 | RSS: Main: 192942080 21:39:46 INFO - PROCESS | 1680 | 21:39:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 21:39:50 INFO - PROCESS | 1680 | RSS: Main: 195952640 21:39:50 INFO - PROCESS | 1680 | 21:39:52 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 21:39:52 INFO - PROCESS | 1680 | RSS: Main: 196300800 21:39:52 INFO - PROCESS | 1680 | 21:39:54 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:39:55 INFO - PROCESS | 1680 | RSS: Main: 197824512 21:39:55 INFO - PROCESS | 1680 | 21:39:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 21:39:59 INFO - PROCESS | 1680 | RSS: Main: 198107136 21:39:59 INFO - PROCESS | 1680 | 21:40:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 21:40:02 INFO - PROCESS | 1680 | RSS: Main: 198086656 21:40:02 INFO - PROCESS | 1680 | 21:40:05 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 21:40:06 INFO - PROCESS | 1680 | RSS: Main: 198205440 21:40:06 INFO - PROCESS | 1680 | 21:40:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:40:08 INFO - PROCESS | 1680 | RSS: Main: 197804032 21:40:08 INFO - PROCESS | 1680 | 21:40:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:40:10 INFO - PROCESS | 1680 | RSS: Main: 197951488 21:40:10 INFO - PROCESS | 1680 | 21:40:12 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:40:13 INFO - PROCESS | 1680 | RSS: Main: 198184960 21:40:13 INFO - PROCESS | 1680 | 21:40:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:40:16 INFO - PROCESS | 1680 | RSS: Main: 198336512 21:40:16 INFO - PROCESS | 1680 | 21:40:19 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:40:20 INFO - PROCESS | 1680 | RSS: Main: 198266880 21:40:20 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 21:40:22 INFO - PROCESS | 1680 | RSS: Main: 200269824 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | __start_tp_report 21:40:22 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 21:40:22 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 21:40:22 INFO - PROCESS | 1680 | |i|pagename|runs| 21:40:22 INFO - PROCESS | 1680 | |0;ai-astar;115;112;116;116;117;129;117;116;115;116 21:40:22 INFO - PROCESS | 1680 | |1;audio-beat-detection;157;122;157;167;139;165;154;147;152;119 21:40:22 INFO - PROCESS | 1680 | |2;audio-dft;250;202;192;203;274;229;194;201;196;193 21:40:22 INFO - PROCESS | 1680 | |3;audio-fft;62;71;93;163;56;56;58;67;124;59 21:40:22 INFO - PROCESS | 1680 | |4;audio-oscillator;80;80;147;70;60;109;113;75;68;164 21:40:22 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;86;89;85;107;86;75;129;92;130 21:40:22 INFO - PROCESS | 1680 | |6;imaging-darkroom;141;118;94;95;94;95;95;95;94;96 21:40:22 INFO - PROCESS | 1680 | |7;imaging-desaturate;90;89;92;90;89;90;90;121;140;90 21:40:22 INFO - PROCESS | 1680 | |8;json-parse-financial;62;64;66;64;64;65;66;80;60;58 21:40:22 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;66;77;98;109;65;95;59;61;75;96 21:40:22 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;81;79;80;81;79;79;68;94;106;108 21:40:22 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;128;147;139;144;127;124;125;124;182;165 21:40:22 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;162;163;175;226;171;160;162;164;160;163 21:40:22 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;71;86;69;61;56;83;96;71;60 21:40:22 INFO - PROCESS | 1680 | __end_tp_report 21:40:22 INFO - PROCESS | 1680 | __start_cc_report 21:40:22 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1040 21:40:22 INFO - PROCESS | 1680 | __end_cc_report 21:40:22 INFO - PROCESS | 1680 | __startTimestamp1467434422406__endTimestamp 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | ------- Summary: start ------- 21:40:22 INFO - PROCESS | 1680 | Number of tests: 14 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.00 stddev:4.48 (3.9%) stddev-sans-first:4.70 21:40:22 INFO - PROCESS | 1680 | Values: 115.0 112.0 116.0 116.0 117.0 129.0 117.0 116.0 115.0 116.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:155.50 stddev:16.54 (10.6%) stddev-sans-first:17.22 21:40:22 INFO - PROCESS | 1680 | Values: 157.0 122.0 157.0 167.0 139.0 165.0 154.0 147.0 152.0 119.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:213.40 Median:202.50 stddev:28.29 (14.0%) stddev-sans-first:26.72 21:40:22 INFO - PROCESS | 1680 | Values: 250.0 202.0 192.0 203.0 274.0 229.0 194.0 201.0 196.0 193.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:80.90 Median:60.50 stddev:35.96 (59.4%) stddev-sans-first:37.48 21:40:22 INFO - PROCESS | 1680 | Values: 62.0 71.0 93.0 163.0 56.0 56.0 58.0 67.0 124.0 59.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:69.00 stddev:35.57 (51.6%) stddev-sans-first:37.22 21:40:22 INFO - PROCESS | 1680 | Values: 80.0 80.0 147.0 70.0 60.0 109.0 113.0 75.0 68.0 164.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:86.00 stddev:19.01 (22.1%) stddev-sans-first:19.90 21:40:22 INFO - PROCESS | 1680 | Values: 88.0 86.0 89.0 85.0 107.0 86.0 75.0 129.0 92.0 130.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:95.00 stddev:15.64 (16.5%) stddev-sans-first:7.78 21:40:22 INFO - PROCESS | 1680 | Values: 141.0 118.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 96.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:98.10 Median:90.00 stddev:17.67 (19.6%) stddev-sans-first:18.50 21:40:22 INFO - PROCESS | 1680 | Values: 90.0 89.0 92.0 90.0 89.0 90.0 90.0 121.0 140.0 90.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:5.90 (9.1%) stddev-sans-first:6.16 21:40:22 INFO - PROCESS | 1680 | Values: 62.0 64.0 66.0 64.0 64.0 65.0 66.0 80.0 60.0 58.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:76.00 stddev:17.96 (23.6%) stddev-sans-first:18.31 21:40:22 INFO - PROCESS | 1680 | Values: 66.0 77.0 98.0 109.0 65.0 95.0 59.0 61.0 75.0 96.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:79.50 stddev:12.92 (16.3%) stddev-sans-first:13.60 21:40:22 INFO - PROCESS | 1680 | Values: 81.0 79.0 80.0 81.0 79.0 79.0 68.0 94.0 106.0 108.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:141.50 stddev:19.73 (13.9%) stddev-sans-first:20.40 21:40:22 INFO - PROCESS | 1680 | Values: 128.0 147.0 139.0 144.0 127.0 124.0 125.0 124.0 182.0 165.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:163.50 stddev:20.06 (12.3%) stddev-sans-first:21.03 21:40:22 INFO - PROCESS | 1680 | Values: 162.0 163.0 175.0 226.0 171.0 160.0 162.0 164.0 160.0 163.0 21:40:22 INFO - PROCESS | 1680 | 21:40:22 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.00 stddev:12.69 (17.9%) stddev-sans-first:13.33 21:40:22 INFO - PROCESS | 1680 | Values: 67.0 71.0 86.0 69.0 61.0 56.0 83.0 96.0 71.0 60.0 21:40:22 INFO - PROCESS | 1680 | -------- Summary: end -------- 21:40:22 INFO - PROCESS | 1680 | 21:40:23 INFO - TEST-INFO | 1680: exit 0 21:40:23 INFO - TEST-OK | kraken | took 59049ms 21:40:23 INFO - SUITE-END | took 1169s 21:40:23 INFO - Completed test suite (00:19:29) 21:40:23 INFO - javascript benchmark 21:40:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3623.927521449571, 3649.817509124544, 3689.723270754691, 3692.1877187018863, 3711.610280920503, 6010.8497287567725, 6028.306744724358, 6028.85451764165, 6069.115765909815, 6070.180525629039, 6008.729607167677, 6024.608400453967, 6044.939550604493, 6053.303870054945, 6062.575619706622, 5302.443243459429, 5372.328458942632, 5381.757820898049, 5381.838544843661, 5479.0, 5290.550303224211, 5371.543418809406, 5393.325834270716, 5398.13629819229, 5474.069408200616, 5341.65279256849, 5387.24578559002, 5389.78440862365, 5412.99859525987, 5482.533984611313, 5362.276092727471, 5438.374586922515, 5453.7818487260465, 5465.6447330923365, 5472.50747432733, 5306.177542480922, 5373.623846330758, 5376.166694162411, 5444.128939369722, 5451.563874889999, 5624.493795558378, 5814.447627475383, 5869.7945571904775, 5945.91081133779, 5980.581359304851, 6274.341194174592, 6314.747410103636, 6319.620822750604, 6326.715297811609, 6327.841803954938, 5343.706096164709, 6316.08416779569, 6325.430711236011, 6364.586301890362, 6387.329330420285, 4941.827036053721, 5966.70166491678, 6085.726142323561, 6094.847628809227, 6189.876202475925, 6436.581622194542, 6528.314526974599, 6537.313582073813, 6537.673116344164, 6545.9018114728315, 5347.919781203285, 6276.686165691697, 6302.905456418157, 6328.905066424008, 6330.746770129235, 6288.874222515616, 6364.0, 6402.103705481236, 6432.903506447314, 6439.356064393523, 6278.717457714414, 6284.183056202664, 6292.276388215322, 6297.779577714849, 6299.937000630027, 6186.969065154645, 6298.685065746694, 6304.779332723333, 6313.084602732578, 6316.526260530479, 4993.226049962262, 5137.255098010767, 5139.897202055938, 5146.716930568779, 5152.227165925141, 4581.152486789888, 4610.400647915817, 4634.0500197460115, 4641.95358046422, 4652.674312798072, 5869.972754767899, 6080.908786368208, 6144.754209831646, 6206.224221972254, 6211.16149319836, 6303.842403939847, 6357.936420635734, 6360.872782544323, 6397.912354899679, 6431.485481161496, 6181.072839074175, 6187.195664563668, 6213.130161777355, 6216.627002379872, 6250.812475625738, 5424.077906755861, 5555.2500412444615, 5608.186812912105, 5646.20953066571, 5684.943150568524, 6596.670166491656, 6657.40083392497, 6668.466522678174, 6686.231083425371, 6688.297728738413, 6413.230412350548, 6435.420812126931, 6436.195475565554, 6442.774502892376, 6481.319461456667, 6470.741170353133, 6587.077809106825, 6647.235567909753, 6676.83307917306, 6682.46540276767, 6293.276273228637, 6335.1130841683125, 6343.111964324906, 6343.873122537431, 6369.90445143314, 6367.3314301997625, 6393.200849893763, 6412.583182093149, 6414.5189110815945, 6427.871442571216, 6170.6914654268, 6187.195664563578, 6213.65824879636, 6280.309165991828, 6294.370562943669, 6207.689615519115, 6276.843078923063, 6277.937220627735, 6286.968565157145, 6288.308286088618, 6119.938800612115, 6222.09779581949, 6252.781152659635, 6253.2496100466415, 6254.655993920378, 6093.725782339717, 6183.5671502994355, 6215.81352559424, 6230.408111229426, 6247.687615619292, 6230.875382492234, 6251.531135164972, 6260.280067792262, 6274.560780745304, 6275.466585340298], "value": 5906.4426631529905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5978095771045, 580.7909152705025, 586.3579380578266, 609.9512039036877, 626.1922120464598, 33467.33065338692, 40012.79993600028, 40072.39891401631, 40161.59838401611, 40165.59834401655, 43321.78339108308, 43424.0, 43707.78146109273, 44162.0, 44174.33738493917, 9681.419114853095, 9742.1719153872, 9837.360571562862, 9907.603695852158, 9910.752231194241, 8617.0, 9888.505574721272, 9936.701898943043, 9991.900080999207, 10035.29752917296, 9898.208143348551, 9902.207823374149, 9904.207663386911, 9971.401715897033, 10002.099811017008, 9932.155766759834, 9999.35004224723, 10010.349327293776, 10022.749431264203, 10024.949875250613, 9659.0, 9814.411135331831, 9819.459929703864, 9837.704868853945, 9849.409035457895, 39364.0, 39508.20983580312, 39513.0, 39877.60122398768, 39969.80015099935, 3340.916477088068, 3469.028671971852, 3469.271452994874, 3499.965000349989, 3514.437689969618, 27378.315542111406, 28707.425851482854, 29340.826366945297, 30663.38673226523, 31327.0, 2753.765929895961, 2789.330560665446, 2801.145650576573, 2816.7183281671873, 2848.088611644275, 414453.0, 415869.6826063492, 416615.0, 418917.81082189095, 420772.0, 37402.06494837651, 38485.230295394496, 62652.373476265566, 62843.0, 63039.369606304266, 36439.27121457609, 36499.0, 36601.45097823535, 37179.4423083654, 37434.06414839651, 15527.922360388126, 16447.91776041136, 16455.588610284838, 16622.25199866009, 16651.6669666606, 13995.37020834065, 14021.0, 14068.648283792987, 14150.080244784056, 14161.150330980174, 8464.703735369232, 8522.403431759842, 8539.975202975682, 8585.0, 8615.526146061902, 3533.505309256706, 3564.198055437506, 3566.661167189113, 3573.3210689968823, 3579.46308053794, 1000.2897942460788, 1008.8196809732631, 1029.3206483720708, 1093.1965005720788, 1152.4698638626157, 24612.50774984526, 30355.392892142034, 30723.69276307253, 31159.84420077885, 31339.843300783807, 1039.4594810698395, 1110.2394859521253, 1120.8094623913955, 1174.2836869509592, 1215.0, 12202.38988050594, 15653.686926261411, 15891.443799466962, 15975.920120399323, 16257.918710406373, 611609.0, 703014.0, 707068.0, 723583.0, 725700.0, 60389.09416358758, 60542.697286514165, 61399.07901381483, 61516.0, 61547.6922615384, 1556.750919852818, 1563.4137198550316, 1572.088188850464, 1575.070708282119, 1579.8104227492774, 30884.536731949487, 31612.367752645278, 31653.84173079212, 31894.0, 32253.193670158435, 55334.0, 56070.43929560652, 56178.43821561895, 56236.71881640566, 56275.59311017257, 471645.28354716016, 481920.0, 483351.0, 483597.0, 484568.0, 27534.586981194898, 28723.0, 28822.279443014093, 28990.85504572548, 29007.98472053468, 45680.77159614181, 47087.529124708315, 47099.82250443629, 47866.52133478621, 48875.51124488709, 38969.83090507289, 39440.01399965024, 39512.20975580415, 40612.79693601513, 41161.0, 36911.815440922626, 37238.8138059308, 37278.627213727515, 37757.81121094377, 37885.05287367838, 34091.0, 36692.266154677294, 36722.26555468929, 39240.803795980835, 40035.59964400319, 31871.36257274888, 33346.666533334355, 33383.33233335368, 33629.0, 33723.32553348968, 24792.0, 25159.0, 25519.0, 25965.48069038571, 26274.73725262723], "value": 19045.63459401089, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6006593241927, 411.12225398773626, 413.5203164329379, 414.9751014939106, 424.5436156132159, 20563.794362056375, 20839.47901302468, 20879.895600521995, 21284.36146915595, 21959.121635134616, 20978.790212097912, 21178.57642847146, 21382.89308553459, 21394.57210855786, 21450.463738406546, 5949.643021418718, 5961.8807623847715, 6241.407066328691, 6243.0, 6264.21697287839, 6051.152838602599, 6089.939100608982, 6139.447449729523, 6169.845753856167, 6225.0351195564535, 4963.801447942096, 6021.909671354933, 6026.517878569726, 6045.0, 6075.362086980847, 6019.127226552169, 6037.879242415149, 6097.237845269341, 6110.114033465167, 6160.7535698572, 4268.509121451042, 5262.710550919698, 5266.289050978107, 5346.0, 5373.59698022646, 26085.73914260852, 26621.467570648478, 26705.732942670715, 26807.865960670268, 27006.5949010765, 2236.6868638390474, 2420.9394765131015, 2496.213692686798, 2603.153974958146, 2698.446818402223, 14458.855411445857, 15291.617709557238, 15298.923505382401, 15371.0, 15730.528084157493, 1727.06738361286, 1805.6840052990674, 1826.2603645523584, 1833.5416145963509, 1862.022438219932, 103786.0, 103811.96188038174, 104063.95936040694, 106461.46769266181, 108543.45728271308, 11399.658010259705, 11780.352080635475, 11919.642410727693, 11925.522979080739, 11948.103892207946, 15040.947133700754, 15111.773323400157, 15145.772813407808, 15227.543173704586, 15268.465603703817, 7602.50583712057, 9220.0, 9259.907400926038, 9315.928668203243, 9368.203702685212, 7653.655585498666, 9339.579718912666, 9393.389429687048, 9398.2951278653, 9495.90504094964, 4775.379200703956, 4814.9518504815205, 4825.420949486014, 4855.660103792771, 4856.538628830255, 2007.5483016321211, 2064.7935206479233, 2073.243266207823, 2110.51458164623, 2114.534802343482, 945.5508633399218, 962.8940816510178, 994.955227014786, 999.9050090241416, 1085.5766251162054, 20110.89944550268, 20249.39251822448, 20383.694244586342, 20448.0, 20802.063907124215, 1004.638330201127, 1010.1716592394166, 1036.9429681367446, 1040.9375437473775, 1051.9631812886512, 9378.48418336998, 11048.392338421303, 11219.990200881959, 11349.716257093638, 11361.431928403546, 510270.0, 514709.0, 517107.0, 585176.0, 641938.0, 79604.0, 80114.99712507117, 81621.0, 130118.0, 132513.0, 1039.8752149741929, 1067.6263307842348, 1069.983950240747, 1079.0450451350612, 1079.8434227037035, 18271.1777969989, 19066.142023608692, 19173.90413047926, 19227.230910763414, 19428.611427771648, 50810.90767898246, 51612.22581661203, 51862.0, 52562.47437525729, 53759.19361209507, 64476.065718028534, 72194.63902680454, 74972.62513687396, 76382.6180869092, 76401.61799190969, 7789.454738168501, 8021.358291336795, 8031.959840200761, 8072.313853322534, 8149.796255093433, 11661.475233614678, 11709.297442153498, 12647.177933434297, 12662.556810511587, 12762.42569084412, 9242.630294788134, 10732.839007415052, 10927.398993055458, 11062.889371106186, 11280.943595282299, 10435.828252562795, 10658.840117398091, 10788.838167427652, 11060.612878549213, 11077.556897724, 9017.774555636162, 11184.94407527957, 11307.604233851776, 11384.715382115513, 11539.249948753304, 8025.8394832104195, 8126.228008339198, 8150.184981501802, 8238.794030149054, 8344.87482687748, 10635.14918806478, 10876.619318323821, 11169.106471482424, 11209.215354925076, 11278.37968911685], "value": 9738.789777050864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.1507925403266, 1646.497818165459, 1923.9706756885062, 2061.8453615978806, 2068.896555172243, 7500.849983000344, 8255.504669719807, 9135.223506001981, 9187.402818816781, 9277.628894844214, 8267.718503631932, 8459.069502354752, 8869.157430044135, 8953.955230223855, 8966.596503157358, 2544.414784599543, 2557.514072326252, 2565.422779874523, 2569.9100531481404, 2575.84544927305, 2506.8997240110375, 2553.3871870751072, 2553.399951011511, 2574.781143602796, 2575.2016874768788, 2535.695716514021, 2544.75824796644, 2564.064116597447, 2574.2405990232833, 2579.5872660374343, 2544.592865141578, 2558.8592627405487, 2573.099415204673, 2576.9742302576924, 2579.858107804089, 2328.5459335429596, 2549.8852551635223, 2575.7553032461888, 2585.082295784988, 2587.4178309880313, 7606.695732170707, 9137.680181193626, 9283.164515193665, 9290.02454742249, 9321.906780932171, 5621.494065534081, 5673.602847800656, 5722.9984752668115, 5774.7112644368035, 5835.44563266489, 3649.562052553684, 3771.9434208486896, 3806.90482737931, 3820.5290962979175, 3822.7515211511163, 895.2122132523402, 1047.089032541686, 1085.4355735017825, 1088.6407485529755, 1090.5910283643634, 12122.575709850113, 12143.0, 12524.561640342545, 12526.185797923106, 12609.243445393306, 4231.534531201565, 4923.040007198562, 5007.624428167902, 5045.032437349437, 5128.0, 10469.581216751398, 10549.736256593493, 10550.736231594117, 10605.416702081306, 10606.946965265279, 5546.195801608744, 5588.6646801192055, 5652.858678532987, 5658.91511627326, 5725.883452726762, 4578.1301552705545, 5028.371453568304, 5055.393352797688, 5096.413912400048, 5154.123798954187, 4187.497500299984, 4208.8316467340965, 4232.195882782262, 4273.9358909616385, 4303.913921721548, 1401.4814518628173, 1417.4188582681052, 1425.0737020936267, 1427.1793718611839, 1430.4778755754076, 931.6040682709821, 964.0167029629879, 980.4705459052175, 1001.329109496639, 1008.4788029925187, 5847.0, 6039.516838652898, 6219.440250377488, 6266.655333956676, 6278.058291256257, 423.8325861284837, 465.73220398271127, 475.93812804335215, 1041.073444634276, 1118.5078565431347, 3791.5829258781514, 3982.5021872265966, 4027.1744292419985, 4053.6757059435176, 4134.565870583606, 10748.462576871125, 10956.561737530568, 11144.888551114547, 11170.273932194545, 11209.831852522218, 10815.0, 10977.012068913837, 11009.339439633648, 11037.503312350964, 11045.779084418427, 8338.749837504885, 8558.786030349167, 8669.826603467895, 8708.34687398435, 8750.824983500293, 5031.823886163967, 5656.8020119295625, 5823.155642431739, 5857.707114644336, 5873.911891321548, 9793.167580755715, 9862.358946668444, 9907.058829411195, 9998.700038998843, 10043.949780251052, 10152.695419137437, 10221.33561318512, 10223.977602239716, 10255.846162307422, 10275.0, 5749.453801888814, 6909.827254318682, 7611.657475413509, 7713.1129920057665, 7780.688772449265, 7380.96309518449, 8398.076211616839, 8483.406161568631, 8517.616707248313, 8560.058393576826, 7508.737194198176, 7613.9238607613215, 7638.961805190938, 7686.3082322591235, 7695.115061767969, 7481.476296659182, 7494.325510704063, 7535.8116047099265, 7538.811529711801, 7649.04386951631, 7153.141623005273, 7254.746083887038, 7261.636918154177, 7291.890621640786, 7345.0, 5022.698638081727, 5051.6716413433005, 5103.948960510347, 5189.76646050921, 5241.187615919539, 4925.039617274597, 5194.3247377840635, 5195.480451954774, 5201.1678131498775, 5243.318368612056], "value": 4740.878397195122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.621021095993, 322.157557985867, 342.8902751119643, 344.42481056635415, 347.4198089191051, 6784.2198147213085, 6856.897146542806, 6964.025036494889, 7016.754413595519, 7017.578945263288, 6895.620740859264, 6912.205096413914, 6921.273266307041, 6929.579436215577, 7004.544704594197, 5112.846614601549, 5138.614603904713, 5143.922841157386, 5145.588352931756, 5149.897002059956, 5118.61610379223, 5144.588432925357, 5154.098032844256, 5161.200013997836, 5165.845024649267, 5071.619628527875, 5079.542841144296, 5079.746012699368, 5080.745962701869, 5098.062736160254, 4888.193448081062, 5077.898442031175, 5079.568236699885, 5083.262926875583, 5097.847064588068, 3607.8376473058775, 4360.803763830635, 4376.7811609419405, 4383.539728328511, 4408.559144085598, 5201.609879259033, 6593.637349945751, 6603.240627327871, 6717.496187785936, 6719.798406047827, 6042.093685947099, 6044.304904935901, 6058.93968555501, 6067.7269522871575, 6092.390760923872, 7401.00086488328, 7434.591097489636, 7438.739644112484, 7456.254374562554, 7463.701451941915, 4760.214564596838, 4939.3578834751615, 4947.406311242674, 4953.702777833341, 4968.031233909389, 7092.787216383465, 7887.974563306733, 7934.3255823255095, 7943.205679432069, 7996.520643680938, 5010.473900240495, 5031.572316353151, 5054.848354549369, 5056.988602279559, 5065.189569668835, 5143.485651434901, 5155.510226528474, 5156.123459011977, 5160.535551800356, 5161.638685291993, 6045.0, 6046.909296360558, 6053.818385448443, 6055.303640081447, 6067.635941843503, 7259.4918355715645, 7447.404207663374, 7500.399968002546, 7524.2851929066655, 7532.698692052366, 1477.7044591081826, 1759.551314414816, 1809.095452273863, 1814.782226132846, 1822.3348477805505, 1078.2721662877527, 1130.9547618095185, 1131.8189089745601, 1147.3821911105301, 1155.78040172367, 7007.334303241184, 7067.363937245673, 7086.255943126001, 7103.183133939559, 7140.892886606705, 7638.579878106646, 7725.768226953201, 7749.7287594933905, 7752.379809615217, 7756.883646745303, 6350.555461117678, 7018.929810701828, 7055.788326350218, 7095.148582170173, 7104.11198600175, 3978.562358140602, 4068.7558746475306, 4100.753954762724, 4106.219818234586, 4107.424960505532, 8025.759227223192, 8065.475744076616, 8077.313428358538, 8089.47418417801, 8132.2680958714, 7961.203879612109, 7971.441999060126, 7986.920130798734, 8010.078840933251, 8024.478408903403, 8079.192080791874, 8091.959540202261, 8092.595370231465, 8102.675892964216, 8113.269805717396, 7438.40492760567, 7673.309402153833, 7680.193579674277, 7684.269994350528, 7705.152433232228, 7522.5862577558755, 7562.697492100255, 7565.924340756522, 7577.355924746238, 7619.847603048019, 8029.518228906284, 8054.31538319226, 8062.032556093306, 8072.192780721881, 8097.352211822922, 5045.571126454292, 5054.2671312660195, 5059.974700126476, 5066.82266120684, 5071.847844564669, 7439.070116235471, 7605.353544948742, 7640.808979775327, 7649.426293027934, 7675.232476752503, 6303.716332765129, 7374.520656157332, 7407.66665500043, 7408.222136675571, 7436.628168591657, 6632.933670663231, 7301.598412087386, 7339.082614673166, 7346.889796653161, 7355.742549010973, 6363.93636063652, 6667.866462701256, 7013.0, 7213.495055346076, 7238.927610724036, 5550.722463876709, 7334.376577990931, 7383.483156179231, 7441.367483763941, 7452.366548843409, 7013.368796808311, 7252.854942901007, 7441.441891858024, 7445.069366329209, 7450.96274518624], "value": 5439.396076238665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.7302444144549, 777.9844403111938, 779.8050487378156, 794.122494643419, 796.9163237860024, 13750.58748237552, 14622.683958443751, 15177.0, 15585.0, 15585.84414155858, 14348.282585870717, 14361.856381436182, 14386.496472623461, 14396.784048239284, 14456.92771536141, 765.3876898481207, 935.5275585829181, 944.8252073366415, 974.7904200596905, 975.1223898491344, 959.1271942532297, 964.6720115160844, 972.2999440402899, 973.0998826085878, 976.1214906584061, 997.7854761226334, 998.3859926145404, 1028.8559601655775, 1044.94775261237, 1053.9209559283047, 1027.8201314769922, 1027.9383237005804, 1032.8708911386077, 1035.4201647077662, 1035.989640103597, 654.4175683641563, 764.6826566974698, 767.6123557603374, 771.5062360089547, 781.4256521456725, 15282.235888205656, 15419.460318888898, 15501.302441390164, 15535.844641553553, 15615.609609759847, 13117.737645247136, 13186.142900711424, 13268.93365533166, 13335.73328533424, 13347.265900375476, 10338.741531461774, 10354.948225258826, 10355.0, 10381.480925953672, 10752.462376881203, 3064.9693503064905, 3559.0924314299946, 3606.8196590170387, 3608.260306637133, 3841.058940559553, 77699.44601108003, 80722.5963870177, 80962.0, 82150.0, 82972.75540866831, 9125.863112053325, 9619.951900240594, 9651.179649729711, 9784.461854597923, 10351.861295257515, 21295.68056479154, 21465.0, 21491.14035438565, 21542.35372938814, 21615.56768864614, 6518.380753828379, 7571.659275332623, 7788.532688038736, 7790.0, 7841.529508229524, 4241.833252072138, 4252.149570085995, 4278.422412974209, 4286.7856607169515, 4422.0, 3697.8335974881193, 3765.0, 3767.849286028583, 3787.5833658297565, 3788.412796016622, 670.7115940145686, 683.9555428897205, 684.993060201503, 686.9210040845267, 697.6372286411038, 625.8998560230341, 626.8777588370315, 627.3663599764179, 631.2897989761518, 650.1515522243518, 8359.749207523784, 8482.363822713321, 8513.872291915626, 8523.0, 8788.824223515621, 560.8205374280191, 560.834553806628, 599.487438240307, 624.4380057947883, 628.9433950944345, 3334.4164771165433, 3913.7064720146104, 4020.798960051986, 4170.854020109282, 4213.894652633709, 91481.0, 92728.53635731777, 93837.0, 94921.0, 95117.52441237749, 80051.59974200209, 80128.79806802902, 80657.38685226263, 81386.37227255422, 81620.59189704132, 73458.53082938312, 73978.52042959111, 74170.0, 74247.0, 75256.99999999891, 7851.293383595504, 7933.3653307736395, 8007.879881801894, 8050.637721302673, 8186.386021048326, 49318.75340623417, 50586.2412063812, 50642.0, 50694.74652626713, 50952.98094038173, 39343.606563933994, 50452.0, 64381.0, 68034.31965680279, 69082.85502869844, 8985.775355616162, 9902.455364954996, 10138.442385668564, 10284.897151028394, 10305.381677099398, 11045.944770276097, 11047.464390567435, 11217.326960382403, 11258.268212566158, 11340.716482088013, 8944.776380590538, 10553.841692374774, 10691.0, 10724.678259652223, 11180.720481988015, 10227.130693891102, 10450.477476126316, 10586.735331616772, 10846.67459976202, 10881.292715973437, 8850.513221772606, 9137.680181193626, 9698.321117521706, 11337.603183888525, 11873.228240164362, 9726.124648781644, 9841.015898410387, 9846.966068562984, 9905.653302134391, 10080.84878726805, 9727.124558789743, 9914.801703965735, 9950.651727189514, 10138.188944884245, 10150.695479135638], "value": 6996.224577298518, "unit": "score"}], "name": "dromaeo_css", "value": 7632.30030964285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 116.0, 116.0, 117.0, 129.0, 117.0, 116.0, 115.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 157.0, 167.0, 139.0, 165.0, 154.0, 147.0, 152.0, 119.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [250.0, 202.0, 192.0, 203.0, 274.0, 229.0, 194.0, 201.0, 196.0, 193.0], "value": 213.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 93.0, 163.0, 56.0, 56.0, 58.0, 67.0, 124.0, 59.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 147.0, 70.0, 60.0, 109.0, 113.0, 75.0, 68.0, 164.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 85.0, 107.0, 86.0, 75.0, 129.0, 92.0, 130.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 96.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 92.0, 90.0, 89.0, 90.0, 90.0, 121.0, 140.0, 90.0], "value": 98.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 64.0, 64.0, 65.0, 66.0, 80.0, 60.0, 58.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 98.0, 109.0, 65.0, 95.0, 59.0, 61.0, 75.0, 96.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 81.0, 79.0, 79.0, 68.0, 94.0, 106.0, 108.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 147.0, 139.0, 144.0, 127.0, 124.0, 125.0, 124.0, 182.0, 165.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 175.0, 226.0, 171.0, 160.0, 162.0, 164.0, 160.0, 163.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 86.0, 69.0, 61.0, 56.0, 83.0, 96.0, 71.0, 60.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1565.8, "alertThreshold": 2.0}]} 21:40:23 INFO - Return code: 0 21:40:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:40:23 ERROR - # TBPL SUCCESS # 21:40:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:40:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:40:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:40:23 INFO - 2016-07-01 21:40:23.745 screenresolution[1685:10612] starting screenresolution argv=screenresolution get 21:40:23 INFO - 2016-07-01 21:40:23.748 screenresolution[1685:10612] Display 0: 1600x1200x32@60 21:40:23 INFO - 2016-07-01 21:40:23.753 screenresolution[1686:10615] starting screenresolution argv=screenresolution list 21:40:23 INFO - Available Modes on Display 0 21:40:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:40:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:40:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:40:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:40:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:40:23 INFO - Intel Iris: 21:40:23 INFO - Chipset Model: Intel Iris 21:40:23 INFO - Type: GPU 21:40:23 INFO - Bus: Built-In 21:40:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:40:23 INFO - Vendor: Intel (0x8086) 21:40:23 INFO - Device ID: 0x0a2e 21:40:23 INFO - Revision ID: 0x0009 21:40:23 INFO - Displays: 21:40:23 INFO - Display: 21:40:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:40:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:40:23 INFO - Display Serial Number: 1600x1200 60 21:40:23 INFO - Main Display: Yes 21:40:23 INFO - Mirror: Off 21:40:23 INFO - Online: Yes 21:40:23 INFO - Rotation: Supported 21:40:23 INFO - Return code: 0 21:40:23 INFO - Running post-action listener: _resource_record_post_action 21:40:23 INFO - Running post-run listener: _resource_record_post_run 21:40:25 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 32624128; Write bytes: 498770944; Read time: 328; Write time: 3504 21:40:25 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 187138560; Write bytes: 187127808; Read time: 17253; Write time: 466 21:40:25 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30866944; Write bytes: 300854272; Read time: 305; Write time: 3005 21:40:25 INFO - Running post-run listener: _upload_blobber_files 21:40:25 INFO - Blob upload gear active. 21:40:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:40:25 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 21:40:25 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'] 21:40:25 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 21:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 21:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:40:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:26 INFO - (blobuploader) - INFO - Done attempting. 21:40:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:40:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:40:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:27 INFO - (blobuploader) - INFO - Done attempting. 21:40:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:40:27 INFO - Return code: 0 21:40:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:40:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:40:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/345cb7ce7f572173c3ba4646d29ef26b07fe712cc5d16de8f22f8ce07c6d2f3b11f5e87b4941dc82ac694d7bb68143c770cc540ba71cb8a92a3ffb52695ff63d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57742c8cc9a149236f44b36d6cfe5a50bdc046c76e7fd575a209593e391941b802528364dd9a13933aa0b13153327d8ede74546b9d88c358ed7e2e05f4668ca5"} 21:40:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:40:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:40:27 INFO - Contents: 21:40:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/345cb7ce7f572173c3ba4646d29ef26b07fe712cc5d16de8f22f8ce07c6d2f3b11f5e87b4941dc82ac694d7bb68143c770cc540ba71cb8a92a3ffb52695ff63d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57742c8cc9a149236f44b36d6cfe5a50bdc046c76e7fd575a209593e391941b802528364dd9a13933aa0b13153327d8ede74546b9d88c358ed7e2e05f4668ca5"} 21:40:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:40:27 INFO - Copying logs to upload dir... 21:40:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:40:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.670242 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-07-01 21:40:27.327271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 21:40:27.330495) ========= 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.XjuIels4kG/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.WtMNyu2ayw/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/345cb7ce7f572173c3ba4646d29ef26b07fe712cc5d16de8f22f8ce07c6d2f3b11f5e87b4941dc82ac694d7bb68143c770cc540ba71cb8a92a3ffb52695ff63d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57742c8cc9a149236f44b36d6cfe5a50bdc046c76e7fd575a209593e391941b802528364dd9a13933aa0b13153327d8ede74546b9d88c358ed7e2e05f4668ca5"} build_url:https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/BbjgUZ54Qrq-idCwuBrGFQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/345cb7ce7f572173c3ba4646d29ef26b07fe712cc5d16de8f22f8ce07c6d2f3b11f5e87b4941dc82ac694d7bb68143c770cc540ba71cb8a92a3ffb52695ff63d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57742c8cc9a149236f44b36d6cfe5a50bdc046c76e7fd575a209593e391941b802528364dd9a13933aa0b13153327d8ede74546b9d88c358ed7e2e05f4668ca5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 21:40:27.371763) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 21:40:27.372118) ========= 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.XjuIels4kG/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.WtMNyu2ayw/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005040 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 21:40:27.489436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 21:40:27.489748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 21:40:27.490254) ========= ========= Total master_lag: 0.27 =========