builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0209 starttime: 1475543344.47 results: success (0) buildid: 20161003155858 builduid: 969b9eaeb81d49d3bdb3c2161832dee1 revision: 6414a3001705218a78ca1a24b7ddffd689742ed3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.472053) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.472943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.473629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.498618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.499225) ========= 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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-03 18:09:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.7M=0.001s 2016-10-03 18:09:04 (17.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120302 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.645207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.645927) ========= 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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.027668 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.698307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:04.699083) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6414a3001705218a78ca1a24b7ddffd689742ed3 --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 6414a3001705218a78ca1a24b7ddffd689742ed3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JlDhwMIMCH/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.6BRYF6E1cc/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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-03 18:09:04,778 truncating revision to first 12 chars 2016-10-03 18:09:04,778 Setting DEBUG logging. 2016-10-03 18:09:04,778 attempt 1/10 2016-10-03 18:09:04,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6414a3001705?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 18:09:05,429 unpacking tar archive at: mozilla-aurora-6414a3001705/testing/mozharness/ program finished with exit code 0 elapsedTime=0.944304 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.670331) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.670743) ========= script_repo_revision: 6414a3001705218a78ca1a24b7ddffd689742ed3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.671218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.671529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 18:09:05.690569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-03 18:09:05.691309) ========= /tools/buildbot/bin/python 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', '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:05 INFO - MultiFileLogger online at 20161003 18:09:05 in /builds/slave/test 18:09:05 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 18:09:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:09:05 INFO - {'append_to_log': False, 18:09:05 INFO - 'base_work_dir': '/builds/slave/test', 18:09:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:09:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:09:05 INFO - 'branch': 'Mozilla-Aurora', 18:09:05 INFO - 'buildbot_json_path': 'buildprops.json', 18:09:05 INFO - 'config_files': ('talos/mac_config.py',), 18:09:05 INFO - 'default_actions': ('clobber', 18:09:05 INFO - 'read-buildbot-config', 18:09:05 INFO - 'download-and-extract', 18:09:05 INFO - 'populate-webroot', 18:09:05 INFO - 'create-virtualenv', 18:09:05 INFO - 'install', 18:09:05 INFO - 'run-tests'), 18:09:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:09:05 INFO - 'download_minidump_stackwalk': True, 18:09:05 INFO - 'download_symbols': 'ondemand', 18:09:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:09:05 INFO - 'tooltool.py': '/tools/tooltool.py', 18:09:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:09:05 INFO - '/tools/misc-python/virtualenv.py')}, 18:09:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:09:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:09:05 INFO - 'installer_path': 'installer.exe', 18:09:05 INFO - 'log_level': 'info', 18:09:05 INFO - 'log_name': 'talos', 18:09:05 INFO - 'log_to_console': True, 18:09:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:09:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:09:05 INFO - 'opt_config_files': (), 18:09:05 INFO - 'pip_index': False, 18:09:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:05 INFO - 'cmd': ('bash', 18:09:05 INFO - '-c', 18:09:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:05 INFO - 'enabled': True, 18:09:05 INFO - 'halt_on_failure': False, 18:09:05 INFO - 'name': 'check_screen_resolution'},), 18:09:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:05 INFO - 'cmd': ('bash', 18:09:05 INFO - '-c', 18:09:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:05 INFO - 'enabled': True, 18:09:05 INFO - 'halt_on_failure': False, 18:09:05 INFO - 'name': 'check_screen_resolution'},), 18:09:05 INFO - 'run_cmd_checks_enabled': True, 18:09:05 INFO - 'sps_profile': False, 18:09:05 INFO - 'sps_profile_interval': 0, 18:09:05 INFO - 'suite': 'dromaeojs-e10s', 18:09:05 INFO - 'system_bits': '32', 18:09:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:09:05 INFO - 'title': 't-yosemite-r7-0209', 18:09:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:09:05 INFO - 'use_talos_json': True, 18:09:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:09:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:09:05 INFO - 'work_dir': 'build'} 18:09:05 INFO - [mozharness: 2016-10-04 01:09:05.903184Z] Running clobber step. 18:09:05 INFO - Running pre-action listener: _resource_record_pre_action 18:09:05 INFO - Running main action method: clobber 18:09:05 INFO - rmtree: /builds/slave/test/build 18:09:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:09:08 INFO - Running post-action listener: _resource_record_post_action 18:09:08 INFO - [mozharness: 2016-10-04 01:09:08.302818Z] Finished clobber step (success) 18:09:08 INFO - [mozharness: 2016-10-04 01:09:08.303056Z] Running read-buildbot-config step. 18:09:08 INFO - Running pre-action listener: _resource_record_pre_action 18:09:08 INFO - Running main action method: read_buildbot_config 18:09:08 INFO - Using buildbot properties: 18:09:08 INFO - { 18:09:08 INFO - "project": "", 18:09:08 INFO - "product": "firefox", 18:09:08 INFO - "script_repo_revision": "production", 18:09:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:09:08 INFO - "repository": "", 18:09:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:09:08 INFO - "buildid": "20161003155858", 18:09:08 INFO - "pgo_build": "False", 18:09:08 INFO - "basedir": "/builds/slave/test", 18:09:08 INFO - "buildnumber": 34, 18:09:08 INFO - "slavename": "t-yosemite-r7-0209", 18:09:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:09:08 INFO - "platform": "yosemite_r7", 18:09:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:09:08 INFO - "branch": "mozilla-aurora", 18:09:08 INFO - "repo_path": "releases/mozilla-aurora", 18:09:08 INFO - "revision": "6414a3001705218a78ca1a24b7ddffd689742ed3", 18:09:08 INFO - "stage_platform": "macosx64", 18:09:08 INFO - "builduid": "969b9eaeb81d49d3bdb3c2161832dee1", 18:09:08 INFO - "slavebuilddir": "test" 18:09:08 INFO - } 18:09:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 18:09:08 INFO - Running post-action listener: _resource_record_post_action 18:09:08 INFO - [mozharness: 2016-10-04 01:09:08.308805Z] Finished read-buildbot-config step (success) 18:09:08 INFO - [mozharness: 2016-10-04 01:09:08.309036Z] Running download-and-extract step. 18:09:08 INFO - Running pre-action listener: _resource_record_pre_action 18:09:08 INFO - Running main action method: download_and_extract 18:09:08 INFO - mkdir: /builds/slave/test/build/tests 18:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:08 INFO - trying https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 18:09:08 INFO - Downloading https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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 18:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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 18:09:09 INFO - Downloaded 1199 bytes. 18:09:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:09:09 INFO - Using the following test package requirements: 18:09:09 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:09:09 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 18:09:09 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 18:09:09 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'jsshell-mac.zip'], 18:09:09 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 18:09:09 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:09:09 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 18:09:09 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 18:09:09 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 18:09:09 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:09:09 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 18:09:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:09:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:09:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:09:09 INFO - Fetch https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:09:09 INFO - Expected file size: 16434167 18:09:16 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 18:09:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:09:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:09:16 INFO - Fetch https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:09:17 INFO - Expected file size: 16434167 18:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 18:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 18:09:24 INFO - Expected file size: 14414059 18:09:25 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')]} 18:09:25 INFO - trying https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:09:25 INFO - Downloading https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 18:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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 18:09:28 INFO - Downloaded 115268789 bytes. 18:09:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:09:28 INFO - mkdir: /builds/slave/test/properties 18:09:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:28 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:28 INFO - Contents: 18:09:28 INFO - build_url:https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:09:28 INFO - Running post-action listener: _resource_record_post_action 18:09:28 INFO - Running post-action listener: set_extra_try_arguments 18:09:28 INFO - [mozharness: 2016-10-04 01:09:28.727546Z] Finished download-and-extract step (success) 18:09:28 INFO - [mozharness: 2016-10-04 01:09:28.727671Z] Running populate-webroot step. 18:09:28 INFO - Running pre-action listener: _resource_record_pre_action 18:09:28 INFO - Running main action method: populate_webroot 18:09:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:28 INFO - '--tppagecycles', 18:09:28 INFO - '7'], 18:09:28 INFO - 'tests': ['tsvgm']}}, 18:09:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:09:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['damp', 'tps']}, 18:09:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'tests': ['damp', 'tps']}, 18:09:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['dromaeo_dom']}, 18:09:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['basic_compositor_video']}, 18:09:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:09:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['a11yr', 18:09:28 INFO - 'ts_paint', 18:09:28 INFO - 'tpaint', 18:09:28 INFO - 'sessionrestore', 18:09:28 INFO - 'sessionrestore_no_auto_restore', 18:09:28 INFO - 'tabpaint']}, 18:09:28 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:28 INFO - 'ts_paint', 18:09:28 INFO - 'tpaint', 18:09:28 INFO - 'sessionrestore', 18:09:28 INFO - 'sessionrestore_no_auto_restore', 18:09:28 INFO - 'tabpaint']}, 18:09:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:28 INFO - 'ts_paint', 18:09:28 INFO - 'tpaint', 18:09:28 INFO - 'sessionrestore', 18:09:28 INFO - 'sessionrestore_no_auto_restore', 18:09:28 INFO - 'tabpaint']}, 18:09:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:28 INFO - 'ts_paint', 18:09:28 INFO - 'tpaint', 18:09:28 INFO - 'sessionrestore', 18:09:28 INFO - 'sessionrestore_no_auto_restore', 18:09:28 INFO - 'tabpaint']}, 18:09:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['a11yr', 18:09:28 INFO - 'ts_paint', 18:09:28 INFO - 'tpaint', 18:09:28 INFO - 'sessionrestore', 18:09:28 INFO - 'sessionrestore_no_auto_restore', 18:09:28 INFO - 'tabpaint']}, 18:09:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['a11yr', 18:09:28 INFO - 'ts_paint', 18:09:28 INFO - 'tpaint', 18:09:28 INFO - 'sessionrestore', 18:09:28 INFO - 'sessionrestore_no_auto_restore', 18:09:28 INFO - 'tabpaint']}, 18:09:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['tsvgx', 18:09:28 INFO - 'tsvgr_opacity', 18:09:28 INFO - 'tart', 18:09:28 INFO - 'tscrollx', 18:09:28 INFO - 'cart']}, 18:09:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:28 INFO - 'tsvgr_opacity', 18:09:28 INFO - 'tart', 18:09:28 INFO - 'tscrollx', 18:09:28 INFO - 'cart']}, 18:09:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'talos_options': ['--disable-e10s'], 18:09:28 INFO - 'tests': ['tp5o']}, 18:09:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'tests': ['tp5o']}, 18:09:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'talos_options': ['--disable-e10s', 18:09:28 INFO - '--xperf_path', 18:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:28 INFO - 'tests': ['tp5n']}, 18:09:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:28 INFO - 'talos_options': ['--xperf_path', 18:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:28 INFO - 'tests': ['tp5n']}}, 18:09:28 INFO - 'talos.zip': {'path': '', 18:09:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:28 INFO - Running post-action listener: _resource_record_post_action 18:09:28 INFO - [mozharness: 2016-10-04 01:09:28.746172Z] Finished populate-webroot step (success) 18:09:28 INFO - [mozharness: 2016-10-04 01:09:28.746302Z] Running create-virtualenv step. 18:09:28 INFO - Running pre-action listener: _resource_record_pre_action 18:09:28 INFO - Running main action method: create_virtualenv 18:09:28 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:28 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 18:09:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:28 INFO - Using real prefix '/tools/python27' 18:09:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:29 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:32 INFO - Installing pip.................done. 18:09:32 INFO - Return code: 0 18:09:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:32 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')]} 18:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:32 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')]} 18:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:32 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:32 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 18:09:32 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 18:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:32 INFO - 'HOME': '/Users/cltbld', 18:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:32 INFO - 'LOGNAME': 'cltbld', 18:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:32 INFO - 'MOZ_NO_REMOTE': '1', 18:09:32 INFO - 'NO_EM_RESTART': '1', 18:09:32 INFO - 'PAGER': '/bin/cat', 18:09:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:32 INFO - 'PWD': '/builds/slave/test', 18:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:32 INFO - 'SHELL': '/bin/bash', 18:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:32 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:32 INFO - 'USER': 'cltbld', 18:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:32 INFO - 'XPC_FLAGS': '0x0', 18:09:32 INFO - 'XPC_SERVICE_NAME': '0', 18:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:32 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 18:09:32 INFO - Cleaning up... 18:09:32 INFO - Return code: 0 18:09:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:09:32 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')]} 18:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:32 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')]} 18:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:32 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:32 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 18:09:32 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 18:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:32 INFO - 'HOME': '/Users/cltbld', 18:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:32 INFO - 'LOGNAME': 'cltbld', 18:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:32 INFO - 'MOZ_NO_REMOTE': '1', 18:09:32 INFO - 'NO_EM_RESTART': '1', 18:09:32 INFO - 'PAGER': '/bin/cat', 18:09:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:32 INFO - 'PWD': '/builds/slave/test', 18:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:32 INFO - 'SHELL': '/bin/bash', 18:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:32 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:32 INFO - 'USER': 'cltbld', 18:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:32 INFO - 'XPC_FLAGS': '0x0', 18:09:32 INFO - 'XPC_SERVICE_NAME': '0', 18:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:33 INFO - Downloading/unpacking psutil>=3.1.1 18:09:33 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 18:09:33 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 18:09:33 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 18:09:33 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 18:09:33 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 18:09:33 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 18:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:35 INFO - Installing collected packages: psutil 18:09:35 INFO - Running setup.py install for psutil 18:09:35 INFO - building 'psutil._psutil_osx' extension 18:09:35 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 18:09:36 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 18:09:36 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 18:09:36 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 18:09:36 INFO - building 'psutil._psutil_posix' extension 18:09:36 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 18:09:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:09:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:09:36 INFO - ^ 18:09:36 INFO - 1 warning generated. 18:09:36 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 18:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:36 INFO - Successfully installed psutil 18:09:36 INFO - Cleaning up... 18:09:36 INFO - Return code: 0 18:09:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:36 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:36 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 18:09:36 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 18:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:36 INFO - 'HOME': '/Users/cltbld', 18:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:36 INFO - 'LOGNAME': 'cltbld', 18:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:36 INFO - 'MOZ_NO_REMOTE': '1', 18:09:36 INFO - 'NO_EM_RESTART': '1', 18:09:36 INFO - 'PAGER': '/bin/cat', 18:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:36 INFO - 'PWD': '/builds/slave/test', 18:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:36 INFO - 'SHELL': '/bin/bash', 18:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:36 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:36 INFO - 'USER': 'cltbld', 18:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:36 INFO - 'XPC_FLAGS': '0x0', 18:09:36 INFO - 'XPC_SERVICE_NAME': '0', 18:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:09:39 INFO - Installing collected packages: mozsystemmonitor 18:09:39 INFO - Running setup.py install for mozsystemmonitor 18:09:39 INFO - Successfully installed mozsystemmonitor 18:09:39 INFO - Cleaning up... 18:09:39 INFO - Return code: 0 18:09:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:39 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:39 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 18:09:39 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 18:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:39 INFO - 'HOME': '/Users/cltbld', 18:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:39 INFO - 'LOGNAME': 'cltbld', 18:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:39 INFO - 'MOZ_NO_REMOTE': '1', 18:09:39 INFO - 'NO_EM_RESTART': '1', 18:09:39 INFO - 'PAGER': '/bin/cat', 18:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:39 INFO - 'PWD': '/builds/slave/test', 18:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:39 INFO - 'SHELL': '/bin/bash', 18:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:39 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:39 INFO - 'USER': 'cltbld', 18:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:39 INFO - 'XPC_FLAGS': '0x0', 18:09:39 INFO - 'XPC_SERVICE_NAME': '0', 18:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:40 INFO - Downloading/unpacking jsonschema==2.5.1 18:09:40 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 18:09:40 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 18:09:40 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 18:09:40 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 18:09:40 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 18:09:40 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 18:09:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:09:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 18:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:09:43 INFO - warning: no files found matching '*.txt' 18:09:43 INFO - no previously-included directories found matching 'build' 18:09:43 INFO - no previously-included directories found matching 'dist' 18:09:43 INFO - no previously-included directories found matching '.git*' 18:09:43 INFO - Installing collected packages: jsonschema, functools32 18:09:43 INFO - Running setup.py install for functools32 18:09:43 INFO - warning: no files found matching '*.txt' 18:09:43 INFO - no previously-included directories found matching 'build' 18:09:43 INFO - no previously-included directories found matching 'dist' 18:09:43 INFO - no previously-included directories found matching '.git*' 18:09:43 INFO - Successfully installed jsonschema functools32 18:09:43 INFO - Cleaning up... 18:09:43 INFO - Return code: 0 18:09:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09: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')]} 18:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:43 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:43 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 18:09:43 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 18:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:43 INFO - 'HOME': '/Users/cltbld', 18:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:43 INFO - 'LOGNAME': 'cltbld', 18:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:43 INFO - 'MOZ_NO_REMOTE': '1', 18:09:43 INFO - 'NO_EM_RESTART': '1', 18:09:43 INFO - 'PAGER': '/bin/cat', 18:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:43 INFO - 'PWD': '/builds/slave/test', 18:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:43 INFO - 'SHELL': '/bin/bash', 18:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:43 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:43 INFO - 'USER': 'cltbld', 18:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:43 INFO - 'XPC_FLAGS': '0x0', 18:09:43 INFO - 'XPC_SERVICE_NAME': '0', 18:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:09:43 INFO - Cleaning up... 18:09:43 INFO - Return code: 0 18:09:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09: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')]} 18:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:43 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:43 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 18:09:43 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 18:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:43 INFO - 'HOME': '/Users/cltbld', 18:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:43 INFO - 'LOGNAME': 'cltbld', 18:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:43 INFO - 'MOZ_NO_REMOTE': '1', 18:09:43 INFO - 'NO_EM_RESTART': '1', 18:09:43 INFO - 'PAGER': '/bin/cat', 18:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:43 INFO - 'PWD': '/builds/slave/test', 18:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:43 INFO - 'SHELL': '/bin/bash', 18:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:43 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:43 INFO - 'USER': 'cltbld', 18:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:43 INFO - 'XPC_FLAGS': '0x0', 18:09:43 INFO - 'XPC_SERVICE_NAME': '0', 18:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:09:43 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 18:09:43 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 18:09:43 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 18:09:43 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 18:09:43 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 18:09:43 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 18:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 18:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 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 18:09:46 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 18:09:47 INFO - Downloading docopt-0.6.1.tar.gz 18:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 18:09:47 INFO - Running setup.py install for blobuploader 18:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:09:47 INFO - Running setup.py install for requests 18:09:48 INFO - Running setup.py install for docopt 18:09:48 INFO - Successfully installed blobuploader requests docopt 18:09:48 INFO - Cleaning up... 18:09:48 INFO - Return code: 0 18:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09: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')]} 18:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:48 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:48 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 18:09:48 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 18:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:48 INFO - 'HOME': '/Users/cltbld', 18:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:48 INFO - 'LOGNAME': 'cltbld', 18:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:48 INFO - 'MOZ_NO_REMOTE': '1', 18:09:48 INFO - 'NO_EM_RESTART': '1', 18:09:48 INFO - 'PAGER': '/bin/cat', 18:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:48 INFO - 'PWD': '/builds/slave/test', 18:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:48 INFO - 'SHELL': '/bin/bash', 18:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:48 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:48 INFO - 'USER': 'cltbld', 18:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:48 INFO - 'XPC_FLAGS': '0x0', 18:09:48 INFO - 'XPC_SERVICE_NAME': '0', 18:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:48 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-V6_WJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:48 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WScg2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:48 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-InOUTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:48 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-_gRETp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-VEyo3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-wXpfrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-UGCZuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-9Aqrjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-EmS0xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-vuKxj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Tg8VrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-7Btp7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-d5eNq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:49 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-qOXe3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-LdJ9wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-92Od6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:50 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-2bf632-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:09:50 INFO - Running setup.py install for manifestparser 18:09:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Running setup.py install for mozcrash 18:09:50 INFO - Running setup.py install for mozdebug 18:09:50 INFO - Running setup.py install for mozdevice 18:09:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:09:50 INFO - Running setup.py install for mozfile 18:09:51 INFO - Running setup.py install for mozhttpd 18:09:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for mozinfo 18:09:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for mozInstall 18:09:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for mozleak 18:09:51 INFO - Running setup.py install for mozlog 18:09:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:09:51 INFO - Running setup.py install for moznetwork 18:09:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Running setup.py install for mozprocess 18:09:52 INFO - Running setup.py install for mozprofile 18:09:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Running setup.py install for mozrunner 18:09:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Running setup.py install for mozscreenshot 18:09:52 INFO - Running setup.py install for moztest 18:09:52 INFO - Running setup.py install for mozversion 18:09:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:09:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:09:52 INFO - Cleaning up... 18:09:52 INFO - Return code: 0 18:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:52 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:52 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 18:09:52 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 18:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:52 INFO - 'HOME': '/Users/cltbld', 18:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:52 INFO - 'LOGNAME': 'cltbld', 18:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:52 INFO - 'MOZ_NO_REMOTE': '1', 18:09:52 INFO - 'NO_EM_RESTART': '1', 18:09:52 INFO - 'PAGER': '/bin/cat', 18:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:52 INFO - 'PWD': '/builds/slave/test', 18:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:52 INFO - 'SHELL': '/bin/bash', 18:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:52 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:52 INFO - 'USER': 'cltbld', 18:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:52 INFO - 'XPC_FLAGS': '0x0', 18:09:52 INFO - 'XPC_SERVICE_NAME': '0', 18:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-YSgQJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-hIEcYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-91Idg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-mGmYql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-IOyEkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-BExgYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:53 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)) 18:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:53 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-lQaQYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-Li4Fdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-9YU3CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-WMN7OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-nbxFEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-8kCDPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-rzpesR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-zGSbG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-spxpMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-3xg7N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:54 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)) 18:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:54 INFO - Running setup.py (path:/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/pip-EjIjYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:55 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)) 18:09:55 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)) 18:09:55 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)) 18:09:55 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)) 18:09:55 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)) 18:09:55 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)) 18:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09:55 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 18:09:55 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 18:09:55 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 18:09:55 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 18:09:55 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 18:09:55 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 18:09:57 INFO - Downloading blessings-1.6.tar.gz 18:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:09:57 INFO - Installing collected packages: blessings 18:09:57 INFO - Running setup.py install for blessings 18:09:57 INFO - Successfully installed blessings 18:09:57 INFO - Cleaning up... 18:09:57 INFO - Return code: 0 18:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:58 INFO - Reading from file tmpfile_stdout 18:09:58 INFO - Current package versions: 18:09:58 INFO - blessings == 1.6 18:09:58 INFO - blobuploader == 1.2.4 18:09:58 INFO - docopt == 0.6.1 18:09:58 INFO - functools32 == 3.2.3-2 18:09:58 INFO - jsonschema == 2.5.1 18:09:58 INFO - manifestparser == 1.1 18:09:58 INFO - mozInstall == 1.12 18:09:58 INFO - mozcrash == 0.17 18:09:58 INFO - mozdebug == 0.1 18:09:58 INFO - mozdevice == 0.48 18:09:58 INFO - mozfile == 1.2 18:09:58 INFO - mozhttpd == 0.7 18:09:58 INFO - mozinfo == 0.9 18:09:58 INFO - mozleak == 0.1 18:09:58 INFO - mozlog == 3.4 18:09:58 INFO - moznetwork == 0.27 18:09:58 INFO - mozprocess == 0.23 18:09:58 INFO - mozprofile == 0.28 18:09:58 INFO - mozrunner == 6.12 18:09:58 INFO - mozscreenshot == 0.1 18:09:58 INFO - mozsystemmonitor == 0.3 18:09:58 INFO - moztest == 0.7 18:09:58 INFO - mozversion == 1.4 18:09:58 INFO - psutil == 3.1.1 18:09:58 INFO - requests == 1.2.3 18:09:58 INFO - wsgiref == 0.1.2 18:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 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 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:58 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 18:09:58 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 18:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:58 INFO - 'HOME': '/Users/cltbld', 18:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:58 INFO - 'LOGNAME': 'cltbld', 18:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:58 INFO - 'MOZ_NO_REMOTE': '1', 18:09:58 INFO - 'NO_EM_RESTART': '1', 18:09:58 INFO - 'PAGER': '/bin/cat', 18:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:58 INFO - 'PWD': '/builds/slave/test', 18:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:58 INFO - 'SHELL': '/bin/bash', 18:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:58 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:58 INFO - 'USER': 'cltbld', 18:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:58 INFO - 'XPC_FLAGS': '0x0', 18:09:58 INFO - 'XPC_SERVICE_NAME': '0', 18:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 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)) 18:09:58 INFO - Cleaning up... 18:09:58 INFO - Return code: 0 18:09:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103644490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ba570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f95a7260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, '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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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 18:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:09:58 INFO - 'HOME': '/Users/cltbld', 18:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:09:58 INFO - 'LOGNAME': 'cltbld', 18:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:58 INFO - 'MOZ_NO_REMOTE': '1', 18:09:58 INFO - 'NO_EM_RESTART': '1', 18:09:58 INFO - 'PAGER': '/bin/cat', 18:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:58 INFO - 'PWD': '/builds/slave/test', 18:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:09:58 INFO - 'SHELL': '/bin/bash', 18:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:09:58 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:09:58 INFO - 'USER': 'cltbld', 18:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:58 INFO - 'XPC_FLAGS': '0x0', 18:09:58 INFO - 'XPC_SERVICE_NAME': '0', 18:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:09:58 INFO - Cleaning up... 18:09:58 INFO - Return code: 0 18:09:58 INFO - Running post-action listener: _resource_record_post_action 18:09:58 INFO - Running post-action listener: _start_resource_monitoring 18:09:58 INFO - Starting resource monitoring. 18:09:58 INFO - [mozharness: 2016-10-04 01:09:58.734710Z] Finished create-virtualenv step (success) 18:09:58 INFO - [mozharness: 2016-10-04 01:09:58.735730Z] Running install step. 18:09:58 INFO - Running pre-action listener: _resource_record_pre_action 18:09:58 INFO - Running main action method: install 18:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:58 INFO - Reading from file tmpfile_stdout 18:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:09:59 INFO - Reading from file tmpfile_stdout 18:09:59 INFO - Output received: 18:09:59 INFO - Usage: mozinstall [options] installer 18:09:59 INFO - Options: 18:09:59 INFO - -h, --help show this help message and exit 18:09:59 INFO - -d DEST, --destination=DEST 18:09:59 INFO - Directory to install application into. [default: 18:09:59 INFO - "/builds/slave/test"] 18:09:59 INFO - --app=APP Application being installed. [default: firefox] 18:09:59 INFO - mkdir: /builds/slave/test/build/application 18:09:59 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'] 18:09:59 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 18:10:30 INFO - Reading from file tmpfile_stdout 18:10:30 INFO - Output received: 18:10:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:10:30 INFO - Running post-action listener: _resource_record_post_action 18:10:30 INFO - [mozharness: 2016-10-04 01:10:30.937759Z] Finished install step (success) 18:10:30 INFO - [mozharness: 2016-10-04 01:10:30.937914Z] Running run-tests step. 18:10:30 INFO - Running pre-action listener: _resource_record_pre_action 18:10:30 INFO - Running main action method: run_tests 18:10:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:30 INFO - 2016-10-03 18:10:30.952 screenresolution[1628:7466] starting screenresolution argv=screenresolution get 18:10:30 INFO - 2016-10-03 18:10:30.955 screenresolution[1628:7466] Display 0: 1600x1200x32@60 18:10:30 INFO - 2016-10-03 18:10:30.961 screenresolution[1629:7468] starting screenresolution argv=screenresolution list 18:10:30 INFO - Available Modes on Display 0 18:10:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:31 INFO - Intel Iris: 18:10:31 INFO - Chipset Model: Intel Iris 18:10:31 INFO - Type: GPU 18:10:31 INFO - Bus: Built-In 18:10:31 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:31 INFO - Vendor: Intel (0x8086) 18:10:31 INFO - Device ID: 0x0a2e 18:10:31 INFO - Revision ID: 0x0009 18:10:31 INFO - Displays: 18:10:31 INFO - Display: 18:10:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:31 INFO - Display Serial Number: 1600x1200 60 18:10:31 INFO - Main Display: Yes 18:10:31 INFO - Mirror: Off 18:10:31 INFO - Online: Yes 18:10:31 INFO - Rotation: Supported 18:10:31 INFO - Return code: 0 18:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:10:31 INFO - Python 2.7.3 18:10:31 INFO - Return code: 0 18:10:31 INFO - grabbing minidump binary from tooltool 18:10: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')]} 18:10:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x103458d30>, '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 0x1032bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103450b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:10:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:10:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:10:31 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 18:10:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:10:31 INFO - Return code: 0 18:10:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:10:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:10:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:10:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:10:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:10:31 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/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 18:10:31 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/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0209 --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 18:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JlDhwMIMCH/Render', 18:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:31 INFO - 'HOME': '/Users/cltbld', 18:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:31 INFO - 'LOGNAME': 'cltbld', 18:10:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:10:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:31 INFO - 'MOZ_NO_REMOTE': '1', 18:10:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:10:31 INFO - 'NO_EM_RESTART': '1', 18:10:31 INFO - 'PAGER': '/bin/cat', 18:10:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:31 INFO - 'PWD': '/builds/slave/test', 18:10:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:31 INFO - 'SHELL': '/bin/bash', 18:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6BRYF6E1cc/Listeners', 18:10:31 INFO - 'TMPDIR': '/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/', 18:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:31 INFO - 'USER': 'cltbld', 18:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:31 INFO - 'XPC_FLAGS': '0x0', 18:10:31 INFO - 'XPC_SERVICE_NAME': '0', 18:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:31 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/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0209', '--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 18:10:31 INFO - mozversion application_buildid: 20161003155858 18:10:31 INFO - mozversion application_changeset: 6414a3001705218a78ca1a24b7ddffd689742ed3 18:10:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:10:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:10:31 INFO - mozversion application_name: Firefox 18:10:31 INFO - mozversion application_remotingname: firefox-dev 18:10:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:10:31 INFO - mozversion application_vendor: Mozilla 18:10:31 INFO - mozversion application_version: 51.0a2 18:10:31 INFO - mozversion platform_buildid: 20161003155858 18:10:31 INFO - mozversion platform_changeset: 6414a3001705218a78ca1a24b7ddffd689742ed3 18:10:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:10:31 INFO - mozversion platform_version: 51.0a2 18:10:31 INFO - using testdate: 1475543431 18:10:31 INFO - actual date: 1475543431 18:10:31 INFO - starting webserver on 'localhost:49274' 18:10:31 INFO - SUITE-START | Running 2 tests 18:10:31 INFO - TEST-START | dromaeo_css 18:10:31 INFO - operating with platform_type : mac_ 18:10:31 INFO - Initialising browser for dromaeo_css test... 18:10:31 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpVHrrSc/profile http://localhost:49274/getInfo.html) 18:10:34 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 18:10:34 INFO - PROCESS | 1639 | colorDepth:24 18:10:34 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 18:10:34 INFO - PROCESS | 1639 | __metrics 18:10:34 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:10:35 INFO - TEST-INFO | 1639: exit 0 18:10:35 INFO - Browser initialized. 18:10:35 INFO - Running cycle 1/1 for dromaeo_css test... 18:10:35 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpVHrrSc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:47 INFO - PROCESS | 1642 | RSS: Main: 225095680 18:10:47 INFO - PROCESS | 1642 | 18:11:36 INFO - PROCESS | 1642 | 1475543496880 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] 18:13:50 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 18:13:51 INFO - PROCESS | 1642 | RSS: Main: 235683840 18:13:51 INFO - PROCESS | 1642 | 18:16:54 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 18:16:54 INFO - PROCESS | 1642 | RSS: Main: 249987072 18:16:54 INFO - PROCESS | 1642 | 18:19:56 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 18:19:57 INFO - PROCESS | 1642 | RSS: Main: 251867136 18:19:57 INFO - PROCESS | 1642 | 18:22:59 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 18:22:59 INFO - PROCESS | 1642 | RSS: Main: 252076032 18:22:59 INFO - PROCESS | 1642 | 18:26:02 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 18:26:03 INFO - PROCESS | 1642 | RSS: Main: 256528384 18:26:03 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 18:29:05 INFO - PROCESS | 1642 | RSS: Main: 258244608 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | __start_tp_report 18:29:05 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 18:29:05 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 18:29:05 INFO - PROCESS | 1642 | |i|pagename|runs| 18:29:05 INFO - PROCESS | 1642 | |0;dojo.html;3460.965390346097;3482.7736197147183;3483.111806489345;3483.982580087099;3493.9650603493965;5606.21512988182;5821.573714439957;5852.414758524145;5962.165296858432;5964.7315870785815;5895.380984996567;5930.495907847828;5966.5226781857455;5987.820365389034;5991.790287339944;5313.468653134684;5377.462253774611;5389.245505629215;5430.728463576826;5462.317210348707;4208.45290112285;4511.826924999491;5429.647072940266;5446.891062178774;5452.318460192476;5298.125809241471;5312.335958005249;5438.945610543903;5449.754761035763;5457;5342.332208473941;5348.839534813942;5363.275957745694;5374.381946076212;5406.135018397038;5300.602454815866;5331.360236771612;5354.5180933715765;5402.054640437907;5460.126379779216;5406.432324605899;5741.33974592923;5745.454181852718;6030.849228769272;6032.66820324882;5926.992411290091;5958.702064896738;6228.906566401508;6238.2825975013;6260.906086408708;5568.192612071227;6304.27500837405;6307.180066591313;6333.493320534346;6369.426751592333;5278.57771378285;6061.666608336495;6070.089486577004;6082.60463069899;6089.69551522431;5348.705821179795;6253.812385628438;6312;6416.262129855127;6421.646809425526;6275.811725648238;6289.7169627366875;6290.339514350927;6293.685315734195;6320.083587879823;6319.96840015797;6355.968220158869;6367.745290188341;6368.713407896656;6384.585001974857;6162.445379915739;6169.105479705418;6235.906461403082;6278.497720182374;6297.2128483939505;5421.213923981;6170.321264660884;6254.687265636791;6293.716782744787;6300.71646775887;4995.625328100335;5013.699178049329;5025.748712564357;5028.044671512401;5033.345665063592;4401.965538098544;4416.183006143874;4428.977855110768;4486.461624605068;4540.818367265339;6009.879802403927;6110.4500594945775;6122.295935967331;6124.234470691164;6143.907841382383;6131.84670383244;6304.05439184126;6316.589421687576;6360.840978975562;6382.808515744535;4950.727709975914;5104.719240441811;5964.373740757244;5982.012967860254;6092.451679348791;5528.944710552843;5532.225488431623;5532.75102620375;5546.889062218733;5550.639208451437;6477.611343319321;6513.478921686159;6524.9021264682015;6560.8359791005605;6565.277819439762;6198.2252218472695;6254.312025677081;6280.120783090462;6285.874282514415;6322.0200868865395;6555.3772391622715;6564.048213009182;6569.9343006569325;6580.078788969452;6582.80251592453;6276.686165691788;6283.96858015707;6328.525360597881;6334.714937827716;6350.396712312323;6201.2868520118955;6217.720202590804;6261.812145635638;6267.122602835698;6340.651264180515;6234.376562343729;6242.65665388408;6288.9685551573775;6290.685465726787;6297.748090076346;6254.593451425642;6271.780487683091;6272.686365681607;6277.780277690259;6289.685515724104;6000.5799594028;6026.457618814327;6093.238345206849;6100.359462256399;6102.145699602148;6203.720832562455;6256.217972753406;6266.279377871603;6269.153664255449;6308.053791931247;6000.789972350947;6124.908126378197;6148.047052706837;6186.4122908325435;6189.164462797465 18:29:05 INFO - PROCESS | 1642 | |1;ext.html;498.16557266578474;507.90095931293365;518.8080410248209;522.6472131311365;531.1209947536826;30473.847630761844;41159.971000724996;41230.58769412301;41268.174636507254;41317.17365652685;36871.815640921755;37092;42421;42556.57443425565;43196.56803431965;9761.121499065082;9916.504174791267;9969.950150249239;9981.251406144533;10001.649942252023;9923.652672156475;9979.850302245472;9996.850047249298;10004.349717268355;10006.399616023025;10011.59953601855;10012.199024078092;10040.598376064949;10067.395956242612;10080.899191008106;9976;10013.299069065168;10020.448875311855;10022;10040.598376064949;9917.305788594802;9978.201743860474;9993.350432221881;9996.95001524995;9997.400155990665;40336.19327613431;40574.79712601418;40655.7967210165;40689.186216275804;40812.591874081474;3381.6956473917467;3390.338883917637;3411.778234414755;3496.527968724215;3563.6970857477145;29729.851350743324;30124.69875301241;30489.542656860165;32043.83978080118;32261.677383226102;2568.7944964402805;2724.5968326311963;2900.76793856491;2926.034408645142;3012.472817256993;514378;519494;520736;520924;521838;33712.325753484794;61684.38315616876;62153.37846621566;62322.68838655778;62396.68801655962;34272;35031;35182.64817351845;35533.644663553554;35566.68816526917;14757.77863332051;15121.470748523969;15227.923860380848;15234.847651523565;15236.771448428282;12876.871231287754;12968.35158242084;12975.286359250144;12995.870041299466;13006.219626822422;7042.753503627348;7545.396368290523;7667.1949445308555;7688.192739762357;7759.068911730628;3232.9191770205935;3268.10127215013;3275.132089996153;3287.5561799157285;3328.284418849959;885.880406145175;898.1916275352236;907.2877790934085;908.9727308180766;941.8493041113389;29073;30292.24269393283;30476.54285185724;30690.23274418113;30815.69184308173;744.9217832127657;895.7671005538607;1086.435053772034;1094.124700239805;1131.637875879727;13649.863501365058;14535.927320363542;15388.461403850812;16146.03123812575;16184.676306473804;992664;994734;1005816;1008501;1012363;59153.40846591565;59618.403815962156;60475;60682.39317606856;60989.08516372258;1324.265032906746;1329.7872340425486;1362.2439546052037;1364.2632978191864;1366.637840972143;30153.547696784128;31750.682493175696;32144.678553215104;32257.35485290328;32432.67567324391;51596.74201628968;52093.21860172176;52140.478595213564;52189.47810521846;52269;673447;678716;682836;683012;685332;27467.31331716643;27542.724572754018;27897.860510697315;27938.720612794426;27950.440991179657;47362.763186183845;47505.04989900113;47514.52485475101;48338;48874;34067.14832129217;39192.804035979636;40165.79917100396;40297.59702402938;41385.79307103445;32842.83578582092;39436.01409964659;40052;40101.19797603973;41500;33188.50217246695;33870.98387048393;38266;39244.60755392409;39459.21081578295;29932.700672992993;33141.83429082839;34936.12659683528;35381.29237415289;35606.465903011995;22873.65689514692;26275.868620656773;26530.336741580842;26628.7337126634;26782.866085670226 18:29:05 INFO - PROCESS | 1642 | |2;jquery.html;367.7242068448665;369.1841031320781;378.66677323954923;381.02457708266854;394.8716667083199;19389;21070.89464552679;21162.470938226554;21533.892330538343;21649.3505194844;17819;20600.763954162725;20710.48223794406;21024.57950840982;21131.788682113176;4678;5673.120666296721;6069.271687397519;6079.057746049347;6148.35442278561;5917.2307600012155;5925.34821169671;6025.548083893704;6031.638101713911;6040.96979515104;5790.507806836403;5889.234399528055;5972.820815375546;5985.191999080112;5995.4304341087745;5668.744906479218;5902.468777809996;5906.497947674453;5918.7928422505;5965.910511342312;5130.820421285237;5136.794528218867;5166.974165129188;5175.482451754832;5178.948210517922;25707.22878313635;25765;25959.870200648875;26079.608805867927;26405.47189056208;2108.7047813305994;2775.486534991013;3080.4609193391293;3165.5568220449154;3171.0803866878578;12829.807552886714;15311.540653780405;15643;15759.842401576067;15835.287412066486;1513.735096358133;1690.687222863762;1731.333436626895;1904.190718944443;1953.306576165455;120802;123255;126668.36665816704;127781;130613.34693326568;9616.663416780379;10684.412357320422;11068.28056176346;11239.988401043945;11508.424578771195;13811.930940345233;13934.233617151154;13936.163830170222;13973.790393143907;14966.551003469913;7141.321574450419;7935.603219838985;8054.657317213291;8813.515256660945;8863.468191908378;8844.204021638083;8882.06738292483;8919.821603567892;8982.955085224663;9079.319051071065;6710.295418980937;6795;6809.114815074107;6833.829154271084;6911.101556797685;1835.9265629374675;1843.3732530939544;1847.5658220318214;1848.3253612431365;1859.4421673498166;896.9641214351483;920.3879420185635;967.1054274795927;985.2118305355687;1051.0960573906434;17656.735148972777;21262.681059784114;22245.44386390321;22727.545449091256;22851.542969140857;819.9262066414051;964.5755867418313;969.3553786731744;1023.4180368709517;1046.2414749306693;11322.37726925027;11885.16803823724;11934.35854683676;11936.104792140624;12075.637730868088;557577;586875;625111;635028.8248558728;636685;118492;122453;127115;128555.71444285437;130098.69901301056;965.9275554333453;983.8868530118984;1010.141379827141;1014.5789497358661;1020.5101551255291;19477.415677529698;20082.994984475667;20193.293234737303;20219.191232351128;20250.68370555909;58793.412065880504;59364.70317648384;59796.40203598082;60581.39418605757;60947.69526152341;84007;87096.12903870881;87695;88363;88747.55626221828;8156.9184308156155;8173.836523269621;8234.176582341957;8403.537805420761;8422;11480.425978700865;12962.611121665988;13063.869361306646;13278.468861245829;13325.533606323732;9096.226820720312;11001.00990910822;11023.61417350389;11453.312801231952;11462.598809041643;11020.669379918616;11215.271007384494;11413.543458261576;11426.371549564521;11511.53953841837;11158.218924675195;11282;11372.37451940118;11590.188686791844;11751.882481175078;6339;7055.400290975324;7455.105387353552;7464.701411943679;8480;7672.309492145734;10977;11249.775004500028;11385.259958102697;11552.6534203974 18:29:05 INFO - PROCESS | 1642 | |3;mootools.html;1419.6592817723747;1516.5374560758964;1524.5959820647524;1691.255847427132;1773.2109211400932;8197.508149511033;8471.534065626389;8673.17604827542;9284.58219380127;9310.255179585634;8081.636326365313;8324.83350332993;8987.10128987101;9135.497547634877;9137.588808503617;2417.7098748150247;2440.0849681369486;2444.804415646744;2445.877706114696;2448.155386391701;2407.0251548123038;2428.5264373447185;2442.3405680466262;2443.022790883652;2451.6322551617222;2040.6632905570636;2425.9393515162087;2439.012200058979;2444.303373538542;2454.214651311581;1873.681474149398;2395.209580838319;2400.4838959623676;2400.5078958813488;2425.4057755849753;2406.097713357491;2409.481961378312;2412.541617092747;2417.129833260025;2425.2360506440414;9159.816803663889;9189.172974432333;9217.723468295962;9247.474166762477;9289.767755806091;5324.787008519694;5468.589855760833;5506.972465137648;5510.972445137789;5516.365617953947;3477.634848340913;3509.438489841613;3517.2789578136676;3542.4332106863035;3572.5712914450173;979.9755006124833;991.8958509356486;999.3254553176577;1015.8425444056184;1026.5996261458038;11990.400479975966;12016.279023258545;12172.026237901035;12189.878101218963;12204.572839950648;4796.544328288807;4846.442659094178;4881.243407271879;4929.0881186979805;4991.725455099931;10241.74395640115;10301.433421161908;10320.535575899103;10340.017698318648;10348.689539313833;5385.542228910508;5447.155690867842;5468.48049435303;5474.315710536183;5487.039768040577;4454.331850222493;4610.40064791575;4822.300766388854;4949.406071271471;4973.751312434364;4008.478897743333;4052.0477687743355;4127.463429754112;4146.792660366969;4187.5184353799095;1319.300770591588;1319.3139567424885;1326.1380102932978;1330.5010621017118;1337.4886378392548;803.7990502374406;911.1981456318398;912.3203213605906;930.5533343994921;939.056248470283;5938.524918006549;6097.390260973867;6143.723532441051;6155.876882462326;6200.0699895015205;395.9049828041249;436.2300539547701;439.69221544918685;443.5786003296881;461.6768262216395;4028.5165780106577;4078.571749966211;4089.6319331259733;4117.835286588503;4122.216778812016;10810.18923580719;11016.449177541092;11072.501737421835;11119.499622517005;11134.33194008362;10959.232853700323;11045.502952367162;11066.28069175501;11074.667759967213;11081.889181108247;7424.071991001125;7524.2851929066655;8153.959230203811;8247.546384948886;8274.793130171673;4935.777889995031;5839.883202336015;5870.4604272949655;6061.969690151521;6067.24159480065;10088;10160.745981350525;10277.383356998604;10291.639792607222;10306.587736490756;8697.652093916173;10144.239182061227;10328.638497652546;10390.844137338097;10570.682879513626;6305.432511074026;7050.717971281297;7255.056842610426;7499.400047996256;7684.615769211406;7382.6677799498075;8545.017323007934;8693.30453563726;8698.91301086981;8702.303815694855;7664.846703066019;7718.961405192938;7749.380049596131;7820.374370050268;7868.291853732962;7418.072740907387;7563;7584.317411432998;7653.043369578802;7670.348020418104;7032.683529241094;7162.462815288978;7166.641667916479;7169.820754481179;7175.138983321826;4510.977445112885;5001.67489113221;5081.212412075986;5177.326947496801;5337.092694241911;5021.774020169174;5063.721495317793;5135.35808023997;5143.151380022255;5161.509656582619 18:29:05 INFO - PROCESS | 1642 | |4;prototype.html;265.24405444483216;280.1944409821762;311.54669955215167;313.24507935874544;325.0395082531121;4775.47469778325;5753.798617048405;5786.971065144674;5876.32729544035;5899.026660601006;4712.3638308828295;4768.880777980552;4978;5511.311086114226;5647.887042259153;3832.329342365082;4380.452443444569;4383.430154079965;4395.780210989437;4411.514733379326;3770.0386401467586;3865.5747867734526;4260.67793052787;4373.387725718402;4389.692721509496;3571.3750093733493;3708.0903334782474;4216.283231850577;4239.47006624172;4240.97879510602;3393.9660603393895;4201.416129080624;4254.4469219001485;4278.550752171009;4302.892427689301;3318.767686261963;3439.7616857931125;3675.099600597844;3682.39240525313;3685.8894233173046;4725.480197178307;5042.890564075898;5361.5978801589645;5506.339239291271;5559.777608895639;4491.25894227452;4803.3995750531185;4825.372701548811;4875.34182885313;4879.170541008001;4878.97541516282;4946.455889852114;5295.761690723926;5879.059350503899;5947.762089516415;3789.8587298176717;3967.4247234150885;3982.4623675803687;4002.419649150857;4010.8796736097966;5236.978789136082;5526.751296191681;6014.75940962361;6327.3988971047675;6397.776077837253;3332.3002169544184;3385.7968521888765;3390.8643654254047;3487.5466189395215;4085.571015043437;3627.709783217389;3818.522684664417;4134.235166494208;4153.937690934638;4167.5207351154395;4647.512011238839;4853.538913803183;4872.269159626014;4900.632452566;4915.705057696549;6069.393060693896;6082.75668973245;6090.386047697275;6098.786542470993;6141.96929015361;1147.6499667601295;1178.505027888289;1250.5060501102014;1334.873187047229;1419.32582023538;737.9668464150126;750.7785203365021;777.4713195027435;825.529448214512;847.7918965474174;4284.421603083606;4645.5610804328;4785.856424307276;4861.95138048615;4867.002264535761;5307.867303317371;5320.52115309624;5321.8935621287355;5329.440408757102;5331;4040.757554546678;4236.051416348452;4324.740515569076;4636.44362676481;4820.927686084711;2881.841498717549;2971;3297.571315728988;3306.8591335989045;3307.570015897966;5821.388754180834;6354.2811469676735;6484;6515.609063456208;6524.217093948757;5503.11950087984;6344.510519214414;6348.968255158695;6417.294097649255;6431.710573024132;5702.659874929388;5732.283464566929;5878.618524646705;5986.246326689685;6537.5096867734155;5432.185172224198;5551.833444996657;5634.23937768396;5721.91283656104;6181.660008699565;5916.970415147896;6144.600600960924;6153.2000839890525;6158.630482171084;6169.051806843713;5975.880482390415;6466.612003279818;6501.609903405811;6524.9673751630935;6566.409023187936;3675.4486826976167;3710.4972486143156;3973.8807835764974;4015.678745700395;4042.4138499916758;5194.091034069098;5889.440503152194;6219.595726277777;6220.409061139185;6230.7507699691505;5782.595218334676;5828.883422331614;5960.97326908853;5992.490638295793;6064.545159112996;6074.939250607437;6082.756689732361;6086.573939824169;6096.756129754937;6119.877602448015;5571.860703482445;5779.075347944308;5790.420957904176;5850.327212370632;5937.435943585352;5739.483446489836;6012.939870601238;6044.516438684806;6062.696865156813;6087.878242435215;5138.332016837787;5554.361248456317;5726.936089192262;5810.593258471867;5972.402759724167 18:29:05 INFO - PROCESS | 1642 | |5;yui.html;733.1641928201855;736.9742059027932;764.2853931573978;780.4926797581571;819.0539926385026;10078.496075196239;13772.931135344334;14887.627809304759;15224.705899998513;16418.425355112573;14167.008309418345;14252.859771218304;14255.71488570228;14289.71420571588;14292.571222863306;819.6885183630212;833.5582141465003;864.2481041493909;870.229846585773;878.6309749905055;859.3125499600326;862.0086900064913;865.4893612768466;869.647792643977;870.6734974384606;900.3517467423477;912.8539433690611;912.9041450647686;915.789368445258;920.8112336970905;893.4415990006246;898.3352319283748;902.6795487601905;910.9772255693628;916.8441364967971;636.6212103798233;677.989830152548;679.2596070283365;682.7269092363044;687.2749249541731;15068;15322.693546129016;15322.770158447633;15334.003289786127;15337.846621533865;11687.357195354338;12850;14486.20325882076;14632.048916820373;14732.926335368362;11604.477798499087;11705.517189798378;11909.761804763857;11995.340256285901;12241.143119981605;3718.9442158367374;3867.2265546890735;3890.7860067696265;3974.066094467798;4001.659858911996;115253;115537.84462155355;115743;116893.83106168914;122773;11175.776484470265;11302.43487825622;11535.36555489456;11568.76862462746;11659.008984236434;21239.68140477894;22026.88986555089;23606.055757769496;23855.165069222494;23901.282961511184;6833.769921414094;7643.923560764321;7807.414443916729;8285.047219569706;8440.493570385674;4324.675649326313;4363.410939523187;4373.1472362888935;4488.887777805581;4674;3621.5292012038267;3751.6998640108727;3771.7548359356556;3775;3788.9201577550816;666.1972323350351;675.7195763757985;675.9662016899135;676.9323067693191;677.6679427080794;549.6895638074923;556.4241010554057;602.9698515074228;668.1247565688963;686.2417029182682;9285.117913798178;9313.44119352841;9417.434953902788;9476.715698529055;9689;555.9457803416337;560.3555910702725;560.5879678436346;600.8107446154447;649.7985624456339;4250.192463431938;4668.95331046692;4700.036492519025;4705.449043381305;4821.328130055424;94199;105636;111858;154023;158161;108468.8306233871;133778;134033;136087.63912360946;140203.29898350648;101049.49475252577;103773;111639.88360116295;111998;115128.84871151182;8083.191680832105;8613.569321534023;9042.638294468148;9818.950905245714;10154.847677284699;50042.74978625084;58232.708836455546;59759;60241;62066;53983.19025214703;61093;68180.6590967042;74211;92391.53804230936;12731.363431828557;12987.350632468528;13245.139065960682;13322.800157997444;13332.400041998328;14201.076929999517;14314.785278221043;14626;14771.94625123276;14934.77597836055;13766.31168441554;14051.297435128407;14506.984511084123;14604.707905841611;14685.192314422382;12660.683482913;12827.358632068173;12888.742225155633;13387.800761079203;13478.663033424244;12510.249385036926;13444.529441469502;13578.388972496065;13905.235212063433;14041.929790350983;11092.500837462172;11259.437028148395;11285.347943233497;11304.265222760494;12059.311696362693;10521.368717876645;11625.360605166798;11626.88373116258;11797.646070617895;11825.526978920747 18:29:05 INFO - PROCESS | 1642 | __end_tp_report 18:29:05 INFO - PROCESS | 1642 | __start_cc_report 18:29:05 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,363 18:29:05 INFO - PROCESS | 1642 | __end_cc_report 18:29:05 INFO - PROCESS | 1642 | __startTimestamp1475544545948__endTimestamp 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | ------- Summary: start ------- 18:29:05 INFO - PROCESS | 1642 | Number of tests: 6 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5845.71 Median:6110.45 stddev:665.39 (10.9%) stddev-sans-first:640.59 18:29:05 INFO - PROCESS | 1642 | Values: 3461.0 3482.8 3483.1 3484.0 3494.0 5606.2 5821.6 5852.4 5962.2 5964.7 5895.4 5930.5 5966.5 5987.8 5991.8 5313.5 5377.5 5389.2 5430.7 5462.3 4208.5 4511.8 5429.6 5446.9 5452.3 5298.1 5312.3 5438.9 5449.8 5457.0 5342.3 5348.8 5363.3 5374.4 5406.1 5300.6 5331.4 5354.5 5402.1 5460.1 5406.4 5741.3 5745.5 6030.8 6032.7 5927.0 5958.7 6228.9 6238.3 6260.9 5568.2 6304.3 6307.2 6333.5 6369.4 5278.6 6061.7 6070.1 6082.6 6089.7 5348.7 6253.8 6312.0 6416.3 6421.6 6275.8 6289.7 6290.3 6293.7 6320.1 6320.0 6356.0 6367.7 6368.7 6384.6 6162.4 6169.1 6235.9 6278.5 6297.2 5421.2 6170.3 6254.7 6293.7 6300.7 4995.6 5013.7 5025.7 5028.0 5033.3 4402.0 4416.2 4429.0 4486.5 4540.8 6009.9 6110.5 6122.3 6124.2 6143.9 6131.8 6304.1 6316.6 6360.8 6382.8 4950.7 5104.7 5964.4 5982.0 6092.5 5528.9 5532.2 5532.8 5546.9 5550.6 6477.6 6513.5 6524.9 6560.8 6565.3 6198.2 6254.3 6280.1 6285.9 6322.0 6555.4 6564.0 6569.9 6580.1 6582.8 6276.7 6284.0 6328.5 6334.7 6350.4 6201.3 6217.7 6261.8 6267.1 6340.7 6234.4 6242.7 6289.0 6290.7 6297.7 6254.6 6271.8 6272.7 6277.8 6289.7 6000.6 6026.5 6093.2 6100.4 6102.1 6203.7 6256.2 6266.3 6269.2 6308.1 6000.8 6124.9 6148.0 6186.4 6189.2 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:82883.92 Median:35550.17 stddev:206100.14 (579.7%) stddev-sans-first:206585.48 18:29:05 INFO - PROCESS | 1642 | Values: 498.2 507.9 518.8 522.6 531.1 30473.8 41160.0 41230.6 41268.2 41317.2 36871.8 37092.0 42421.0 42556.6 43196.6 9761.1 9916.5 9970.0 9981.3 10001.6 9923.7 9979.9 9996.9 10004.3 10006.4 10011.6 10012.2 10040.6 10067.4 10080.9 9976.0 10013.3 10020.4 10022.0 10040.6 9917.3 9978.2 9993.4 9997.0 9997.4 40336.2 40574.8 40655.8 40689.2 40812.6 3381.7 3390.3 3411.8 3496.5 3563.7 29729.9 30124.7 30489.5 32043.8 32261.7 2568.8 2724.6 2900.8 2926.0 3012.5 514378.0 519494.0 520736.0 520924.0 521838.0 33712.3 61684.4 62153.4 62322.7 62396.7 34272.0 35031.0 35182.6 35533.6 35566.7 14757.8 15121.5 15227.9 15234.8 15236.8 12876.9 12968.4 12975.3 12995.9 13006.2 7042.8 7545.4 7667.2 7688.2 7759.1 3232.9 3268.1 3275.1 3287.6 3328.3 885.9 898.2 907.3 909.0 941.8 29073.0 30292.2 30476.5 30690.2 30815.7 744.9 895.8 1086.4 1094.1 1131.6 13649.9 14535.9 15388.5 16146.0 16184.7 992664.0 994734.0 1005816.0 1008501.0 1012363.0 59153.4 59618.4 60475.0 60682.4 60989.1 1324.3 1329.8 1362.2 1364.3 1366.6 30153.5 31750.7 32144.7 32257.4 32432.7 51596.7 52093.2 52140.5 52189.5 52269.0 673447.0 678716.0 682836.0 683012.0 685332.0 27467.3 27542.7 27897.9 27938.7 27950.4 47362.8 47505.0 47514.5 48338.0 48874.0 34067.1 39192.8 40165.8 40297.6 41385.8 32842.8 39436.0 40052.0 40101.2 41500.0 33188.5 33871.0 38266.0 39244.6 39459.2 29932.7 33141.8 34936.1 35381.3 35606.5 22873.7 26275.9 26530.3 26628.7 26782.9 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:36163.75 Median:25862.44 stddev:101779.36 (393.5%) stddev-sans-first:102029.39 18:29:05 INFO - PROCESS | 1642 | Values: 367.7 369.2 378.7 381.0 394.9 19389.0 21070.9 21162.5 21533.9 21649.4 17819.0 20600.8 20710.5 21024.6 21131.8 4678.0 5673.1 6069.3 6079.1 6148.4 5917.2 5925.3 6025.5 6031.6 6041.0 5790.5 5889.2 5972.8 5985.2 5995.4 5668.7 5902.5 5906.5 5918.8 5965.9 5130.8 5136.8 5167.0 5175.5 5178.9 25707.2 25765.0 25959.9 26079.6 26405.5 2108.7 2775.5 3080.5 3165.6 3171.1 12829.8 15311.5 15643.0 15759.8 15835.3 1513.7 1690.7 1731.3 1904.2 1953.3 120802.0 123255.0 126668.4 127781.0 130613.3 9616.7 10684.4 11068.3 11240.0 11508.4 13811.9 13934.2 13936.2 13973.8 14966.6 7141.3 7935.6 8054.7 8813.5 8863.5 8844.2 8882.1 8919.8 8983.0 9079.3 6710.3 6795.0 6809.1 6833.8 6911.1 1835.9 1843.4 1847.6 1848.3 1859.4 897.0 920.4 967.1 985.2 1051.1 17656.7 21262.7 22245.4 22727.5 22851.5 819.9 964.6 969.4 1023.4 1046.2 11322.4 11885.2 11934.4 11936.1 12075.6 557577.0 586875.0 625111.0 635028.8 636685.0 118492.0 122453.0 127115.0 128555.7 130098.7 965.9 983.9 1010.1 1014.6 1020.5 19477.4 20083.0 20193.3 20219.2 20250.7 58793.4 59364.7 59796.4 60581.4 60947.7 84007.0 87096.1 87695.0 88363.0 88747.6 8156.9 8173.8 8234.2 8403.5 8422.0 11480.4 12962.6 13063.9 13278.5 13325.5 9096.2 11001.0 11023.6 11453.3 11462.6 11020.7 11215.3 11413.5 11426.4 11511.5 11158.2 11282.0 11372.4 11590.2 11751.9 6339.0 7055.4 7455.1 7464.7 8480.0 7672.3 10977.0 11249.8 11385.3 11552.7 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5803.79 Median:4834.37 stddev:3307.97 (68.4%) stddev-sans-first:3300.84 18:29:05 INFO - PROCESS | 1642 | Values: 1419.7 1516.5 1524.6 1691.3 1773.2 8197.5 8471.5 8673.2 9284.6 9310.3 8081.6 8324.8 8987.1 9135.5 9137.6 2417.7 2440.1 2444.8 2445.9 2448.2 2407.0 2428.5 2442.3 2443.0 2451.6 2040.7 2425.9 2439.0 2444.3 2454.2 1873.7 2395.2 2400.5 2400.5 2425.4 2406.1 2409.5 2412.5 2417.1 2425.2 9159.8 9189.2 9217.7 9247.5 9289.8 5324.8 5468.6 5507.0 5511.0 5516.4 3477.6 3509.4 3517.3 3542.4 3572.6 980.0 991.9 999.3 1015.8 1026.6 11990.4 12016.3 12172.0 12189.9 12204.6 4796.5 4846.4 4881.2 4929.1 4991.7 10241.7 10301.4 10320.5 10340.0 10348.7 5385.5 5447.2 5468.5 5474.3 5487.0 4454.3 4610.4 4822.3 4949.4 4973.8 4008.5 4052.0 4127.5 4146.8 4187.5 1319.3 1319.3 1326.1 1330.5 1337.5 803.8 911.2 912.3 930.6 939.1 5938.5 6097.4 6143.7 6155.9 6200.1 395.9 436.2 439.7 443.6 461.7 4028.5 4078.6 4089.6 4117.8 4122.2 10810.2 11016.4 11072.5 11119.5 11134.3 10959.2 11045.5 11066.3 11074.7 11081.9 7424.1 7524.3 8154.0 8247.5 8274.8 4935.8 5839.9 5870.5 6062.0 6067.2 10088.0 10160.7 10277.4 10291.6 10306.6 8697.7 10144.2 10328.6 10390.8 10570.7 6305.4 7050.7 7255.1 7499.4 7684.6 7382.7 8545.0 8693.3 8698.9 8702.3 7664.8 7719.0 7749.4 7820.4 7868.3 7418.1 7563.0 7584.3 7653.0 7670.3 7032.7 7162.5 7166.6 7169.8 7175.1 4511.0 5001.7 5081.2 5177.3 5337.1 5021.8 5063.7 5135.4 5143.2 5161.5 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4734.35 Median:5266.37 stddev:1529.18 (29.0%) stddev-sans-first:1496.23 18:29:05 INFO - PROCESS | 1642 | Values: 265.2 280.2 311.5 313.2 325.0 4775.5 5753.8 5787.0 5876.3 5899.0 4712.4 4768.9 4978.0 5511.3 5647.9 3832.3 4380.5 4383.4 4395.8 4411.5 3770.0 3865.6 4260.7 4373.4 4389.7 3571.4 3708.1 4216.3 4239.5 4241.0 3394.0 4201.4 4254.4 4278.6 4302.9 3318.8 3439.8 3675.1 3682.4 3685.9 4725.5 5042.9 5361.6 5506.3 5559.8 4491.3 4803.4 4825.4 4875.3 4879.2 4879.0 4946.5 5295.8 5879.1 5947.8 3789.9 3967.4 3982.5 4002.4 4010.9 5237.0 5526.8 6014.8 6327.4 6397.8 3332.3 3385.8 3390.9 3487.5 4085.6 3627.7 3818.5 4134.2 4153.9 4167.5 4647.5 4853.5 4872.3 4900.6 4915.7 6069.4 6082.8 6090.4 6098.8 6142.0 1147.6 1178.5 1250.5 1334.9 1419.3 738.0 750.8 777.5 825.5 847.8 4284.4 4645.6 4785.9 4862.0 4867.0 5307.9 5320.5 5321.9 5329.4 5331.0 4040.8 4236.1 4324.7 4636.4 4820.9 2881.8 2971.0 3297.6 3306.9 3307.6 5821.4 6354.3 6484.0 6515.6 6524.2 5503.1 6344.5 6349.0 6417.3 6431.7 5702.7 5732.3 5878.6 5986.2 6537.5 5432.2 5551.8 5634.2 5721.9 6181.7 5917.0 6144.6 6153.2 6158.6 6169.1 5975.9 6466.6 6501.6 6525.0 6566.4 3675.4 3710.5 3973.9 4015.7 4042.4 5194.1 5889.4 6219.6 6220.4 6230.8 5782.6 5828.9 5961.0 5992.5 6064.5 6074.9 6082.8 6086.6 6096.8 6119.9 5571.9 5779.1 5790.4 5850.3 5937.4 5739.5 6012.9 6044.5 6062.7 6087.9 5138.3 5554.4 5726.9 5810.6 5972.4 18:29:05 INFO - PROCESS | 1642 | 18:29:05 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:23728.11 Median:3670.24 stddev:37502.10 (1021.8%) stddev-sans-first:37567.56 18:29:05 INFO - PROCESS | 1642 | Values: 733.2 737.0 764.3 780.5 819.1 10078.5 13772.9 14887.6 15224.7 16418.4 14167.0 14252.9 14255.7 14289.7 14292.6 819.7 833.6 864.2 870.2 878.6 859.3 862.0 865.5 869.6 870.7 900.4 912.9 912.9 915.8 920.8 893.4 898.3 902.7 911.0 916.8 636.6 678.0 679.3 682.7 687.3 15068.0 15322.7 15322.8 15334.0 15337.8 11687.4 12850.0 14486.2 14632.0 14732.9 11604.5 11705.5 11909.8 11995.3 12241.1 3718.9 3867.2 3890.8 3974.1 4001.7 115253.0 115537.8 115743.0 116893.8 122773.0 11175.8 11302.4 11535.4 11568.8 11659.0 21239.7 22026.9 23606.1 23855.2 23901.3 6833.8 7643.9 7807.4 8285.0 8440.5 4324.7 4363.4 4373.1 4488.9 4674.0 3621.5 3751.7 3771.8 3775.0 3788.9 666.2 675.7 676.0 676.9 677.7 549.7 556.4 603.0 668.1 686.2 9285.1 9313.4 9417.4 9476.7 9689.0 555.9 560.4 560.6 600.8 649.8 4250.2 4669.0 4700.0 4705.4 4821.3 94199.0 105636.0 111858.0 154023.0 158161.0 108468.8 133778.0 134033.0 136087.6 140203.3 101049.5 103773.0 111639.9 111998.0 115128.8 8083.2 8613.6 9042.6 9819.0 10154.8 50042.7 58232.7 59759.0 60241.0 62066.0 53983.2 61093.0 68180.7 74211.0 92391.5 12731.4 12987.4 13245.1 13322.8 13332.4 14201.1 14314.8 14626.0 14771.9 14934.8 13766.3 14051.3 14507.0 14604.7 14685.2 12660.7 12827.4 12888.7 13387.8 13478.7 12510.2 13444.5 13578.4 13905.2 14041.9 11092.5 11259.4 11285.3 11304.3 12059.3 10521.4 11625.4 11626.9 11797.6 11825.5 18:29:05 INFO - PROCESS | 1642 | -------- Summary: end -------- 18:29:05 INFO - PROCESS | 1642 | 18:29:06 INFO - TEST-INFO | 1642: exit 0 18:29:06 INFO - TEST-OK | dromaeo_css | took 1115100ms 18:29:06 INFO - TEST-START | kraken 18:29:06 INFO - operating with platform_type : mac_ 18:29:06 INFO - Initialising browser for kraken test... 18:29:06 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpUTWETf/profile http://localhost:49274/getInfo.html) 18:29:09 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 18:29:09 INFO - PROCESS | 1653 | colorDepth:24 18:29:09 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 18:29:09 INFO - PROCESS | 1653 | __metrics 18:29:09 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:29:09 INFO - TEST-INFO | 1653: exit 0 18:29:09 INFO - Browser initialized. 18:29:09 INFO - Running cycle 1/1 for kraken test... 18:29:09 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/T/tmpUTWETf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:21 INFO - PROCESS | 1655 | RSS: Main: 224698368 18:29:21 INFO - PROCESS | 1655 | 18:29:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:25 INFO - PROCESS | 1655 | RSS: Main: 237268992 18:29:25 INFO - PROCESS | 1655 | 18:29:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 18:29:28 INFO - PROCESS | 1655 | RSS: Main: 244690944 18:29:28 INFO - PROCESS | 1655 | 18:29:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 18:29:32 INFO - PROCESS | 1655 | RSS: Main: 248569856 18:29:32 INFO - PROCESS | 1655 | 18:29:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 18:29:35 INFO - PROCESS | 1655 | RSS: Main: 249356288 18:29:35 INFO - PROCESS | 1655 | 18:29:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:29:37 INFO - PROCESS | 1655 | RSS: Main: 250806272 18:29:37 INFO - PROCESS | 1655 | 18:29:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 18:29:41 INFO - PROCESS | 1655 | RSS: Main: 251150336 18:29:41 INFO - PROCESS | 1655 | 18:29:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 18:29:44 INFO - PROCESS | 1655 | RSS: Main: 250966016 18:29:44 INFO - PROCESS | 1655 | 18:29:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 18:29:48 INFO - PROCESS | 1655 | RSS: Main: 251596800 18:29:48 INFO - PROCESS | 1655 | 18:29:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:29:51 INFO - PROCESS | 1655 | RSS: Main: 250937344 18:29:51 INFO - PROCESS | 1655 | 18:29:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:29:53 INFO - PROCESS | 1655 | RSS: Main: 250990592 18:29:53 INFO - PROCESS | 1655 | 18:29:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:29:56 INFO - PROCESS | 1655 | RSS: Main: 251764736 18:29:56 INFO - PROCESS | 1655 | 18:29:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:00 INFO - PROCESS | 1655 | RSS: Main: 251629568 18:30:00 INFO - PROCESS | 1655 | 18:30:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:03 INFO - PROCESS | 1655 | RSS: Main: 251449344 18:30:03 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 18:30:05 INFO - PROCESS | 1655 | RSS: Main: 253333504 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | __start_tp_report 18:30:05 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 18:30:05 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 18:30:05 INFO - PROCESS | 1655 | |i|pagename|runs| 18:30:05 INFO - PROCESS | 1655 | |0;ai-astar;107;120;119;118;121;118;118;119;118;119 18:30:05 INFO - PROCESS | 1655 | |1;audio-beat-detection;146;115;111;147;113;115;112;114;124;142 18:30:05 INFO - PROCESS | 1655 | |2;audio-dft;245;223;202;199;201;204;201;197;201;198 18:30:05 INFO - PROCESS | 1655 | |3;audio-fft;88;57;61;89;60;59;59;60;82;60 18:30:05 INFO - PROCESS | 1655 | |4;audio-oscillator;92;70;91;70;73;71;85;71;73;86 18:30:05 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;90;88;89;92;89;75;138;133;89;86 18:30:05 INFO - PROCESS | 1655 | |6;imaging-darkroom;123;96;96;96;95;97;153;96;94;95 18:30:05 INFO - PROCESS | 1655 | |7;imaging-desaturate;147;151;91;108;90;145;143;113;96;92 18:30:05 INFO - PROCESS | 1655 | |8;json-parse-financial;56;57;56;57;60;59;71;84;95;93 18:30:05 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;69;74;67;83;76;73;68;85;73;70 18:30:05 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;87;85;89;87;89;104;107;83;82;80 18:30:05 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;131;166;130;150;150;160;161;154;196;163 18:30:05 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;169;167;169;216;173;232;153;229;221;171 18:30:05 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;70;68;68;69;73;78;84;87;93 18:30:05 INFO - PROCESS | 1655 | __end_tp_report 18:30:05 INFO - PROCESS | 1655 | __start_cc_report 18:30:05 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,943 18:30:05 INFO - PROCESS | 1655 | __end_cc_report 18:30:05 INFO - PROCESS | 1655 | __startTimestamp1475544605905__endTimestamp 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | ------- Summary: start ------- 18:30:05 INFO - PROCESS | 1655 | Number of tests: 14 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:117.70 Median:119.00 stddev:3.89 (3.3%) stddev-sans-first:1.05 18:30:05 INFO - PROCESS | 1655 | Values: 107.0 120.0 119.0 118.0 121.0 118.0 118.0 119.0 118.0 119.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:119.50 stddev:15.03 (12.6%) stddev-sans-first:13.65 18:30:05 INFO - PROCESS | 1655 | Values: 146.0 115.0 111.0 147.0 113.0 115.0 112.0 114.0 124.0 142.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:207.10 Median:201.50 stddev:15.23 (7.6%) stddev-sans-first:7.83 18:30:05 INFO - PROCESS | 1655 | Values: 245.0 223.0 202.0 199.0 201.0 204.0 201.0 197.0 201.0 198.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:67.50 Median:60.50 stddev:13.16 (21.8%) stddev-sans-first:11.68 18:30:05 INFO - PROCESS | 1655 | Values: 88.0 57.0 61.0 89.0 60.0 59.0 59.0 60.0 82.0 60.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:79.00 stddev:9.15 (11.6%) stddev-sans-first:8.23 18:30:05 INFO - PROCESS | 1655 | Values: 92.0 70.0 91.0 70.0 73.0 71.0 85.0 71.0 73.0 86.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:89.00 stddev:20.89 (23.5%) stddev-sans-first:22.01 18:30:05 INFO - PROCESS | 1655 | Values: 90.0 88.0 89.0 92.0 89.0 75.0 138.0 133.0 89.0 86.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:96.00 stddev:19.23 (20.0%) stddev-sans-first:19.14 18:30:05 INFO - PROCESS | 1655 | Values: 123.0 96.0 96.0 96.0 95.0 97.0 153.0 96.0 94.0 95.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:117.60 Median:120.50 stddev:25.99 (21.6%) stddev-sans-first:25.30 18:30:05 INFO - PROCESS | 1655 | Values: 147.0 151.0 91.0 108.0 90.0 145.0 143.0 113.0 96.0 92.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:65.50 stddev:15.94 (24.3%) stddev-sans-first:16.22 18:30:05 INFO - PROCESS | 1655 | Values: 56.0 57.0 56.0 57.0 60.0 59.0 71.0 84.0 95.0 93.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:73.50 stddev:6.09 (8.3%) stddev-sans-first:6.20 18:30:05 INFO - PROCESS | 1655 | Values: 69.0 74.0 67.0 83.0 76.0 73.0 68.0 85.0 73.0 70.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.00 stddev:9.06 (10.5%) stddev-sans-first:9.57 18:30:05 INFO - PROCESS | 1655 | Values: 87.0 85.0 89.0 87.0 89.0 104.0 107.0 83.0 82.0 80.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:160.50 stddev:18.76 (11.7%) stddev-sans-first:17.56 18:30:05 INFO - PROCESS | 1655 | Values: 131.0 166.0 130.0 150.0 150.0 160.0 161.0 154.0 196.0 163.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:194.50 stddev:30.46 (15.7%) stddev-sans-first:31.35 18:30:05 INFO - PROCESS | 1655 | Values: 169.0 167.0 169.0 216.0 173.0 232.0 153.0 229.0 221.0 171.0 18:30:05 INFO - PROCESS | 1655 | 18:30:05 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:75.50 stddev:9.31 (12.3%) stddev-sans-first:9.33 18:30:05 INFO - PROCESS | 1655 | Values: 67.0 70.0 68.0 68.0 69.0 73.0 78.0 84.0 87.0 93.0 18:30:05 INFO - PROCESS | 1655 | -------- Summary: end -------- 18:30:05 INFO - PROCESS | 1655 | 18:30:06 INFO - TEST-INFO | 1655: exit 0 18:30:06 INFO - TEST-OK | kraken | took 60052ms 18:30:06 INFO - SUITE-END | took 1175s 18:30:07 INFO - Completed test suite (00:19:35) 18:30:07 INFO - javascript benchmark 18:30:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7399.526299263984, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3460.965390346097, 3482.7736197147183, 3483.111806489345, 3483.982580087099, 3493.9650603493965, 5606.21512988182, 5821.573714439957, 5852.414758524145, 5962.165296858432, 5964.7315870785815, 5895.380984996567, 5930.495907847828, 5966.5226781857455, 5987.820365389034, 5991.790287339944, 5313.468653134684, 5377.462253774611, 5389.245505629215, 5430.728463576826, 5462.317210348707, 4208.45290112285, 4511.826924999491, 5429.647072940266, 5446.891062178774, 5452.318460192476, 5298.125809241471, 5312.335958005249, 5438.945610543903, 5449.754761035763, 5457.0, 5342.332208473941, 5348.839534813942, 5363.275957745694, 5374.381946076212, 5406.135018397038, 5300.602454815866, 5331.360236771612, 5354.5180933715765, 5402.054640437907, 5460.126379779216, 5406.432324605899, 5741.33974592923, 5745.454181852718, 6030.849228769272, 6032.66820324882, 5926.992411290091, 5958.702064896738, 6228.906566401508, 6238.2825975013, 6260.906086408708, 5568.192612071227, 6304.27500837405, 6307.180066591313, 6333.493320534346, 6369.426751592333, 5278.57771378285, 6061.666608336495, 6070.089486577004, 6082.60463069899, 6089.69551522431, 5348.705821179795, 6253.812385628438, 6312.0, 6416.262129855127, 6421.646809425526, 6275.811725648238, 6289.7169627366875, 6290.339514350927, 6293.685315734195, 6320.083587879823, 6319.96840015797, 6355.968220158869, 6367.745290188341, 6368.713407896656, 6384.585001974857, 6162.445379915739, 6169.105479705418, 6235.906461403082, 6278.497720182374, 6297.2128483939505, 5421.213923981, 6170.321264660884, 6254.687265636791, 6293.716782744787, 6300.71646775887, 4995.625328100335, 5013.699178049329, 5025.748712564357, 5028.044671512401, 5033.345665063592, 4401.965538098544, 4416.183006143874, 4428.977855110768, 4486.461624605068, 4540.818367265339, 6009.879802403927, 6110.4500594945775, 6122.295935967331, 6124.234470691164, 6143.907841382383, 6131.84670383244, 6304.05439184126, 6316.589421687576, 6360.840978975562, 6382.808515744535, 4950.727709975914, 5104.719240441811, 5964.373740757244, 5982.012967860254, 6092.451679348791, 5528.944710552843, 5532.225488431623, 5532.75102620375, 5546.889062218733, 5550.639208451437, 6477.611343319321, 6513.478921686159, 6524.9021264682015, 6560.8359791005605, 6565.277819439762, 6198.2252218472695, 6254.312025677081, 6280.120783090462, 6285.874282514415, 6322.0200868865395, 6555.3772391622715, 6564.048213009182, 6569.9343006569325, 6580.078788969452, 6582.80251592453, 6276.686165691788, 6283.96858015707, 6328.525360597881, 6334.714937827716, 6350.396712312323, 6201.2868520118955, 6217.720202590804, 6261.812145635638, 6267.122602835698, 6340.651264180515, 6234.376562343729, 6242.65665388408, 6288.9685551573775, 6290.685465726787, 6297.748090076346, 6254.593451425642, 6271.780487683091, 6272.686365681607, 6277.780277690259, 6289.685515724104, 6000.5799594028, 6026.457618814327, 6093.238345206849, 6100.359462256399, 6102.145699602148, 6203.720832562455, 6256.217972753406, 6266.279377871603, 6269.153664255449, 6308.053791931247, 6000.789972350947, 6124.908126378197, 6148.047052706837, 6186.4122908325435, 6189.164462797465], "value": 5804.47794142493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.16557266578474, 507.90095931293365, 518.8080410248209, 522.6472131311365, 531.1209947536826, 30473.847630761844, 41159.971000724996, 41230.58769412301, 41268.174636507254, 41317.17365652685, 36871.815640921755, 37092.0, 42421.0, 42556.57443425565, 43196.56803431965, 9761.121499065082, 9916.504174791267, 9969.950150249239, 9981.251406144533, 10001.649942252023, 9923.652672156475, 9979.850302245472, 9996.850047249298, 10004.349717268355, 10006.399616023025, 10011.59953601855, 10012.199024078092, 10040.598376064949, 10067.395956242612, 10080.899191008106, 9976.0, 10013.299069065168, 10020.448875311855, 10022.0, 10040.598376064949, 9917.305788594802, 9978.201743860474, 9993.350432221881, 9996.95001524995, 9997.400155990665, 40336.19327613431, 40574.79712601418, 40655.7967210165, 40689.186216275804, 40812.591874081474, 3381.6956473917467, 3390.338883917637, 3411.778234414755, 3496.527968724215, 3563.6970857477145, 29729.851350743324, 30124.69875301241, 30489.542656860165, 32043.83978080118, 32261.677383226102, 2568.7944964402805, 2724.5968326311963, 2900.76793856491, 2926.034408645142, 3012.472817256993, 514378.0, 519494.0, 520736.0, 520924.0, 521838.0, 33712.325753484794, 61684.38315616876, 62153.37846621566, 62322.68838655778, 62396.68801655962, 34272.0, 35031.0, 35182.64817351845, 35533.644663553554, 35566.68816526917, 14757.77863332051, 15121.470748523969, 15227.923860380848, 15234.847651523565, 15236.771448428282, 12876.871231287754, 12968.35158242084, 12975.286359250144, 12995.870041299466, 13006.219626822422, 7042.753503627348, 7545.396368290523, 7667.1949445308555, 7688.192739762357, 7759.068911730628, 3232.9191770205935, 3268.10127215013, 3275.132089996153, 3287.5561799157285, 3328.284418849959, 885.880406145175, 898.1916275352236, 907.2877790934085, 908.9727308180766, 941.8493041113389, 29073.0, 30292.24269393283, 30476.54285185724, 30690.23274418113, 30815.69184308173, 744.9217832127657, 895.7671005538607, 1086.435053772034, 1094.124700239805, 1131.637875879727, 13649.863501365058, 14535.927320363542, 15388.461403850812, 16146.03123812575, 16184.676306473804, 992664.0, 994734.0, 1005816.0, 1008501.0, 1012363.0, 59153.40846591565, 59618.403815962156, 60475.0, 60682.39317606856, 60989.08516372258, 1324.265032906746, 1329.7872340425486, 1362.2439546052037, 1364.2632978191864, 1366.637840972143, 30153.547696784128, 31750.682493175696, 32144.678553215104, 32257.35485290328, 32432.67567324391, 51596.74201628968, 52093.21860172176, 52140.478595213564, 52189.47810521846, 52269.0, 673447.0, 678716.0, 682836.0, 683012.0, 685332.0, 27467.31331716643, 27542.724572754018, 27897.860510697315, 27938.720612794426, 27950.440991179657, 47362.763186183845, 47505.04989900113, 47514.52485475101, 48338.0, 48874.0, 34067.14832129217, 39192.804035979636, 40165.79917100396, 40297.59702402938, 41385.79307103445, 32842.83578582092, 39436.01409964659, 40052.0, 40101.19797603973, 41500.0, 33188.50217246695, 33870.98387048393, 38266.0, 39244.60755392409, 39459.21081578295, 29932.700672992993, 33141.83429082839, 34936.12659683528, 35381.29237415289, 35606.465903011995, 22873.65689514692, 26275.868620656773, 26530.336741580842, 26628.7337126634, 26782.866085670226], "value": 19061.924050626923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.7242068448665, 369.1841031320781, 378.66677323954923, 381.02457708266854, 394.8716667083199, 19389.0, 21070.89464552679, 21162.470938226554, 21533.892330538343, 21649.3505194844, 17819.0, 20600.763954162725, 20710.48223794406, 21024.57950840982, 21131.788682113176, 4678.0, 5673.120666296721, 6069.271687397519, 6079.057746049347, 6148.35442278561, 5917.2307600012155, 5925.34821169671, 6025.548083893704, 6031.638101713911, 6040.96979515104, 5790.507806836403, 5889.234399528055, 5972.820815375546, 5985.191999080112, 5995.4304341087745, 5668.744906479218, 5902.468777809996, 5906.497947674453, 5918.7928422505, 5965.910511342312, 5130.820421285237, 5136.794528218867, 5166.974165129188, 5175.482451754832, 5178.948210517922, 25707.22878313635, 25765.0, 25959.870200648875, 26079.608805867927, 26405.47189056208, 2108.7047813305994, 2775.486534991013, 3080.4609193391293, 3165.5568220449154, 3171.0803866878578, 12829.807552886714, 15311.540653780405, 15643.0, 15759.842401576067, 15835.287412066486, 1513.735096358133, 1690.687222863762, 1731.333436626895, 1904.190718944443, 1953.306576165455, 120802.0, 123255.0, 126668.36665816704, 127781.0, 130613.34693326568, 9616.663416780379, 10684.412357320422, 11068.28056176346, 11239.988401043945, 11508.424578771195, 13811.930940345233, 13934.233617151154, 13936.163830170222, 13973.790393143907, 14966.551003469913, 7141.321574450419, 7935.603219838985, 8054.657317213291, 8813.515256660945, 8863.468191908378, 8844.204021638083, 8882.06738292483, 8919.821603567892, 8982.955085224663, 9079.319051071065, 6710.295418980937, 6795.0, 6809.114815074107, 6833.829154271084, 6911.101556797685, 1835.9265629374675, 1843.3732530939544, 1847.5658220318214, 1848.3253612431365, 1859.4421673498166, 896.9641214351483, 920.3879420185635, 967.1054274795927, 985.2118305355687, 1051.0960573906434, 17656.735148972777, 21262.681059784114, 22245.44386390321, 22727.545449091256, 22851.542969140857, 819.9262066414051, 964.5755867418313, 969.3553786731744, 1023.4180368709517, 1046.2414749306693, 11322.37726925027, 11885.16803823724, 11934.35854683676, 11936.104792140624, 12075.637730868088, 557577.0, 586875.0, 625111.0, 635028.8248558728, 636685.0, 118492.0, 122453.0, 127115.0, 128555.71444285437, 130098.69901301056, 965.9275554333453, 983.8868530118984, 1010.141379827141, 1014.5789497358661, 1020.5101551255291, 19477.415677529698, 20082.994984475667, 20193.293234737303, 20219.191232351128, 20250.68370555909, 58793.412065880504, 59364.70317648384, 59796.40203598082, 60581.39418605757, 60947.69526152341, 84007.0, 87096.12903870881, 87695.0, 88363.0, 88747.55626221828, 8156.9184308156155, 8173.836523269621, 8234.176582341957, 8403.537805420761, 8422.0, 11480.425978700865, 12962.611121665988, 13063.869361306646, 13278.468861245829, 13325.533606323732, 9096.226820720312, 11001.00990910822, 11023.61417350389, 11453.312801231952, 11462.598809041643, 11020.669379918616, 11215.271007384494, 11413.543458261576, 11426.371549564521, 11511.53953841837, 11158.218924675195, 11282.0, 11372.37451940118, 11590.188686791844, 11751.882481175078, 6339.0, 7055.400290975324, 7455.105387353552, 7464.701411943679, 8480.0, 7672.309492145734, 10977.0, 11249.775004500028, 11385.259958102697, 11552.6534203974], "value": 9919.921015458785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.6592817723747, 1516.5374560758964, 1524.5959820647524, 1691.255847427132, 1773.2109211400932, 8197.508149511033, 8471.534065626389, 8673.17604827542, 9284.58219380127, 9310.255179585634, 8081.636326365313, 8324.83350332993, 8987.10128987101, 9135.497547634877, 9137.588808503617, 2417.7098748150247, 2440.0849681369486, 2444.804415646744, 2445.877706114696, 2448.155386391701, 2407.0251548123038, 2428.5264373447185, 2442.3405680466262, 2443.022790883652, 2451.6322551617222, 2040.6632905570636, 2425.9393515162087, 2439.012200058979, 2444.303373538542, 2454.214651311581, 1873.681474149398, 2395.209580838319, 2400.4838959623676, 2400.5078958813488, 2425.4057755849753, 2406.097713357491, 2409.481961378312, 2412.541617092747, 2417.129833260025, 2425.2360506440414, 9159.816803663889, 9189.172974432333, 9217.723468295962, 9247.474166762477, 9289.767755806091, 5324.787008519694, 5468.589855760833, 5506.972465137648, 5510.972445137789, 5516.365617953947, 3477.634848340913, 3509.438489841613, 3517.2789578136676, 3542.4332106863035, 3572.5712914450173, 979.9755006124833, 991.8958509356486, 999.3254553176577, 1015.8425444056184, 1026.5996261458038, 11990.400479975966, 12016.279023258545, 12172.026237901035, 12189.878101218963, 12204.572839950648, 4796.544328288807, 4846.442659094178, 4881.243407271879, 4929.0881186979805, 4991.725455099931, 10241.74395640115, 10301.433421161908, 10320.535575899103, 10340.017698318648, 10348.689539313833, 5385.542228910508, 5447.155690867842, 5468.48049435303, 5474.315710536183, 5487.039768040577, 4454.331850222493, 4610.40064791575, 4822.300766388854, 4949.406071271471, 4973.751312434364, 4008.478897743333, 4052.0477687743355, 4127.463429754112, 4146.792660366969, 4187.5184353799095, 1319.300770591588, 1319.3139567424885, 1326.1380102932978, 1330.5010621017118, 1337.4886378392548, 803.7990502374406, 911.1981456318398, 912.3203213605906, 930.5533343994921, 939.056248470283, 5938.524918006549, 6097.390260973867, 6143.723532441051, 6155.876882462326, 6200.0699895015205, 395.9049828041249, 436.2300539547701, 439.69221544918685, 443.5786003296881, 461.6768262216395, 4028.5165780106577, 4078.571749966211, 4089.6319331259733, 4117.835286588503, 4122.216778812016, 10810.18923580719, 11016.449177541092, 11072.501737421835, 11119.499622517005, 11134.33194008362, 10959.232853700323, 11045.502952367162, 11066.28069175501, 11074.667759967213, 11081.889181108247, 7424.071991001125, 7524.2851929066655, 8153.959230203811, 8247.546384948886, 8274.793130171673, 4935.777889995031, 5839.883202336015, 5870.4604272949655, 6061.969690151521, 6067.24159480065, 10088.0, 10160.745981350525, 10277.383356998604, 10291.639792607222, 10306.587736490756, 8697.652093916173, 10144.239182061227, 10328.638497652546, 10390.844137338097, 10570.682879513626, 6305.432511074026, 7050.717971281297, 7255.056842610426, 7499.400047996256, 7684.615769211406, 7382.6677799498075, 8545.017323007934, 8693.30453563726, 8698.91301086981, 8702.303815694855, 7664.846703066019, 7718.961405192938, 7749.380049596131, 7820.374370050268, 7868.291853732962, 7418.072740907387, 7563.0, 7584.317411432998, 7653.043369578802, 7670.348020418104, 7032.683529241094, 7162.462815288978, 7166.641667916479, 7169.820754481179, 7175.138983321826, 4510.977445112885, 5001.67489113221, 5081.212412075986, 5177.326947496801, 5337.092694241911, 5021.774020169174, 5063.721495317793, 5135.35808023997, 5143.151380022255, 5161.509656582619], "value": 4559.797187357092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.24405444483216, 280.1944409821762, 311.54669955215167, 313.24507935874544, 325.0395082531121, 4775.47469778325, 5753.798617048405, 5786.971065144674, 5876.32729544035, 5899.026660601006, 4712.3638308828295, 4768.880777980552, 4978.0, 5511.311086114226, 5647.887042259153, 3832.329342365082, 4380.452443444569, 4383.430154079965, 4395.780210989437, 4411.514733379326, 3770.0386401467586, 3865.5747867734526, 4260.67793052787, 4373.387725718402, 4389.692721509496, 3571.3750093733493, 3708.0903334782474, 4216.283231850577, 4239.47006624172, 4240.97879510602, 3393.9660603393895, 4201.416129080624, 4254.4469219001485, 4278.550752171009, 4302.892427689301, 3318.767686261963, 3439.7616857931125, 3675.099600597844, 3682.39240525313, 3685.8894233173046, 4725.480197178307, 5042.890564075898, 5361.5978801589645, 5506.339239291271, 5559.777608895639, 4491.25894227452, 4803.3995750531185, 4825.372701548811, 4875.34182885313, 4879.170541008001, 4878.97541516282, 4946.455889852114, 5295.761690723926, 5879.059350503899, 5947.762089516415, 3789.8587298176717, 3967.4247234150885, 3982.4623675803687, 4002.419649150857, 4010.8796736097966, 5236.978789136082, 5526.751296191681, 6014.75940962361, 6327.3988971047675, 6397.776077837253, 3332.3002169544184, 3385.7968521888765, 3390.8643654254047, 3487.5466189395215, 4085.571015043437, 3627.709783217389, 3818.522684664417, 4134.235166494208, 4153.937690934638, 4167.5207351154395, 4647.512011238839, 4853.538913803183, 4872.269159626014, 4900.632452566, 4915.705057696549, 6069.393060693896, 6082.75668973245, 6090.386047697275, 6098.786542470993, 6141.96929015361, 1147.6499667601295, 1178.505027888289, 1250.5060501102014, 1334.873187047229, 1419.32582023538, 737.9668464150126, 750.7785203365021, 777.4713195027435, 825.529448214512, 847.7918965474174, 4284.421603083606, 4645.5610804328, 4785.856424307276, 4861.95138048615, 4867.002264535761, 5307.867303317371, 5320.52115309624, 5321.8935621287355, 5329.440408757102, 5331.0, 4040.757554546678, 4236.051416348452, 4324.740515569076, 4636.44362676481, 4820.927686084711, 2881.841498717549, 2971.0, 3297.571315728988, 3306.8591335989045, 3307.570015897966, 5821.388754180834, 6354.2811469676735, 6484.0, 6515.609063456208, 6524.217093948757, 5503.11950087984, 6344.510519214414, 6348.968255158695, 6417.294097649255, 6431.710573024132, 5702.659874929388, 5732.283464566929, 5878.618524646705, 5986.246326689685, 6537.5096867734155, 5432.185172224198, 5551.833444996657, 5634.23937768396, 5721.91283656104, 6181.660008699565, 5916.970415147896, 6144.600600960924, 6153.2000839890525, 6158.630482171084, 6169.051806843713, 5975.880482390415, 6466.612003279818, 6501.609903405811, 6524.9673751630935, 6566.409023187936, 3675.4486826976167, 3710.4972486143156, 3973.8807835764974, 4015.678745700395, 4042.4138499916758, 5194.091034069098, 5889.440503152194, 6219.595726277777, 6220.409061139185, 6230.7507699691505, 5782.595218334676, 5828.883422331614, 5960.97326908853, 5992.490638295793, 6064.545159112996, 6074.939250607437, 6082.756689732361, 6086.573939824169, 6096.756129754937, 6119.877602448015, 5571.860703482445, 5779.075347944308, 5790.420957904176, 5850.327212370632, 5937.435943585352, 5739.483446489836, 6012.939870601238, 6044.516438684806, 6062.696865156813, 6087.878242435215, 5138.332016837787, 5554.361248456317, 5726.936089192262, 5810.593258471867, 5972.402759724167], "value": 4226.610401020719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.1641928201855, 736.9742059027932, 764.2853931573978, 780.4926797581571, 819.0539926385026, 10078.496075196239, 13772.931135344334, 14887.627809304759, 15224.705899998513, 16418.425355112573, 14167.008309418345, 14252.859771218304, 14255.71488570228, 14289.71420571588, 14292.571222863306, 819.6885183630212, 833.5582141465003, 864.2481041493909, 870.229846585773, 878.6309749905055, 859.3125499600326, 862.0086900064913, 865.4893612768466, 869.647792643977, 870.6734974384606, 900.3517467423477, 912.8539433690611, 912.9041450647686, 915.789368445258, 920.8112336970905, 893.4415990006246, 898.3352319283748, 902.6795487601905, 910.9772255693628, 916.8441364967971, 636.6212103798233, 677.989830152548, 679.2596070283365, 682.7269092363044, 687.2749249541731, 15068.0, 15322.693546129016, 15322.770158447633, 15334.003289786127, 15337.846621533865, 11687.357195354338, 12850.0, 14486.20325882076, 14632.048916820373, 14732.926335368362, 11604.477798499087, 11705.517189798378, 11909.761804763857, 11995.340256285901, 12241.143119981605, 3718.9442158367374, 3867.2265546890735, 3890.7860067696265, 3974.066094467798, 4001.659858911996, 115253.0, 115537.84462155355, 115743.0, 116893.83106168914, 122773.0, 11175.776484470265, 11302.43487825622, 11535.36555489456, 11568.76862462746, 11659.008984236434, 21239.68140477894, 22026.88986555089, 23606.055757769496, 23855.165069222494, 23901.282961511184, 6833.769921414094, 7643.923560764321, 7807.414443916729, 8285.047219569706, 8440.493570385674, 4324.675649326313, 4363.410939523187, 4373.1472362888935, 4488.887777805581, 4674.0, 3621.5292012038267, 3751.6998640108727, 3771.7548359356556, 3775.0, 3788.9201577550816, 666.1972323350351, 675.7195763757985, 675.9662016899135, 676.9323067693191, 677.6679427080794, 549.6895638074923, 556.4241010554057, 602.9698515074228, 668.1247565688963, 686.2417029182682, 9285.117913798178, 9313.44119352841, 9417.434953902788, 9476.715698529055, 9689.0, 555.9457803416337, 560.3555910702725, 560.5879678436346, 600.8107446154447, 649.7985624456339, 4250.192463431938, 4668.95331046692, 4700.036492519025, 4705.449043381305, 4821.328130055424, 94199.0, 105636.0, 111858.0, 154023.0, 158161.0, 108468.8306233871, 133778.0, 134033.0, 136087.63912360946, 140203.29898350648, 101049.49475252577, 103773.0, 111639.88360116295, 111998.0, 115128.84871151182, 8083.191680832105, 8613.569321534023, 9042.638294468148, 9818.950905245714, 10154.847677284699, 50042.74978625084, 58232.708836455546, 59759.0, 60241.0, 62066.0, 53983.19025214703, 61093.0, 68180.6590967042, 74211.0, 92391.53804230936, 12731.363431828557, 12987.350632468528, 13245.139065960682, 13322.800157997444, 13332.400041998328, 14201.076929999517, 14314.785278221043, 14626.0, 14771.94625123276, 14934.77597836055, 13766.31168441554, 14051.297435128407, 14506.984511084123, 14604.707905841611, 14685.192314422382, 12660.683482913, 12827.358632068173, 12888.742225155633, 13387.800761079203, 13478.663033424244, 12510.249385036926, 13444.529441469502, 13578.388972496065, 13905.235212063433, 14041.929790350983, 11092.500837462172, 11259.437028148395, 11285.347943233497, 11304.265222760494, 12059.311696362693, 10521.368717876645, 11625.360605166798, 11626.88373116258, 11797.646070617895, 11825.526978920747], "value": 7758.976948243087, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 119.0, 118.0, 121.0, 118.0, 118.0, 119.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 111.0, 147.0, 113.0, 115.0, 112.0, 114.0, 124.0, 142.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [245.0, 223.0, 202.0, 199.0, 201.0, 204.0, 201.0, 197.0, 201.0, 198.0], "value": 207.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 57.0, 61.0, 89.0, 60.0, 59.0, 59.0, 60.0, 82.0, 60.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 91.0, 70.0, 73.0, 71.0, 85.0, 71.0, 73.0, 86.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 92.0, 89.0, 75.0, 138.0, 133.0, 89.0, 86.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 96.0, 96.0, 96.0, 95.0, 97.0, 153.0, 96.0, 94.0, 95.0], "value": 104.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 91.0, 108.0, 90.0, 145.0, 143.0, 113.0, 96.0, 92.0], "value": 117.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 57.0, 60.0, 59.0, 71.0, 84.0, 95.0, 93.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 67.0, 83.0, 76.0, 73.0, 68.0, 85.0, 73.0, 70.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 87.0, 89.0, 104.0, 107.0, 83.0, 82.0, 80.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 166.0, 130.0, 150.0, 150.0, 160.0, 161.0, 154.0, 196.0, 163.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 169.0, 216.0, 173.0, 232.0, 153.0, 229.0, 221.0, 171.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 68.0, 69.0, 73.0, 78.0, 84.0, 87.0, 93.0], "value": 75.7, "unit": "score"}]}]} 18:30:07 INFO - Return code: 0 18:30:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:07 ERROR - # TBPL SUCCESS # 18:30:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:30:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:30:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:30:07 INFO - 2016-10-03 18:30:07.217 screenresolution[1661:10634] starting screenresolution argv=screenresolution get 18:30:07 INFO - 2016-10-03 18:30:07.220 screenresolution[1661:10634] Display 0: 1600x1200x32@60 18:30:07 INFO - 2016-10-03 18:30:07.226 screenresolution[1662:10637] starting screenresolution argv=screenresolution list 18:30:07 INFO - Available Modes on Display 0 18:30:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:30:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:30:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:30:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:30:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:30:07 INFO - Intel Iris: 18:30:07 INFO - Chipset Model: Intel Iris 18:30:07 INFO - Type: GPU 18:30:07 INFO - Bus: Built-In 18:30:07 INFO - VRAM (Dynamic, Max): 1536 MB 18:30:07 INFO - Vendor: Intel (0x8086) 18:30:07 INFO - Device ID: 0x0a2e 18:30:07 INFO - Revision ID: 0x0009 18:30:07 INFO - Displays: 18:30:07 INFO - Display: 18:30:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:30:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:30:07 INFO - Display Serial Number: 1600x1200 60 18:30:07 INFO - Main Display: Yes 18:30:07 INFO - Mirror: Off 18:30:07 INFO - Online: Yes 18:30:07 INFO - Rotation: Supported 18:30:07 INFO - Return code: 0 18:30:07 INFO - Running post-action listener: _resource_record_post_action 18:30:07 INFO - [mozharness: 2016-10-04 01:30:07.467950Z] Finished run-tests step (success) 18:30:07 INFO - Running post-run listener: _resource_record_post_run 18:30:07 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37340160; Write bytes: 665841664; Read time: 237; Write time: 1934 18:30:07 INFO - TinderboxPrint: CPU usage
54.3% 18:30:07 INFO - TinderboxPrint: I/O read bytes / time
37,340,160 / 237 18:30:07 INFO - TinderboxPrint: I/O write bytes / time
665,841,664 / 1,934 18:30:07 INFO - TinderboxPrint: CPU idle
2,209.3 (45.7%) 18:30:07 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 18:30:07 INFO - TinderboxPrint: CPU user
1,646.8 (34.1%) 18:30:07 INFO - TinderboxPrint: Swap in / out
400,293,888 / 0 18:30:07 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362322432; Write bytes: 357427200; Read time: 27704; Write time: 728 18:30:07 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34452480; Write bytes: 298010624; Read time: 215; Write time: 1170 18:30:07 INFO - Running post-run listener: _upload_blobber_files 18:30:07 INFO - Blob upload gear active. 18:30:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:07 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 18:30:07 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'] 18:30:07 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 18:30:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:09 INFO - (blobuploader) - INFO - Done attempting. 18:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:10 INFO - (blobuploader) - INFO - Done attempting. 18:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:12 INFO - (blobuploader) - INFO - Done attempting. 18:30:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:12 INFO - Return code: 0 18:30:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6aefafe90af0df6182fbe3181d36189dff196fd54768148489e64dc1e128698ded60ebeb7655482726bef87f7debd1734dc0ae29afc83f8c529b7120631a724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46da2b100a209ce05248f6281d474b6fe3932e648377fe988bd11ec5fe30bbaa1ea47202e09cae94fba2c55aff763c07a372058b276ec740248704c80b9eb602", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbe5f320a0cd6c795398b4d077627ac651e2c645610b24b9bc1f2851e8805ea513194715ebed3d092916e6ed8c1c7978ec5eb0c5db1b7a9dda528b1a6e2ec51"} 18:30:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:12 INFO - Contents: 18:30:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6aefafe90af0df6182fbe3181d36189dff196fd54768148489e64dc1e128698ded60ebeb7655482726bef87f7debd1734dc0ae29afc83f8c529b7120631a724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46da2b100a209ce05248f6281d474b6fe3932e648377fe988bd11ec5fe30bbaa1ea47202e09cae94fba2c55aff763c07a372058b276ec740248704c80b9eb602", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbe5f320a0cd6c795398b4d077627ac651e2c645610b24b9bc1f2851e8805ea513194715ebed3d092916e6ed8c1c7978ec5eb0c5db1b7a9dda528b1a6e2ec51"} 18:30:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:12 INFO - Copying logs to upload dir... 18:30:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.188223 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-03 18:30:12.917613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:12.921432) ========= 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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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/d6aefafe90af0df6182fbe3181d36189dff196fd54768148489e64dc1e128698ded60ebeb7655482726bef87f7debd1734dc0ae29afc83f8c529b7120631a724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46da2b100a209ce05248f6281d474b6fe3932e648377fe988bd11ec5fe30bbaa1ea47202e09cae94fba2c55aff763c07a372058b276ec740248704c80b9eb602", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbe5f320a0cd6c795398b4d077627ac651e2c645610b24b9bc1f2851e8805ea513194715ebed3d092916e6ed8c1c7978ec5eb0c5db1b7a9dda528b1a6e2ec51"} build_url:https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010836 build_url: 'https://queue.taskcluster.net/v1/task/JBnh1TmYQLmWjqdDlRAGHA/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/d6aefafe90af0df6182fbe3181d36189dff196fd54768148489e64dc1e128698ded60ebeb7655482726bef87f7debd1734dc0ae29afc83f8c529b7120631a724", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46da2b100a209ce05248f6281d474b6fe3932e648377fe988bd11ec5fe30bbaa1ea47202e09cae94fba2c55aff763c07a372058b276ec740248704c80b9eb602", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dbe5f320a0cd6c795398b4d077627ac651e2c645610b24b9bc1f2851e8805ea513194715ebed3d092916e6ed8c1c7978ec5eb0c5db1b7a9dda528b1a6e2ec51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:12.953309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:12.953641) ========= 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.JlDhwMIMCH/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.6BRYF6E1cc/Listeners TMPDIR=/var/folders/dv/frhyy9rn3p3fbk6y0hr9dblm00000w/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.005259 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 18:30:13.001774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 18:30:13.002118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 18:30:13.002442) ========= ========= Total master_lag: 0.18 =========