builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1482038013.55 results: success (0) buildid: 20161217201335 builduid: 5254cd2c71bc4d61b517aa2f5eab8c91 revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:33.548618) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:33.549056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:33.549366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:33.584114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:33.584421) ========= 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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-12-17 21:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.6M=0.001s 2016-12-17 21:13:34 (10.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.662584 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:34.272419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:34.272784) ========= 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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.019929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:34.326260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:34.326614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L9hCjDEyuX/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.XDA4ITfW4D/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-12-17 21:13:34,397 truncating revision to first 12 chars 2016-12-17 21:13:34,397 Setting DEBUG logging. 2016-12-17 21:13:34,398 attempt 1/10 2016-12-17 21:13:34,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3ce1fce4f15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 21:13:35,079 unpacking tar archive at: mozilla-central-a3ce1fce4f15/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922412 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:35.272870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:35.273256) ========= script_repo_revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:35.273700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:35.274024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:13:35.294031) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-17 21:13:35.294352) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L9hCjDEyuX/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.XDA4ITfW4D/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:13:35 INFO - MultiFileLogger online at 20161217 21:13:35 in /builds/slave/test 21:13:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:13:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:13:35 INFO - {'append_to_log': False, 21:13:35 INFO - 'base_work_dir': '/builds/slave/test', 21:13:35 INFO - 'blob_upload_branch': 'Firefox', 21:13:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:13:35 INFO - 'branch': 'Firefox', 21:13:35 INFO - 'buildbot_json_path': 'buildprops.json', 21:13:35 INFO - 'config_files': ('talos/mac_config.py',), 21:13:35 INFO - 'default_actions': ('clobber', 21:13:35 INFO - 'read-buildbot-config', 21:13:35 INFO - 'download-and-extract', 21:13:35 INFO - 'populate-webroot', 21:13:35 INFO - 'create-virtualenv', 21:13:35 INFO - 'install', 21:13:35 INFO - 'run-tests'), 21:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:13:35 INFO - 'download_minidump_stackwalk': True, 21:13:35 INFO - 'download_symbols': 'ondemand', 21:13:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:13:35 INFO - 'tooltool.py': '/tools/tooltool.py', 21:13:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:13:35 INFO - '/tools/misc-python/virtualenv.py')}, 21:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:13:35 INFO - 'installer_path': 'installer.exe', 21:13:35 INFO - 'log_level': 'info', 21:13:35 INFO - 'log_name': 'talos', 21:13:35 INFO - 'log_to_console': True, 21:13:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:13:35 INFO - 'opt_config_files': (), 21:13:35 INFO - 'pip_index': False, 21:13:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:35 INFO - 'cmd': ('bash', 21:13:35 INFO - '-c', 21:13:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:35 INFO - 'enabled': True, 21:13:35 INFO - 'halt_on_failure': False, 21:13:35 INFO - 'name': 'check_screen_resolution'},), 21:13:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:35 INFO - 'cmd': ('bash', 21:13:35 INFO - '-c', 21:13:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:35 INFO - 'enabled': True, 21:13:35 INFO - 'halt_on_failure': False, 21:13:35 INFO - 'name': 'check_screen_resolution'},), 21:13:35 INFO - 'run_cmd_checks_enabled': True, 21:13:35 INFO - 'sps_profile': False, 21:13:35 INFO - 'sps_profile_interval': 0, 21:13:35 INFO - 'suite': 'dromaeojs', 21:13:35 INFO - 'system_bits': '32', 21:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:13:35 INFO - 'title': 't-yosemite-r7-0102', 21:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:13:35 INFO - 'use_talos_json': True, 21:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:13:35 INFO - 'work_dir': 'build'} 21:13:35 INFO - [mozharness: 2016-12-18 05:13:35.495098Z] Running clobber step. 21:13:35 INFO - Running pre-action listener: _resource_record_pre_action 21:13:35 INFO - Running main action method: clobber 21:13:35 INFO - rmtree: /builds/slave/test/build 21:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:13:37 INFO - Running post-action listener: _resource_record_post_action 21:13:37 INFO - [mozharness: 2016-12-18 05:13:37.120718Z] Finished clobber step (success) 21:13:37 INFO - [mozharness: 2016-12-18 05:13:37.121044Z] Running read-buildbot-config step. 21:13:37 INFO - Running pre-action listener: _resource_record_pre_action 21:13:37 INFO - Running main action method: read_buildbot_config 21:13:37 INFO - Using buildbot properties: 21:13:37 INFO - { 21:13:37 INFO - "project": "", 21:13:37 INFO - "product": "firefox", 21:13:37 INFO - "script_repo_revision": "production", 21:13:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:13:37 INFO - "repository": "", 21:13:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:13:37 INFO - "buildid": "20161217201335", 21:13:37 INFO - "pgo_build": "False", 21:13:37 INFO - "basedir": "/builds/slave/test", 21:13:37 INFO - "buildnumber": 6, 21:13:37 INFO - "slavename": "t-yosemite-r7-0102", 21:13:37 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:13:37 INFO - "platform": "yosemite_r7", 21:13:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:13:37 INFO - "branch": "mozilla-central", 21:13:37 INFO - "repo_path": "mozilla-central", 21:13:37 INFO - "revision": "a3ce1fce4f15616f66ac328e4a562d0117c93a0d", 21:13:37 INFO - "stage_platform": "macosx64", 21:13:37 INFO - "builduid": "5254cd2c71bc4d61b517aa2f5eab8c91", 21:13:37 INFO - "slavebuilddir": "test" 21:13:37 INFO - } 21:13:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:13:37 INFO - Running post-action listener: _resource_record_post_action 21:13:37 INFO - [mozharness: 2016-12-18 05:13:37.126676Z] Finished read-buildbot-config step (success) 21:13:37 INFO - [mozharness: 2016-12-18 05:13:37.126855Z] Running download-and-extract step. 21:13:37 INFO - Running pre-action listener: _resource_record_pre_action 21:13:37 INFO - Running main action method: download_and_extract 21:13:37 INFO - mkdir: /builds/slave/test/build/tests 21:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:37 INFO - trying https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:13:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:13:37 INFO - Downloaded 1199 bytes. 21:13:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:13:37 INFO - Using the following test package requirements: 21:13:37 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:13:37 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:13:37 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:13:37 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'jsshell-mac.zip'], 21:13:37 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:13:37 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:13:37 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:13:37 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:13:37 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:13:37 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:13:37 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:13:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:13:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:13:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:13:37 INFO - Fetch https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:13:39 INFO - Expected file size: 16275180 21:13:39 INFO - Obtained file size: 16275180 21:13:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:13:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:13:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:13:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:13:46 INFO - Expected file size: 16275180 21:13:46 INFO - Obtained file size: 16275180 21:13:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:13:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:13:53 INFO - Fetch https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:13:54 INFO - Expected file size: 14409734 21:13:54 INFO - Obtained file size: 14409734 21:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:54 INFO - trying https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:13:54 INFO - Downloading https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:13:59 INFO - Downloaded 69568548 bytes. 21:13:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:13:59 INFO - mkdir: /builds/slave/test/properties 21:13:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:59 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:59 INFO - Contents: 21:13:59 INFO - build_url:https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:14:00 INFO - Running post-action listener: _resource_record_post_action 21:14:00 INFO - Running post-action listener: set_extra_try_arguments 21:14:00 INFO - [mozharness: 2016-12-18 05:14:00.112299Z] Finished download-and-extract step (success) 21:14:00 INFO - [mozharness: 2016-12-18 05:14:00.112425Z] Running populate-webroot step. 21:14:00 INFO - Running pre-action listener: _resource_record_pre_action 21:14:00 INFO - Running main action method: populate_webroot 21:14:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:14:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:14:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:14:00 INFO - '--tppagecycles', 21:14:00 INFO - '7'], 21:14:00 INFO - 'tests': ['tsvgm']}}, 21:14:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:14:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:14:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:14:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:14:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['damp', 'tps']}, 21:14:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'tests': ['damp', 'tps']}, 21:14:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['dromaeo_dom']}, 21:14:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:14:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['basic_compositor_video']}, 21:14:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:14:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['a11yr', 21:14:00 INFO - 'ts_paint', 21:14:00 INFO - 'tpaint', 21:14:00 INFO - 'sessionrestore', 21:14:00 INFO - 'sessionrestore_no_auto_restore', 21:14:00 INFO - 'tabpaint']}, 21:14:00 INFO - 'other-e10s': {'tests': ['a11yr', 21:14:00 INFO - 'ts_paint', 21:14:00 INFO - 'tpaint', 21:14:00 INFO - 'sessionrestore', 21:14:00 INFO - 'sessionrestore_no_auto_restore', 21:14:00 INFO - 'tabpaint']}, 21:14:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:14:00 INFO - 'ts_paint', 21:14:00 INFO - 'tpaint', 21:14:00 INFO - 'sessionrestore', 21:14:00 INFO - 'sessionrestore_no_auto_restore', 21:14:00 INFO - 'tabpaint']}, 21:14:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:14:00 INFO - 'ts_paint', 21:14:00 INFO - 'tpaint', 21:14:00 INFO - 'sessionrestore', 21:14:00 INFO - 'sessionrestore_no_auto_restore', 21:14:00 INFO - 'tabpaint']}, 21:14:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['a11yr', 21:14:00 INFO - 'ts_paint', 21:14:00 INFO - 'tpaint', 21:14:00 INFO - 'sessionrestore', 21:14:00 INFO - 'sessionrestore_no_auto_restore', 21:14:00 INFO - 'tabpaint']}, 21:14:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['a11yr', 21:14:00 INFO - 'ts_paint', 21:14:00 INFO - 'tpaint', 21:14:00 INFO - 'sessionrestore', 21:14:00 INFO - 'sessionrestore_no_auto_restore', 21:14:00 INFO - 'tabpaint']}, 21:14:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['tsvgx', 21:14:00 INFO - 'tsvgr_opacity', 21:14:00 INFO - 'tart', 21:14:00 INFO - 'tscrollx', 21:14:00 INFO - 'cart', 21:14:00 INFO - 'tsvg_static']}, 21:14:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:14:00 INFO - 'tsvgr_opacity', 21:14:00 INFO - 'tart', 21:14:00 INFO - 'tscrollx', 21:14:00 INFO - 'cart', 21:14:00 INFO - 'tsvg_static']}, 21:14:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'talos_options': ['--disable-e10s'], 21:14:00 INFO - 'tests': ['tp5o']}, 21:14:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:14:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'talos_options': ['--disable-e10s', 21:14:00 INFO - '--xperf_path', 21:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:00 INFO - 'tests': ['tp5n']}, 21:14:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:14:00 INFO - 'talos_options': ['--xperf_path', 21:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:00 INFO - 'tests': ['tp5n']}}, 21:14:00 INFO - 'talos.zip': {'path': '', 21:14:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:14:00 INFO - Running post-action listener: _resource_record_post_action 21:14:00 INFO - [mozharness: 2016-12-18 05:14:00.131048Z] Finished populate-webroot step (success) 21:14:00 INFO - [mozharness: 2016-12-18 05:14:00.131160Z] Running create-virtualenv step. 21:14:00 INFO - Running pre-action listener: _resource_record_pre_action 21:14:00 INFO - Running main action method: create_virtualenv 21:14:00 INFO - Creating virtualenv /builds/slave/test/build/venv 21:14:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:14:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:14:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:14:00 INFO - Using real prefix '/tools/python27' 21:14:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:14:00 INFO - Installing distribute.............................................................................................................................................................................................done. 21:14:03 INFO - Installing pip.................done. 21:14:03 INFO - Return code: 0 21:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:14:04 INFO - Reading from file tmpfile_stdout 21:14:04 INFO - Output received: 21:14:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:14:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:14:04 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')]} 21:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:04 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')]} 21:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:04 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:04 INFO - 'HOME': '/Users/cltbld', 21:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:04 INFO - 'LOGNAME': 'cltbld', 21:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:04 INFO - 'MOZ_NO_REMOTE': '1', 21:14:04 INFO - 'NO_EM_RESTART': '1', 21:14:04 INFO - 'PAGER': '/bin/cat', 21:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:04 INFO - 'PWD': '/builds/slave/test', 21:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:04 INFO - 'SHELL': '/bin/bash', 21:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:04 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:04 INFO - 'USER': 'cltbld', 21:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:04 INFO - 'XPC_FLAGS': '0x0', 21:14:04 INFO - 'XPC_SERVICE_NAME': '0', 21:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:14:04 INFO - Cleaning up... 21:14:04 INFO - Return code: 0 21:14:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:14:04 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')]} 21:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:04 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')]} 21:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:04 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:04 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 21:14:04 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 21:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:04 INFO - 'HOME': '/Users/cltbld', 21:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:04 INFO - 'LOGNAME': 'cltbld', 21:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:04 INFO - 'MOZ_NO_REMOTE': '1', 21:14:04 INFO - 'NO_EM_RESTART': '1', 21:14:04 INFO - 'PAGER': '/bin/cat', 21:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:04 INFO - 'PWD': '/builds/slave/test', 21:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:04 INFO - 'SHELL': '/bin/bash', 21:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:04 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:04 INFO - 'USER': 'cltbld', 21:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:04 INFO - 'XPC_FLAGS': '0x0', 21:14:04 INFO - 'XPC_SERVICE_NAME': '0', 21:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:04 INFO - Downloading/unpacking psutil>=3.1.1 21:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:08 INFO - Installing collected packages: psutil 21:14:08 INFO - Running setup.py install for psutil 21:14:08 INFO - building 'psutil._psutil_osx' extension 21:14:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:14:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:14:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:14:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:14:09 INFO - building 'psutil._psutil_posix' extension 21:14:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:14:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:14:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:14:09 INFO - ^ 21:14:09 INFO - 1 warning generated. 21:14:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:14:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:09 INFO - Successfully installed psutil 21:14:09 INFO - Cleaning up... 21:14:09 INFO - Return code: 0 21:14:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:09 INFO - 'HOME': '/Users/cltbld', 21:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:09 INFO - 'LOGNAME': 'cltbld', 21:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:09 INFO - 'MOZ_NO_REMOTE': '1', 21:14:09 INFO - 'NO_EM_RESTART': '1', 21:14:09 INFO - 'PAGER': '/bin/cat', 21:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:09 INFO - 'PWD': '/builds/slave/test', 21:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:09 INFO - 'SHELL': '/bin/bash', 21:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:09 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:09 INFO - 'USER': 'cltbld', 21:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:09 INFO - 'XPC_FLAGS': '0x0', 21:14:09 INFO - 'XPC_SERVICE_NAME': '0', 21:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:14:12 INFO - Installing collected packages: mozsystemmonitor 21:14:12 INFO - Running setup.py install for mozsystemmonitor 21:14:12 INFO - Successfully installed mozsystemmonitor 21:14:12 INFO - Cleaning up... 21:14:12 INFO - Return code: 0 21:14:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:12 INFO - 'HOME': '/Users/cltbld', 21:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:12 INFO - 'LOGNAME': 'cltbld', 21:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:12 INFO - 'MOZ_NO_REMOTE': '1', 21:14:12 INFO - 'NO_EM_RESTART': '1', 21:14:12 INFO - 'PAGER': '/bin/cat', 21:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:12 INFO - 'PWD': '/builds/slave/test', 21:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:12 INFO - 'SHELL': '/bin/bash', 21:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:12 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:12 INFO - 'USER': 'cltbld', 21:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:12 INFO - 'XPC_FLAGS': '0x0', 21:14:12 INFO - 'XPC_SERVICE_NAME': '0', 21:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:12 INFO - Downloading/unpacking jsonschema==2.5.1 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:15 INFO - warning: no files found matching '*.txt' 21:14:15 INFO - no previously-included directories found matching 'build' 21:14:15 INFO - no previously-included directories found matching 'dist' 21:14:15 INFO - no previously-included directories found matching '.git*' 21:14:15 INFO - Installing collected packages: jsonschema, functools32 21:14:15 INFO - Running setup.py install for functools32 21:14:16 INFO - warning: no files found matching '*.txt' 21:14:16 INFO - no previously-included directories found matching 'build' 21:14:16 INFO - no previously-included directories found matching 'dist' 21:14:16 INFO - no previously-included directories found matching '.git*' 21:14:16 INFO - Successfully installed jsonschema functools32 21:14:16 INFO - Cleaning up... 21:14:16 INFO - Return code: 0 21:14:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:16 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:16 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 21:14:16 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 21:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:16 INFO - 'HOME': '/Users/cltbld', 21:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:16 INFO - 'LOGNAME': 'cltbld', 21:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:16 INFO - 'MOZ_NO_REMOTE': '1', 21:14:16 INFO - 'NO_EM_RESTART': '1', 21:14:16 INFO - 'PAGER': '/bin/cat', 21:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:16 INFO - 'PWD': '/builds/slave/test', 21:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:16 INFO - 'SHELL': '/bin/bash', 21:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:16 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:16 INFO - 'USER': 'cltbld', 21:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:16 INFO - 'XPC_FLAGS': '0x0', 21:14:16 INFO - 'XPC_SERVICE_NAME': '0', 21:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:14:16 INFO - Cleaning up... 21:14:16 INFO - Return code: 0 21:14:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:16 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:16 INFO - 'HOME': '/Users/cltbld', 21:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:16 INFO - 'LOGNAME': 'cltbld', 21:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:16 INFO - 'MOZ_NO_REMOTE': '1', 21:14:16 INFO - 'NO_EM_RESTART': '1', 21:14:16 INFO - 'PAGER': '/bin/cat', 21:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:16 INFO - 'PWD': '/builds/slave/test', 21:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:16 INFO - 'SHELL': '/bin/bash', 21:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:16 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:16 INFO - 'USER': 'cltbld', 21:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:16 INFO - 'XPC_FLAGS': '0x0', 21:14:16 INFO - 'XPC_SERVICE_NAME': '0', 21:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:16 INFO - Downloading/unpacking blobuploader==1.2.4 21:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:19 INFO - Downloading blobuploader-1.2.4.tar.gz 21:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:14:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:14:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:20 INFO - Downloading docopt-0.6.1.tar.gz 21:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:14:20 INFO - Installing collected packages: blobuploader, requests, docopt 21:14:20 INFO - Running setup.py install for blobuploader 21:14:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:14:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:14:20 INFO - Running setup.py install for requests 21:14:21 INFO - Running setup.py install for docopt 21:14:21 INFO - Successfully installed blobuploader requests docopt 21:14:21 INFO - Cleaning up... 21:14:21 INFO - Return code: 0 21:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:21 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:21 INFO - 'HOME': '/Users/cltbld', 21:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:21 INFO - 'LOGNAME': 'cltbld', 21:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:21 INFO - 'MOZ_NO_REMOTE': '1', 21:14:21 INFO - 'NO_EM_RESTART': '1', 21:14:21 INFO - 'PAGER': '/bin/cat', 21:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:21 INFO - 'PWD': '/builds/slave/test', 21:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:21 INFO - 'SHELL': '/bin/bash', 21:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:21 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:21 INFO - 'USER': 'cltbld', 21:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:21 INFO - 'XPC_FLAGS': '0x0', 21:14:21 INFO - 'XPC_SERVICE_NAME': '0', 21:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:21 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vCiXM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:21 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-uy7yDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:21 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-088EHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:21 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-txS_us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gej43z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Xs6v1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-sKogmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Vmrm3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-whGDYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VhP4q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ang8TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-CfxhKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tIkVNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-obgP_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-idQo3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Czwcdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-l1W7Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:14:23 INFO - Running setup.py install for manifestparser 21:14:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:14:23 INFO - Running setup.py install for mozcrash 21:14:23 INFO - Running setup.py install for mozdebug 21:14:23 INFO - Running setup.py install for mozdevice 21:14:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Running setup.py install for mozfile 21:14:24 INFO - Running setup.py install for mozhttpd 21:14:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Running setup.py install for mozinfo 21:14:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Running setup.py install for mozInstall 21:14:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Running setup.py install for mozleak 21:14:24 INFO - Running setup.py install for mozlog 21:14:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:14:24 INFO - Running setup.py install for moznetwork 21:14:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:14:25 INFO - Running setup.py install for mozprocess 21:14:25 INFO - Running setup.py install for mozprofile 21:14:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:14:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:14:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:14:25 INFO - Running setup.py install for mozrunner 21:14:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:14:25 INFO - Running setup.py install for mozscreenshot 21:14:25 INFO - Running setup.py install for moztest 21:14:25 INFO - Running setup.py install for mozversion 21:14:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:14:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:14:26 INFO - Cleaning up... 21:14:26 INFO - Return code: 0 21:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:26 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:26 INFO - 'HOME': '/Users/cltbld', 21:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:26 INFO - 'LOGNAME': 'cltbld', 21:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:26 INFO - 'MOZ_NO_REMOTE': '1', 21:14:26 INFO - 'NO_EM_RESTART': '1', 21:14:26 INFO - 'PAGER': '/bin/cat', 21:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:26 INFO - 'PWD': '/builds/slave/test', 21:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:26 INFO - 'SHELL': '/bin/bash', 21:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:26 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:26 INFO - 'USER': 'cltbld', 21:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:26 INFO - 'XPC_FLAGS': '0x0', 21:14:26 INFO - 'XPC_SERVICE_NAME': '0', 21:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ioMilI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-HrNQej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-8BbfLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JJu4Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-CGW2hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PTSkOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:26 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-0Oi7Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-pomIvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Z6oeUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VYwheq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:27 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)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JeRn5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-otcmOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:27 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)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-RL9NJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vFZRJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6SfxXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-3yDvhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-HlhEuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:14:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:14:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:14:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:30 INFO - Downloading blessings-1.6.tar.gz 21:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:14:30 INFO - Installing collected packages: blessings 21:14:30 INFO - Running setup.py install for blessings 21:14:30 INFO - Successfully installed blessings 21:14:30 INFO - Cleaning up... 21:14:31 INFO - Return code: 0 21:14:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:31 INFO - Reading from file tmpfile_stdout 21:14:31 INFO - Current package versions: 21:14:31 INFO - blessings == 1.6 21:14:31 INFO - blobuploader == 1.2.4 21:14:31 INFO - docopt == 0.6.1 21:14:31 INFO - functools32 == 3.2.3-2 21:14:31 INFO - jsonschema == 2.5.1 21:14:31 INFO - manifestparser == 1.1 21:14:31 INFO - mozInstall == 1.12 21:14:31 INFO - mozcrash == 1.0 21:14:31 INFO - mozdebug == 0.1 21:14:31 INFO - mozdevice == 0.49 21:14:31 INFO - mozfile == 1.2 21:14:31 INFO - mozhttpd == 0.7 21:14:31 INFO - mozinfo == 0.9 21:14:31 INFO - mozleak == 0.1 21:14:31 INFO - mozlog == 3.4 21:14:31 INFO - moznetwork == 0.27 21:14:31 INFO - mozprocess == 0.23 21:14:31 INFO - mozprofile == 0.28 21:14:31 INFO - mozrunner == 6.13 21:14:31 INFO - mozscreenshot == 0.1 21:14:31 INFO - mozsystemmonitor == 0.3 21:14:31 INFO - moztest == 0.7 21:14:31 INFO - mozversion == 1.4 21:14:31 INFO - psutil == 3.1.1 21:14:31 INFO - requests == 1.2.3 21:14:31 INFO - wsgiref == 0.1.2 21:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:31 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 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:31 INFO - 'HOME': '/Users/cltbld', 21:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:31 INFO - 'LOGNAME': 'cltbld', 21:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:31 INFO - 'MOZ_NO_REMOTE': '1', 21:14:31 INFO - 'NO_EM_RESTART': '1', 21:14:31 INFO - 'PAGER': '/bin/cat', 21:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:31 INFO - 'PWD': '/builds/slave/test', 21:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:31 INFO - 'SHELL': '/bin/bash', 21:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:31 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:31 INFO - 'USER': 'cltbld', 21:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:31 INFO - 'XPC_FLAGS': '0x0', 21:14:31 INFO - 'XPC_SERVICE_NAME': '0', 21:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:14:31 INFO - Cleaning up... 21:14:31 INFO - Return code: 0 21:14:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103804b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103807768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb73dcbe30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, '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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:31 INFO - 'HOME': '/Users/cltbld', 21:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:31 INFO - 'LOGNAME': 'cltbld', 21:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:31 INFO - 'MOZ_NO_REMOTE': '1', 21:14:31 INFO - 'NO_EM_RESTART': '1', 21:14:31 INFO - 'PAGER': '/bin/cat', 21:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:31 INFO - 'PWD': '/builds/slave/test', 21:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:31 INFO - 'SHELL': '/bin/bash', 21:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:31 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:31 INFO - 'USER': 'cltbld', 21:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:31 INFO - 'XPC_FLAGS': '0x0', 21:14:31 INFO - 'XPC_SERVICE_NAME': '0', 21:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:14:31 INFO - Cleaning up... 21:14:31 INFO - Return code: 0 21:14:31 INFO - Running post-action listener: _resource_record_post_action 21:14:31 INFO - Running post-action listener: _start_resource_monitoring 21:14:31 INFO - Starting resource monitoring. 21:14:31 INFO - [mozharness: 2016-12-18 05:14:31.871986Z] Finished create-virtualenv step (success) 21:14:31 INFO - [mozharness: 2016-12-18 05:14:31.872960Z] Running install step. 21:14:31 INFO - Running pre-action listener: _resource_record_pre_action 21:14:31 INFO - Running main action method: install 21:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:32 INFO - Reading from file tmpfile_stdout 21:14:32 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:32 INFO - Reading from file tmpfile_stdout 21:14:32 INFO - Output received: 21:14:32 INFO - Usage: mozinstall [options] installer 21:14:32 INFO - Options: 21:14:32 INFO - -h, --help show this help message and exit 21:14:32 INFO - -d DEST, --destination=DEST 21:14:32 INFO - Directory to install application into. [default: 21:14:32 INFO - "/builds/slave/test"] 21:14:32 INFO - --app=APP Application being installed. [default: firefox] 21:14:32 INFO - mkdir: /builds/slave/test/build/application 21:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:14:54 INFO - Reading from file tmpfile_stdout 21:14:54 INFO - Output received: 21:14:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:14:54 INFO - Running post-action listener: _resource_record_post_action 21:14:54 INFO - [mozharness: 2016-12-18 05:14:54.071716Z] Finished install step (success) 21:14:54 INFO - [mozharness: 2016-12-18 05:14:54.071839Z] Running run-tests step. 21:14:54 INFO - Running pre-action listener: _resource_record_pre_action 21:14:54 INFO - Running main action method: run_tests 21:14:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:54 INFO - 2016-12-17 21:14:54.086 screenresolution[1918:15811] starting screenresolution argv=screenresolution get 21:14:54 INFO - 2016-12-17 21:14:54.089 screenresolution[1918:15811] Display 0: 1600x1200x32@60 21:14:54 INFO - 2016-12-17 21:14:54.094 screenresolution[1919:15813] starting screenresolution argv=screenresolution list 21:14:54 INFO - Available Modes on Display 0 21:14:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:54 INFO - Intel Iris: 21:14:54 INFO - Chipset Model: Intel Iris 21:14:54 INFO - Type: GPU 21:14:54 INFO - Bus: Built-In 21:14:54 INFO - VRAM (Dynamic, Max): 1536 MB 21:14:54 INFO - Vendor: Intel (0x8086) 21:14:54 INFO - Device ID: 0x0a2e 21:14:54 INFO - Revision ID: 0x0009 21:14:54 INFO - Displays: 21:14:54 INFO - Display: 21:14:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:54 INFO - Display Serial Number: 1600x1200 60 21:14:54 INFO - Main Display: Yes 21:14:54 INFO - Mirror: Off 21:14:54 INFO - Online: Yes 21:14:54 INFO - Rotation: Supported 21:14:54 INFO - Return code: 0 21:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:54 INFO - Python 2.7.3 21:14:54 INFO - Return code: 0 21:14:54 INFO - grabbing minidump binary from tooltool 21:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:54 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 0x1035e2d30>, '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 0x103509db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035d7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:14:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:14:54 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 21:14:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:54 INFO - Return code: 0 21:14:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:14:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:14:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L9hCjDEyuX/Render', 21:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:54 INFO - 'HOME': '/Users/cltbld', 21:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:54 INFO - 'LOGNAME': 'cltbld', 21:14:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:54 INFO - 'MOZ_NO_REMOTE': '1', 21:14:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:54 INFO - 'NO_EM_RESTART': '1', 21:14:54 INFO - 'PAGER': '/bin/cat', 21:14:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:54 INFO - 'PWD': '/builds/slave/test', 21:14:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:54 INFO - 'SHELL': '/bin/bash', 21:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDA4ITfW4D/Listeners', 21:14:54 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 21:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:54 INFO - 'USER': 'cltbld', 21:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:54 INFO - 'XPC_FLAGS': '0x0', 21:14:54 INFO - 'XPC_SERVICE_NAME': '0', 21:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:14:54 INFO - mozversion application_buildid: 20161217201335 21:14:54 INFO - mozversion application_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 21:14:54 INFO - mozversion application_display_name: Nightly 21:14:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:54 INFO - mozversion application_name: Firefox 21:14:54 INFO - mozversion application_remotingname: firefox 21:14:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:14:54 INFO - mozversion application_vendor: Mozilla 21:14:54 INFO - mozversion application_version: 53.0a1 21:14:54 INFO - mozversion platform_buildid: 20161217201335 21:14:54 INFO - mozversion platform_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 21:14:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:14:54 INFO - mozversion platform_version: 53.0a1 21:14:54 INFO - using testdate: 1482038094 21:14:54 INFO - actual date: 1482038094 21:14:54 INFO - starting webserver on 'localhost:51508' 21:14:54 INFO - SUITE-START | Running 2 tests 21:14:54 INFO - TEST-START | dromaeo_css 21:14:54 INFO - operating with platform_type : mac_ 21:14:54 INFO - Initialising browser for dromaeo_css test... 21:14:54 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpemnh_S/profile http://localhost:51508/getInfo.html) 21:14:56 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 21:14:56 INFO - PROCESS | 1929 | colorDepth:24 21:14:56 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 21:14:56 INFO - PROCESS | 1929 | __metrics 21:14:56 INFO - PROCESS | 1929 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:14:56 INFO - PROCESS | 1929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:14:57 INFO - TEST-INFO | 1929: exit 0 21:14:57 INFO - Browser initialized. 21:14:57 INFO - Running cycle 1/1 for dromaeo_css test... 21:14:57 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpemnh_S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:09 INFO - PROCESS | 1931 | RSS: Main: 231022592 21:15:09 INFO - PROCESS | 1931 | 21:16:01 INFO - PROCESS | 1931 | 1482038161098 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:18:13 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51508/tests/dromaeo/cssquery-ext.html) 21:18:16 INFO - PROCESS | 1931 | RSS: Main: 494272512 21:18:16 INFO - PROCESS | 1931 | 21:21:20 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51508/tests/dromaeo/cssquery-ext.html (next: http://localhost:51508/tests/dromaeo/cssquery-jquery.html) 21:21:20 INFO - PROCESS | 1931 | RSS: Main: 377245696 21:21:20 INFO - PROCESS | 1931 | 21:24:23 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51508/tests/dromaeo/cssquery-mootools.html) 21:24:23 INFO - PROCESS | 1931 | RSS: Main: 351072256 21:24:23 INFO - PROCESS | 1931 | 21:27:26 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51508/tests/dromaeo/cssquery-prototype.html) 21:27:26 INFO - PROCESS | 1931 | RSS: Main: 357367808 21:27:26 INFO - PROCESS | 1931 | 21:30:30 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51508/tests/dromaeo/cssquery-yui.html) 21:30:30 INFO - PROCESS | 1931 | RSS: Main: 342855680 21:30:30 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:51508/tests/dromaeo/cssquery-yui.html (next: http://localhost:51508/tests/dromaeo/cssquery-dojo.html) 21:33:34 INFO - PROCESS | 1931 | RSS: Main: 518897664 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | __start_tp_report 21:33:34 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 21:33:34 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 21:33:34 INFO - PROCESS | 1931 | |i|pagename|runs| 21:33:34 INFO - PROCESS | 1931 | |0;dojo.html;2718.959215611766;2831.7309855563713;3286.8027918324888;3314.403407386671;3318.717908977737;5407.053765591016;5480.616356855022;5487.204355368469;5493.835184944448;5534.08687566552;5456.61803673742;5478.945210547893;5523.861903452415;5524.14375771755;5555.194496797972;5017.071841709278;5118.411382691001;5120.923186152192;5121.974390128063;5137.51193636604;4164.646005089571;4961.355023846912;5078.64449488536;5160.071187186305;5175.327207463025;5128.692278463304;5132.999065182291;5151.484851514856;5156.69059856408;5166.405863325728;5015.971725796203;5026.67326623772;5044.772985215674;5105.719185444799;5163.457836927144;4174.603412675791;5008.5993120550265;5030.346055012825;5066.9746651266505;5102.923456148161;5441.238226648273;5466.835994920159;5468.808591699311;5476.91784623227;5483.917741233885;4913.656044076916;5797.942020579782;5897.292324920994;5916.112583112525;5923.052311630162;4921.360223170965;5938.8218353449465;6000.489958353545;6058;6076.422739839708;5618.85952851182;5622.85942851432;5625.099984002581;5628.746706398222;5666.320041594994;6222.906656400158;6247.375262473807;6253.53098517613;6255.24937007562;6260.467860231931;5638.633488823295;5766.163906233573;5770.711464426762;5839.649621022752;5876.941230587639;5890.352061273256;5948.405159484104;5959.493443057302;5963.701814909237;5968.462838344483;5847.649141051465;5850.619709718854;5865.882682346414;5869.266341707286;5890.4698577128265;5894.115882617556;5897.321807992136;5898.115282707542;5904.114382842522;5916.112583112482;4726.054789042205;4746.715197088117;4751.287306903923;4761.857144285677;4773.331733557305;4169.0411205422315;4231.259529582311;4253;4302;4364.890877728082;5601.439856014366;5618.297712785902;5625.493705566519;5626.352969408488;5668.574856885668;5795.652260864362;5841.649501029951;5843.503302219274;6088.908666370008;6092.268927728701;5593.3847276799515;5598.664080155204;5640.548756099584;5682.318121825408;5702.030654788696;5201.401838788512;5206.062908676475;5206.193040078718;5216.26972223889;5223.242629818655;6318.304986451487;6337.366263373626;6337.809865704036;6347.904781428375;6365.7135428904885;5864.149698293809;5916.911246331395;5920.141579470866;5970.940290597212;5992.460678538778;6296.874062518816;6315.526335524946;6329.367063293818;6364.109024736448;6375.171227740364;5919.289685237627;5942.1383899335215;5947.702614869326;5954.910676339771;5958.560872150276;5781.537477001746;5812;5883.646981181143;5890.322612899571;6041.214642096499;5753.1370294456165;5753.453421924911;5755.309362876482;5764.193012978102;5767.798127065533;5764.855878603068;5765.769369225184;5767.509761670305;5771.192033115283;5771.451712087345;5620.4660557248635;5654.6324488908085;5655.830325090254;5666.858328541654;5679.6876171810945;5757.366689664217;5758.1650660654805;5764.711764411679;5772.595918285848;5788.450097240755;4731.858044258678;5603.131514615241;5641.689707066151;5642.012647786703;5650.350209725934 21:33:34 INFO - PROCESS | 1931 | |1;ext.html;462.11043740798976;488.69700785512987;489.06832484117723;490.9582685471736;528.9391719952207;34462.65537344626;37979.43030854536;39129;39196.60803391965;39264;40077.599224007754;40714.38928416076;40717.38923916136;40752.38871416931;40972.180556388856;7710.113336966265;8883.600237989305;9191.63233470662;9382.061793820598;9413.48225847578;8377.329813614897;10958.835617465704;11278.943605281962;11284.887151128507;11461.140414468906;11106.167037472182;11148.665540033771;11204.42298271398;11221.270617409884;11241.494132764044;8360.498370097814;9416.858747118798;11206.495707693173;11217.214794964355;11221.38282394468;8282.792930176794;8405.915940840636;8408;8441.113683063251;10808.243422960395;35805.64194358049;37460.438093428624;37462.43806342907;37528.81235593805;37556.061098472484;3340.5824271966003;3377.3583019226267;3500.03748969033;3500.5274287971306;3722.590515043343;28731.856340718372;29023.12930612085;29188;29222.561661575095;29514.70485295141;2793.6368272124696;3113.5467206534368;3145.2608636970294;3181.681831816823;3275.4595491743835;436311;442297.57702422887;442315.1916327514;442849;445159.77420113015;56597;57137.14294285589;57151.42848571461;57166.142507862416;57239;59673;59715;59802.40197597969;59810.401895981355;59881.70059149763;14851.183184924932;15335.693286134216;15398.15310157952;15404.537863864101;15408.844336674794;10826.296290741077;11092.389918554558;12004.939975300242;12102.757944841054;12131.636050918487;11555.653330400102;13881;13966.650833729034;13976.161430314214;15116.395344186329;6105.877882442326;6353.4599559038;6400.97584386496;6408.92371661605;6445.806625801233;815.4780940198278;943.3962264150949;945.5272363818091;973.3575839945602;1036.2849633752687;23865;27954.580681289797;29249.41501170007;29686.55470167949;29739.85130074379;1017.3031473440717;1076.5532304093713;1112.3437172068357;1115.6151127860876;1223.7613665335352;14343.85656143446;14366.066205696596;14409;14863.405463781544;14979;573093;576128;580061;580141;584152;50064.749676251384;50070.248946265834;50311.74844125756;50336.24495632568;50428;1331.1347624044256;1339.4441306857545;1361.6663917340118;1368.8904887609167;1374.883134933542;25997.480050399263;27096.32259193536;27161.320966975985;27362.863185683946;27409.862950685118;45759.77120114378;47898.76050619724;47992.04015919732;48114.27828582644;48252.27621585749;550696;552339;557090;559687;560957;23827;24246.51506969886;24287;24308.663023533874;24333.51332973366;40283;41493.585064148974;41585.79207104066;43063.784681076395;43484.91287717832;32087.037388878372;33047.834760826045;34411.4838277421;35221;35728;30908.53637195399;34412.08036939972;34513.827430862686;34525;35197;28114.437711246068;33770.49344259887;34321.82839085789;34398;34550.30899381948;28080;28960;30691;30735.077947661604;30885;18957.71563426522;22767;22829.429264268525;23487.76512234856;23610.17364392238 21:33:34 INFO - PROCESS | 1931 | |2;jquery.html;342.88733061216357;370.80162113269404;371.33530979546606;384.19894519925947;400.06983762751594;14261.50084747034;14447.783283250747;15204.467843625474;18919.148638311275;19888.906110163934;18759.249630014783;19190.42428727137;19684.015799210054;19950.600987980233;19958.90020549895;5583.246261754672;5900.350961394243;5909.9704501477645;5910.822675319726;5922.111683247525;4717.150912835688;5841.065429531276;5868.647881127146;5876.324222714378;5900.911486327708;5751.942480575182;5827.038538641119;5839.445252701008;5846.795362162326;5856.619319744224;5046;5477.260569823063;5674.290713660793;5746.942530574704;5760.596758226926;5015.3730783652045;5025.422076461181;5036.748162591855;5039.496050394968;5045.571126454256;12923.67690807728;13127.737445251138;20903.477413064644;21885.452863678536;22569.984350704093;1762.3743571032355;2100.548382097841;2108.578284343122;2154.192177933275;2357.0807385119815;7915.604219788987;9457.668981585612;9510.1440870322;9943.651972180938;10032.799344013152;1776.413783451458;1811.94564163074;1877.9812201877944;1941.834944029759;1947.6591596470703;100562;105485.47257263665;108748.456257719;111415;112402;9077.591508382007;11412.029977451844;11423;11489.827652585218;11603.6518904433;14487.637809054859;14498.202598856953;14499.275036248146;14509.637259068608;14510.782338264935;8095.676172953016;8197.05733840604;8259.8348033039;8265.338772898154;8378.99452065756;8031.196880312039;8039.638216280281;8101.270885620323;8173.75478735627;8313.08556058833;4143.901866005511;4171.311733563989;4384.364267181241;4567.36056952027;4622.329762184464;1903.7525121734363;1914.272576420979;1923.9903800480909;1933.4586315831589;1966.4985428715872;781.9638978353704;805.5086397297644;875.6759998800485;946.8874072964239;951.2675240065112;17067;20255.392338229878;20801.375958721263;20857.791422085887;21242;839.4879123734516;870.190722627962;912.5254867469012;933.1088810186255;933.1881263300971;10098.949505252427;10749.570017199225;10834.783304333869;10883.891161088446;10898.945505272422;452838;467643;483423;483841;485076;112461.43769281264;115058;119148;126518;131625;997.8852431970416;1027.024326889458;1030.4126647810826;1037.7198156497702;1062.3201151263197;18087.457376278733;18393.54016149607;18435.17041733152;18607.720884186478;18909.90545047266;48007.75996119997;48947.51052489429;49384.50615493943;51985.7400712994;52091.14277870643;75045.6247718758;76960.61519692365;76997.23002770124;77008;78266.21733782817;6530.771423000172;7868.803279918048;8066.919330806617;8119.797005074684;8149.429539932385;9924.603015879284;10888.564457421615;12040.337781422106;12134.211276267015;12463.439145238668;10605.098566621924;10663.733406664585;10897.67306980792;11009.394483303495;11095;10043.4476103815;10444.007819257158;10590.735231619272;10977.670669879917;11065.668029959113;7580.393568514616;10818.891811081789;10947.233693641687;11031.282966607145;11106.888931110585;6668.633225172662;6914.55055421396;7135.5361901476235;7240.746573869889;7391.2239214881665;9381.859272110787;10736.367911685416;11027.79444111165;11096.890310969162;11210.775784484102 21:33:34 INFO - PROCESS | 1931 | |3;mootools.html;1368.4457794593193;1406.1633328169737;1533.2793587014103;1725.232271639121;1912.416712902564;7460.925390746091;7842;8105.1489593592705;8356.373272004594;8371.372147088978;8231.62957666905;8233.464824786384;8326.458780179284;8342.874856877137;8346.41575089744;2023.2109477303864;2254.233560589399;2290.2098775922364;2302.1021801497345;2302.7466978632337;2088.6136064828056;2107.346722516025;2114.164904862586;2115.1010820401343;2240.9103635854544;2272.6022945984387;2291.415688999303;2298.8735619540917;2302.700648915639;2308.8730119843403;2260.1185537640335;2273.6930514380597;2276.044061494168;2278.293728944016;2299.724033116037;2257.582347265761;2264.603694353498;2286.0969916882905;2291.2438895164555;2293.323469576479;8289.626966786509;8351.33189344857;8419;8440.029396619406;8447.535385553792;5005.799768009275;5177.870553236162;5181.248718935771;5186.429492755794;5196;3459.896203113911;3477.3914564951288;3530.064532898784;3547.5388199533895;3551.3607550640872;1004.7739258666815;1054.5307338234488;1059.9046085852233;1091.0889407344876;1097.237419993105;10837.83743243852;10948.671539853816;10953.068989135932;10962.451877406178;11028.503717332658;4362.476502819682;4501.41481607389;4598.655100867449;4600.677952543357;4677.134730074879;9489.051094890456;9505.809883802285;9519.381240219363;9529.666461673809;9543.141117299476;5069.771860266297;5170.17277235648;5176.767045482887;5178.016176926447;5187.06632806091;4528.320751887243;4651.883702907455;4677.7193368398;4704.247320428715;4736.123817093849;3020.5771192032694;3667.908302292464;3780.11167375672;3831.731778775459;3920;1267.3473161321926;1267.9429425675867;1288.491046036829;1294.6569159172827;1298.3248710670398;840.4201101240125;892.9641615725727;914.2503147419186;914.6158613382395;921.8652107759714;5435.10320797064;5507.118860982224;5694.9430505695245;5766;5782.108623026202;913.853783394667;942.7737343037759;962.6871266838306;964.252704154286;1002.4236064263077;3785.280796648628;3952.4861767970556;3954.248692748426;3988.980055099706;3990.5809889961715;9384.202342800801;9484.525773711286;9823.607055717834;9887.209023278121;10048;9852.605895764233;10005.449700266556;10011.749706257402;10016.64941727036;10021.09810117093;7590.013298271189;7876.488028278258;7883.251091146332;7884.526928384315;7885.408594355446;4988.12707776145;5545;5674.290713660793;5755.395683453345;5922.1412895130825;9192.31057670664;9217.953910230406;9372.671956481763;9386.15524602789;9400.576974036048;9060.411073280216;9362.672306469241;9389.24886009104;9461.148496635336;9494.762630934005;7095.751648692478;7219.711211551479;7287.489875708649;7300.890486642598;7308.159561650478;6926.168859736864;7131.928680713334;7824.647890844812;7907.011623547057;7909.406794490551;6201.875962480635;6879.5184337095925;7135.5361901476235;7143.82140446493;7240.203577606354;6957.1651401832105;7058;7100.7869763907165;7139.32176443237;7160.964195178991;6611.371919667624;6746.527743057939;6747.595144291358;6755.628440435823;6773.458123350219;4714.528547145258;4840.782164802522;4861.4895435980125;4915.483874193158;4997.075541024922;4751.61987041029;4841.298011788342;4925.38432695913;4956.8760780980765;5043.697378157322 21:33:34 INFO - PROCESS | 1931 | |4;prototype.html;300.4486766782953;314.55804594544657;352.89589571076533;355.2106408752853;375.19520628252417;5063.924041139377;5081.8475445736685;5095.847124586264;5097.668651537648;5141.511556402141;4506.6394688424925;4523.977380113095;4681.431720373679;4797.280407938811;5021.3221215135945;3675.2726218677312;3933.645971862532;3979;3985.9202815943663;3988.6809055275653;3468.601110872257;3973.284808734427;3987.3022221111332;3991.5409727881374;3995.9200815983663;3817.7327587068776;3930.842766289345;3973.443717879499;3985.561588225293;3994.5034353529045;3378.864845406181;3893.6301051400073;3949.8420063197436;3952.288588054149;4029.657479114279;3184.506401507747;3518.856371679189;3523.559555055618;3524.013276282645;3528.311979164064;4069.491313585802;4955.4548999610015;4969.726665033421;4978.278149668277;5011.649184557083;3966.5240171179644;3975.8012099395205;4275.187714334297;4363.629091527224;4501.48232953208;4409.36064270679;4740.976295118537;4979.850604481871;5302.231176479428;5314.97342513285;3621.8953219268114;3699.1491956850077;3872.9806350968347;3878.3212937736066;3884.6309600587897;4551.658625603093;4735.668503204777;4874.975625121851;5529.778808847641;5562.276904002494;3330.58367704037;3836.9040773980873;3917.5494818095713;3948.842046318115;3957.2085582883537;3239.3071898036255;3360.5463262459743;3591.2278860044694;3770.8680196193;3982.681385489154;4005.8798236052967;4520.886977825515;4523.914260577438;4528.456585209796;4534.659900507475;5117.590592752571;5296.708681022581;5312.468753124734;5336.973315133399;5376.973115134399;1214.6416807041944;1285.562908611058;1293.6959814443599;1296.4684479363416;1306.660672810358;818.9631466584018;875.0811647769943;894.4320356573622;900.9909900900907;918.8116436130578;4060.878173654795;4462.48681401643;4509.751963642031;4822.445418776885;4829.396325459317;4814.146553576898;4821.63837712173;5148.910653607805;5163.831190899831;5205.765740541685;4110.794460276974;4293.592108749664;4611.492735799059;4775.21209000511;4824.734639594786;2257.796798288162;2425.733169351405;2717.6331195288385;2718.497078040569;2719.891204351804;4605.111904119362;4827.637927155477;5342.973285133549;5459.508644222039;5494.945050549443;4748.95251047492;4877.878053048702;4929.605631549467;5088.0587091388215;5320.701165277553;4853.684510506806;4952.72174799589;5370.382406023357;5442.612133905829;5476.1511965644595;4315.611594956469;4435.6249562635685;4470.742275151028;5150.034473455493;5167.509086636764;4547.431571053618;4721.834735784369;5009.574186194214;5328.602129042024;5471.179323101566;5512.779488820403;5605.5515558756015;5759.654420734601;5782.739776709974;5821.476067153976;3399.5070714746716;3654.2508785698337;3825.3521970805605;3901.4733011043145;4017.4978127734034;4318.8903989127775;5322.520973112439;5417.566594672496;5464.890702186013;5505.256790333254;5275.525202731773;5281.55106815925;5289.497497737709;5294.179402192666;5315.548178404879;4276.251655960256;4658.229872648372;4771.809127634994;5166.2508936204795;5231.503007214461;4576.382188404656;5026.547610715053;5142.151544995034;5154.675234473819;5253.711045892513;4704.518076805932;5053.913408617165;5105.948940510547;5236.921446178387;5370;4422.955770442383;4800.927986080282;4963.1636294571235;5276.385675812081;5285.762140703754 21:33:34 INFO - PROCESS | 1931 | |5;yui.html;718.3534818663203;730.9218902119375;764.1327093748597;777.4412303331819;791.964361603728;13473.719996600332;14905.32926018329;15570.53288401347;15586;15593.376264949402;13736.244506552135;14125.152490850556;14140;14140.78788818166;14169.079009864352;691.7717153339411;714;720.8089856188114;853.5262929074361;866.9479831210148;870.9129087091272;871.4553404122423;886.5124181700071;887.0641473245723;888.3115585421285;919.2002957427048;923.5982347678747;929.9909598086085;932.0167223579122;932.0399988012358;712.729162918093;730.9451791115688;923.1829830599934;923.7598224461622;924.713338864954;533.967961922282;675.7499725101744;683.4907993544791;686.3342557719004;686.3376841348073;14193.574192774233;14246.430142794276;14269.357878895475;14274.785878211835;14294.499692510817;10937;13065.673358166121;13103.86896131036;13105.410256538478;13271;12186.634400967985;12417.93791031048;12541;12570.434330455151;12770.48918043277;3517;3681.2821499807546;3713.4615480755137;3719.981400093009;3793;98454.5077274609;104482.47758761233;105567.99999999923;106202;106395;8893.244074253631;10355.896441035493;10597.84103238452;10601.522931468102;10771.892281077246;20326.695099573517;20335.389938301876;20357.287494937606;20363.287284944956;20406.877621730946;6360.650164241011;7270.272972702687;7376.7786966391095;7642.325186184791;7680.654370553339;4156.709030367845;4275.3800698898485;4276.444062271885;4298.6131248187185;4425.867223983286;3205.487122060459;3375.8987230383127;3384.7799893006877;3398.745094117951;3401.166714155048;663.4574614022417;667.6795138333628;670.1221399965963;674.8481591641842;679.5582871133803;601.4316470934924;637.8932552022238;653.6666300186939;665.7037618259828;667.3226674924955;9123.635054597742;9207.76980575491;9385.765355866159;9603.991580883907;9614.95192524033;649.4836604899023;676.4149011105359;686.1765880942888;693.4313862632592;696.719283487557;4408.647308215399;4410.514843367227;4629.490756016836;4698.271767875985;4736.719489647737;73746.52506949939;81437;83483.16516834754;85183.5740821292;85383.57308213419;81876;82429;83045;84550;84830;70807.64596176986;72022.63988679918;72669;73354;77722.22277777264;8883.644654214018;9835.60657573689;9856.260780441353;9865.704028879145;9877.456739879375;41462;46944.29583556318;47972.280415793095;48351;48811.26783098328;54497.72751136219;64232.67883660552;66187.66906165438;68083.31916680769;71131;12458;12548.121631485708;12581.559645412734;12649.367531623198;13129.015323850941;14291;14360.712785744436;14449.060811047248;14548.781768273273;14617.196054216694;13351.866481335062;13381.39783709716;13512.459501619825;13631.182129072287;14055.929720351332;13213.339333033118;13349.399750040971;13615.591532254048;13701.246431446367;13933.164010159018;13106.541271055466;13315.001374896729;13317.53388631432;13493.32533373347;13792.724145517233;10558.947205263925;10879.357423315418;10967.835482467928;11296.548138074386;11583.362915039754;8775;11119.44402779874;11122.221444498808;11510.59712910044;11581.710457238636 21:33:34 INFO - PROCESS | 1931 | __end_tp_report 21:33:34 INFO - PROCESS | 1931 | __start_cc_report 21:33:34 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,3452 21:33:34 INFO - PROCESS | 1931 | __end_cc_report 21:33:34 INFO - PROCESS | 1931 | __startTimestamp1482039214339__endTimestamp 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | ------- Summary: start ------- 21:33:34 INFO - PROCESS | 1931 | Number of tests: 6 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5508.73 Median:5666.32 stddev:646.36 (11.4%) stddev-sans-first:610.17 21:33:34 INFO - PROCESS | 1931 | Values: 2719.0 2831.7 3286.8 3314.4 3318.7 5407.1 5480.6 5487.2 5493.8 5534.1 5456.6 5478.9 5523.9 5524.1 5555.2 5017.1 5118.4 5120.9 5122.0 5137.5 4164.6 4961.4 5078.6 5160.1 5175.3 5128.7 5133.0 5151.5 5156.7 5166.4 5016.0 5026.7 5044.8 5105.7 5163.5 4174.6 5008.6 5030.3 5067.0 5102.9 5441.2 5466.8 5468.8 5476.9 5483.9 4913.7 5797.9 5897.3 5916.1 5923.1 4921.4 5938.8 6000.5 6058.0 6076.4 5618.9 5622.9 5625.1 5628.7 5666.3 6222.9 6247.4 6253.5 6255.2 6260.5 5638.6 5766.2 5770.7 5839.6 5876.9 5890.4 5948.4 5959.5 5963.7 5968.5 5847.6 5850.6 5865.9 5869.3 5890.5 5894.1 5897.3 5898.1 5904.1 5916.1 4726.1 4746.7 4751.3 4761.9 4773.3 4169.0 4231.3 4253.0 4302.0 4364.9 5601.4 5618.3 5625.5 5626.4 5668.6 5795.7 5841.6 5843.5 6088.9 6092.3 5593.4 5598.7 5640.5 5682.3 5702.0 5201.4 5206.1 5206.2 5216.3 5223.2 6318.3 6337.4 6337.8 6347.9 6365.7 5864.1 5916.9 5920.1 5970.9 5992.5 6296.9 6315.5 6329.4 6364.1 6375.2 5919.3 5942.1 5947.7 5954.9 5958.6 5781.5 5812.0 5883.6 5890.3 6041.2 5753.1 5753.5 5755.3 5764.2 5767.8 5764.9 5765.8 5767.5 5771.2 5771.5 5620.5 5654.6 5655.8 5666.9 5679.7 5757.4 5758.2 5764.7 5772.6 5788.5 4731.9 5603.1 5641.7 5642.0 5650.4 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:64799.40 Median:34488.24 stddev:141347.06 (409.8%) stddev-sans-first:141661.03 21:33:34 INFO - PROCESS | 1931 | Values: 462.1 488.7 489.1 491.0 528.9 34462.7 37979.4 39129.0 39196.6 39264.0 40077.6 40714.4 40717.4 40752.4 40972.2 7710.1 8883.6 9191.6 9382.1 9413.5 8377.3 10958.8 11278.9 11284.9 11461.1 11106.2 11148.7 11204.4 11221.3 11241.5 8360.5 9416.9 11206.5 11217.2 11221.4 8282.8 8405.9 8408.0 8441.1 10808.2 35805.6 37460.4 37462.4 37528.8 37556.1 3340.6 3377.4 3500.0 3500.5 3722.6 28731.9 29023.1 29188.0 29222.6 29514.7 2793.6 3113.5 3145.3 3181.7 3275.5 436311.0 442297.6 442315.2 442849.0 445159.8 56597.0 57137.1 57151.4 57166.1 57239.0 59673.0 59715.0 59802.4 59810.4 59881.7 14851.2 15335.7 15398.2 15404.5 15408.8 10826.3 11092.4 12004.9 12102.8 12131.6 11555.7 13881.0 13966.7 13976.2 15116.4 6105.9 6353.5 6401.0 6408.9 6445.8 815.5 943.4 945.5 973.4 1036.3 23865.0 27954.6 29249.4 29686.6 29739.9 1017.3 1076.6 1112.3 1115.6 1223.8 14343.9 14366.1 14409.0 14863.4 14979.0 573093.0 576128.0 580061.0 580141.0 584152.0 50064.7 50070.2 50311.7 50336.2 50428.0 1331.1 1339.4 1361.7 1368.9 1374.9 25997.5 27096.3 27161.3 27362.9 27409.9 45759.8 47898.8 47992.0 48114.3 48252.3 550696.0 552339.0 557090.0 559687.0 560957.0 23827.0 24246.5 24287.0 24308.7 24333.5 40283.0 41493.6 41585.8 43063.8 43484.9 32087.0 33047.8 34411.5 35221.0 35728.0 30908.5 34412.1 34513.8 34525.0 35197.0 28114.4 33770.5 34321.8 34398.0 34550.3 28080.0 28960.0 30691.0 30735.1 30885.0 18957.7 22767.0 22829.4 23487.8 23610.2 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:30419.43 Median:1349.98 stddev:80170.43 (5938.6%) stddev-sans-first:80363.52 21:33:34 INFO - PROCESS | 1931 | Values: 342.9 370.8 371.3 384.2 400.1 14261.5 14447.8 15204.5 18919.1 19888.9 18759.2 19190.4 19684.0 19950.6 19958.9 5583.2 5900.4 5910.0 5910.8 5922.1 4717.2 5841.1 5868.6 5876.3 5900.9 5751.9 5827.0 5839.4 5846.8 5856.6 5046.0 5477.3 5674.3 5746.9 5760.6 5015.4 5025.4 5036.7 5039.5 5045.6 12923.7 13127.7 20903.5 21885.5 22570.0 1762.4 2100.5 2108.6 2154.2 2357.1 7915.6 9457.7 9510.1 9943.7 10032.8 1776.4 1811.9 1878.0 1941.8 1947.7 100562.0 105485.5 108748.5 111415.0 112402.0 9077.6 11412.0 11423.0 11489.8 11603.7 14487.6 14498.2 14499.3 14509.6 14510.8 8095.7 8197.1 8259.8 8265.3 8379.0 8031.2 8039.6 8101.3 8173.8 8313.1 4143.9 4171.3 4384.4 4567.4 4622.3 1903.8 1914.3 1924.0 1933.5 1966.5 782.0 805.5 875.7 946.9 951.3 17067.0 20255.4 20801.4 20857.8 21242.0 839.5 870.2 912.5 933.1 933.2 10098.9 10749.6 10834.8 10883.9 10898.9 452838.0 467643.0 483423.0 483841.0 485076.0 112461.4 115058.0 119148.0 126518.0 131625.0 997.9 1027.0 1030.4 1037.7 1062.3 18087.5 18393.5 18435.2 18607.7 18909.9 48007.8 48947.5 49384.5 51985.7 52091.1 75045.6 76960.6 76997.2 77008.0 78266.2 6530.8 7868.8 8066.9 8119.8 8149.4 9924.6 10888.6 12040.3 12134.2 12463.4 10605.1 10663.7 10897.7 11009.4 11095.0 10043.4 10444.0 10590.7 10977.7 11065.7 7580.4 10818.9 10947.2 11031.3 11106.9 6668.6 6914.6 7135.5 7240.7 7391.2 9381.9 10736.4 11027.8 11096.9 11210.8 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5430.09 Median:5177.32 stddev:2967.07 (57.3%) stddev-sans-first:2959.69 21:33:34 INFO - PROCESS | 1931 | Values: 1368.4 1406.2 1533.3 1725.2 1912.4 7460.9 7842.0 8105.1 8356.4 8371.4 8231.6 8233.5 8326.5 8342.9 8346.4 2023.2 2254.2 2290.2 2302.1 2302.7 2088.6 2107.3 2114.2 2115.1 2240.9 2272.6 2291.4 2298.9 2302.7 2308.9 2260.1 2273.7 2276.0 2278.3 2299.7 2257.6 2264.6 2286.1 2291.2 2293.3 8289.6 8351.3 8419.0 8440.0 8447.5 5005.8 5177.9 5181.2 5186.4 5196.0 3459.9 3477.4 3530.1 3547.5 3551.4 1004.8 1054.5 1059.9 1091.1 1097.2 10837.8 10948.7 10953.1 10962.5 11028.5 4362.5 4501.4 4598.7 4600.7 4677.1 9489.1 9505.8 9519.4 9529.7 9543.1 5069.8 5170.2 5176.8 5178.0 5187.1 4528.3 4651.9 4677.7 4704.2 4736.1 3020.6 3667.9 3780.1 3831.7 3920.0 1267.3 1267.9 1288.5 1294.7 1298.3 840.4 893.0 914.3 914.6 921.9 5435.1 5507.1 5694.9 5766.0 5782.1 913.9 942.8 962.7 964.3 1002.4 3785.3 3952.5 3954.2 3989.0 3990.6 9384.2 9484.5 9823.6 9887.2 10048.0 9852.6 10005.4 10011.7 10016.6 10021.1 7590.0 7876.5 7883.3 7884.5 7885.4 4988.1 5545.0 5674.3 5755.4 5922.1 9192.3 9218.0 9372.7 9386.2 9400.6 9060.4 9362.7 9389.2 9461.1 9494.8 7095.8 7219.7 7287.5 7300.9 7308.2 6926.2 7131.9 7824.6 7907.0 7909.4 6201.9 6879.5 7135.5 7143.8 7240.2 6957.2 7058.0 7100.8 7139.3 7161.0 6611.4 6746.5 6747.6 6755.6 6773.5 4714.5 4840.8 4861.5 4915.5 4997.1 4751.6 4841.3 4925.4 4956.9 5043.7 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4245.24 Median:4669.83 stddev:1253.23 (26.8%) stddev-sans-first:1221.26 21:33:34 INFO - PROCESS | 1931 | Values: 300.4 314.6 352.9 355.2 375.2 5063.9 5081.8 5095.8 5097.7 5141.5 4506.6 4524.0 4681.4 4797.3 5021.3 3675.3 3933.6 3979.0 3985.9 3988.7 3468.6 3973.3 3987.3 3991.5 3995.9 3817.7 3930.8 3973.4 3985.6 3994.5 3378.9 3893.6 3949.8 3952.3 4029.7 3184.5 3518.9 3523.6 3524.0 3528.3 4069.5 4955.5 4969.7 4978.3 5011.6 3966.5 3975.8 4275.2 4363.6 4501.5 4409.4 4741.0 4979.9 5302.2 5315.0 3621.9 3699.1 3873.0 3878.3 3884.6 4551.7 4735.7 4875.0 5529.8 5562.3 3330.6 3836.9 3917.5 3948.8 3957.2 3239.3 3360.5 3591.2 3770.9 3982.7 4005.9 4520.9 4523.9 4528.5 4534.7 5117.6 5296.7 5312.5 5337.0 5377.0 1214.6 1285.6 1293.7 1296.5 1306.7 819.0 875.1 894.4 901.0 918.8 4060.9 4462.5 4509.8 4822.4 4829.4 4814.1 4821.6 5148.9 5163.8 5205.8 4110.8 4293.6 4611.5 4775.2 4824.7 2257.8 2425.7 2717.6 2718.5 2719.9 4605.1 4827.6 5343.0 5459.5 5494.9 4749.0 4877.9 4929.6 5088.1 5320.7 4853.7 4952.7 5370.4 5442.6 5476.2 4315.6 4435.6 4470.7 5150.0 5167.5 4547.4 4721.8 5009.6 5328.6 5471.2 5512.8 5605.6 5759.7 5782.7 5821.5 3399.5 3654.3 3825.4 3901.5 4017.5 4318.9 5322.5 5417.6 5464.9 5505.3 5275.5 5281.6 5289.5 5294.2 5315.5 4276.3 4658.2 4771.8 5166.3 5231.5 4576.4 5026.5 5142.2 5154.7 5253.7 4704.5 5053.9 5105.9 5236.9 5370.0 4423.0 4800.9 4963.2 5276.4 5285.8 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:19222.45 Median:25786.89 stddev:26931.51 (104.4%) stddev-sans-first:26971.22 21:33:34 INFO - PROCESS | 1931 | Values: 718.4 730.9 764.1 777.4 792.0 13473.7 14905.3 15570.5 15586.0 15593.4 13736.2 14125.2 14140.0 14140.8 14169.1 691.8 714.0 720.8 853.5 866.9 870.9 871.5 886.5 887.1 888.3 919.2 923.6 930.0 932.0 932.0 712.7 730.9 923.2 923.8 924.7 534.0 675.7 683.5 686.3 686.3 14193.6 14246.4 14269.4 14274.8 14294.5 10937.0 13065.7 13103.9 13105.4 13271.0 12186.6 12417.9 12541.0 12570.4 12770.5 3517.0 3681.3 3713.5 3720.0 3793.0 98454.5 104482.5 105568.0 106202.0 106395.0 8893.2 10355.9 10597.8 10601.5 10771.9 20326.7 20335.4 20357.3 20363.3 20406.9 6360.7 7270.3 7376.8 7642.3 7680.7 4156.7 4275.4 4276.4 4298.6 4425.9 3205.5 3375.9 3384.8 3398.7 3401.2 663.5 667.7 670.1 674.8 679.6 601.4 637.9 653.7 665.7 667.3 9123.6 9207.8 9385.8 9604.0 9615.0 649.5 676.4 686.2 693.4 696.7 4408.6 4410.5 4629.5 4698.3 4736.7 73746.5 81437.0 83483.2 85183.6 85383.6 81876.0 82429.0 83045.0 84550.0 84830.0 70807.6 72022.6 72669.0 73354.0 77722.2 8883.6 9835.6 9856.3 9865.7 9877.5 41462.0 46944.3 47972.3 48351.0 48811.3 54497.7 64232.7 66187.7 68083.3 71131.0 12458.0 12548.1 12581.6 12649.4 13129.0 14291.0 14360.7 14449.1 14548.8 14617.2 13351.9 13381.4 13512.5 13631.2 14055.9 13213.3 13349.4 13615.6 13701.2 13933.2 13106.5 13315.0 13317.5 13493.3 13792.7 10558.9 10879.4 10967.8 11296.5 11583.4 8775.0 11119.4 11122.2 11510.6 11581.7 21:33:34 INFO - PROCESS | 1931 | -------- Summary: end -------- 21:33:34 INFO - PROCESS | 1931 | 21:33:34 INFO - TEST-INFO | 1931: exit 0 21:33:34 INFO - TEST-OK | dromaeo_css | took 1120307ms 21:33:34 INFO - TEST-START | kraken 21:33:34 INFO - operating with platform_type : mac_ 21:33:34 INFO - Initialising browser for kraken test... 21:33:35 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpOXenzy/profile http://localhost:51508/getInfo.html) 21:33:37 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 21:33:37 INFO - PROCESS | 1936 | colorDepth:24 21:33:37 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 21:33:37 INFO - PROCESS | 1936 | __metrics 21:33:37 INFO - PROCESS | 1936 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:33:37 INFO - PROCESS | 1936 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:38 INFO - TEST-INFO | 1936: exit 0 21:33:38 INFO - Browser initialized. 21:33:38 INFO - Running cycle 1/1 for kraken test... 21:33:38 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpOXenzy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:50 INFO - PROCESS | 1937 | RSS: Main: 230510592 21:33:50 INFO - PROCESS | 1937 | 21:33:52 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51508/tests/kraken/driver.html?testName=audio-beat-detection) 21:33:53 INFO - PROCESS | 1937 | RSS: Main: 288673792 21:33:53 INFO - PROCESS | 1937 | 21:33:56 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51508/tests/kraken/driver.html?testName=audio-dft) 21:33:57 INFO - PROCESS | 1937 | RSS: Main: 291987456 21:33:57 INFO - PROCESS | 1937 | 21:34:00 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51508/tests/kraken/driver.html?testName=audio-fft) 21:34:01 INFO - PROCESS | 1937 | RSS: Main: 381853696 21:34:01 INFO - PROCESS | 1937 | 21:34:03 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51508/tests/kraken/driver.html?testName=audio-oscillator) 21:34:03 INFO - PROCESS | 1937 | RSS: Main: 284688384 21:34:03 INFO - PROCESS | 1937 | 21:34:05 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:34:06 INFO - PROCESS | 1937 | RSS: Main: 288055296 21:34:06 INFO - PROCESS | 1937 | 21:34:09 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51508/tests/kraken/driver.html?testName=imaging-darkroom) 21:34:09 INFO - PROCESS | 1937 | RSS: Main: 331214848 21:34:09 INFO - PROCESS | 1937 | 21:34:12 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51508/tests/kraken/driver.html?testName=imaging-desaturate) 21:34:13 INFO - PROCESS | 1937 | RSS: Main: 332201984 21:34:13 INFO - PROCESS | 1937 | 21:34:16 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51508/tests/kraken/driver.html?testName=json-parse-financial) 21:34:16 INFO - PROCESS | 1937 | RSS: Main: 328769536 21:34:16 INFO - PROCESS | 1937 | 21:34:18 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:34:19 INFO - PROCESS | 1937 | RSS: Main: 306372608 21:34:19 INFO - PROCESS | 1937 | 21:34:21 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:34:21 INFO - PROCESS | 1937 | RSS: Main: 308490240 21:34:21 INFO - PROCESS | 1937 | 21:34:24 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:24 INFO - PROCESS | 1937 | RSS: Main: 311193600 21:34:24 INFO - PROCESS | 1937 | 21:34:27 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:28 INFO - PROCESS | 1937 | RSS: Main: 320286720 21:34:28 INFO - PROCESS | 1937 | 21:34:31 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:32 INFO - PROCESS | 1937 | RSS: Main: 318865408 21:34:32 INFO - PROCESS | 1937 | 21:34:33 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:51508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51508/tests/kraken/driver.html?testName=ai-astar) 21:34:34 INFO - PROCESS | 1937 | RSS: Main: 363020288 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | __start_tp_report 21:34:34 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 21:34:34 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 21:34:34 INFO - PROCESS | 1937 | |i|pagename|runs| 21:34:34 INFO - PROCESS | 1937 | |0;ai-astar;113;116;115;115;115;115;115;116;115;115 21:34:34 INFO - PROCESS | 1937 | |1;audio-beat-detection;153;113;115;148;113;112;112;108;125;112 21:34:34 INFO - PROCESS | 1937 | |2;audio-dft;184;184;187;186;187;182;183;201;182;187 21:34:34 INFO - PROCESS | 1937 | |3;audio-fft;83;58;59;91;62;59;59;59;74;59 21:34:34 INFO - PROCESS | 1937 | |4;audio-oscillator;86;71;87;70;68;67;84;69;68;86 21:34:34 INFO - PROCESS | 1937 | |5;imaging-gaussian-blur;109;112;110;112;109;113;109;112;109;111 21:34:34 INFO - PROCESS | 1937 | |6;imaging-darkroom;96;97;96;107;98;97;96;97;96;97 21:34:34 INFO - PROCESS | 1937 | |7;imaging-desaturate;87;85;86;88;86;86;88;87;87;85 21:34:34 INFO - PROCESS | 1937 | |8;json-parse-financial;57;56;55;56;56;56;56;55;56;56 21:34:34 INFO - PROCESS | 1937 | |9;json-stringify-tinderbox;65;77;66;77;73;95;103;103;78;73 21:34:34 INFO - PROCESS | 1937 | |10;stanford-crypto-aes;85;87;86;77;102;107;107;107;77;96 21:34:34 INFO - PROCESS | 1937 | |11;stanford-crypto-ccm;145;144;130;144;143;154;155;148;250;168 21:34:34 INFO - PROCESS | 1937 | |12;stanford-crypto-pbkdf2;175;172;169;169;172;171;175;170;172;170 21:34:34 INFO - PROCESS | 1937 | |13;stanford-crypto-sha256-iterative;67;67;68;67;68;68;66;66;65;66 21:34:34 INFO - PROCESS | 1937 | __end_tp_report 21:34:34 INFO - PROCESS | 1937 | __start_cc_report 21:34:34 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,2000 21:34:34 INFO - PROCESS | 1937 | __end_cc_report 21:34:34 INFO - PROCESS | 1937 | __startTimestamp1482039274030__endTimestamp 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | ------- Summary: start ------- 21:34:34 INFO - PROCESS | 1937 | Number of tests: 14 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 21:34:34 INFO - PROCESS | 1937 | Values: 113.0 116.0 115.0 115.0 115.0 115.0 115.0 116.0 115.0 115.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:114.00 stddev:16.14 (14.2%) stddev-sans-first:12.32 21:34:34 INFO - PROCESS | 1937 | Values: 153.0 113.0 115.0 148.0 113.0 112.0 112.0 108.0 125.0 112.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#2] audio-dft Cycles:10 Average:186.30 Median:186.50 stddev:5.54 (3.0%) stddev-sans-first:5.81 21:34:34 INFO - PROCESS | 1937 | Values: 184.0 184.0 187.0 186.0 187.0 182.0 183.0 201.0 182.0 187.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:12.03 (19.9%) stddev-sans-first:11.14 21:34:34 INFO - PROCESS | 1937 | Values: 83.0 58.0 59.0 91.0 62.0 59.0 59.0 59.0 74.0 59.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.50 stddev:8.83 (11.4%) stddev-sans-first:8.53 21:34:34 INFO - PROCESS | 1937 | Values: 86.0 71.0 87.0 70.0 68.0 67.0 84.0 69.0 68.0 86.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:111.50 stddev:1.58 (1.4%) stddev-sans-first:1.56 21:34:34 INFO - PROCESS | 1937 | Values: 109.0 112.0 110.0 112.0 109.0 113.0 109.0 112.0 109.0 111.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:97.00 stddev:3.33 (3.4%) stddev-sans-first:3.48 21:34:34 INFO - PROCESS | 1937 | Values: 96.0 97.0 96.0 107.0 98.0 97.0 96.0 97.0 96.0 97.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.08 (1.2%) stddev-sans-first:1.13 21:34:34 INFO - PROCESS | 1937 | Values: 87.0 85.0 86.0 88.0 86.0 86.0 88.0 87.0 87.0 85.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 21:34:34 INFO - PROCESS | 1937 | Values: 57.0 56.0 55.0 56.0 56.0 56.0 56.0 55.0 56.0 56.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:75.00 stddev:14.20 (18.9%) stddev-sans-first:13.83 21:34:34 INFO - PROCESS | 1937 | Values: 65.0 77.0 66.0 77.0 73.0 95.0 103.0 103.0 78.0 73.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:81.00 stddev:12.20 (15.1%) stddev-sans-first:12.58 21:34:34 INFO - PROCESS | 1937 | Values: 85.0 87.0 86.0 77.0 102.0 107.0 107.0 107.0 77.0 96.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#11] stanford-crypto-ccm Cycles:10 Average:158.10 Median:151.00 stddev:33.76 (22.4%) stddev-sans-first:35.48 21:34:34 INFO - PROCESS | 1937 | Values: 145.0 144.0 130.0 144.0 143.0 154.0 155.0 148.0 250.0 168.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:2.17 (1.3%) stddev-sans-first:1.90 21:34:34 INFO - PROCESS | 1937 | Values: 175.0 172.0 169.0 169.0 172.0 171.0 175.0 170.0 172.0 170.0 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - PROCESS | 1937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 21:34:34 INFO - PROCESS | 1937 | Values: 67.0 67.0 68.0 67.0 68.0 68.0 66.0 66.0 65.0 66.0 21:34:34 INFO - PROCESS | 1937 | -------- Summary: end -------- 21:34:34 INFO - PROCESS | 1937 | 21:34:34 INFO - TEST-INFO | 1937: exit 0 21:34:34 INFO - TEST-OK | kraken | took 59987ms 21:34:34 INFO - SUITE-END | took 1180s 21:34:35 INFO - Completed test suite (00:19:40) 21:34:35 INFO - javascript benchmark 21:34:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2718.959215611766, 2831.7309855563713, 3286.8027918324888, 3314.403407386671, 3318.717908977737, 5407.053765591016, 5480.616356855022, 5487.204355368469, 5493.835184944448, 5534.08687566552, 5456.61803673742, 5478.945210547893, 5523.861903452415, 5524.14375771755, 5555.194496797972, 5017.071841709278, 5118.411382691001, 5120.923186152192, 5121.974390128063, 5137.51193636604, 4164.646005089571, 4961.355023846912, 5078.64449488536, 5160.071187186305, 5175.327207463025, 5128.692278463304, 5132.999065182291, 5151.484851514856, 5156.69059856408, 5166.405863325728, 5015.971725796203, 5026.67326623772, 5044.772985215674, 5105.719185444799, 5163.457836927144, 4174.603412675791, 5008.5993120550265, 5030.346055012825, 5066.9746651266505, 5102.923456148161, 5441.238226648273, 5466.835994920159, 5468.808591699311, 5476.91784623227, 5483.917741233885, 4913.656044076916, 5797.942020579782, 5897.292324920994, 5916.112583112525, 5923.052311630162, 4921.360223170965, 5938.8218353449465, 6000.489958353545, 6058.0, 6076.422739839708, 5618.85952851182, 5622.85942851432, 5625.099984002581, 5628.746706398222, 5666.320041594994, 6222.906656400158, 6247.375262473807, 6253.53098517613, 6255.24937007562, 6260.467860231931, 5638.633488823295, 5766.163906233573, 5770.711464426762, 5839.649621022752, 5876.941230587639, 5890.352061273256, 5948.405159484104, 5959.493443057302, 5963.701814909237, 5968.462838344483, 5847.649141051465, 5850.619709718854, 5865.882682346414, 5869.266341707286, 5890.4698577128265, 5894.115882617556, 5897.321807992136, 5898.115282707542, 5904.114382842522, 5916.112583112482, 4726.054789042205, 4746.715197088117, 4751.287306903923, 4761.857144285677, 4773.331733557305, 4169.0411205422315, 4231.259529582311, 4253.0, 4302.0, 4364.890877728082, 5601.439856014366, 5618.297712785902, 5625.493705566519, 5626.352969408488, 5668.574856885668, 5795.652260864362, 5841.649501029951, 5843.503302219274, 6088.908666370008, 6092.268927728701, 5593.3847276799515, 5598.664080155204, 5640.548756099584, 5682.318121825408, 5702.030654788696, 5201.401838788512, 5206.062908676475, 5206.193040078718, 5216.26972223889, 5223.242629818655, 6318.304986451487, 6337.366263373626, 6337.809865704036, 6347.904781428375, 6365.7135428904885, 5864.149698293809, 5916.911246331395, 5920.141579470866, 5970.940290597212, 5992.460678538778, 6296.874062518816, 6315.526335524946, 6329.367063293818, 6364.109024736448, 6375.171227740364, 5919.289685237627, 5942.1383899335215, 5947.702614869326, 5954.910676339771, 5958.560872150276, 5781.537477001746, 5812.0, 5883.646981181143, 5890.322612899571, 6041.214642096499, 5753.1370294456165, 5753.453421924911, 5755.309362876482, 5764.193012978102, 5767.798127065533, 5764.855878603068, 5765.769369225184, 5767.509761670305, 5771.192033115283, 5771.451712087345, 5620.4660557248635, 5654.6324488908085, 5655.830325090254, 5666.858328541654, 5679.6876171810945, 5757.366689664217, 5758.1650660654805, 5764.711764411679, 5772.595918285848, 5788.450097240755, 4731.858044258678, 5603.131514615241, 5641.689707066151, 5642.012647786703, 5650.350209725934], "value": 5465.987368642963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.11043740798976, 488.69700785512987, 489.06832484117723, 490.9582685471736, 528.9391719952207, 34462.65537344626, 37979.43030854536, 39129.0, 39196.60803391965, 39264.0, 40077.599224007754, 40714.38928416076, 40717.38923916136, 40752.38871416931, 40972.180556388856, 7710.113336966265, 8883.600237989305, 9191.63233470662, 9382.061793820598, 9413.48225847578, 8377.329813614897, 10958.835617465704, 11278.943605281962, 11284.887151128507, 11461.140414468906, 11106.167037472182, 11148.665540033771, 11204.42298271398, 11221.270617409884, 11241.494132764044, 8360.498370097814, 9416.858747118798, 11206.495707693173, 11217.214794964355, 11221.38282394468, 8282.792930176794, 8405.915940840636, 8408.0, 8441.113683063251, 10808.243422960395, 35805.64194358049, 37460.438093428624, 37462.43806342907, 37528.81235593805, 37556.061098472484, 3340.5824271966003, 3377.3583019226267, 3500.03748969033, 3500.5274287971306, 3722.590515043343, 28731.856340718372, 29023.12930612085, 29188.0, 29222.561661575095, 29514.70485295141, 2793.6368272124696, 3113.5467206534368, 3145.2608636970294, 3181.681831816823, 3275.4595491743835, 436311.0, 442297.57702422887, 442315.1916327514, 442849.0, 445159.77420113015, 56597.0, 57137.14294285589, 57151.42848571461, 57166.142507862416, 57239.0, 59673.0, 59715.0, 59802.40197597969, 59810.401895981355, 59881.70059149763, 14851.183184924932, 15335.693286134216, 15398.15310157952, 15404.537863864101, 15408.844336674794, 10826.296290741077, 11092.389918554558, 12004.939975300242, 12102.757944841054, 12131.636050918487, 11555.653330400102, 13881.0, 13966.650833729034, 13976.161430314214, 15116.395344186329, 6105.877882442326, 6353.4599559038, 6400.97584386496, 6408.92371661605, 6445.806625801233, 815.4780940198278, 943.3962264150949, 945.5272363818091, 973.3575839945602, 1036.2849633752687, 23865.0, 27954.580681289797, 29249.41501170007, 29686.55470167949, 29739.85130074379, 1017.3031473440717, 1076.5532304093713, 1112.3437172068357, 1115.6151127860876, 1223.7613665335352, 14343.85656143446, 14366.066205696596, 14409.0, 14863.405463781544, 14979.0, 573093.0, 576128.0, 580061.0, 580141.0, 584152.0, 50064.749676251384, 50070.248946265834, 50311.74844125756, 50336.24495632568, 50428.0, 1331.1347624044256, 1339.4441306857545, 1361.6663917340118, 1368.8904887609167, 1374.883134933542, 25997.480050399263, 27096.32259193536, 27161.320966975985, 27362.863185683946, 27409.862950685118, 45759.77120114378, 47898.76050619724, 47992.04015919732, 48114.27828582644, 48252.27621585749, 550696.0, 552339.0, 557090.0, 559687.0, 560957.0, 23827.0, 24246.51506969886, 24287.0, 24308.663023533874, 24333.51332973366, 40283.0, 41493.585064148974, 41585.79207104066, 43063.784681076395, 43484.91287717832, 32087.037388878372, 33047.834760826045, 34411.4838277421, 35221.0, 35728.0, 30908.53637195399, 34412.08036939972, 34513.827430862686, 34525.0, 35197.0, 28114.437711246068, 33770.49344259887, 34321.82839085789, 34398.0, 34550.30899381948, 28080.0, 28960.0, 30691.0, 30735.077947661604, 30885.0, 18957.71563426522, 22767.0, 22829.429264268525, 23487.76512234856, 23610.17364392238], "value": 18717.21739693033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.88733061216357, 370.80162113269404, 371.33530979546606, 384.19894519925947, 400.06983762751594, 14261.50084747034, 14447.783283250747, 15204.467843625474, 18919.148638311275, 19888.906110163934, 18759.249630014783, 19190.42428727137, 19684.015799210054, 19950.600987980233, 19958.90020549895, 5583.246261754672, 5900.350961394243, 5909.9704501477645, 5910.822675319726, 5922.111683247525, 4717.150912835688, 5841.065429531276, 5868.647881127146, 5876.324222714378, 5900.911486327708, 5751.942480575182, 5827.038538641119, 5839.445252701008, 5846.795362162326, 5856.619319744224, 5046.0, 5477.260569823063, 5674.290713660793, 5746.942530574704, 5760.596758226926, 5015.3730783652045, 5025.422076461181, 5036.748162591855, 5039.496050394968, 5045.571126454256, 12923.67690807728, 13127.737445251138, 20903.477413064644, 21885.452863678536, 22569.984350704093, 1762.3743571032355, 2100.548382097841, 2108.578284343122, 2154.192177933275, 2357.0807385119815, 7915.604219788987, 9457.668981585612, 9510.1440870322, 9943.651972180938, 10032.799344013152, 1776.413783451458, 1811.94564163074, 1877.9812201877944, 1941.834944029759, 1947.6591596470703, 100562.0, 105485.47257263665, 108748.456257719, 111415.0, 112402.0, 9077.591508382007, 11412.029977451844, 11423.0, 11489.827652585218, 11603.6518904433, 14487.637809054859, 14498.202598856953, 14499.275036248146, 14509.637259068608, 14510.782338264935, 8095.676172953016, 8197.05733840604, 8259.8348033039, 8265.338772898154, 8378.99452065756, 8031.196880312039, 8039.638216280281, 8101.270885620323, 8173.75478735627, 8313.08556058833, 4143.901866005511, 4171.311733563989, 4384.364267181241, 4567.36056952027, 4622.329762184464, 1903.7525121734363, 1914.272576420979, 1923.9903800480909, 1933.4586315831589, 1966.4985428715872, 781.9638978353704, 805.5086397297644, 875.6759998800485, 946.8874072964239, 951.2675240065112, 17067.0, 20255.392338229878, 20801.375958721263, 20857.791422085887, 21242.0, 839.4879123734516, 870.190722627962, 912.5254867469012, 933.1088810186255, 933.1881263300971, 10098.949505252427, 10749.570017199225, 10834.783304333869, 10883.891161088446, 10898.945505272422, 452838.0, 467643.0, 483423.0, 483841.0, 485076.0, 112461.43769281264, 115058.0, 119148.0, 126518.0, 131625.0, 997.8852431970416, 1027.024326889458, 1030.4126647810826, 1037.7198156497702, 1062.3201151263197, 18087.457376278733, 18393.54016149607, 18435.17041733152, 18607.720884186478, 18909.90545047266, 48007.75996119997, 48947.51052489429, 49384.50615493943, 51985.7400712994, 52091.14277870643, 75045.6247718758, 76960.61519692365, 76997.23002770124, 77008.0, 78266.21733782817, 6530.771423000172, 7868.803279918048, 8066.919330806617, 8119.797005074684, 8149.429539932385, 9924.603015879284, 10888.564457421615, 12040.337781422106, 12134.211276267015, 12463.439145238668, 10605.098566621924, 10663.733406664585, 10897.67306980792, 11009.394483303495, 11095.0, 10043.4476103815, 10444.007819257158, 10590.735231619272, 10977.670669879917, 11065.668029959113, 7580.393568514616, 10818.891811081789, 10947.233693641687, 11031.282966607145, 11106.888931110585, 6668.633225172662, 6914.55055421396, 7135.5361901476235, 7240.746573869889, 7391.2239214881665, 9381.859272110787, 10736.367911685416, 11027.79444111165, 11096.890310969162, 11210.775784484102], "value": 9015.759556209327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.4457794593193, 1406.1633328169737, 1533.2793587014103, 1725.232271639121, 1912.416712902564, 7460.925390746091, 7842.0, 8105.1489593592705, 8356.373272004594, 8371.372147088978, 8231.62957666905, 8233.464824786384, 8326.458780179284, 8342.874856877137, 8346.41575089744, 2023.2109477303864, 2254.233560589399, 2290.2098775922364, 2302.1021801497345, 2302.7466978632337, 2088.6136064828056, 2107.346722516025, 2114.164904862586, 2115.1010820401343, 2240.9103635854544, 2272.6022945984387, 2291.415688999303, 2298.8735619540917, 2302.700648915639, 2308.8730119843403, 2260.1185537640335, 2273.6930514380597, 2276.044061494168, 2278.293728944016, 2299.724033116037, 2257.582347265761, 2264.603694353498, 2286.0969916882905, 2291.2438895164555, 2293.323469576479, 8289.626966786509, 8351.33189344857, 8419.0, 8440.029396619406, 8447.535385553792, 5005.799768009275, 5177.870553236162, 5181.248718935771, 5186.429492755794, 5196.0, 3459.896203113911, 3477.3914564951288, 3530.064532898784, 3547.5388199533895, 3551.3607550640872, 1004.7739258666815, 1054.5307338234488, 1059.9046085852233, 1091.0889407344876, 1097.237419993105, 10837.83743243852, 10948.671539853816, 10953.068989135932, 10962.451877406178, 11028.503717332658, 4362.476502819682, 4501.41481607389, 4598.655100867449, 4600.677952543357, 4677.134730074879, 9489.051094890456, 9505.809883802285, 9519.381240219363, 9529.666461673809, 9543.141117299476, 5069.771860266297, 5170.17277235648, 5176.767045482887, 5178.016176926447, 5187.06632806091, 4528.320751887243, 4651.883702907455, 4677.7193368398, 4704.247320428715, 4736.123817093849, 3020.5771192032694, 3667.908302292464, 3780.11167375672, 3831.731778775459, 3920.0, 1267.3473161321926, 1267.9429425675867, 1288.491046036829, 1294.6569159172827, 1298.3248710670398, 840.4201101240125, 892.9641615725727, 914.2503147419186, 914.6158613382395, 921.8652107759714, 5435.10320797064, 5507.118860982224, 5694.9430505695245, 5766.0, 5782.108623026202, 913.853783394667, 942.7737343037759, 962.6871266838306, 964.252704154286, 1002.4236064263077, 3785.280796648628, 3952.4861767970556, 3954.248692748426, 3988.980055099706, 3990.5809889961715, 9384.202342800801, 9484.525773711286, 9823.607055717834, 9887.209023278121, 10048.0, 9852.605895764233, 10005.449700266556, 10011.749706257402, 10016.64941727036, 10021.09810117093, 7590.013298271189, 7876.488028278258, 7883.251091146332, 7884.526928384315, 7885.408594355446, 4988.12707776145, 5545.0, 5674.290713660793, 5755.395683453345, 5922.1412895130825, 9192.31057670664, 9217.953910230406, 9372.671956481763, 9386.15524602789, 9400.576974036048, 9060.411073280216, 9362.672306469241, 9389.24886009104, 9461.148496635336, 9494.762630934005, 7095.751648692478, 7219.711211551479, 7287.489875708649, 7300.890486642598, 7308.159561650478, 6926.168859736864, 7131.928680713334, 7824.647890844812, 7907.011623547057, 7909.406794490551, 6201.875962480635, 6879.5184337095925, 7135.5361901476235, 7143.82140446493, 7240.203577606354, 6957.1651401832105, 7058.0, 7100.7869763907165, 7139.32176443237, 7160.964195178991, 6611.371919667624, 6746.527743057939, 6747.595144291358, 6755.628440435823, 6773.458123350219, 4714.528547145258, 4840.782164802522, 4861.4895435980125, 4915.483874193158, 4997.075541024922, 4751.61987041029, 4841.298011788342, 4925.38432695913, 4956.8760780980765, 5043.697378157322], "value": 4408.103334456528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.4486766782953, 314.55804594544657, 352.89589571076533, 355.2106408752853, 375.19520628252417, 5063.924041139377, 5081.8475445736685, 5095.847124586264, 5097.668651537648, 5141.511556402141, 4506.6394688424925, 4523.977380113095, 4681.431720373679, 4797.280407938811, 5021.3221215135945, 3675.2726218677312, 3933.645971862532, 3979.0, 3985.9202815943663, 3988.6809055275653, 3468.601110872257, 3973.284808734427, 3987.3022221111332, 3991.5409727881374, 3995.9200815983663, 3817.7327587068776, 3930.842766289345, 3973.443717879499, 3985.561588225293, 3994.5034353529045, 3378.864845406181, 3893.6301051400073, 3949.8420063197436, 3952.288588054149, 4029.657479114279, 3184.506401507747, 3518.856371679189, 3523.559555055618, 3524.013276282645, 3528.311979164064, 4069.491313585802, 4955.4548999610015, 4969.726665033421, 4978.278149668277, 5011.649184557083, 3966.5240171179644, 3975.8012099395205, 4275.187714334297, 4363.629091527224, 4501.48232953208, 4409.36064270679, 4740.976295118537, 4979.850604481871, 5302.231176479428, 5314.97342513285, 3621.8953219268114, 3699.1491956850077, 3872.9806350968347, 3878.3212937736066, 3884.6309600587897, 4551.658625603093, 4735.668503204777, 4874.975625121851, 5529.778808847641, 5562.276904002494, 3330.58367704037, 3836.9040773980873, 3917.5494818095713, 3948.842046318115, 3957.2085582883537, 3239.3071898036255, 3360.5463262459743, 3591.2278860044694, 3770.8680196193, 3982.681385489154, 4005.8798236052967, 4520.886977825515, 4523.914260577438, 4528.456585209796, 4534.659900507475, 5117.590592752571, 5296.708681022581, 5312.468753124734, 5336.973315133399, 5376.973115134399, 1214.6416807041944, 1285.562908611058, 1293.6959814443599, 1296.4684479363416, 1306.660672810358, 818.9631466584018, 875.0811647769943, 894.4320356573622, 900.9909900900907, 918.8116436130578, 4060.878173654795, 4462.48681401643, 4509.751963642031, 4822.445418776885, 4829.396325459317, 4814.146553576898, 4821.63837712173, 5148.910653607805, 5163.831190899831, 5205.765740541685, 4110.794460276974, 4293.592108749664, 4611.492735799059, 4775.21209000511, 4824.734639594786, 2257.796798288162, 2425.733169351405, 2717.6331195288385, 2718.497078040569, 2719.891204351804, 4605.111904119362, 4827.637927155477, 5342.973285133549, 5459.508644222039, 5494.945050549443, 4748.95251047492, 4877.878053048702, 4929.605631549467, 5088.0587091388215, 5320.701165277553, 4853.684510506806, 4952.72174799589, 5370.382406023357, 5442.612133905829, 5476.1511965644595, 4315.611594956469, 4435.6249562635685, 4470.742275151028, 5150.034473455493, 5167.509086636764, 4547.431571053618, 4721.834735784369, 5009.574186194214, 5328.602129042024, 5471.179323101566, 5512.779488820403, 5605.5515558756015, 5759.654420734601, 5782.739776709974, 5821.476067153976, 3399.5070714746716, 3654.2508785698337, 3825.3521970805605, 3901.4733011043145, 4017.4978127734034, 4318.8903989127775, 5322.520973112439, 5417.566594672496, 5464.890702186013, 5505.256790333254, 5275.525202731773, 5281.55106815925, 5289.497497737709, 5294.179402192666, 5315.548178404879, 4276.251655960256, 4658.229872648372, 4771.809127634994, 5166.2508936204795, 5231.503007214461, 4576.382188404656, 5026.547610715053, 5142.151544995034, 5154.675234473819, 5253.711045892513, 4704.518076805932, 5053.913408617165, 5105.948940510547, 5236.921446178387, 5370.0, 4422.955770442383, 4800.927986080282, 4963.1636294571235, 5276.385675812081, 5285.762140703754], "value": 3863.711216897066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.3534818663203, 730.9218902119375, 764.1327093748597, 777.4412303331819, 791.964361603728, 13473.719996600332, 14905.32926018329, 15570.53288401347, 15586.0, 15593.376264949402, 13736.244506552135, 14125.152490850556, 14140.0, 14140.78788818166, 14169.079009864352, 691.7717153339411, 714.0, 720.8089856188114, 853.5262929074361, 866.9479831210148, 870.9129087091272, 871.4553404122423, 886.5124181700071, 887.0641473245723, 888.3115585421285, 919.2002957427048, 923.5982347678747, 929.9909598086085, 932.0167223579122, 932.0399988012358, 712.729162918093, 730.9451791115688, 923.1829830599934, 923.7598224461622, 924.713338864954, 533.967961922282, 675.7499725101744, 683.4907993544791, 686.3342557719004, 686.3376841348073, 14193.574192774233, 14246.430142794276, 14269.357878895475, 14274.785878211835, 14294.499692510817, 10937.0, 13065.673358166121, 13103.86896131036, 13105.410256538478, 13271.0, 12186.634400967985, 12417.93791031048, 12541.0, 12570.434330455151, 12770.48918043277, 3517.0, 3681.2821499807546, 3713.4615480755137, 3719.981400093009, 3793.0, 98454.5077274609, 104482.47758761233, 105567.99999999923, 106202.0, 106395.0, 8893.244074253631, 10355.896441035493, 10597.84103238452, 10601.522931468102, 10771.892281077246, 20326.695099573517, 20335.389938301876, 20357.287494937606, 20363.287284944956, 20406.877621730946, 6360.650164241011, 7270.272972702687, 7376.7786966391095, 7642.325186184791, 7680.654370553339, 4156.709030367845, 4275.3800698898485, 4276.444062271885, 4298.6131248187185, 4425.867223983286, 3205.487122060459, 3375.8987230383127, 3384.7799893006877, 3398.745094117951, 3401.166714155048, 663.4574614022417, 667.6795138333628, 670.1221399965963, 674.8481591641842, 679.5582871133803, 601.4316470934924, 637.8932552022238, 653.6666300186939, 665.7037618259828, 667.3226674924955, 9123.635054597742, 9207.76980575491, 9385.765355866159, 9603.991580883907, 9614.95192524033, 649.4836604899023, 676.4149011105359, 686.1765880942888, 693.4313862632592, 696.719283487557, 4408.647308215399, 4410.514843367227, 4629.490756016836, 4698.271767875985, 4736.719489647737, 73746.52506949939, 81437.0, 83483.16516834754, 85183.5740821292, 85383.57308213419, 81876.0, 82429.0, 83045.0, 84550.0, 84830.0, 70807.64596176986, 72022.63988679918, 72669.0, 73354.0, 77722.22277777264, 8883.644654214018, 9835.60657573689, 9856.260780441353, 9865.704028879145, 9877.456739879375, 41462.0, 46944.29583556318, 47972.280415793095, 48351.0, 48811.26783098328, 54497.72751136219, 64232.67883660552, 66187.66906165438, 68083.31916680769, 71131.0, 12458.0, 12548.121631485708, 12581.559645412734, 12649.367531623198, 13129.015323850941, 14291.0, 14360.712785744436, 14449.060811047248, 14548.781768273273, 14617.196054216694, 13351.866481335062, 13381.39783709716, 13512.459501619825, 13631.182129072287, 14055.929720351332, 13213.339333033118, 13349.399750040971, 13615.591532254048, 13701.246431446367, 13933.164010159018, 13106.541271055466, 13315.001374896729, 13317.53388631432, 13493.32533373347, 13792.724145517233, 10558.947205263925, 10879.357423315418, 10967.835482467928, 11296.548138074386, 11583.362915039754, 8775.0, 11119.44402779874, 11122.221444498808, 11510.59712910044, 11581.710457238636], "value": 7274.70927547468, "unit": "score"}], "name": "dromaeo_css", "value": 6966.349847321647, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 113.0, 115.0, 148.0, 113.0, 112.0, 112.0, 108.0, 125.0, 112.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 187.0, 186.0, 187.0, 182.0, 183.0, 201.0, 182.0, 187.0], "value": 186.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 91.0, 62.0, 59.0, 59.0, 59.0, 74.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 87.0, 70.0, 68.0, 67.0, 84.0, 69.0, 68.0, 86.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 112.0, 109.0, 113.0, 109.0, 112.0, 109.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 107.0, 98.0, 97.0, 96.0, 97.0, 96.0, 97.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 88.0, 86.0, 86.0, 88.0, 87.0, 87.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 66.0, 77.0, 73.0, 95.0, 103.0, 103.0, 78.0, 73.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 77.0, 102.0, 107.0, 107.0, 107.0, 77.0, 96.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 130.0, 144.0, 143.0, 154.0, 155.0, 148.0, 250.0, 168.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 169.0, 169.0, 172.0, 171.0, 175.0, 170.0, 172.0, 170.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 66.0, 66.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1485.4999999999998, "alertThreshold": 2.0}]} 21:34:35 INFO - Return code: 0 21:34:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:34:35 INFO - # TBPL SUCCESS # 21:34:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:35 INFO - 2016-12-17 21:34:35.357 screenresolution[1941:18006] starting screenresolution argv=screenresolution get 21:34:35 INFO - 2016-12-17 21:34:35.360 screenresolution[1941:18006] Display 0: 1600x1200x32@60 21:34:35 INFO - 2016-12-17 21:34:35.366 screenresolution[1942:18009] starting screenresolution argv=screenresolution list 21:34:35 INFO - Available Modes on Display 0 21:34:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:35 INFO - Intel Iris: 21:34:35 INFO - Chipset Model: Intel Iris 21:34:35 INFO - Type: GPU 21:34:35 INFO - Bus: Built-In 21:34:35 INFO - VRAM (Dynamic, Max): 1536 MB 21:34:35 INFO - Vendor: Intel (0x8086) 21:34:35 INFO - Device ID: 0x0a2e 21:34:35 INFO - Revision ID: 0x0009 21:34:35 INFO - Displays: 21:34:35 INFO - Display: 21:34:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:35 INFO - Display Serial Number: 1600x1200 60 21:34:35 INFO - Main Display: Yes 21:34:35 INFO - Mirror: Off 21:34:35 INFO - Online: Yes 21:34:35 INFO - Rotation: Supported 21:34:35 INFO - Return code: 0 21:34:35 INFO - Running post-action listener: _resource_record_post_action 21:34:35 INFO - [mozharness: 2016-12-18 05:34:35.608960Z] Finished run-tests step (success) 21:34:35 INFO - Running post-run listener: _resource_record_post_run 21:34:35 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 606208; Write bytes: 554986496; Read time: 7; Write time: 1695 21:34:35 INFO - TinderboxPrint: CPU usage
53.8% 21:34:35 INFO - TinderboxPrint: I/O read bytes / time
606,208 / 7 21:34:35 INFO - TinderboxPrint: I/O write bytes / time
554,986,496 / 1,695 21:34:35 INFO - TinderboxPrint: CPU idle
2,225.5 (46.2%) 21:34:35 INFO - TinderboxPrint: CPU system
964.8 (20.0%) 21:34:35 INFO - TinderboxPrint: CPU user
1,623.4 (33.7%) 21:34:35 INFO - TinderboxPrint: Swap in / out
249,683,968 / 0 21:34:35 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247407104; Write bytes: 241956864; Read time: 18108; Write time: 509 21:34:35 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 540672; Write bytes: 301446144; Read time: 5; Write time: 1151 21:34:36 INFO - Running post-run listener: _upload_blobber_files 21:34:36 INFO - Blob upload gear active. 21:34:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:34:36 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:34:36 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:34:36 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:37 INFO - (blobuploader) - INFO - Done attempting. 21:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:34:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:38 INFO - (blobuploader) - INFO - Done attempting. 21:34:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:34:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:39 INFO - (blobuploader) - INFO - Done attempting. 21:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:41 INFO - (blobuploader) - INFO - Done attempting. 21:34:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:41 INFO - Return code: 0 21:34:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cb47e78eb001f04c58e346aaf6b774252b5c5384c9bbbf899ab789513f70f21b80b1fb688f31d884441bf39d1d16fe1ae07cb11a9766a075bbb82f6fcf40503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b29530e563a5b44cd9749b4d0f6ecab870aab22b49246254c684a4b3f2fb9e5764adb3b5e18d978c858e513a43fbe4b0fe919c031eded4fa7d40cc2646f4086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e52305568e606fe8c4d1f0507336797b5e21ac10bba15692b6cc1904af55ac6b0ae0eedbbabc2092c5e940a329fb6a00e63d68c7d30863ddced18975c182156", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7120c536a3e56da531cb84d733a109e9b922fed74d4485e30a77876e5518036184ef7c663912e9790499d76846ed664801ceab877beb55647339215fc2122031"} 21:34:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:41 INFO - Contents: 21:34:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cb47e78eb001f04c58e346aaf6b774252b5c5384c9bbbf899ab789513f70f21b80b1fb688f31d884441bf39d1d16fe1ae07cb11a9766a075bbb82f6fcf40503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b29530e563a5b44cd9749b4d0f6ecab870aab22b49246254c684a4b3f2fb9e5764adb3b5e18d978c858e513a43fbe4b0fe919c031eded4fa7d40cc2646f4086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e52305568e606fe8c4d1f0507336797b5e21ac10bba15692b6cc1904af55ac6b0ae0eedbbabc2092c5e940a329fb6a00e63d68c7d30863ddced18975c182156", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7120c536a3e56da531cb84d733a109e9b922fed74d4485e30a77876e5518036184ef7c663912e9790499d76846ed664801ceab877beb55647339215fc2122031"} 21:34:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:41 INFO - Copying logs to upload dir... 21:34:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.351666 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-17 21:34:41.683368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 21:34:41.687431) ========= 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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cb47e78eb001f04c58e346aaf6b774252b5c5384c9bbbf899ab789513f70f21b80b1fb688f31d884441bf39d1d16fe1ae07cb11a9766a075bbb82f6fcf40503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b29530e563a5b44cd9749b4d0f6ecab870aab22b49246254c684a4b3f2fb9e5764adb3b5e18d978c858e513a43fbe4b0fe919c031eded4fa7d40cc2646f4086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e52305568e606fe8c4d1f0507336797b5e21ac10bba15692b6cc1904af55ac6b0ae0eedbbabc2092c5e940a329fb6a00e63d68c7d30863ddced18975c182156", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7120c536a3e56da531cb84d733a109e9b922fed74d4485e30a77876e5518036184ef7c663912e9790499d76846ed664801ceab877beb55647339215fc2122031"} build_url:https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/HT6Tp-7cQ428YhkL5HAdpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cb47e78eb001f04c58e346aaf6b774252b5c5384c9bbbf899ab789513f70f21b80b1fb688f31d884441bf39d1d16fe1ae07cb11a9766a075bbb82f6fcf40503", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b29530e563a5b44cd9749b4d0f6ecab870aab22b49246254c684a4b3f2fb9e5764adb3b5e18d978c858e513a43fbe4b0fe919c031eded4fa7d40cc2646f4086", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e52305568e606fe8c4d1f0507336797b5e21ac10bba15692b6cc1904af55ac6b0ae0eedbbabc2092c5e940a329fb6a00e63d68c7d30863ddced18975c182156", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7120c536a3e56da531cb84d733a109e9b922fed74d4485e30a77876e5518036184ef7c663912e9790499d76846ed664801ceab877beb55647339215fc2122031"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 21:34:41.722139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:34:41.722453) ========= 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.L9hCjDEyuX/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.XDA4ITfW4D/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:34:41.772157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 21:34:41.772888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 21:34:41.773499) ========= ========= Total master_lag: 0.19 =========