builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0016 starttime: 1476917444.92 results: success (0) buildid: 20161019133122 builduid: a39922c3290e4258a93f6a9db72e3530 revision: cb7f5639c1473b8bad95e8f848f2b3ba6ff89753 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:44.921024) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:44.921516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:44.925978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:44.958594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:44.959049) ========= 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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-10-19 15:50:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.9M=0.001s 2016-10-19 15:50:45 (14.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:45.108923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-10-19 15:50:45.109313) ========= 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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.028037 ========= master_lag: 6.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-10-19 15:50:51.397083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-10-19 15:50:51.397559) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cb7f5639c1473b8bad95e8f848f2b3ba6ff89753 --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-aurora --rev cb7f5639c1473b8bad95e8f848f2b3ba6ff89753 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fi0QU7vhk8/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.AGlzqjfk2I/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-10-19 15:50:51,486 truncating revision to first 12 chars 2016-10-19 15:50:51,486 Setting DEBUG logging. 2016-10-19 15:50:51,486 attempt 1/10 2016-10-19 15:50:51,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cb7f5639c147?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 15:50:52,181 unpacking tar archive at: mozilla-aurora-cb7f5639c147/testing/mozharness/ program finished with exit code 0 elapsedTime=0.972082 ========= master_lag: 5.81 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-10-19 15:50:58.183133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:58.183470) ========= script_repo_revision: cb7f5639c1473b8bad95e8f848f2b3ba6ff89753 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:58.183957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:58.184264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:50:59.131383) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-19 15:50:59.131917) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fi0QU7vhk8/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.AGlzqjfk2I/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:50:59 INFO - MultiFileLogger online at 20161019 15:50:59 in /builds/slave/test 15:50:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:50:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:59 INFO - {'append_to_log': False, 15:50:59 INFO - 'base_work_dir': '/builds/slave/test', 15:50:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:50:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:59 INFO - 'branch': 'Mozilla-Aurora', 15:50:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:59 INFO - 'config_files': ('talos/mac_config.py',), 15:50:59 INFO - 'default_actions': ('clobber', 15:50:59 INFO - 'read-buildbot-config', 15:50:59 INFO - 'download-and-extract', 15:50:59 INFO - 'populate-webroot', 15:50:59 INFO - 'create-virtualenv', 15:50:59 INFO - 'install', 15:50:59 INFO - 'run-tests'), 15:50:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:59 INFO - 'download_minidump_stackwalk': True, 15:50:59 INFO - 'download_symbols': 'ondemand', 15:50:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:59 INFO - 'installer_path': 'installer.exe', 15:50:59 INFO - 'log_level': 'info', 15:50:59 INFO - 'log_name': 'talos', 15:50:59 INFO - 'log_to_console': True, 15:50:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:50:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:50:59 INFO - 'opt_config_files': (), 15:50:59 INFO - 'pip_index': False, 15:50:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:59 INFO - 'cmd': ('bash', 15:50:59 INFO - '-c', 15:50:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:59 INFO - 'enabled': True, 15:50:59 INFO - 'halt_on_failure': False, 15:50:59 INFO - 'name': 'check_screen_resolution'},), 15:50:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:59 INFO - 'cmd': ('bash', 15:50:59 INFO - '-c', 15:50:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:59 INFO - 'enabled': True, 15:50:59 INFO - 'halt_on_failure': False, 15:50:59 INFO - 'name': 'check_screen_resolution'},), 15:50:59 INFO - 'run_cmd_checks_enabled': True, 15:50:59 INFO - 'sps_profile': False, 15:50:59 INFO - 'sps_profile_interval': 0, 15:50:59 INFO - 'suite': 'dromaeojs-e10s', 15:50:59 INFO - 'system_bits': '32', 15:50:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:59 INFO - 'title': 't-yosemite-r7-0016', 15:50:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:59 INFO - 'use_talos_json': True, 15:50:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:59 INFO - 'work_dir': 'build'} 15:50:59 INFO - [mozharness: 2016-10-19 22:50:59.336910Z] Running clobber step. 15:50:59 INFO - Running pre-action listener: _resource_record_pre_action 15:50:59 INFO - Running main action method: clobber 15:50:59 INFO - rmtree: /builds/slave/test/build 15:50:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:01 INFO - Running post-action listener: _resource_record_post_action 15:51:01 INFO - [mozharness: 2016-10-19 22:51:01.423498Z] Finished clobber step (success) 15:51:01 INFO - [mozharness: 2016-10-19 22:51:01.423658Z] Running read-buildbot-config step. 15:51:01 INFO - Running pre-action listener: _resource_record_pre_action 15:51:01 INFO - Running main action method: read_buildbot_config 15:51:01 INFO - Using buildbot properties: 15:51:01 INFO - { 15:51:01 INFO - "project": "", 15:51:01 INFO - "product": "firefox", 15:51:01 INFO - "script_repo_revision": "production", 15:51:01 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 15:51:01 INFO - "repository": "", 15:51:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 15:51:01 INFO - "buildid": "20161019133122", 15:51:01 INFO - "pgo_build": "False", 15:51:01 INFO - "basedir": "/builds/slave/test", 15:51:01 INFO - "buildnumber": 5, 15:51:01 INFO - "slavename": "t-yosemite-r7-0016", 15:51:01 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:51:01 INFO - "platform": "yosemite_r7", 15:51:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:51:01 INFO - "branch": "mozilla-aurora", 15:51:01 INFO - "repo_path": "releases/mozilla-aurora", 15:51:01 INFO - "revision": "cb7f5639c1473b8bad95e8f848f2b3ba6ff89753", 15:51:01 INFO - "stage_platform": "macosx64", 15:51:01 INFO - "builduid": "a39922c3290e4258a93f6a9db72e3530", 15:51:01 INFO - "slavebuilddir": "test" 15:51:01 INFO - } 15:51:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 15:51:01 INFO - Running post-action listener: _resource_record_post_action 15:51:01 INFO - [mozharness: 2016-10-19 22:51:01.427000Z] Finished read-buildbot-config step (success) 15:51:01 INFO - [mozharness: 2016-10-19 22:51:01.427110Z] Running download-and-extract step. 15:51:01 INFO - Running pre-action listener: _resource_record_pre_action 15:51:01 INFO - Running main action method: download_and_extract 15:51:01 INFO - mkdir: /builds/slave/test/build/tests 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:01 INFO - trying https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 15:51:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 15:51:02 INFO - Downloaded 1199 bytes. 15:51:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:51:02 INFO - Using the following test package requirements: 15:51:02 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:51:02 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 15:51:02 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 15:51:02 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'jsshell-mac.zip'], 15:51:02 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 15:51:02 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:51:02 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 15:51:02 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 15:51:02 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 15:51:02 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:51:02 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 15:51:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:51:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:51:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:51:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:51:03 INFO - Expected file size: 16436208 15:51:10 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:51:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:51:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:51:10 INFO - Fetch https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:51:10 INFO - Expected file size: 16436208 15:51:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 15:51:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:51:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 15:51:17 INFO - Expected file size: 14414081 15:51:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:18 INFO - trying https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 15:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 15:51:21 INFO - Downloaded 115423744 bytes. 15:51:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:51:21 INFO - mkdir: /builds/slave/test/properties 15:51:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:21 INFO - Contents: 15:51:21 INFO - build_url:https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:51:22 INFO - Running post-action listener: _resource_record_post_action 15:51:22 INFO - Running post-action listener: set_extra_try_arguments 15:51:22 INFO - [mozharness: 2016-10-19 22:51:22.614336Z] Finished download-and-extract step (success) 15:51:22 INFO - [mozharness: 2016-10-19 22:51:22.614477Z] Running populate-webroot step. 15:51:22 INFO - Running pre-action listener: _resource_record_pre_action 15:51:22 INFO - Running main action method: populate_webroot 15:51:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:22 INFO - '--tppagecycles', 15:51:22 INFO - '7'], 15:51:22 INFO - 'tests': ['tsvgm']}}, 15:51:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['damp', 'tps']}, 15:51:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'tests': ['damp', 'tps']}, 15:51:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['dromaeo_dom']}, 15:51:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['basic_compositor_video']}, 15:51:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:51:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tsvgx', 15:51:22 INFO - 'tsvgr_opacity', 15:51:22 INFO - 'tart', 15:51:22 INFO - 'tscrollx', 15:51:22 INFO - 'cart']}, 15:51:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:22 INFO - 'tsvgr_opacity', 15:51:22 INFO - 'tart', 15:51:22 INFO - 'tscrollx', 15:51:22 INFO - 'cart']}, 15:51:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tp5o']}, 15:51:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'tests': ['tp5o']}, 15:51:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s', 15:51:22 INFO - '--xperf_path', 15:51:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:22 INFO - 'tests': ['tp5n']}, 15:51:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--xperf_path', 15:51:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:22 INFO - 'tests': ['tp5n']}}, 15:51:22 INFO - 'talos.zip': {'path': '', 15:51:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:22 INFO - Running post-action listener: _resource_record_post_action 15:51:22 INFO - [mozharness: 2016-10-19 22:51:22.633313Z] Finished populate-webroot step (success) 15:51:22 INFO - [mozharness: 2016-10-19 22:51:22.633443Z] Running create-virtualenv step. 15:51:22 INFO - Running pre-action listener: _resource_record_pre_action 15:51:22 INFO - Running main action method: create_virtualenv 15:51:22 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:51:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:22 INFO - Using real prefix '/tools/python27' 15:51:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:26 INFO - Installing pip.................done. 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:26 INFO - 'HOME': '/Users/cltbld', 15:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PAGER': '/bin/cat', 15:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:26 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - 'XPC_FLAGS': '0x0', 15:51:26 INFO - 'XPC_SERVICE_NAME': '0', 15:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:51:26 INFO - Cleaning up... 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:51:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:26 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>=3.1.1'] in /builds/slave/test/build 15:51:26 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>=3.1.1 15:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:26 INFO - 'HOME': '/Users/cltbld', 15:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PAGER': '/bin/cat', 15:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:26 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - 'XPC_FLAGS': '0x0', 15:51:26 INFO - 'XPC_SERVICE_NAME': '0', 15:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:27 INFO - Downloading/unpacking psutil>=3.1.1 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:30 INFO - Installing collected packages: psutil 15:51:30 INFO - Running setup.py install for psutil 15:51:30 INFO - building 'psutil._psutil_osx' extension 15:51:30 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 15:51:30 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 15:51:30 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 15:51:30 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 15:51:31 INFO - building 'psutil._psutil_posix' extension 15:51:31 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 15:51:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:51:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:51:31 INFO - ^ 15:51:31 INFO - 1 warning generated. 15:51:31 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 15:51:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:31 INFO - Successfully installed psutil 15:51:31 INFO - Cleaning up... 15:51:31 INFO - Return code: 0 15:51:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:31 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:31 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.3'] in /builds/slave/test/build 15:51:31 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.3 15:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:31 INFO - 'HOME': '/Users/cltbld', 15:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:31 INFO - 'LOGNAME': 'cltbld', 15:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:31 INFO - 'MOZ_NO_REMOTE': '1', 15:51:31 INFO - 'NO_EM_RESTART': '1', 15:51:31 INFO - 'PAGER': '/bin/cat', 15:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:31 INFO - 'PWD': '/builds/slave/test', 15:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:31 INFO - 'SHELL': '/bin/bash', 15:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:31 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:31 INFO - 'USER': 'cltbld', 15:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:31 INFO - 'XPC_FLAGS': '0x0', 15:51:31 INFO - 'XPC_SERVICE_NAME': '0', 15:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:51:34 INFO - Installing collected packages: mozsystemmonitor 15:51:34 INFO - Running setup.py install for mozsystemmonitor 15:51:34 INFO - Successfully installed mozsystemmonitor 15:51:34 INFO - Cleaning up... 15:51:34 INFO - Return code: 0 15:51:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:34 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==2.5.1'] in /builds/slave/test/build 15:51:34 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==2.5.1 15:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:34 INFO - 'HOME': '/Users/cltbld', 15:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:34 INFO - 'LOGNAME': 'cltbld', 15:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:34 INFO - 'MOZ_NO_REMOTE': '1', 15:51:34 INFO - 'NO_EM_RESTART': '1', 15:51:34 INFO - 'PAGER': '/bin/cat', 15:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:34 INFO - 'PWD': '/builds/slave/test', 15:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:34 INFO - 'SHELL': '/bin/bash', 15:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:34 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:34 INFO - 'USER': 'cltbld', 15:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:34 INFO - 'XPC_FLAGS': '0x0', 15:51:34 INFO - 'XPC_SERVICE_NAME': '0', 15:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:38 INFO - warning: no files found matching '*.txt' 15:51:38 INFO - no previously-included directories found matching 'build' 15:51:38 INFO - no previously-included directories found matching 'dist' 15:51:38 INFO - no previously-included directories found matching '.git*' 15:51:38 INFO - Installing collected packages: jsonschema, functools32 15:51:38 INFO - Running setup.py install for functools32 15:51:38 INFO - warning: no files found matching '*.txt' 15:51:38 INFO - no previously-included directories found matching 'build' 15:51:38 INFO - no previously-included directories found matching 'dist' 15:51:38 INFO - no previously-included directories found matching '.git*' 15:51:38 INFO - Successfully installed jsonschema functools32 15:51:38 INFO - Cleaning up... 15:51:38 INFO - Return code: 0 15:51:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:51:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:38 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:51:38 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 functools32==3.2.3-2 15:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:38 INFO - 'HOME': '/Users/cltbld', 15:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:38 INFO - 'LOGNAME': 'cltbld', 15:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:38 INFO - 'MOZ_NO_REMOTE': '1', 15:51:38 INFO - 'NO_EM_RESTART': '1', 15:51:38 INFO - 'PAGER': '/bin/cat', 15:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:38 INFO - 'PWD': '/builds/slave/test', 15:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:38 INFO - 'SHELL': '/bin/bash', 15:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:38 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:38 INFO - 'USER': 'cltbld', 15:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:38 INFO - 'XPC_FLAGS': '0x0', 15:51:38 INFO - 'XPC_SERVICE_NAME': '0', 15:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:51:38 INFO - Cleaning up... 15:51:38 INFO - Return code: 0 15:51:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:38 INFO - 'HOME': '/Users/cltbld', 15:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:38 INFO - 'LOGNAME': 'cltbld', 15:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:38 INFO - 'MOZ_NO_REMOTE': '1', 15:51:38 INFO - 'NO_EM_RESTART': '1', 15:51:38 INFO - 'PAGER': '/bin/cat', 15:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:38 INFO - 'PWD': '/builds/slave/test', 15:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:38 INFO - 'SHELL': '/bin/bash', 15:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:38 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:38 INFO - 'USER': 'cltbld', 15:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:38 INFO - 'XPC_FLAGS': '0x0', 15:51:38 INFO - 'XPC_SERVICE_NAME': '0', 15:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:42 INFO - Downloading docopt-0.6.1.tar.gz 15:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:42 INFO - Running setup.py install for blobuploader 15:51:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:43 INFO - Running setup.py install for requests 15:51:43 INFO - Running setup.py install for docopt 15:51:43 INFO - Successfully installed blobuploader requests docopt 15:51:43 INFO - Cleaning up... 15:51:43 INFO - Return code: 0 15:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:43 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 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:43 INFO - 'HOME': '/Users/cltbld', 15:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:43 INFO - 'LOGNAME': 'cltbld', 15:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:43 INFO - 'MOZ_NO_REMOTE': '1', 15:51:43 INFO - 'NO_EM_RESTART': '1', 15:51:43 INFO - 'PAGER': '/bin/cat', 15:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:43 INFO - 'PWD': '/builds/slave/test', 15:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:43 INFO - 'SHELL': '/bin/bash', 15:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:43 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:43 INFO - 'USER': 'cltbld', 15:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:43 INFO - 'XPC_FLAGS': '0x0', 15:51:43 INFO - 'XPC_SERVICE_NAME': '0', 15:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9mdCvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9piQmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-DsDs9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-RFEHiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-hYNAcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ftO4I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-lQD6Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-il8ZIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Dhm8AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:44 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-o2ZwLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-IpN9VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-zp5hPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-nDjeIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Se7Ola-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-sgnYTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-AIly7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:45 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-QyZI5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:45 INFO - Running setup.py install for manifestparser 15:51:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Running setup.py install for mozcrash 15:51:46 INFO - Running setup.py install for mozdebug 15:51:46 INFO - Running setup.py install for mozdevice 15:51:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozfile 15:51:46 INFO - Running setup.py install for mozhttpd 15:51:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozinfo 15:51:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozInstall 15:51:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozleak 15:51:47 INFO - Running setup.py install for mozlog 15:51:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Running setup.py install for moznetwork 15:51:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Running setup.py install for mozprocess 15:51:47 INFO - Running setup.py install for mozprofile 15:51:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Running setup.py install for mozrunner 15:51:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Running setup.py install for mozscreenshot 15:51:48 INFO - Running setup.py install for moztest 15:51:48 INFO - Running setup.py install for mozversion 15:51:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:48 INFO - Cleaning up... 15:51:48 INFO - Return code: 0 15:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:48 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 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:48 INFO - 'HOME': '/Users/cltbld', 15:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:48 INFO - 'LOGNAME': 'cltbld', 15:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:48 INFO - 'MOZ_NO_REMOTE': '1', 15:51:48 INFO - 'NO_EM_RESTART': '1', 15:51:48 INFO - 'PAGER': '/bin/cat', 15:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:48 INFO - 'PWD': '/builds/slave/test', 15:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:48 INFO - 'SHELL': '/bin/bash', 15:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:48 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:48 INFO - 'USER': 'cltbld', 15:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:48 INFO - 'XPC_FLAGS': '0x0', 15:51:48 INFO - 'XPC_SERVICE_NAME': '0', 15:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-2aDD00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-IBtwX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:48 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-q9Lmlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-wHBUBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-YyI24S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-eKY2KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-QtwzmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-1fRGEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-XDnbNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-zWJdms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-AGy192-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-L0bp_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:49 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-5cSOUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:50 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-7rlI3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:50 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-oI9rJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:50 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-0GDWbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:50 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9M4KQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - Downloading blessings-1.6.tar.gz 15:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:53 INFO - Installing collected packages: blessings 15:51:53 INFO - Running setup.py install for blessings 15:51:53 INFO - Successfully installed blessings 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:53 INFO - Reading from file tmpfile_stdout 15:51:53 INFO - Current package versions: 15:51:53 INFO - blessings == 1.6 15:51:53 INFO - blobuploader == 1.2.4 15:51:53 INFO - docopt == 0.6.1 15:51:53 INFO - functools32 == 3.2.3-2 15:51:53 INFO - jsonschema == 2.5.1 15:51:53 INFO - manifestparser == 1.1 15:51:53 INFO - mozInstall == 1.12 15:51:53 INFO - mozcrash == 0.17 15:51:53 INFO - mozdebug == 0.1 15:51:53 INFO - mozdevice == 0.48 15:51:53 INFO - mozfile == 1.2 15:51:53 INFO - mozhttpd == 0.7 15:51:53 INFO - mozinfo == 0.9 15:51:53 INFO - mozleak == 0.1 15:51:53 INFO - mozlog == 3.4 15:51:53 INFO - moznetwork == 0.27 15:51:53 INFO - mozprocess == 0.23 15:51:53 INFO - mozprofile == 0.28 15:51:53 INFO - mozrunner == 6.12 15:51:53 INFO - mozscreenshot == 0.1 15:51:53 INFO - mozsystemmonitor == 0.3 15:51:53 INFO - moztest == 0.7 15:51:53 INFO - mozversion == 1.4 15:51:53 INFO - psutil == 3.1.1 15:51:53 INFO - requests == 1.2.3 15:51:53 INFO - wsgiref == 0.1.2 15:51:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 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 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:53 INFO - 'HOME': '/Users/cltbld', 15:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:53 INFO - 'LOGNAME': 'cltbld', 15:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:53 INFO - 'MOZ_NO_REMOTE': '1', 15:51:53 INFO - 'NO_EM_RESTART': '1', 15:51:53 INFO - 'PAGER': '/bin/cat', 15:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:53 INFO - 'PWD': '/builds/slave/test', 15:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:53 INFO - 'SHELL': '/bin/bash', 15:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:53 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:53 INFO - 'USER': 'cltbld', 15:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:53 INFO - 'XPC_FLAGS': '0x0', 15:51:53 INFO - 'XPC_SERVICE_NAME': '0', 15:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107811490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107787570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6f0d95960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, '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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 15:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:53 INFO - 'HOME': '/Users/cltbld', 15:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:53 INFO - 'LOGNAME': 'cltbld', 15:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:53 INFO - 'MOZ_NO_REMOTE': '1', 15:51:53 INFO - 'NO_EM_RESTART': '1', 15:51:53 INFO - 'PAGER': '/bin/cat', 15:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:53 INFO - 'PWD': '/builds/slave/test', 15:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:53 INFO - 'SHELL': '/bin/bash', 15:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:51:53 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:53 INFO - 'USER': 'cltbld', 15:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:53 INFO - 'XPC_FLAGS': '0x0', 15:51:53 INFO - 'XPC_SERVICE_NAME': '0', 15:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:54 INFO - Cleaning up... 15:51:54 INFO - Return code: 0 15:51:54 INFO - Running post-action listener: _resource_record_post_action 15:51:54 INFO - Running post-action listener: _start_resource_monitoring 15:51:54 INFO - Starting resource monitoring. 15:51:54 INFO - [mozharness: 2016-10-19 22:51:54.239933Z] Finished create-virtualenv step (success) 15:51:54 INFO - [mozharness: 2016-10-19 22:51:54.240977Z] Running install step. 15:51:54 INFO - Running pre-action listener: _resource_record_pre_action 15:51:54 INFO - Running main action method: install 15:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:54 INFO - Reading from file tmpfile_stdout 15:51:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:54 INFO - Reading from file tmpfile_stdout 15:51:54 INFO - Output received: 15:51:54 INFO - Usage: mozinstall [options] installer 15:51:54 INFO - Options: 15:51:54 INFO - -h, --help show this help message and exit 15:51:54 INFO - -d DEST, --destination=DEST 15:51:54 INFO - Directory to install application into. [default: 15:51:54 INFO - "/builds/slave/test"] 15:51:54 INFO - --app=APP Application being installed. [default: firefox] 15:51:54 INFO - mkdir: /builds/slave/test/build/application 15:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:52:27 INFO - Reading from file tmpfile_stdout 15:52:27 INFO - Output received: 15:52:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:52:27 INFO - Running post-action listener: _resource_record_post_action 15:52:27 INFO - [mozharness: 2016-10-19 22:52:27.317138Z] Finished install step (success) 15:52:27 INFO - [mozharness: 2016-10-19 22:52:27.317302Z] Running run-tests step. 15:52:27 INFO - Running pre-action listener: _resource_record_pre_action 15:52:27 INFO - Running main action method: run_tests 15:52:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:52:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:52:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:52:27 INFO - 2016-10-19 15:52:27.332 screenresolution[1636:7674] starting screenresolution argv=screenresolution get 15:52:27 INFO - 2016-10-19 15:52:27.334 screenresolution[1636:7674] Display 0: 1600x1200x32@60 15:52:27 INFO - 2016-10-19 15:52:27.340 screenresolution[1637:7676] starting screenresolution argv=screenresolution list 15:52:27 INFO - Available Modes on Display 0 15:52:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:52:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:52:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:52:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:52:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:52:27 INFO - Intel Iris: 15:52:27 INFO - Chipset Model: Intel Iris 15:52:27 INFO - Type: GPU 15:52:27 INFO - Bus: Built-In 15:52:27 INFO - VRAM (Dynamic, Max): 1536 MB 15:52:27 INFO - Vendor: Intel (0x8086) 15:52:27 INFO - Device ID: 0x0a2e 15:52:27 INFO - Revision ID: 0x0009 15:52:27 INFO - Displays: 15:52:27 INFO - Display: 15:52:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:52:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:52:27 INFO - Display Serial Number: 1600x1200 60 15:52:27 INFO - Main Display: Yes 15:52:27 INFO - Mirror: Off 15:52:27 INFO - Online: Yes 15:52:27 INFO - Rotation: Supported 15:52:27 INFO - Return code: 0 15:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:27 INFO - Python 2.7.3 15:52:27 INFO - Return code: 0 15:52:27 INFO - grabbing minidump binary from tooltool 15:52:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:27 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107625d30>, '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 0x10748bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10761db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:27 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 15:52:27 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 15:52:27 INFO - Calling ['/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'] with output_timeout 600 15:52:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:27 INFO - Return code: 0 15:52:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:52:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:52:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 15:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --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 15:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fi0QU7vhk8/Render', 15:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:27 INFO - 'HOME': '/Users/cltbld', 15:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:27 INFO - 'LOGNAME': 'cltbld', 15:52:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:27 INFO - 'MOZ_NO_REMOTE': '1', 15:52:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:27 INFO - 'NO_EM_RESTART': '1', 15:52:27 INFO - 'PAGER': '/bin/cat', 15:52:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:27 INFO - 'PWD': '/builds/slave/test', 15:52:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:27 INFO - 'SHELL': '/bin/bash', 15:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AGlzqjfk2I/Listeners', 15:52:27 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 15:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:27 INFO - 'USER': 'cltbld', 15:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:27 INFO - 'XPC_FLAGS': '0x0', 15:52:27 INFO - 'XPC_SERVICE_NAME': '0', 15:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 15:52:27 INFO - mozversion application_buildid: 20161019133122 15:52:27 INFO - mozversion application_changeset: cb7f5639c1473b8bad95e8f848f2b3ba6ff89753 15:52:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:52:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:27 INFO - mozversion application_name: Firefox 15:52:27 INFO - mozversion application_remotingname: firefox-dev 15:52:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:52:27 INFO - mozversion application_vendor: Mozilla 15:52:27 INFO - mozversion application_version: 51.0a2 15:52:27 INFO - mozversion platform_buildid: 20161019133122 15:52:27 INFO - mozversion platform_changeset: cb7f5639c1473b8bad95e8f848f2b3ba6ff89753 15:52:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:52:27 INFO - mozversion platform_version: 51.0a2 15:52:27 INFO - using testdate: 1476917547 15:52:27 INFO - actual date: 1476917547 15:52:27 INFO - starting webserver on 'localhost:49273' 15:52:27 INFO - SUITE-START | Running 2 tests 15:52:27 INFO - TEST-START | dromaeo_css 15:52:27 INFO - operating with platform_type : mac_ 15:52:27 INFO - Initialising browser for dromaeo_css test... 15:52:27 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmplyOdm6/profile http://localhost:49273/getInfo.html) 15:52:30 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 15:52:30 INFO - PROCESS | 1647 | colorDepth:24 15:52:30 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 15:52:30 INFO - PROCESS | 1647 | __metrics 15:52:30 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 15:52:31 INFO - TEST-INFO | 1647: exit 0 15:52:31 INFO - Browser initialized. 15:52:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:31 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmplyOdm6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:43 INFO - PROCESS | 1651 | RSS: Main: 225386496 15:52:43 INFO - PROCESS | 1651 | 15:53:33 INFO - PROCESS | 1651 | 1476917613213 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:55:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 15:55:46 INFO - PROCESS | 1651 | RSS: Main: 238759936 15:55:46 INFO - PROCESS | 1651 | 15:58:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 15:58:49 INFO - PROCESS | 1651 | RSS: Main: 249024512 15:58:49 INFO - PROCESS | 1651 | 16:01:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 16:01:52 INFO - PROCESS | 1651 | RSS: Main: 252358656 16:01:52 INFO - PROCESS | 1651 | 16:04:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 16:04:54 INFO - PROCESS | 1651 | RSS: Main: 252596224 16:04:54 INFO - PROCESS | 1651 | 16:07:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 16:07:58 INFO - PROCESS | 1651 | RSS: Main: 257392640 16:07:58 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 16:11:01 INFO - PROCESS | 1651 | RSS: Main: 258818048 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | __start_tp_report 16:11:01 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 16:11:01 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 16:11:01 INFO - PROCESS | 1651 | |i|pagename|runs| 16:11:01 INFO - PROCESS | 1651 | |0;dojo.html;3387.3733359328526;3415.880444184454;3437.329720704463;3447.586289645243;3479.7216222702186;5816.563757718172;5905.232319798425;5920.555958303134;5927.229460170182;5941.732622032014;4157.979210103953;5809.796657117002;5891.469767720904;5912.586118971673;5935.910961335572;4565.863024109282;5327.786888524454;5331.813386531472;5401;5404.7838086476495;4868.440129385131;5391.218273350361;5422.9728851355685;5427.755750991215;5479.643823151482;5268.473152684739;5305.734713264341;5392.2181283714035;5408.91886621701;5415.972920135414;5311.521963023327;5332.866678333034;5335.626506144571;5336.279602253724;5369.40936496985;4751.88541099211;5007.223880298559;5280.155175171954;5336.786528538853;5453.2092846537425;5753.827385178452;5963.940360596382;6008.008678568031;6069.666168360738;6084.269887613515;6161.229846269216;6221.377862213788;6236.906446403307;6276.152719382871;6286.151369565096;6312.684365781693;6329.177206963065;6334.4299013088585;6344.524160687921;6355.269144048448;5877.265341832271;5997.370276121032;6009.1587177795145;6009.729562169713;6011.729472173763;6263.530235232284;6362.872742545216;6387.201599800025;6398.552101352953;6424.550281480251;6302.905456418157;6312.652804095819;6315.96842015787;6316.463100636405;6322.114903913456;5866.970665146647;6184.350643182401;6201.317855035943;6279.529035322369;6329.936700633027;6230.719617617218;6286.245650521967;6324.114623952651;6355.396237357444;6377.362263773585;5011.323471331397;6245.531585131133;6253.749250149988;6282.403171698681;6316.778912738124;4945.357103576512;4963.851084467472;5001.349824522788;5064.46823083571;5066.6453348266;4463.973286144205;4506.752128632891;4517.728936263835;4521.3896124023495;4606.147862645421;4524.343970124313;5004.599632029429;5644.604877658607;6086.543509236825;6158.384161583896;5934.584579079423;6068.75724971005;6286.057091436322;6333.271673757485;6342.968285158545;5374.596905232123;6022.638641681513;6041.697915104227;6064.211652485149;6120.020512922583;5485.561155107582;5502.752376143083;5510.311211098613;5518.834434966958;5524.861878452991;6345.143405640272;6358.046293055986;6404.615723056631;6421.8394540135005;6437.485001199986;6216.7824126155365;6250.906236406367;6257.2491301044165;6292.653904035322;6299.464545513682;6409.4231519163495;6432.581882177644;6434.64609446485;6446.5165112615805;6468.579542329733;6299.874002519832;6301.180846489927;6305.905411418924;6350.110984462087;6352.936470635234;6212.223472065992;6240.375962403723;6248.187735594343;6272.18461599989;6305.90541141874;6116.816495505142;6241.407066328691;6260.561760676709;6299.905501417391;6337.746490140343;6275.52933529978;6307.432331090224;6315.368463153832;6317.052442133717;6330.968345158429;5797.333306669787;6082.574219804748;6123.785667501616;6173.444390004921;6276.748930042747;6255.593386429868;6269.843253918689;6311.558190926775;6317.905231421624;6339.144215530844;6132.9386706134155;6179.938200617937;6181.907271390843;6202.968985155046;6208.534359922934 16:11:01 INFO - PROCESS | 1651 | |1;ext.html;460.31413194340445;514.0951924612681;529.3885562175689;529.7880847660934;548.6516062300439;32110.036698899043;40368;40372.59627403725;40442.797786011106;40592.797036014854;33209.83395083021;41219;41788.58211417885;41791;41852;9649.855252171206;9870.753231169243;9878.407295562254;9892.802143957117;9897.208223342152;9737.367071140388;9868.950655246714;9872.654457094002;9884.357516761387;9912.553935072903;7688.6924523019015;9856.901430985707;9896.109350158484;9900.950495247514;9918.950405247964;9817.656382026595;9842.212622990179;9851.211903047739;9858.359206651616;9878.407295562218;9728;9744.07431294026;9848.852267215998;9855.655052073214;9887.90112098877;39273;39360.803195984125;39550;39629;39637;3085.799423037495;3289.7697161198726;3314.9171270718425;3502.6322236165347;3751;29331.853340733374;30649.38701225963;30895.91864284739;31285.37429251402;31366.215799882757;2683.7450442208155;3106.937861242785;3156.4476216662224;3158.352537729783;3336.5328853960464;494523;506952;507211.4639426816;507819;508591;51753.706157345616;51905.74047129816;52150.47849521532;52151.217731734054;53163.20255196175;59828.70085649544;59976.70011650001;60017.69991150016;60077.69961150167;60127.69936150291;16281.348746050262;16510.75233871493;16521.586960326087;16547.503574892773;16555.751663725056;12926;12956.157849739737;12975.961923046134;12979.35103244834;13013.934930325287;14077;14825.851741482662;14974.326155323037;14980.40078396852;15145.394184232728;7137.857242855114;7221.4583906207245;7315.195328513859;7330.450216233698;7359.4480413968095;796.4584082823735;928.8049509602924;953.3421938862163;955.5508910811907;1052.394872948058;23797.881010594836;29548.409031819672;30220.5466917992;30689.539656905163;31119.066428007198;994.8608842874868;1023.9897601024044;1038.8389799581078;1098.6209757633603;1161.12335186935;15136.621584460476;15783.526494205193;15876.52370428889;15888.841111588967;15979.840201597835;666531;683855;684600;685263;685688;56856.43143568594;57087.42912570821;57409;57488.137677934865;57620;1285.460106755165;1308.627041293227;1334.2661536155076;1340.8726171013739;1346.3941226448137;28131.296717582223;29686;30252.394952100396;30567.08298751041;30878.38243235168;44947;48786.756066219445;53843.46156538385;56044;58743;530434;535079;537438;537721;539320;34473.482897756054;34743.4788478168;34926;34934.82532587321;34945.82527087348;34673;40567.594324057565;44171;45157.322640159764;45802;36702.63297367099;38164.427533586466;38407.61592384041;38708.516233539114;42202.36696449617;38717.80641096889;39013;39189;39820.40269396019;39947.60052399439;30968.535471967487;37112;37759.244815104095;37959.81020094882;38071;33025;34633.9609811706;34956.82521587376;35122.82438587791;35171.82414087913;23209.651855221848;25025.29410597772;26044.479110417305;26110.151736081312;26395.944162233296 16:11:01 INFO - PROCESS | 1651 | |2;jquery.html;357.81214862197345;362.81315122711794;372.1050872651274;376.14990122323576;393.9684825213983;18824;19169.61660766784;20145.59708805823;20489.975501224915;20725;19280.807191928077;19959.900200499014;20009.499762505944;20372.879491627955;20477;5447.591430642708;5564.322812624846;5582.413846546115;5636.126400407943;6031.185789918349;6062.787802426916;6228.564000519966;6234.283057448406;6241.843953901143;6259.561830671855;5221.660592061504;5878.941790477712;6056.394360563931;6158.322584515699;6185.350538193492;6112.083187521885;6157.876842463148;6167.938320616781;6171.012637977902;6180.84547886302;5191.472365070663;5300.549453296474;5303.4166241713765;5372.462753724635;5372.597055220874;11210.551577936872;12760.872391276062;12810.74378512434;12955.870441295654;12964.935175324157;2180.738311402642;2280.429892526868;2397.5324811661735;2427.927162185137;2439.536488067279;8084.514929104273;9595.328327017112;9753.658621948269;10317.793644127076;10437.373757574494;1532.9770053449208;1857.359211072178;1877.108373522566;1921.1162865082078;1924.913378897953;71533;96099.51950240273;119234.80765192324;120434.39782801118;130663;11660.76678466426;11671.941640291745;11748.236364636272;11813.90538134883;11821.349825759666;14712.926435367755;14748.188849613374;14749.188794616399;14789.482368117064;14806.851931480764;8523;8698.956505217433;8712.346574006975;8832.02847686754;8866.20204181614;8546.871796923051;8624.439411438236;8659.78350541229;8722.345824063093;8803.691870784492;4442.933355999663;4523.457185137804;4532.546745325507;4550.340200670884;4620.353150558924;1898.6297671953837;1899.6105798311312;1939.398786376228;1952.160570954503;1957.2660252405349;770.5569297653872;818.3902992270678;904.9457032577935;982.823091843475;998.8901220865699;19316.903415483113;20517.38447846567;20679.27622533204;20770.688439673417;21068.57862842765;809.6154326694773;858.733792524307;880.872273520336;919.797644518205;921.7603423109906;10159.441230732233;10770.299930504492;10782.975617316342;10802.973717496825;10803.783924321628;550475.2476237674;558953;562556;595558;607531;99408.5029574862;118866.4056679711;129074;130904;131024.34487827691;851.1445996773203;872.0581771686436;872.520113937332;876.373393023991;877.3419935048713;18176.81823181804;18521.62956740831;19736.506587335432;19895.403137905887;20774;56779.71610141923;56914;57200;58452;58534.7073264648;64283.67858160679;70814;73212.26787732268;76698.61650691711;80371.59814200892;4759.764708232226;7568.4323675725645;7611.467197296136;7849.921500784919;8109.310708589836;10626.89373106259;12636.684082898;13022.54421095295;13068.54260100892;13159.407826647632;9786.217102631916;10518.631847885288;10988.120950324115;11050.171237157085;11383.373914434786;10130.746731331776;10307.29929561614;10701.464926753786;11068.391238481961;11183.273087249303;11197.38414387184;11200.719982000515;11268.492917818554;11543.88456115428;11564.074874010228;7912.520698760349;7913;8119.79700507492;8270.917290827014;8303.62633681498;7957.482763620577;10677.039066484054;10961.068309193808;11160.33038017689;11174.441277936234 16:11:01 INFO - PROCESS | 1651 | |3;mootools.html;1336.4921329894642;1538.876350636122;1701;1831.3590243414799;1842.530154810523;8143.267105960463;8424.452410593323;8672.089430609782;9237.63049478021;9259.444433334005;8674.869876951834;8982.37123401362;9001.549922503882;9081.228095611881;9085.227755640763;2264.241479104502;2301.5972204864083;2301.850379725321;2310.2838120182714;2312.7455979842202;2065.5559054803216;2084.6560317547587;2295.724513058427;2411.6503107049466;2438.9634155487684;2421.878906054699;2422.321749910028;2423.575874222004;2443.5235129149823;2444.0956845967016;2343.5898717724417;2352;2353.470469144437;2358.8584684918874;2369.4905595297096;2378.4172877644914;2409.506051259488;2426.980668119394;2427.7450867658818;2436.3056528889183;9022.593983270703;9066.093390660948;9124.315676324302;9126.77183070422;9145.176934075898;5316.441773613754;5442.156465747816;5471.917921231185;5480.506754392124;5490.203920431515;3653.725970552219;3666.046827824758;3701.9074523137137;3711.5175027246555;3736.551613806361;1045.9320144190604;1060.4379678770265;1101.7741363020561;1110.4170310586926;1122.0630773304301;12053.15627906047;12098.697532561668;12203.511859525608;12226.816597751042;12234.388280585936;4754.215554433549;4804.855854324376;4805.303231031551;4872.756362181876;4924.359833221658;8607.311415086779;10152.289339746147;10246.436445995392;10275.229357798195;10302.175825933908;5421;5426.294581704353;5437.184422336682;5439.156930675752;5441.809536666197;4410.625096866738;4669.089527542164;4905.068037072945;4957.3059771632;4984.651074424755;4030.7984600769846;4071.3892916062828;4132.318167502329;4170.791460426966;4177.206330797199;1245.3088535862503;1246.8503779546513;1253.486070711004;1261.7161138743893;1261.9432125554372;767.5087943716027;792.6235038356734;796.3072127249214;905.7463910105181;916.7158180963922;4991.50084991498;5350.705711185922;5621.887562248732;5796.536277097822;6123.601965872204;756.8826831841073;823.2549542663899;928.6888892221182;936.878205833251;997.9201663867018;3352.8826491072696;3925.293447179535;3945.861894833667;3963.623455771697;4035.414864844581;9984.301098923152;10366.859645438995;11189.328640281608;11196.720081998015;11212.943935280435;9308.301877359225;11087.33475991443;11157.609483668033;11159.330440173615;11198.664040078811;8030.437869349206;8403.327733781283;8408.873866892001;8532.36007299455;8568.785780355542;6077.908831367445;6081.787137450168;6130.295016073031;6178.1350610913605;6239.563230573816;10258.743531411475;10330.760308762996;10363;10367.481625918523;10460.372377657364;10108.342957707726;10781.838272425763;10790.406527641055;10796.892031079902;10798;7125.1093613298335;7355.66899489535;7537.283958023979;7755.457118001686;7928.881066784118;8384.245417912418;8545.700900468453;8697;8717.91282087171;8768.605412756313;7593.240675932362;7679.654415551202;7715.267049630276;7826.099998500245;7858.921410786048;7458.105027396748;7562.978997835442;7579.772606821804;7591.734289299848;7729.265719756614;7052.682629281592;7188.460865435009;7193.568385896863;7194.388476979515;7212.062431884031;4875.7074575525585;4948.62885283598;5013.498650135103;5053.67151135175;5114.846554603368;4944.975275123746;5081.339425874613;5105.974470127626;5145.845624631267;5207.505286997729 16:11:01 INFO - PROCESS | 1651 | |4;prototype.html;304.46110384619226;307.67079225229014;310.74829388195565;319.11127509884943;319.44895056028355;5312.707801070939;5495.258140151079;5523.502884740373;5577.940191363643;5622.706777441186;4791.113643975867;5038.420581633104;5289.979615492225;5360.115580929142;5459.863503412406;3594.6405359464106;4188.853390131346;4190.601892820185;4227.746335219881;4231.090315582149;3921.4117882317737;4096.5903409659095;4143.7720925349095;4197.7901104944785;4218.346156345771;4085.387191921206;4086.2031903778775;4118.464599602063;4138.399932009872;4149.149424367997;3519.8064106474135;3610.8736194233074;3959.0696186396176;4150.584941505856;4174.478190226222;3572.178398968226;3575.7318201135017;3594.867616700731;3596.2198711637643;3596.388613935611;3948.822302996372;4089.734167279117;4244.596763307481;4873.732829464329;5091.0581542414775;4104.42538044674;4550.317452382169;4606.976965115153;4744.485422725961;4754.407273563361;4501.27979523278;4737.952620473786;4868.863349166628;5735.279416175131;5765.913511297334;3359.025882494074;3561.3411518868834;3885.5531613864487;3890.2219556088894;3913.706472014582;5688.857778555569;5969.134475501071;6014.8195554133445;6058.333583305833;6060.787872424488;3632.9091772705365;3692.984429281969;3946.901327466779;3950.6839452843706;3976.900577485528;3621.3925973299183;3681.2637472505608;4023.295923213426;4028.113814960704;4035.6996511988473;3617.3488772020764;4353.128154893363;4649.883752906137;4680.274557443602;4692.7653617319;5067.873303167376;5279.9208011879855;5286.629935904527;5889.440503152194;5940.138679891392;1267.195330964844;1314.6187605594462;1344.6503908983539;1362.5912226332061;1366.3919555797575;788.7791418402857;891.4116682989326;900.9954950225338;921.3550514639779;925.893522244937;4465.352523884018;5293.835356221625;5339.252504649352;5366.7048312343195;5393.083175860113;4901.485344038896;5797.347755889551;5799.971000144972;5809.796657116981;5819.330776960619;4743.9089009528;5076.3908330999775;5330.360356757136;5386.542143917733;5392.514673679388;2355.5053438777704;2355.6702061711376;2445.682061332051;2513.80042462845;2615.973840261573;4192;4212.7340823970035;4522.796474158671;4857.919347747908;5124.641275110706;5010.171287480043;5036.143855544567;5048.864005598784;5725.685087320154;6193.036456667736;5414.884687637424;5702.7433765480655;5831.891940531285;5846.532277417797;6087.786927457518;4853.80584776605;5576.470235327637;6041.426064523863;6110.816675499742;6154.83026241477;4817.9518204817505;4929.531694489017;4954.572259592702;5933.258342707161;5985.401459854154;5213.191955246943;5595.692236927008;6151.384861513813;6220.346863579259;6256.624602523863;3374.443216869189;3376.6454522274807;3869.825857836348;4006.8397264109108;4052.8986775330854;4946;5377.462253774747;5421.403645598902;5940.277319577274;5980.0398802593;5511.448855114617;5649.519790817826;5708.714564271853;5708.829689913475;5851.21008663825;4860.441049279378;5559.749811258423;5770.769169233184;5822.670931627214;5891.882162356643;5389.353277606712;5715.628484148517;5726.396608949501;5729.942700572941;5750.016244395677;4545.54544545556;5050.74746262678;5081.898362032664;5380;5760.855978600401;4837.210232214104;5343.648794530394;5790.118211581337;5797.739101740516;5830.679312637845 16:11:01 INFO - PROCESS | 1651 | |5;yui.html;603.4478452216222;666.4868051600271;690.2958981838525;800.2677550041712;815.4454970619976;12086.456109475073;13964.441422343107;14977.625559361022;15387.846121538782;15958.361665533364;11982.681904990466;14096.506622268224;14224.431022759103;14313.212773297464;14373.065750726195;819.1685439279137;842.9536375499375;846.031294168177;846.2130218896424;851.6976473351964;679.2833560593572;699.2727563334126;826.0912995704707;843.7047033538274;854.8461276970174;758.3175142371882;869.8564736818417;887.6582515731425;894.065701342099;898.716904175186;882.2104216726059;893.0355216366308;893.0845882970008;893.1247377570018;893.1827377949169;647.4464332995268;656.3731636287334;657.7171816119067;657.7500549791097;657.8421178917073;14703.779443308253;14782.03916745408;14812.629684257872;14828.851711482963;14851.554453366416;14501.27493625325;14528;14537.78193327101;14600.634984125376;14876;10389.792204155874;11685;11911.10666700001;12013.819792703116;12143.514259429612;3796.506454160969;3821.73247872649;3855.363864962278;3857.5756666766633;3984.083660758042;117646;121394.39302803518;123224;125455;125498.99999999908;9848.606055757833;10872;11126.942940420648;11153;11253.043491303331;21575.56848863014;23235.186768463023;23289.53420931572;23300.067997280257;23308.65037024446;7793.610319484003;7890.763277101696;7895.763127106081;8083.1916808319875;8210.01479822425;4217.578242175758;4284.357346398003;4309.267424537836;4314.201872653569;4438.689291749611;3619.782813031174;3714.312852122366;3720.311742327678;3722.40441529354;3726.2174943262216;649.7433513762132;668.9364510371604;674.9730010799611;679.0832376291967;684.9623270720059;508.7659676548755;521.9947800521946;639.517164540778;641.9005054216603;664.1764212376618;8492.683634036734;9014.95162708885;9257.861132083024;9269.16577508014;9777.755556111155;537.5887446103734;584.6959581017846;639.5728211437605;650.0996120373222;684.5242556423337;3730.403135498307;3922.7450215735885;4358.259095953696;4521.84173553924;4535.911381268472;169024.15487922728;171995.84012479646;173306;175107;176622;147114;147865;151751;155708.221458892;160528;127211.36394318154;130106.34946825205;130231.69768302195;134141;134208;6751.683421732715;7410.407167426485;7817.296443320129;7966.601669916365;8165.673373065011;61215;65417.672911635134;66809.66595166993;67203.66398167978;73294;105046.94953050371;106818;108916;110974;112413;11762.823557646814;11913.702157446132;12157.392130393622;12434.564790232298;12520.186187897758;13506.932465338003;13626.318684065955;13711.451541938211;14287.928560357132;14313.427462901367;12603.558875439316;12652.557160499338;12877.484900603871;13116.606501804961;13124.409401577142;12201.51193952232;12398.690032749253;12421.813672794735;12579;12941.935290323489;12038.879611203776;12098.637040888787;12369.381530923238;12401.069919755873;12885.742285154432;8936;9700.563474643517;9979.950100249453;10473.371597704163;10755.677329680122;9138.68014619485;10195.898041019791;10294.073533382032;10621.522031508446;10670.093042091508 16:11:01 INFO - PROCESS | 1651 | __end_tp_report 16:11:01 INFO - PROCESS | 1651 | __start_cc_report 16:11:01 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,357 16:11:01 INFO - PROCESS | 1651 | __end_cc_report 16:11:01 INFO - PROCESS | 1651 | __startTimestamp1476918661260__endTimestamp 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | ------- Summary: start ------- 16:11:01 INFO - PROCESS | 1651 | Number of tests: 6 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5831.15 Median:6132.94 stddev:680.47 (11.1%) stddev-sans-first:654.99 16:11:01 INFO - PROCESS | 1651 | Values: 3387.4 3415.9 3437.3 3447.6 3479.7 5816.6 5905.2 5920.6 5927.2 5941.7 4158.0 5809.8 5891.5 5912.6 5935.9 4565.9 5327.8 5331.8 5401.0 5404.8 4868.4 5391.2 5423.0 5427.8 5479.6 5268.5 5305.7 5392.2 5408.9 5416.0 5311.5 5332.9 5335.6 5336.3 5369.4 4751.9 5007.2 5280.2 5336.8 5453.2 5753.8 5963.9 6008.0 6069.7 6084.3 6161.2 6221.4 6236.9 6276.2 6286.2 6312.7 6329.2 6334.4 6344.5 6355.3 5877.3 5997.4 6009.2 6009.7 6011.7 6263.5 6362.9 6387.2 6398.6 6424.6 6302.9 6312.7 6316.0 6316.5 6322.1 5867.0 6184.4 6201.3 6279.5 6329.9 6230.7 6286.2 6324.1 6355.4 6377.4 5011.3 6245.5 6253.7 6282.4 6316.8 4945.4 4963.9 5001.3 5064.5 5066.6 4464.0 4506.8 4517.7 4521.4 4606.1 4524.3 5004.6 5644.6 6086.5 6158.4 5934.6 6068.8 6286.1 6333.3 6343.0 5374.6 6022.6 6041.7 6064.2 6120.0 5485.6 5502.8 5510.3 5518.8 5524.9 6345.1 6358.0 6404.6 6421.8 6437.5 6216.8 6250.9 6257.2 6292.7 6299.5 6409.4 6432.6 6434.6 6446.5 6468.6 6299.9 6301.2 6305.9 6350.1 6352.9 6212.2 6240.4 6248.2 6272.2 6305.9 6116.8 6241.4 6260.6 6299.9 6337.7 6275.5 6307.4 6315.4 6317.1 6331.0 5797.3 6082.6 6123.8 6173.4 6276.7 6255.6 6269.8 6311.6 6317.9 6339.1 6132.9 6179.9 6181.9 6203.0 6208.5 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:70274.34 Median:39884.00 stddev:154911.79 (388.4%) stddev-sans-first:155257.68 16:11:01 INFO - PROCESS | 1651 | Values: 460.3 514.1 529.4 529.8 548.7 32110.0 40368.0 40372.6 40442.8 40592.8 33209.8 41219.0 41788.6 41791.0 41852.0 9649.9 9870.8 9878.4 9892.8 9897.2 9737.4 9869.0 9872.7 9884.4 9912.6 7688.7 9856.9 9896.1 9901.0 9919.0 9817.7 9842.2 9851.2 9858.4 9878.4 9728.0 9744.1 9848.9 9855.7 9887.9 39273.0 39360.8 39550.0 39629.0 39637.0 3085.8 3289.8 3314.9 3502.6 3751.0 29331.9 30649.4 30895.9 31285.4 31366.2 2683.7 3106.9 3156.4 3158.4 3336.5 494523.0 506952.0 507211.5 507819.0 508591.0 51753.7 51905.7 52150.5 52151.2 53163.2 59828.7 59976.7 60017.7 60077.7 60127.7 16281.3 16510.8 16521.6 16547.5 16555.8 12926.0 12956.2 12976.0 12979.4 13013.9 14077.0 14825.9 14974.3 14980.4 15145.4 7137.9 7221.5 7315.2 7330.5 7359.4 796.5 928.8 953.3 955.6 1052.4 23797.9 29548.4 30220.5 30689.5 31119.1 994.9 1024.0 1038.8 1098.6 1161.1 15136.6 15783.5 15876.5 15888.8 15979.8 666531.0 683855.0 684600.0 685263.0 685688.0 56856.4 57087.4 57409.0 57488.1 57620.0 1285.5 1308.6 1334.3 1340.9 1346.4 28131.3 29686.0 30252.4 30567.1 30878.4 44947.0 48786.8 53843.5 56044.0 58743.0 530434.0 535079.0 537438.0 537721.0 539320.0 34473.5 34743.5 34926.0 34934.8 34945.8 34673.0 40567.6 44171.0 45157.3 45802.0 36702.6 38164.4 38407.6 38708.5 42202.4 38717.8 39013.0 39189.0 39820.4 39947.6 30968.5 37112.0 37759.2 37959.8 38071.0 33025.0 34634.0 34956.8 35122.8 35171.8 23209.7 25025.3 26044.5 26110.2 26395.9 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:33485.12 Median:385.06 stddev:95995.65 (24930.1%) stddev-sans-first:96232.71 16:11:01 INFO - PROCESS | 1651 | Values: 357.8 362.8 372.1 376.1 394.0 18824.0 19169.6 20145.6 20490.0 20725.0 19280.8 19959.9 20009.5 20372.9 20477.0 5447.6 5564.3 5582.4 5636.1 6031.2 6062.8 6228.6 6234.3 6241.8 6259.6 5221.7 5878.9 6056.4 6158.3 6185.4 6112.1 6157.9 6167.9 6171.0 6180.8 5191.5 5300.5 5303.4 5372.5 5372.6 11210.6 12760.9 12810.7 12955.9 12964.9 2180.7 2280.4 2397.5 2427.9 2439.5 8084.5 9595.3 9753.7 10317.8 10437.4 1533.0 1857.4 1877.1 1921.1 1924.9 71533.0 96099.5 119234.8 120434.4 130663.0 11660.8 11671.9 11748.2 11813.9 11821.3 14712.9 14748.2 14749.2 14789.5 14806.9 8523.0 8699.0 8712.3 8832.0 8866.2 8546.9 8624.4 8659.8 8722.3 8803.7 4442.9 4523.5 4532.5 4550.3 4620.4 1898.6 1899.6 1939.4 1952.2 1957.3 770.6 818.4 904.9 982.8 998.9 19316.9 20517.4 20679.3 20770.7 21068.6 809.6 858.7 880.9 919.8 921.8 10159.4 10770.3 10783.0 10803.0 10803.8 550475.2 558953.0 562556.0 595558.0 607531.0 99408.5 118866.4 129074.0 130904.0 131024.3 851.1 872.1 872.5 876.4 877.3 18176.8 18521.6 19736.5 19895.4 20774.0 56779.7 56914.0 57200.0 58452.0 58534.7 64283.7 70814.0 73212.3 76698.6 80371.6 4759.8 7568.4 7611.5 7849.9 8109.3 10626.9 12636.7 13022.5 13068.5 13159.4 9786.2 10518.6 10988.1 11050.2 11383.4 10130.7 10307.3 10701.5 11068.4 11183.3 11197.4 11200.7 11268.5 11543.9 11564.1 7912.5 7913.0 8119.8 8270.9 8303.6 7957.5 10677.0 10961.1 11160.3 11174.4 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5831.98 Median:4934.67 stddev:3311.30 (67.1%) stddev-sans-first:3303.36 16:11:01 INFO - PROCESS | 1651 | Values: 1336.5 1538.9 1701.0 1831.4 1842.5 8143.3 8424.5 8672.1 9237.6 9259.4 8674.9 8982.4 9001.5 9081.2 9085.2 2264.2 2301.6 2301.9 2310.3 2312.7 2065.6 2084.7 2295.7 2411.7 2439.0 2421.9 2422.3 2423.6 2443.5 2444.1 2343.6 2352.0 2353.5 2358.9 2369.5 2378.4 2409.5 2427.0 2427.7 2436.3 9022.6 9066.1 9124.3 9126.8 9145.2 5316.4 5442.2 5471.9 5480.5 5490.2 3653.7 3666.0 3701.9 3711.5 3736.6 1045.9 1060.4 1101.8 1110.4 1122.1 12053.2 12098.7 12203.5 12226.8 12234.4 4754.2 4804.9 4805.3 4872.8 4924.4 8607.3 10152.3 10246.4 10275.2 10302.2 5421.0 5426.3 5437.2 5439.2 5441.8 4410.6 4669.1 4905.1 4957.3 4984.7 4030.8 4071.4 4132.3 4170.8 4177.2 1245.3 1246.9 1253.5 1261.7 1261.9 767.5 792.6 796.3 905.7 916.7 4991.5 5350.7 5621.9 5796.5 6123.6 756.9 823.3 928.7 936.9 997.9 3352.9 3925.3 3945.9 3963.6 4035.4 9984.3 10366.9 11189.3 11196.7 11212.9 9308.3 11087.3 11157.6 11159.3 11198.7 8030.4 8403.3 8408.9 8532.4 8568.8 6077.9 6081.8 6130.3 6178.1 6239.6 10258.7 10330.8 10363.0 10367.5 10460.4 10108.3 10781.8 10790.4 10796.9 10798.0 7125.1 7355.7 7537.3 7755.5 7928.9 8384.2 8545.7 8697.0 8717.9 8768.6 7593.2 7679.7 7715.3 7826.1 7858.9 7458.1 7563.0 7579.8 7591.7 7729.3 7052.7 7188.5 7193.6 7194.4 7212.1 4875.7 4948.6 5013.5 5053.7 5114.8 4945.0 5081.3 5106.0 5145.8 5207.5 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4513.00 Median:4937.77 stddev:1419.12 (28.7%) stddev-sans-first:1387.50 16:11:01 INFO - PROCESS | 1651 | Values: 304.5 307.7 310.7 319.1 319.4 5312.7 5495.3 5523.5 5577.9 5622.7 4791.1 5038.4 5290.0 5360.1 5459.9 3594.6 4188.9 4190.6 4227.7 4231.1 3921.4 4096.6 4143.8 4197.8 4218.3 4085.4 4086.2 4118.5 4138.4 4149.1 3519.8 3610.9 3959.1 4150.6 4174.5 3572.2 3575.7 3594.9 3596.2 3596.4 3948.8 4089.7 4244.6 4873.7 5091.1 4104.4 4550.3 4607.0 4744.5 4754.4 4501.3 4738.0 4868.9 5735.3 5765.9 3359.0 3561.3 3885.6 3890.2 3913.7 5688.9 5969.1 6014.8 6058.3 6060.8 3632.9 3693.0 3946.9 3950.7 3976.9 3621.4 3681.3 4023.3 4028.1 4035.7 3617.3 4353.1 4649.9 4680.3 4692.8 5067.9 5279.9 5286.6 5889.4 5940.1 1267.2 1314.6 1344.7 1362.6 1366.4 788.8 891.4 901.0 921.4 925.9 4465.4 5293.8 5339.3 5366.7 5393.1 4901.5 5797.3 5800.0 5809.8 5819.3 4743.9 5076.4 5330.4 5386.5 5392.5 2355.5 2355.7 2445.7 2513.8 2616.0 4192.0 4212.7 4522.8 4857.9 5124.6 5010.2 5036.1 5048.9 5725.7 6193.0 5414.9 5702.7 5831.9 5846.5 6087.8 4853.8 5576.5 6041.4 6110.8 6154.8 4818.0 4929.5 4954.6 5933.3 5985.4 5213.2 5595.7 6151.4 6220.3 6256.6 3374.4 3376.6 3869.8 4006.8 4052.9 4946.0 5377.5 5421.4 5940.3 5980.0 5511.4 5649.5 5708.7 5708.8 5851.2 4860.4 5559.7 5770.8 5822.7 5891.9 5389.4 5715.6 5726.4 5729.9 5750.0 4545.5 5050.7 5081.9 5380.0 5760.9 4837.2 5343.6 5790.1 5797.7 5830.7 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:27493.64 Median:3667.05 stddev:46560.69 (1269.7%) stddev-sans-first:46647.53 16:11:01 INFO - PROCESS | 1651 | Values: 603.4 666.5 690.3 800.3 815.4 12086.5 13964.4 14977.6 15387.8 15958.4 11982.7 14096.5 14224.4 14313.2 14373.1 819.2 843.0 846.0 846.2 851.7 679.3 699.3 826.1 843.7 854.8 758.3 869.9 887.7 894.1 898.7 882.2 893.0 893.1 893.1 893.2 647.4 656.4 657.7 657.8 657.8 14703.8 14782.0 14812.6 14828.9 14851.6 14501.3 14528.0 14537.8 14600.6 14876.0 10389.8 11685.0 11911.1 12013.8 12143.5 3796.5 3821.7 3855.4 3857.6 3984.1 117646.0 121394.4 123224.0 125455.0 125499.0 9848.6 10872.0 11126.9 11153.0 11253.0 21575.6 23235.2 23289.5 23300.1 23308.7 7793.6 7890.8 7895.8 8083.2 8210.0 4217.6 4284.4 4309.3 4314.2 4438.7 3619.8 3714.3 3720.3 3722.4 3726.2 649.7 668.9 675.0 679.1 685.0 508.8 522.0 639.5 641.9 664.2 8492.7 9015.0 9257.9 9269.2 9777.8 537.6 584.7 639.6 650.1 684.5 3730.4 3922.7 4358.3 4521.8 4535.9 169024.2 171995.8 173306.0 175107.0 176622.0 147114.0 147865.0 151751.0 155708.2 160528.0 127211.4 130106.3 130231.7 134141.0 134208.0 6751.7 7410.4 7817.3 7966.6 8165.7 61215.0 65417.7 66809.7 67203.7 73294.0 105046.9 106818.0 108916.0 110974.0 112413.0 11762.8 11913.7 12157.4 12434.6 12520.2 13506.9 13626.3 13711.5 14287.9 14313.4 12603.6 12652.6 12877.5 13116.6 13124.4 12201.5 12398.7 12421.8 12579.0 12941.9 12038.9 12098.6 12369.4 12401.1 12885.7 8936.0 9700.6 9980.0 10473.4 10755.7 9138.7 10195.9 10294.1 10621.5 10670.1 16:11:01 INFO - PROCESS | 1651 | -------- Summary: end -------- 16:11:01 INFO - PROCESS | 1651 | 16:11:01 INFO - TEST-INFO | 1651: exit 0 16:11:01 INFO - TEST-OK | dromaeo_css | took 1113914ms 16:11:01 INFO - TEST-START | kraken 16:11:01 INFO - operating with platform_type : mac_ 16:11:01 INFO - Initialising browser for kraken test... 16:11:01 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpkSH7Jz/profile http://localhost:49273/getInfo.html) 16:11:04 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 16:11:04 INFO - PROCESS | 1658 | colorDepth:24 16:11:04 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 16:11:04 INFO - PROCESS | 1658 | __metrics 16:11:04 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:11:04 INFO - PROCESS | 1658 | 16:11:04 INFO - PROCESS | 1658 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x10C0011,name=PVRManager::Msg_NotifyVSync) Channel error: cannot send/recv 16:11:04 INFO - PROCESS | 1658 | 16:11:05 INFO - TEST-INFO | 1658: exit 0 16:11:05 INFO - Browser initialized. 16:11:05 INFO - Running cycle 1/1 for kraken test... 16:11:05 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpkSH7Jz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:17 INFO - PROCESS | 1660 | RSS: Main: 225218560 16:11:17 INFO - PROCESS | 1660 | 16:11:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:21 INFO - PROCESS | 1660 | RSS: Main: 237953024 16:11:21 INFO - PROCESS | 1660 | 16:11:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 16:11:24 INFO - PROCESS | 1660 | RSS: Main: 245862400 16:11:24 INFO - PROCESS | 1660 | 16:11:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 16:11:28 INFO - PROCESS | 1660 | RSS: Main: 249110528 16:11:28 INFO - PROCESS | 1660 | 16:11:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 16:11:30 INFO - PROCESS | 1660 | RSS: Main: 249503744 16:11:30 INFO - PROCESS | 1660 | 16:11:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:33 INFO - PROCESS | 1660 | RSS: Main: 249495552 16:11:33 INFO - PROCESS | 1660 | 16:11:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:36 INFO - PROCESS | 1660 | RSS: Main: 251334656 16:11:36 INFO - PROCESS | 1660 | 16:11:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:40 INFO - PROCESS | 1660 | RSS: Main: 251232256 16:11:40 INFO - PROCESS | 1660 | 16:11:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 16:11:43 INFO - PROCESS | 1660 | RSS: Main: 251564032 16:11:43 INFO - PROCESS | 1660 | 16:11:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:46 INFO - PROCESS | 1660 | RSS: Main: 251150336 16:11:46 INFO - PROCESS | 1660 | 16:11:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:48 INFO - PROCESS | 1660 | RSS: Main: 251219968 16:11:48 INFO - PROCESS | 1660 | 16:11:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:51 INFO - PROCESS | 1660 | RSS: Main: 251170816 16:11:51 INFO - PROCESS | 1660 | 16:11:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:55 INFO - PROCESS | 1660 | RSS: Main: 251240448 16:11:55 INFO - PROCESS | 1660 | 16:11:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:58 INFO - PROCESS | 1660 | RSS: Main: 251662336 16:11:58 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 16:12:00 INFO - PROCESS | 1660 | RSS: Main: 253145088 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | __start_tp_report 16:12:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 16:12:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 16:12:00 INFO - PROCESS | 1660 | |i|pagename|runs| 16:12:00 INFO - PROCESS | 1660 | |0;ai-astar;107;119;118;119;121;118;119;122;121;120 16:12:00 INFO - PROCESS | 1660 | |1;audio-beat-detection;138;110;135;172;110;114;112;113;138;113 16:12:00 INFO - PROCESS | 1660 | |2;audio-dft;199;202;195;197;197;196;194;194;206;196 16:12:00 INFO - PROCESS | 1660 | |3;audio-fft;84;60;61;93;53;63;70;84;106;50 16:12:00 INFO - PROCESS | 1660 | |4;audio-oscillator;87;71;90;74;75;75;91;70;74;87 16:12:00 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;92;88;90;87;92;86;92;103;91;87 16:12:00 INFO - PROCESS | 1660 | |6;imaging-darkroom;95;133;97;97;98;96;105;97;131;153 16:12:00 INFO - PROCESS | 1660 | |7;imaging-desaturate;98;92;90;91;96;114;90;118;114;91 16:12:00 INFO - PROCESS | 1660 | |8;json-parse-financial;52;55;77;56;58;60;60;60;60;61 16:12:00 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;100;77;74;75;82;102;105;102;71 16:12:00 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;82;88;82;85;83;82;84;83;96;83 16:12:00 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;140;151;153;139;143;143;143;142;179;159 16:12:00 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;167;170;169;166;169;169;237;182;168;167 16:12:00 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;70;70;70;67;84;91;88;93;70;71 16:12:00 INFO - PROCESS | 1660 | __end_tp_report 16:12:00 INFO - PROCESS | 1660 | __start_cc_report 16:12:00 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,937 16:12:00 INFO - PROCESS | 1660 | __end_cc_report 16:12:00 INFO - PROCESS | 1660 | __startTimestamp1476918720798__endTimestamp 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | ------- Summary: start ------- 16:12:00 INFO - PROCESS | 1660 | Number of tests: 14 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:118.40 Median:119.50 stddev:4.22 (3.5%) stddev-sans-first:1.41 16:12:00 INFO - PROCESS | 1660 | Values: 107.0 119.0 118.0 119.0 121.0 118.0 119.0 122.0 121.0 120.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:124.50 stddev:20.20 (16.2%) stddev-sans-first:20.91 16:12:00 INFO - PROCESS | 1660 | Values: 138.0 110.0 135.0 172.0 110.0 114.0 112.0 113.0 138.0 113.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:197.60 Median:197.00 stddev:3.81 (1.9%) stddev-sans-first:4.00 16:12:00 INFO - PROCESS | 1660 | Values: 199.0 202.0 195.0 197.0 197.0 196.0 194.0 194.0 206.0 196.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:72.40 Median:66.50 stddev:18.49 (27.8%) stddev-sans-first:19.13 16:12:00 INFO - PROCESS | 1660 | Values: 84.0 60.0 61.0 93.0 53.0 63.0 70.0 84.0 106.0 50.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:81.00 stddev:8.29 (10.2%) stddev-sans-first:8.32 16:12:00 INFO - PROCESS | 1660 | Values: 87.0 71.0 90.0 74.0 75.0 75.0 91.0 70.0 74.0 87.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:90.50 stddev:4.87 (5.4%) stddev-sans-first:5.15 16:12:00 INFO - PROCESS | 1660 | Values: 92.0 88.0 90.0 87.0 92.0 86.0 92.0 103.0 91.0 87.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:96.50 stddev:20.86 (21.6%) stddev-sans-first:21.39 16:12:00 INFO - PROCESS | 1660 | Values: 95.0 133.0 97.0 97.0 98.0 96.0 105.0 97.0 131.0 153.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:99.40 Median:91.00 stddev:11.35 (12.5%) stddev-sans-first:12.02 16:12:00 INFO - PROCESS | 1660 | Values: 98.0 92.0 90.0 91.0 96.0 114.0 90.0 118.0 114.0 91.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:6.66 (11.1%) stddev-sans-first:6.42 16:12:00 INFO - PROCESS | 1660 | Values: 52.0 55.0 77.0 56.0 58.0 60.0 60.0 60.0 60.0 61.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:85.70 Median:72.50 stddev:14.70 (20.3%) stddev-sans-first:14.29 16:12:00 INFO - PROCESS | 1660 | Values: 69.0 100.0 77.0 74.0 75.0 82.0 102.0 105.0 102.0 71.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.50 stddev:4.34 (5.2%) stddev-sans-first:4.48 16:12:00 INFO - PROCESS | 1660 | Values: 82.0 88.0 82.0 85.0 83.0 82.0 84.0 83.0 96.0 83.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:147.00 stddev:12.28 (8.4%) stddev-sans-first:12.57 16:12:00 INFO - PROCESS | 1660 | Values: 140.0 151.0 153.0 139.0 143.0 143.0 143.0 142.0 179.0 159.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:169.00 stddev:21.77 (12.9%) stddev-sans-first:22.82 16:12:00 INFO - PROCESS | 1660 | Values: 167.0 170.0 169.0 166.0 169.0 169.0 237.0 182.0 168.0 167.0 16:12:00 INFO - PROCESS | 1660 | 16:12:00 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:77.50 stddev:10.29 (13.3%) stddev-sans-first:10.56 16:12:00 INFO - PROCESS | 1660 | Values: 70.0 70.0 70.0 67.0 84.0 91.0 88.0 93.0 70.0 71.0 16:12:00 INFO - PROCESS | 1660 | -------- Summary: end -------- 16:12:00 INFO - PROCESS | 1660 | 16:12:01 INFO - TEST-INFO | 1660: exit 0 16:12:01 INFO - TEST-OK | kraken | took 59758ms 16:12:01 INFO - SUITE-END | took 1173s 16:12:01 INFO - Completed test suite (00:19:34) 16:12:01 INFO - javascript benchmark 16:12:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7330.316763232607, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.3733359328526, 3415.880444184454, 3437.329720704463, 3447.586289645243, 3479.7216222702186, 5816.563757718172, 5905.232319798425, 5920.555958303134, 5927.229460170182, 5941.732622032014, 4157.979210103953, 5809.796657117002, 5891.469767720904, 5912.586118971673, 5935.910961335572, 4565.863024109282, 5327.786888524454, 5331.813386531472, 5401.0, 5404.7838086476495, 4868.440129385131, 5391.218273350361, 5422.9728851355685, 5427.755750991215, 5479.643823151482, 5268.473152684739, 5305.734713264341, 5392.2181283714035, 5408.91886621701, 5415.972920135414, 5311.521963023327, 5332.866678333034, 5335.626506144571, 5336.279602253724, 5369.40936496985, 4751.88541099211, 5007.223880298559, 5280.155175171954, 5336.786528538853, 5453.2092846537425, 5753.827385178452, 5963.940360596382, 6008.008678568031, 6069.666168360738, 6084.269887613515, 6161.229846269216, 6221.377862213788, 6236.906446403307, 6276.152719382871, 6286.151369565096, 6312.684365781693, 6329.177206963065, 6334.4299013088585, 6344.524160687921, 6355.269144048448, 5877.265341832271, 5997.370276121032, 6009.1587177795145, 6009.729562169713, 6011.729472173763, 6263.530235232284, 6362.872742545216, 6387.201599800025, 6398.552101352953, 6424.550281480251, 6302.905456418157, 6312.652804095819, 6315.96842015787, 6316.463100636405, 6322.114903913456, 5866.970665146647, 6184.350643182401, 6201.317855035943, 6279.529035322369, 6329.936700633027, 6230.719617617218, 6286.245650521967, 6324.114623952651, 6355.396237357444, 6377.362263773585, 5011.323471331397, 6245.531585131133, 6253.749250149988, 6282.403171698681, 6316.778912738124, 4945.357103576512, 4963.851084467472, 5001.349824522788, 5064.46823083571, 5066.6453348266, 4463.973286144205, 4506.752128632891, 4517.728936263835, 4521.3896124023495, 4606.147862645421, 4524.343970124313, 5004.599632029429, 5644.604877658607, 6086.543509236825, 6158.384161583896, 5934.584579079423, 6068.75724971005, 6286.057091436322, 6333.271673757485, 6342.968285158545, 5374.596905232123, 6022.638641681513, 6041.697915104227, 6064.211652485149, 6120.020512922583, 5485.561155107582, 5502.752376143083, 5510.311211098613, 5518.834434966958, 5524.861878452991, 6345.143405640272, 6358.046293055986, 6404.615723056631, 6421.8394540135005, 6437.485001199986, 6216.7824126155365, 6250.906236406367, 6257.2491301044165, 6292.653904035322, 6299.464545513682, 6409.4231519163495, 6432.581882177644, 6434.64609446485, 6446.5165112615805, 6468.579542329733, 6299.874002519832, 6301.180846489927, 6305.905411418924, 6350.110984462087, 6352.936470635234, 6212.223472065992, 6240.375962403723, 6248.187735594343, 6272.18461599989, 6305.90541141874, 6116.816495505142, 6241.407066328691, 6260.561760676709, 6299.905501417391, 6337.746490140343, 6275.52933529978, 6307.432331090224, 6315.368463153832, 6317.052442133717, 6330.968345158429, 5797.333306669787, 6082.574219804748, 6123.785667501616, 6173.444390004921, 6276.748930042747, 6255.593386429868, 6269.843253918689, 6311.558190926775, 6317.905231421624, 6339.144215530844, 6132.9386706134155, 6179.938200617937, 6181.907271390843, 6202.968985155046, 6208.534359922934], "value": 5789.067547097769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.31413194340445, 514.0951924612681, 529.3885562175689, 529.7880847660934, 548.6516062300439, 32110.036698899043, 40368.0, 40372.59627403725, 40442.797786011106, 40592.797036014854, 33209.83395083021, 41219.0, 41788.58211417885, 41791.0, 41852.0, 9649.855252171206, 9870.753231169243, 9878.407295562254, 9892.802143957117, 9897.208223342152, 9737.367071140388, 9868.950655246714, 9872.654457094002, 9884.357516761387, 9912.553935072903, 7688.6924523019015, 9856.901430985707, 9896.109350158484, 9900.950495247514, 9918.950405247964, 9817.656382026595, 9842.212622990179, 9851.211903047739, 9858.359206651616, 9878.407295562218, 9728.0, 9744.07431294026, 9848.852267215998, 9855.655052073214, 9887.90112098877, 39273.0, 39360.803195984125, 39550.0, 39629.0, 39637.0, 3085.799423037495, 3289.7697161198726, 3314.9171270718425, 3502.6322236165347, 3751.0, 29331.853340733374, 30649.38701225963, 30895.91864284739, 31285.37429251402, 31366.215799882757, 2683.7450442208155, 3106.937861242785, 3156.4476216662224, 3158.352537729783, 3336.5328853960464, 494523.0, 506952.0, 507211.4639426816, 507819.0, 508591.0, 51753.706157345616, 51905.74047129816, 52150.47849521532, 52151.217731734054, 53163.20255196175, 59828.70085649544, 59976.70011650001, 60017.69991150016, 60077.69961150167, 60127.69936150291, 16281.348746050262, 16510.75233871493, 16521.586960326087, 16547.503574892773, 16555.751663725056, 12926.0, 12956.157849739737, 12975.961923046134, 12979.35103244834, 13013.934930325287, 14077.0, 14825.851741482662, 14974.326155323037, 14980.40078396852, 15145.394184232728, 7137.857242855114, 7221.4583906207245, 7315.195328513859, 7330.450216233698, 7359.4480413968095, 796.4584082823735, 928.8049509602924, 953.3421938862163, 955.5508910811907, 1052.394872948058, 23797.881010594836, 29548.409031819672, 30220.5466917992, 30689.539656905163, 31119.066428007198, 994.8608842874868, 1023.9897601024044, 1038.8389799581078, 1098.6209757633603, 1161.12335186935, 15136.621584460476, 15783.526494205193, 15876.52370428889, 15888.841111588967, 15979.840201597835, 666531.0, 683855.0, 684600.0, 685263.0, 685688.0, 56856.43143568594, 57087.42912570821, 57409.0, 57488.137677934865, 57620.0, 1285.460106755165, 1308.627041293227, 1334.2661536155076, 1340.8726171013739, 1346.3941226448137, 28131.296717582223, 29686.0, 30252.394952100396, 30567.08298751041, 30878.38243235168, 44947.0, 48786.756066219445, 53843.46156538385, 56044.0, 58743.0, 530434.0, 535079.0, 537438.0, 537721.0, 539320.0, 34473.482897756054, 34743.4788478168, 34926.0, 34934.82532587321, 34945.82527087348, 34673.0, 40567.594324057565, 44171.0, 45157.322640159764, 45802.0, 36702.63297367099, 38164.427533586466, 38407.61592384041, 38708.516233539114, 42202.36696449617, 38717.80641096889, 39013.0, 39189.0, 39820.40269396019, 39947.60052399439, 30968.535471967487, 37112.0, 37759.244815104095, 37959.81020094882, 38071.0, 33025.0, 34633.9609811706, 34956.82521587376, 35122.82438587791, 35171.82414087913, 23209.651855221848, 25025.29410597772, 26044.479110417305, 26110.151736081312, 26395.944162233296], "value": 19784.64298720179, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.81214862197345, 362.81315122711794, 372.1050872651274, 376.14990122323576, 393.9684825213983, 18824.0, 19169.61660766784, 20145.59708805823, 20489.975501224915, 20725.0, 19280.807191928077, 19959.900200499014, 20009.499762505944, 20372.879491627955, 20477.0, 5447.591430642708, 5564.322812624846, 5582.413846546115, 5636.126400407943, 6031.185789918349, 6062.787802426916, 6228.564000519966, 6234.283057448406, 6241.843953901143, 6259.561830671855, 5221.660592061504, 5878.941790477712, 6056.394360563931, 6158.322584515699, 6185.350538193492, 6112.083187521885, 6157.876842463148, 6167.938320616781, 6171.012637977902, 6180.84547886302, 5191.472365070663, 5300.549453296474, 5303.4166241713765, 5372.462753724635, 5372.597055220874, 11210.551577936872, 12760.872391276062, 12810.74378512434, 12955.870441295654, 12964.935175324157, 2180.738311402642, 2280.429892526868, 2397.5324811661735, 2427.927162185137, 2439.536488067279, 8084.514929104273, 9595.328327017112, 9753.658621948269, 10317.793644127076, 10437.373757574494, 1532.9770053449208, 1857.359211072178, 1877.108373522566, 1921.1162865082078, 1924.913378897953, 71533.0, 96099.51950240273, 119234.80765192324, 120434.39782801118, 130663.0, 11660.76678466426, 11671.941640291745, 11748.236364636272, 11813.90538134883, 11821.349825759666, 14712.926435367755, 14748.188849613374, 14749.188794616399, 14789.482368117064, 14806.851931480764, 8523.0, 8698.956505217433, 8712.346574006975, 8832.02847686754, 8866.20204181614, 8546.871796923051, 8624.439411438236, 8659.78350541229, 8722.345824063093, 8803.691870784492, 4442.933355999663, 4523.457185137804, 4532.546745325507, 4550.340200670884, 4620.353150558924, 1898.6297671953837, 1899.6105798311312, 1939.398786376228, 1952.160570954503, 1957.2660252405349, 770.5569297653872, 818.3902992270678, 904.9457032577935, 982.823091843475, 998.8901220865699, 19316.903415483113, 20517.38447846567, 20679.27622533204, 20770.688439673417, 21068.57862842765, 809.6154326694773, 858.733792524307, 880.872273520336, 919.797644518205, 921.7603423109906, 10159.441230732233, 10770.299930504492, 10782.975617316342, 10802.973717496825, 10803.783924321628, 550475.2476237674, 558953.0, 562556.0, 595558.0, 607531.0, 99408.5029574862, 118866.4056679711, 129074.0, 130904.0, 131024.34487827691, 851.1445996773203, 872.0581771686436, 872.520113937332, 876.373393023991, 877.3419935048713, 18176.81823181804, 18521.62956740831, 19736.506587335432, 19895.403137905887, 20774.0, 56779.71610141923, 56914.0, 57200.0, 58452.0, 58534.7073264648, 64283.67858160679, 70814.0, 73212.26787732268, 76698.61650691711, 80371.59814200892, 4759.764708232226, 7568.4323675725645, 7611.467197296136, 7849.921500784919, 8109.310708589836, 10626.89373106259, 12636.684082898, 13022.54421095295, 13068.54260100892, 13159.407826647632, 9786.217102631916, 10518.631847885288, 10988.120950324115, 11050.171237157085, 11383.373914434786, 10130.746731331776, 10307.29929561614, 10701.464926753786, 11068.391238481961, 11183.273087249303, 11197.38414387184, 11200.719982000515, 11268.492917818554, 11543.88456115428, 11564.074874010228, 7912.520698760349, 7913.0, 8119.79700507492, 8270.917290827014, 8303.62633681498, 7957.482763620577, 10677.039066484054, 10961.068309193808, 11160.33038017689, 11174.441277936234], "value": 9221.912241046868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.4921329894642, 1538.876350636122, 1701.0, 1831.3590243414799, 1842.530154810523, 8143.267105960463, 8424.452410593323, 8672.089430609782, 9237.63049478021, 9259.444433334005, 8674.869876951834, 8982.37123401362, 9001.549922503882, 9081.228095611881, 9085.227755640763, 2264.241479104502, 2301.5972204864083, 2301.850379725321, 2310.2838120182714, 2312.7455979842202, 2065.5559054803216, 2084.6560317547587, 2295.724513058427, 2411.6503107049466, 2438.9634155487684, 2421.878906054699, 2422.321749910028, 2423.575874222004, 2443.5235129149823, 2444.0956845967016, 2343.5898717724417, 2352.0, 2353.470469144437, 2358.8584684918874, 2369.4905595297096, 2378.4172877644914, 2409.506051259488, 2426.980668119394, 2427.7450867658818, 2436.3056528889183, 9022.593983270703, 9066.093390660948, 9124.315676324302, 9126.77183070422, 9145.176934075898, 5316.441773613754, 5442.156465747816, 5471.917921231185, 5480.506754392124, 5490.203920431515, 3653.725970552219, 3666.046827824758, 3701.9074523137137, 3711.5175027246555, 3736.551613806361, 1045.9320144190604, 1060.4379678770265, 1101.7741363020561, 1110.4170310586926, 1122.0630773304301, 12053.15627906047, 12098.697532561668, 12203.511859525608, 12226.816597751042, 12234.388280585936, 4754.215554433549, 4804.855854324376, 4805.303231031551, 4872.756362181876, 4924.359833221658, 8607.311415086779, 10152.289339746147, 10246.436445995392, 10275.229357798195, 10302.175825933908, 5421.0, 5426.294581704353, 5437.184422336682, 5439.156930675752, 5441.809536666197, 4410.625096866738, 4669.089527542164, 4905.068037072945, 4957.3059771632, 4984.651074424755, 4030.7984600769846, 4071.3892916062828, 4132.318167502329, 4170.791460426966, 4177.206330797199, 1245.3088535862503, 1246.8503779546513, 1253.486070711004, 1261.7161138743893, 1261.9432125554372, 767.5087943716027, 792.6235038356734, 796.3072127249214, 905.7463910105181, 916.7158180963922, 4991.50084991498, 5350.705711185922, 5621.887562248732, 5796.536277097822, 6123.601965872204, 756.8826831841073, 823.2549542663899, 928.6888892221182, 936.878205833251, 997.9201663867018, 3352.8826491072696, 3925.293447179535, 3945.861894833667, 3963.623455771697, 4035.414864844581, 9984.301098923152, 10366.859645438995, 11189.328640281608, 11196.720081998015, 11212.943935280435, 9308.301877359225, 11087.33475991443, 11157.609483668033, 11159.330440173615, 11198.664040078811, 8030.437869349206, 8403.327733781283, 8408.873866892001, 8532.36007299455, 8568.785780355542, 6077.908831367445, 6081.787137450168, 6130.295016073031, 6178.1350610913605, 6239.563230573816, 10258.743531411475, 10330.760308762996, 10363.0, 10367.481625918523, 10460.372377657364, 10108.342957707726, 10781.838272425763, 10790.406527641055, 10796.892031079902, 10798.0, 7125.1093613298335, 7355.66899489535, 7537.283958023979, 7755.457118001686, 7928.881066784118, 8384.245417912418, 8545.700900468453, 8697.0, 8717.91282087171, 8768.605412756313, 7593.240675932362, 7679.654415551202, 7715.267049630276, 7826.099998500245, 7858.921410786048, 7458.105027396748, 7562.978997835442, 7579.772606821804, 7591.734289299848, 7729.265719756614, 7052.682629281592, 7188.460865435009, 7193.568385896863, 7194.388476979515, 7212.062431884031, 4875.7074575525585, 4948.62885283598, 5013.498650135103, 5053.67151135175, 5114.846554603368, 4944.975275123746, 5081.339425874613, 5105.974470127626, 5145.845624631267, 5207.505286997729], "value": 4649.69832787137, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.46110384619226, 307.67079225229014, 310.74829388195565, 319.11127509884943, 319.44895056028355, 5312.707801070939, 5495.258140151079, 5523.502884740373, 5577.940191363643, 5622.706777441186, 4791.113643975867, 5038.420581633104, 5289.979615492225, 5360.115580929142, 5459.863503412406, 3594.6405359464106, 4188.853390131346, 4190.601892820185, 4227.746335219881, 4231.090315582149, 3921.4117882317737, 4096.5903409659095, 4143.7720925349095, 4197.7901104944785, 4218.346156345771, 4085.387191921206, 4086.2031903778775, 4118.464599602063, 4138.399932009872, 4149.149424367997, 3519.8064106474135, 3610.8736194233074, 3959.0696186396176, 4150.584941505856, 4174.478190226222, 3572.178398968226, 3575.7318201135017, 3594.867616700731, 3596.2198711637643, 3596.388613935611, 3948.822302996372, 4089.734167279117, 4244.596763307481, 4873.732829464329, 5091.0581542414775, 4104.42538044674, 4550.317452382169, 4606.976965115153, 4744.485422725961, 4754.407273563361, 4501.27979523278, 4737.952620473786, 4868.863349166628, 5735.279416175131, 5765.913511297334, 3359.025882494074, 3561.3411518868834, 3885.5531613864487, 3890.2219556088894, 3913.706472014582, 5688.857778555569, 5969.134475501071, 6014.8195554133445, 6058.333583305833, 6060.787872424488, 3632.9091772705365, 3692.984429281969, 3946.901327466779, 3950.6839452843706, 3976.900577485528, 3621.3925973299183, 3681.2637472505608, 4023.295923213426, 4028.113814960704, 4035.6996511988473, 3617.3488772020764, 4353.128154893363, 4649.883752906137, 4680.274557443602, 4692.7653617319, 5067.873303167376, 5279.9208011879855, 5286.629935904527, 5889.440503152194, 5940.138679891392, 1267.195330964844, 1314.6187605594462, 1344.6503908983539, 1362.5912226332061, 1366.3919555797575, 788.7791418402857, 891.4116682989326, 900.9954950225338, 921.3550514639779, 925.893522244937, 4465.352523884018, 5293.835356221625, 5339.252504649352, 5366.7048312343195, 5393.083175860113, 4901.485344038896, 5797.347755889551, 5799.971000144972, 5809.796657116981, 5819.330776960619, 4743.9089009528, 5076.3908330999775, 5330.360356757136, 5386.542143917733, 5392.514673679388, 2355.5053438777704, 2355.6702061711376, 2445.682061332051, 2513.80042462845, 2615.973840261573, 4192.0, 4212.7340823970035, 4522.796474158671, 4857.919347747908, 5124.641275110706, 5010.171287480043, 5036.143855544567, 5048.864005598784, 5725.685087320154, 6193.036456667736, 5414.884687637424, 5702.7433765480655, 5831.891940531285, 5846.532277417797, 6087.786927457518, 4853.80584776605, 5576.470235327637, 6041.426064523863, 6110.816675499742, 6154.83026241477, 4817.9518204817505, 4929.531694489017, 4954.572259592702, 5933.258342707161, 5985.401459854154, 5213.191955246943, 5595.692236927008, 6151.384861513813, 6220.346863579259, 6256.624602523863, 3374.443216869189, 3376.6454522274807, 3869.825857836348, 4006.8397264109108, 4052.8986775330854, 4946.0, 5377.462253774747, 5421.403645598902, 5940.277319577274, 5980.0398802593, 5511.448855114617, 5649.519790817826, 5708.714564271853, 5708.829689913475, 5851.21008663825, 4860.441049279378, 5559.749811258423, 5770.769169233184, 5822.670931627214, 5891.882162356643, 5389.353277606712, 5715.628484148517, 5726.396608949501, 5729.942700572941, 5750.016244395677, 4545.54544545556, 5050.74746262678, 5081.898362032664, 5380.0, 5760.855978600401, 4837.210232214104, 5343.648794530394, 5790.118211581337, 5797.739101740516, 5830.679312637845], "value": 4066.0657472787807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4478452216222, 666.4868051600271, 690.2958981838525, 800.2677550041712, 815.4454970619976, 12086.456109475073, 13964.441422343107, 14977.625559361022, 15387.846121538782, 15958.361665533364, 11982.681904990466, 14096.506622268224, 14224.431022759103, 14313.212773297464, 14373.065750726195, 819.1685439279137, 842.9536375499375, 846.031294168177, 846.2130218896424, 851.6976473351964, 679.2833560593572, 699.2727563334126, 826.0912995704707, 843.7047033538274, 854.8461276970174, 758.3175142371882, 869.8564736818417, 887.6582515731425, 894.065701342099, 898.716904175186, 882.2104216726059, 893.0355216366308, 893.0845882970008, 893.1247377570018, 893.1827377949169, 647.4464332995268, 656.3731636287334, 657.7171816119067, 657.7500549791097, 657.8421178917073, 14703.779443308253, 14782.03916745408, 14812.629684257872, 14828.851711482963, 14851.554453366416, 14501.27493625325, 14528.0, 14537.78193327101, 14600.634984125376, 14876.0, 10389.792204155874, 11685.0, 11911.10666700001, 12013.819792703116, 12143.514259429612, 3796.506454160969, 3821.73247872649, 3855.363864962278, 3857.5756666766633, 3984.083660758042, 117646.0, 121394.39302803518, 123224.0, 125455.0, 125498.99999999908, 9848.606055757833, 10872.0, 11126.942940420648, 11153.0, 11253.043491303331, 21575.56848863014, 23235.186768463023, 23289.53420931572, 23300.067997280257, 23308.65037024446, 7793.610319484003, 7890.763277101696, 7895.763127106081, 8083.1916808319875, 8210.01479822425, 4217.578242175758, 4284.357346398003, 4309.267424537836, 4314.201872653569, 4438.689291749611, 3619.782813031174, 3714.312852122366, 3720.311742327678, 3722.40441529354, 3726.2174943262216, 649.7433513762132, 668.9364510371604, 674.9730010799611, 679.0832376291967, 684.9623270720059, 508.7659676548755, 521.9947800521946, 639.517164540778, 641.9005054216603, 664.1764212376618, 8492.683634036734, 9014.95162708885, 9257.861132083024, 9269.16577508014, 9777.755556111155, 537.5887446103734, 584.6959581017846, 639.5728211437605, 650.0996120373222, 684.5242556423337, 3730.403135498307, 3922.7450215735885, 4358.259095953696, 4521.84173553924, 4535.911381268472, 169024.15487922728, 171995.84012479646, 173306.0, 175107.0, 176622.0, 147114.0, 147865.0, 151751.0, 155708.221458892, 160528.0, 127211.36394318154, 130106.34946825205, 130231.69768302195, 134141.0, 134208.0, 6751.683421732715, 7410.407167426485, 7817.296443320129, 7966.601669916365, 8165.673373065011, 61215.0, 65417.672911635134, 66809.66595166993, 67203.66398167978, 73294.0, 105046.94953050371, 106818.0, 108916.0, 110974.0, 112413.0, 11762.823557646814, 11913.702157446132, 12157.392130393622, 12434.564790232298, 12520.186187897758, 13506.932465338003, 13626.318684065955, 13711.451541938211, 14287.928560357132, 14313.427462901367, 12603.558875439316, 12652.557160499338, 12877.484900603871, 13116.606501804961, 13124.409401577142, 12201.51193952232, 12398.690032749253, 12421.813672794735, 12579.0, 12941.935290323489, 12038.879611203776, 12098.637040888787, 12369.381530923238, 12401.069919755873, 12885.742285154432, 8936.0, 9700.563474643517, 9979.950100249453, 10473.371597704163, 10755.677329680122, 9138.68014619485, 10195.898041019791, 10294.073533382032, 10621.522031508446, 10670.093042091508], "value": 7768.457027978094, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 118.0, 119.0, 121.0, 118.0, 119.0, 122.0, 121.0, 120.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 135.0, 172.0, 110.0, 114.0, 112.0, 113.0, 138.0, 113.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 202.0, 195.0, 197.0, 197.0, 196.0, 194.0, 194.0, 206.0, 196.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 61.0, 93.0, 53.0, 63.0, 70.0, 84.0, 106.0, 50.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 90.0, 74.0, 75.0, 75.0, 91.0, 70.0, 74.0, 87.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 90.0, 87.0, 92.0, 86.0, 92.0, 103.0, 91.0, 87.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 133.0, 97.0, 97.0, 98.0, 96.0, 105.0, 97.0, 131.0, 153.0], "value": 110.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 92.0, 90.0, 91.0, 96.0, 114.0, 90.0, 118.0, 114.0, 91.0], "value": 99.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 77.0, 56.0, 58.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 100.0, 77.0, 74.0, 75.0, 82.0, 102.0, 105.0, 102.0, 71.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 82.0, 85.0, 83.0, 82.0, 84.0, 83.0, 96.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 151.0, 153.0, 139.0, 143.0, 143.0, 143.0, 142.0, 179.0, 159.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 169.0, 166.0, 169.0, 169.0, 237.0, 182.0, 168.0, 167.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 67.0, 84.0, 91.0, 88.0, 93.0, 70.0, 71.0], "value": 77.4, "unit": "score"}]}]} 16:12:02 INFO - Return code: 0 16:12:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:02 ERROR - # TBPL SUCCESS # 16:12:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:12:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:12:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:12:02 INFO - 2016-10-19 16:12:02.138 screenresolution[1665:10643] starting screenresolution argv=screenresolution get 16:12:02 INFO - 2016-10-19 16:12:02.140 screenresolution[1665:10643] Display 0: 1600x1200x32@60 16:12:02 INFO - 2016-10-19 16:12:02.146 screenresolution[1666:10646] starting screenresolution argv=screenresolution list 16:12:02 INFO - Available Modes on Display 0 16:12:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:12:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:12:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:12:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:12:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:12:02 INFO - Intel Iris: 16:12:02 INFO - Chipset Model: Intel Iris 16:12:02 INFO - Type: GPU 16:12:02 INFO - Bus: Built-In 16:12:02 INFO - VRAM (Dynamic, Max): 1536 MB 16:12:02 INFO - Vendor: Intel (0x8086) 16:12:02 INFO - Device ID: 0x0a2e 16:12:02 INFO - Revision ID: 0x0009 16:12:02 INFO - Displays: 16:12:02 INFO - Display: 16:12:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:12:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:12:02 INFO - Display Serial Number: 1600x1200 60 16:12:02 INFO - Main Display: Yes 16:12:02 INFO - Mirror: Off 16:12:02 INFO - Online: Yes 16:12:02 INFO - Rotation: Supported 16:12:02 INFO - Return code: 0 16:12:02 INFO - Running post-action listener: _resource_record_post_action 16:12:02 INFO - [mozharness: 2016-10-19 23:12:02.382300Z] Finished run-tests step (success) 16:12:02 INFO - Running post-run listener: _resource_record_post_run 16:12:02 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 43144704; Write bytes: 663912448; Read time: 424; Write time: 2212 16:12:02 INFO - TinderboxPrint: CPU usage
54.3% 16:12:02 INFO - TinderboxPrint: I/O read bytes / time
43,144,704 / 424 16:12:02 INFO - TinderboxPrint: I/O write bytes / time
663,912,448 / 2,212 16:12:02 INFO - TinderboxPrint: CPU idle
2,207.5 (45.7%) 16:12:02 INFO - TinderboxPrint: CPU system
977.9 (20.2%) 16:12:02 INFO - TinderboxPrint: CPU user
1,644.3 (34.0%) 16:12:02 INFO - TinderboxPrint: Swap in / out
414,027,776 / 0 16:12:02 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 369846784; Write bytes: 365950976; Read time: 28417; Write time: 818 16:12:02 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 35569152; Write bytes: 296503296; Read time: 331; Write time: 1389 16:12:02 INFO - Running post-run listener: _upload_blobber_files 16:12:02 INFO - Blob upload gear active. 16:12:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:02 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 16:12:02 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:12:02 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:12:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:12:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:04 INFO - (blobuploader) - INFO - Done attempting. 16:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:05 INFO - (blobuploader) - INFO - Done attempting. 16:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:07 INFO - (blobuploader) - INFO - Done attempting. 16:12:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:07 INFO - Return code: 0 16:12:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d2e650ecc0f2d093e4a8fb1b0bdbca3531c4ff68decf78c689bd5b7244cd1686cd4caa77e7040dc74ffbaf965aece7a6e0347145a09faf490d3c5187e2a76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43dab8cb3a270b9b5f91cad45ce0fa5a1b204ed8d7985cc555f3eabbb9818af3d141d6215c4a4d889c092f25e6ff393b5d925d47e23d2266d1ea419cde0b8bc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73fe746c5eb762b8163f000ce24325930eb54daae90df3511e621bbfddcd71466741d20d2dee2d28dbff945ba4b8d79b4f2b859fa133ae528bf40e9dc1b12f4a"} 16:12:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:07 INFO - Contents: 16:12:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d2e650ecc0f2d093e4a8fb1b0bdbca3531c4ff68decf78c689bd5b7244cd1686cd4caa77e7040dc74ffbaf965aece7a6e0347145a09faf490d3c5187e2a76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43dab8cb3a270b9b5f91cad45ce0fa5a1b204ed8d7985cc555f3eabbb9818af3d141d6215c4a4d889c092f25e6ff393b5d925d47e23d2266d1ea419cde0b8bc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73fe746c5eb762b8163f000ce24325930eb54daae90df3511e621bbfddcd71466741d20d2dee2d28dbff945ba4b8d79b4f2b859fa133ae528bf40e9dc1b12f4a"} 16:12:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:07 INFO - Copying logs to upload dir... 16:12:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.490413 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-19 16:12:07.663924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:07.667132) ========= 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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-Aurora/sha512/31d2e650ecc0f2d093e4a8fb1b0bdbca3531c4ff68decf78c689bd5b7244cd1686cd4caa77e7040dc74ffbaf965aece7a6e0347145a09faf490d3c5187e2a76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43dab8cb3a270b9b5f91cad45ce0fa5a1b204ed8d7985cc555f3eabbb9818af3d141d6215c4a4d889c092f25e6ff393b5d925d47e23d2266d1ea419cde0b8bc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73fe746c5eb762b8163f000ce24325930eb54daae90df3511e621bbfddcd71466741d20d2dee2d28dbff945ba4b8d79b4f2b859fa133ae528bf40e9dc1b12f4a"} build_url:https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011027 build_url: 'https://queue.taskcluster.net/v1/task/JJz5Mi7yQlmP_rOxmEza0Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31d2e650ecc0f2d093e4a8fb1b0bdbca3531c4ff68decf78c689bd5b7244cd1686cd4caa77e7040dc74ffbaf965aece7a6e0347145a09faf490d3c5187e2a76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43dab8cb3a270b9b5f91cad45ce0fa5a1b204ed8d7985cc555f3eabbb9818af3d141d6215c4a4d889c092f25e6ff393b5d925d47e23d2266d1ea419cde0b8bc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73fe746c5eb762b8163f000ce24325930eb54daae90df3511e621bbfddcd71466741d20d2dee2d28dbff945ba4b8d79b4f2b859fa133ae528bf40e9dc1b12f4a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:07.700151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:07.700475) ========= 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.fi0QU7vhk8/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.AGlzqjfk2I/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005346 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 16:12:07.749712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:12:07.750023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 16:12:07.750448) ========= ========= Total master_lag: 12.20 =========