builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0220 starttime: 1477023318.61 results: success (0) buildid: 20161020200849 builduid: 22729866934548208d7f102f00df1503 revision: 10be9d40fa865be7c3c203b9cd042722ab3069ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.607434) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.607891) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.608159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.633090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.633461) ========= 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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-20 21:15:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-10-20 21:15:18 (37.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.739529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.739840) ========= 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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.026556 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:18.788315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 21:15:18.788674) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 10be9d40fa865be7c3c203b9cd042722ab3069ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 10be9d40fa865be7c3c203b9cd042722ab3069ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-20 21:15:18,869 truncating revision to first 12 chars 2016-10-20 21:15:18,869 Setting DEBUG logging. 2016-10-20 21:15:18,869 attempt 1/10 2016-10-20 21:15:18,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/10be9d40fa86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 21:15:20,641 unpacking tar archive at: mozilla-aurora-10be9d40fa86/testing/mozharness/ program finished with exit code 0 elapsedTime=2.056778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 21:15:20.868933) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:20.869426) ========= script_repo_revision: 10be9d40fa865be7c3c203b9cd042722ab3069ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:20.870073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:20.870554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 21:15:20.889776) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-20 21:15:20.890300) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:21 INFO - MultiFileLogger online at 20161020 21:15:21 in /builds/slave/test 21:15:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:15:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:15:21 INFO - {'append_to_log': False, 21:15:21 INFO - 'base_work_dir': '/builds/slave/test', 21:15:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:15:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:15:21 INFO - 'branch': 'Mozilla-Aurora', 21:15:21 INFO - 'buildbot_json_path': 'buildprops.json', 21:15:21 INFO - 'config_files': ('talos/mac_config.py',), 21:15:21 INFO - 'default_actions': ('clobber', 21:15:21 INFO - 'read-buildbot-config', 21:15:21 INFO - 'download-and-extract', 21:15:21 INFO - 'populate-webroot', 21:15:21 INFO - 'create-virtualenv', 21:15:21 INFO - 'install', 21:15:21 INFO - 'run-tests'), 21:15:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:15:21 INFO - 'download_minidump_stackwalk': True, 21:15:21 INFO - 'download_symbols': 'ondemand', 21:15:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:15:21 INFO - 'tooltool.py': '/tools/tooltool.py', 21:15:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:15:21 INFO - '/tools/misc-python/virtualenv.py')}, 21:15:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:15:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:15:21 INFO - 'installer_path': 'installer.exe', 21:15:21 INFO - 'log_level': 'info', 21:15:21 INFO - 'log_name': 'talos', 21:15:21 INFO - 'log_to_console': True, 21:15:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:15:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:15:21 INFO - 'opt_config_files': (), 21:15:21 INFO - 'pip_index': False, 21:15:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:15:21 INFO - 'cmd': ('bash', 21:15:21 INFO - '-c', 21:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:15:21 INFO - 'enabled': True, 21:15:21 INFO - 'halt_on_failure': False, 21:15:21 INFO - 'name': 'check_screen_resolution'},), 21:15:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:15:21 INFO - 'cmd': ('bash', 21:15:21 INFO - '-c', 21:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:15:21 INFO - 'enabled': True, 21:15:21 INFO - 'halt_on_failure': False, 21:15:21 INFO - 'name': 'check_screen_resolution'},), 21:15:21 INFO - 'run_cmd_checks_enabled': True, 21:15:21 INFO - 'sps_profile': False, 21:15:21 INFO - 'sps_profile_interval': 0, 21:15:21 INFO - 'suite': 'dromaeojs', 21:15:21 INFO - 'system_bits': '32', 21:15:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:15:21 INFO - 'title': 't-yosemite-r7-0220', 21:15:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:15:21 INFO - 'use_talos_json': True, 21:15:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:15:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:15:21 INFO - 'work_dir': 'build'} 21:15:21 INFO - [mozharness: 2016-10-21 04:15:21.080440Z] Running clobber step. 21:15:21 INFO - Running pre-action listener: _resource_record_pre_action 21:15:21 INFO - Running main action method: clobber 21:15:21 INFO - rmtree: /builds/slave/test/build 21:15:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:15:21 INFO - Running post-action listener: _resource_record_post_action 21:15:21 INFO - [mozharness: 2016-10-21 04:15:21.228356Z] Finished clobber step (success) 21:15:21 INFO - [mozharness: 2016-10-21 04:15:21.228509Z] Running read-buildbot-config step. 21:15:21 INFO - Running pre-action listener: _resource_record_pre_action 21:15:21 INFO - Running main action method: read_buildbot_config 21:15:21 INFO - Using buildbot properties: 21:15:21 INFO - { 21:15:21 INFO - "project": "", 21:15:21 INFO - "product": "firefox", 21:15:21 INFO - "script_repo_revision": "production", 21:15:21 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:15:21 INFO - "repository": "", 21:15:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:15:21 INFO - "buildid": "20161020200849", 21:15:21 INFO - "pgo_build": "False", 21:15:21 INFO - "basedir": "/builds/slave/test", 21:15:21 INFO - "buildnumber": 58, 21:15:21 INFO - "slavename": "t-yosemite-r7-0220", 21:15:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:15:21 INFO - "platform": "yosemite_r7", 21:15:21 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:15:21 INFO - "branch": "mozilla-aurora", 21:15:21 INFO - "repo_path": "releases/mozilla-aurora", 21:15:21 INFO - "revision": "10be9d40fa865be7c3c203b9cd042722ab3069ca", 21:15:21 INFO - "stage_platform": "macosx64", 21:15:21 INFO - "builduid": "22729866934548208d7f102f00df1503", 21:15:21 INFO - "slavebuilddir": "test" 21:15:21 INFO - } 21:15:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:15:21 INFO - Running post-action listener: _resource_record_post_action 21:15:21 INFO - [mozharness: 2016-10-21 04:15:21.232604Z] Finished read-buildbot-config step (success) 21:15:21 INFO - [mozharness: 2016-10-21 04:15:21.232741Z] Running download-and-extract step. 21:15:21 INFO - Running pre-action listener: _resource_record_pre_action 21:15:21 INFO - Running main action method: download_and_extract 21:15:21 INFO - mkdir: /builds/slave/test/build/tests 21:15: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:15:21 INFO - trying https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:15:21 INFO - Downloading https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 21:15:22 INFO - Downloaded 1199 bytes. 21:15:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:15:22 INFO - Using the following test package requirements: 21:15:22 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:15:22 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:15:22 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:15:22 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'jsshell-mac.zip'], 21:15:22 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:15:22 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:15:22 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:15:22 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:15:22 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:15:22 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:15:22 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:15:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:15:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:15:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:15:22 INFO - Fetch https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:15:23 INFO - Expected file size: 16436525 21:15:30 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:15:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:15:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:15:30 INFO - Fetch https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:15:30 INFO - Expected file size: 16436525 21:15:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:15:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:15:37 INFO - Fetch https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:15:37 INFO - Expected file size: 14414081 21:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:38 INFO - trying https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:15:38 INFO - Downloading https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 21:15:41 INFO - Downloaded 115423611 bytes. 21:15:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:15:41 INFO - mkdir: /builds/slave/test/properties 21:15:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:15:41 INFO - Writing to file /builds/slave/test/properties/build_url 21:15:41 INFO - Contents: 21:15:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:15:42 INFO - Running post-action listener: _resource_record_post_action 21:15:42 INFO - Running post-action listener: set_extra_try_arguments 21:15:42 INFO - [mozharness: 2016-10-21 04:15:42.213535Z] Finished download-and-extract step (success) 21:15:42 INFO - [mozharness: 2016-10-21 04:15:42.213656Z] Running populate-webroot step. 21:15:42 INFO - Running pre-action listener: _resource_record_pre_action 21:15:42 INFO - Running main action method: populate_webroot 21:15:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:15:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:15:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:15:42 INFO - '--tppagecycles', 21:15:42 INFO - '7'], 21:15:42 INFO - 'tests': ['tsvgm']}}, 21:15:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:15:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:15:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:15:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:15:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:15:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:15:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['damp', 'tps']}, 21:15:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'tests': ['damp', 'tps']}, 21:15:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['dromaeo_dom']}, 21:15:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:15:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['basic_compositor_video']}, 21:15:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:15:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['a11yr', 21:15:42 INFO - 'ts_paint', 21:15:42 INFO - 'tpaint', 21:15:42 INFO - 'sessionrestore', 21:15:42 INFO - 'sessionrestore_no_auto_restore', 21:15:42 INFO - 'tabpaint']}, 21:15:42 INFO - 'other-e10s': {'tests': ['a11yr', 21:15:42 INFO - 'ts_paint', 21:15:42 INFO - 'tpaint', 21:15:42 INFO - 'sessionrestore', 21:15:42 INFO - 'sessionrestore_no_auto_restore', 21:15:42 INFO - 'tabpaint']}, 21:15:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:15:42 INFO - 'ts_paint', 21:15:42 INFO - 'tpaint', 21:15:42 INFO - 'sessionrestore', 21:15:42 INFO - 'sessionrestore_no_auto_restore', 21:15:42 INFO - 'tabpaint']}, 21:15:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:15:42 INFO - 'ts_paint', 21:15:42 INFO - 'tpaint', 21:15:42 INFO - 'sessionrestore', 21:15:42 INFO - 'sessionrestore_no_auto_restore', 21:15:42 INFO - 'tabpaint']}, 21:15:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['a11yr', 21:15:42 INFO - 'ts_paint', 21:15:42 INFO - 'tpaint', 21:15:42 INFO - 'sessionrestore', 21:15:42 INFO - 'sessionrestore_no_auto_restore', 21:15:42 INFO - 'tabpaint']}, 21:15:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['a11yr', 21:15:42 INFO - 'ts_paint', 21:15:42 INFO - 'tpaint', 21:15:42 INFO - 'sessionrestore', 21:15:42 INFO - 'sessionrestore_no_auto_restore', 21:15:42 INFO - 'tabpaint']}, 21:15:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['tsvgx', 21:15:42 INFO - 'tsvgr_opacity', 21:15:42 INFO - 'tart', 21:15:42 INFO - 'tscrollx', 21:15:42 INFO - 'cart']}, 21:15:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:15:42 INFO - 'tsvgr_opacity', 21:15:42 INFO - 'tart', 21:15:42 INFO - 'tscrollx', 21:15:42 INFO - 'cart']}, 21:15:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'talos_options': ['--disable-e10s'], 21:15:42 INFO - 'tests': ['tp5o']}, 21:15:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'tests': ['tp5o']}, 21:15:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'talos_options': ['--disable-e10s', 21:15:42 INFO - '--xperf_path', 21:15:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:15:42 INFO - 'tests': ['tp5n']}, 21:15:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:42 INFO - 'talos_options': ['--xperf_path', 21:15:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:15:42 INFO - 'tests': ['tp5n']}}, 21:15:42 INFO - 'talos.zip': {'path': '', 21:15:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:15:42 INFO - Running post-action listener: _resource_record_post_action 21:15:42 INFO - [mozharness: 2016-10-21 04:15:42.232258Z] Finished populate-webroot step (success) 21:15:42 INFO - [mozharness: 2016-10-21 04:15:42.232395Z] Running create-virtualenv step. 21:15:42 INFO - Running pre-action listener: _resource_record_pre_action 21:15:42 INFO - Running main action method: create_virtualenv 21:15:42 INFO - Creating virtualenv /builds/slave/test/build/venv 21:15:42 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:15:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:15:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:15:42 INFO - Using real prefix '/tools/python27' 21:15:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:15:43 INFO - Installing distribute.............................................................................................................................................................................................done. 21:15:45 INFO - Installing pip.................done. 21:15:45 INFO - Return code: 0 21:15:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:15:45 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:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:45 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:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:45 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:45 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:15:45 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:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:45 INFO - 'HOME': '/Users/cltbld', 21:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:45 INFO - 'LOGNAME': 'cltbld', 21:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:45 INFO - 'MOZ_NO_REMOTE': '1', 21:15:45 INFO - 'NO_EM_RESTART': '1', 21:15:45 INFO - 'PAGER': '/bin/cat', 21:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:45 INFO - 'PWD': '/builds/slave/test', 21:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:45 INFO - 'SHELL': '/bin/bash', 21:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:15:45 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:45 INFO - 'USER': 'cltbld', 21:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:45 INFO - 'XPC_FLAGS': '0x0', 21:15:45 INFO - 'XPC_SERVICE_NAME': '0', 21:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:46 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:15:46 INFO - Cleaning up... 21:15:46 INFO - Return code: 0 21:15:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:15:46 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:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:46 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:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:46 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:46 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:15:46 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:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:46 INFO - 'HOME': '/Users/cltbld', 21:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:46 INFO - 'LOGNAME': 'cltbld', 21:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:46 INFO - 'MOZ_NO_REMOTE': '1', 21:15:46 INFO - 'NO_EM_RESTART': '1', 21:15:46 INFO - 'PAGER': '/bin/cat', 21:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:46 INFO - 'PWD': '/builds/slave/test', 21:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:46 INFO - 'SHELL': '/bin/bash', 21:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:15:46 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:46 INFO - 'USER': 'cltbld', 21:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:46 INFO - 'XPC_FLAGS': '0x0', 21:15:46 INFO - 'XPC_SERVICE_NAME': '0', 21:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:46 INFO - Downloading/unpacking psutil>=3.1.1 21:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:15:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:15:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:15:49 INFO - Installing collected packages: psutil 21:15:49 INFO - Running setup.py install for psutil 21:15:49 INFO - building 'psutil._psutil_osx' extension 21:15:49 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:15:50 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:15:50 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:15:50 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:15:50 INFO - building 'psutil._psutil_posix' extension 21:15:50 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:15:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:15:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:15:50 INFO - ^ 21:15:50 INFO - 1 warning generated. 21:15:50 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:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:15:50 INFO - Successfully installed psutil 21:15:50 INFO - Cleaning up... 21:15:50 INFO - Return code: 0 21:15:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:50 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:50 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:15:50 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:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:50 INFO - 'HOME': '/Users/cltbld', 21:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:50 INFO - 'LOGNAME': 'cltbld', 21:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:50 INFO - 'MOZ_NO_REMOTE': '1', 21:15:50 INFO - 'NO_EM_RESTART': '1', 21:15:50 INFO - 'PAGER': '/bin/cat', 21:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:50 INFO - 'PWD': '/builds/slave/test', 21:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:50 INFO - 'SHELL': '/bin/bash', 21:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:15:50 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:50 INFO - 'USER': 'cltbld', 21:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:50 INFO - 'XPC_FLAGS': '0x0', 21:15:50 INFO - 'XPC_SERVICE_NAME': '0', 21:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:15:53 INFO - Installing collected packages: mozsystemmonitor 21:15:53 INFO - Running setup.py install for mozsystemmonitor 21:15:53 INFO - Successfully installed mozsystemmonitor 21:15:53 INFO - Cleaning up... 21:15:53 INFO - Return code: 0 21:15:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:53 INFO - 'HOME': '/Users/cltbld', 21:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:53 INFO - 'LOGNAME': 'cltbld', 21:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:53 INFO - 'MOZ_NO_REMOTE': '1', 21:15:53 INFO - 'NO_EM_RESTART': '1', 21:15:53 INFO - 'PAGER': '/bin/cat', 21:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:53 INFO - 'PWD': '/builds/slave/test', 21:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:53 INFO - 'SHELL': '/bin/bash', 21:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:15:53 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:53 INFO - 'USER': 'cltbld', 21:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:53 INFO - 'XPC_FLAGS': '0x0', 21:15:53 INFO - 'XPC_SERVICE_NAME': '0', 21:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:54 INFO - Downloading/unpacking jsonschema==2.5.1 21:15:54 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:15:54 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:15:54 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:15:54 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:15:54 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:15:54 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:15:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:15:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:15:57 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:15:57 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:15:57 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:15:57 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:15:57 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:15:57 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:15:57 INFO - Downloading functools32-3.2.3-2.tar.gz 21:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:15:57 INFO - warning: no files found matching '*.txt' 21:15:57 INFO - no previously-included directories found matching 'build' 21:15:57 INFO - no previously-included directories found matching 'dist' 21:15:57 INFO - no previously-included directories found matching '.git*' 21:15:58 INFO - Installing collected packages: jsonschema, functools32 21:15:58 INFO - Running setup.py install for functools32 21:15:58 INFO - warning: no files found matching '*.txt' 21:15:58 INFO - no previously-included directories found matching 'build' 21:15:58 INFO - no previously-included directories found matching 'dist' 21:15:58 INFO - no previously-included directories found matching '.git*' 21:15:58 INFO - Successfully installed jsonschema functools32 21:15:58 INFO - Cleaning up... 21:15:58 INFO - Return code: 0 21:15:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:58 INFO - 'HOME': '/Users/cltbld', 21:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:58 INFO - 'LOGNAME': 'cltbld', 21:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:58 INFO - 'MOZ_NO_REMOTE': '1', 21:15:58 INFO - 'NO_EM_RESTART': '1', 21:15:58 INFO - 'PAGER': '/bin/cat', 21:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:58 INFO - 'PWD': '/builds/slave/test', 21:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:58 INFO - 'SHELL': '/bin/bash', 21:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:15:58 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:58 INFO - 'USER': 'cltbld', 21:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:58 INFO - 'XPC_FLAGS': '0x0', 21:15:58 INFO - 'XPC_SERVICE_NAME': '0', 21:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:15:58 INFO - Cleaning up... 21:15:58 INFO - Return code: 0 21:15:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:58 INFO - 'HOME': '/Users/cltbld', 21:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:58 INFO - 'LOGNAME': 'cltbld', 21:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:58 INFO - 'MOZ_NO_REMOTE': '1', 21:15:58 INFO - 'NO_EM_RESTART': '1', 21:15:58 INFO - 'PAGER': '/bin/cat', 21:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:58 INFO - 'PWD': '/builds/slave/test', 21:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:58 INFO - 'SHELL': '/bin/bash', 21:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:15:58 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:58 INFO - 'USER': 'cltbld', 21:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:58 INFO - 'XPC_FLAGS': '0x0', 21:15:58 INFO - 'XPC_SERVICE_NAME': '0', 21:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:01 INFO - Downloading blobuploader-1.2.4.tar.gz 21:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:16:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:16:01 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:16:01 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:16:01 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:16:01 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:16:01 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:16:01 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:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:16:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:16:02 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:16:02 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:16:02 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:16:02 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:16:02 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:16:02 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:16:02 INFO - Downloading docopt-0.6.1.tar.gz 21:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:16:02 INFO - Installing collected packages: blobuploader, requests, docopt 21:16:02 INFO - Running setup.py install for blobuploader 21:16:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:16:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:16:02 INFO - Running setup.py install for requests 21:16:03 INFO - Running setup.py install for docopt 21:16:03 INFO - Successfully installed blobuploader requests docopt 21:16:03 INFO - Cleaning up... 21:16:03 INFO - Return code: 0 21:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:03 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:16:03 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:16:03 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:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:03 INFO - 'HOME': '/Users/cltbld', 21:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:03 INFO - 'LOGNAME': 'cltbld', 21:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:03 INFO - 'MOZ_NO_REMOTE': '1', 21:16:03 INFO - 'NO_EM_RESTART': '1', 21:16:03 INFO - 'PAGER': '/bin/cat', 21:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:03 INFO - 'PWD': '/builds/slave/test', 21:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:03 INFO - 'SHELL': '/bin/bash', 21:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:16:03 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:03 INFO - 'USER': 'cltbld', 21:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:03 INFO - 'XPC_FLAGS': '0x0', 21:16:03 INFO - 'XPC_SERVICE_NAME': '0', 21:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:03 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-NIeTNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:03 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-CIScPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:03 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yl9hJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gfeZp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-NcFiJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-6SJZZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Z1iTfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pN3ET1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BkA1le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Gkvtsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lhiwTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-w5x_lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3dCIGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xyCyh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-myrbZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HIjNyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3KSEuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:16:05 INFO - Running setup.py install for manifestparser 21:16:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:16:05 INFO - Running setup.py install for mozcrash 21:16:05 INFO - Running setup.py install for mozdebug 21:16:05 INFO - Running setup.py install for mozdevice 21:16:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Running setup.py install for mozfile 21:16:06 INFO - Running setup.py install for mozhttpd 21:16:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Running setup.py install for mozinfo 21:16:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Running setup.py install for mozInstall 21:16:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Running setup.py install for mozleak 21:16:06 INFO - Running setup.py install for mozlog 21:16:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:16:06 INFO - Running setup.py install for moznetwork 21:16:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:16:07 INFO - Running setup.py install for mozprocess 21:16:07 INFO - Running setup.py install for mozprofile 21:16:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:16:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:16:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:16:07 INFO - Running setup.py install for mozrunner 21:16:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:16:07 INFO - Running setup.py install for mozscreenshot 21:16:07 INFO - Running setup.py install for moztest 21:16:07 INFO - Running setup.py install for mozversion 21:16:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:16:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:16:08 INFO - Cleaning up... 21:16:08 INFO - Return code: 0 21:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:08 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:16:08 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:16:08 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:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:08 INFO - 'HOME': '/Users/cltbld', 21:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:08 INFO - 'LOGNAME': 'cltbld', 21:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:08 INFO - 'MOZ_NO_REMOTE': '1', 21:16:08 INFO - 'NO_EM_RESTART': '1', 21:16:08 INFO - 'PAGER': '/bin/cat', 21:16:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:08 INFO - 'PWD': '/builds/slave/test', 21:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:08 INFO - 'SHELL': '/bin/bash', 21:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:16:08 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:08 INFO - 'USER': 'cltbld', 21:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:08 INFO - 'XPC_FLAGS': '0x0', 21:16:08 INFO - 'XPC_SERVICE_NAME': '0', 21:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SHg9mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-o4GY0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Fw3XJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mSSP99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pd6ukV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lixeUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:08 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:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-AENiMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BkXLFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pdllIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gHIFYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-x7R80E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BnmWzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-KXH5Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xiMDfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SfbXqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:09 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:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SGcu0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:10 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:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-OMKZSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:10 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:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:16:10 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:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:16:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:16:10 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:16:10 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:16:10 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:16:10 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:16:10 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:16:10 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:16:12 INFO - Downloading blessings-1.6.tar.gz 21:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:16:12 INFO - Installing collected packages: blessings 21:16:12 INFO - Running setup.py install for blessings 21:16:12 INFO - Successfully installed blessings 21:16:12 INFO - Cleaning up... 21:16:13 INFO - Return code: 0 21:16:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:13 INFO - Reading from file tmpfile_stdout 21:16:13 INFO - Current package versions: 21:16:13 INFO - blessings == 1.6 21:16:13 INFO - blobuploader == 1.2.4 21:16:13 INFO - docopt == 0.6.1 21:16:13 INFO - functools32 == 3.2.3-2 21:16:13 INFO - jsonschema == 2.5.1 21:16:13 INFO - manifestparser == 1.1 21:16:13 INFO - mozInstall == 1.12 21:16:13 INFO - mozcrash == 0.17 21:16:13 INFO - mozdebug == 0.1 21:16:13 INFO - mozdevice == 0.48 21:16:13 INFO - mozfile == 1.2 21:16:13 INFO - mozhttpd == 0.7 21:16:13 INFO - mozinfo == 0.9 21:16:13 INFO - mozleak == 0.1 21:16:13 INFO - mozlog == 3.4 21:16:13 INFO - moznetwork == 0.27 21:16:13 INFO - mozprocess == 0.23 21:16:13 INFO - mozprofile == 0.28 21:16:13 INFO - mozrunner == 6.12 21:16:13 INFO - mozscreenshot == 0.1 21:16:13 INFO - mozsystemmonitor == 0.3 21:16:13 INFO - moztest == 0.7 21:16:13 INFO - mozversion == 1.4 21:16:13 INFO - psutil == 3.1.1 21:16:13 INFO - requests == 1.2.3 21:16:13 INFO - wsgiref == 0.1.2 21:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:13 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:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:13 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:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:13 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:16:13 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:16:13 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:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:13 INFO - 'HOME': '/Users/cltbld', 21:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:13 INFO - 'LOGNAME': 'cltbld', 21:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:13 INFO - 'MOZ_NO_REMOTE': '1', 21:16:13 INFO - 'NO_EM_RESTART': '1', 21:16:13 INFO - 'PAGER': '/bin/cat', 21:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:13 INFO - 'PWD': '/builds/slave/test', 21:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:13 INFO - 'SHELL': '/bin/bash', 21:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:16:13 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:13 INFO - 'USER': 'cltbld', 21:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:13 INFO - 'XPC_FLAGS': '0x0', 21:16:13 INFO - 'XPC_SERVICE_NAME': '0', 21:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 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:16:13 INFO - Cleaning up... 21:16:13 INFO - Return code: 0 21:16:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:16:13 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:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:13 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:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:14 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 0x1066e1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1f0599330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, '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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:16:14 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:16:14 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:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:14 INFO - 'HOME': '/Users/cltbld', 21:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:14 INFO - 'LOGNAME': 'cltbld', 21:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:14 INFO - 'MOZ_NO_REMOTE': '1', 21:16:14 INFO - 'NO_EM_RESTART': '1', 21:16:14 INFO - 'PAGER': '/bin/cat', 21:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:14 INFO - 'PWD': '/builds/slave/test', 21:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:14 INFO - 'SHELL': '/bin/bash', 21:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:16:14 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:14 INFO - 'USER': 'cltbld', 21:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:14 INFO - 'XPC_FLAGS': '0x0', 21:16:14 INFO - 'XPC_SERVICE_NAME': '0', 21:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:16:14 INFO - Cleaning up... 21:16:14 INFO - Return code: 0 21:16:14 INFO - Running post-action listener: _resource_record_post_action 21:16:14 INFO - Running post-action listener: _start_resource_monitoring 21:16:14 INFO - Starting resource monitoring. 21:16:14 INFO - [mozharness: 2016-10-21 04:16:14.613254Z] Finished create-virtualenv step (success) 21:16:14 INFO - [mozharness: 2016-10-21 04:16:14.614200Z] Running install step. 21:16:14 INFO - Running pre-action listener: _resource_record_pre_action 21:16:14 INFO - Running main action method: install 21:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:14 INFO - Reading from file tmpfile_stdout 21:16:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:16:14 INFO - Reading from file tmpfile_stdout 21:16:14 INFO - Output received: 21:16:14 INFO - Usage: mozinstall [options] installer 21:16:14 INFO - Options: 21:16:14 INFO - -h, --help show this help message and exit 21:16:14 INFO - -d DEST, --destination=DEST 21:16:14 INFO - Directory to install application into. [default: 21:16:14 INFO - "/builds/slave/test"] 21:16:14 INFO - --app=APP Application being installed. [default: firefox] 21:16:14 INFO - mkdir: /builds/slave/test/build/application 21:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:16:47 INFO - Reading from file tmpfile_stdout 21:16:47 INFO - Output received: 21:16:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:16:47 INFO - Running post-action listener: _resource_record_post_action 21:16:47 INFO - [mozharness: 2016-10-21 04:16:47.131463Z] Finished install step (success) 21:16:47 INFO - [mozharness: 2016-10-21 04:16:47.131585Z] Running run-tests step. 21:16:47 INFO - Running pre-action listener: _resource_record_pre_action 21:16:47 INFO - Running main action method: run_tests 21:16:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:16:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:16:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:16:47 INFO - 2016-10-20 21:16:47.145 screenresolution[1641:7445] starting screenresolution argv=screenresolution get 21:16:47 INFO - 2016-10-20 21:16:47.148 screenresolution[1641:7445] Display 0: 1600x1200x32@60 21:16:47 INFO - 2016-10-20 21:16:47.154 screenresolution[1642:7447] starting screenresolution argv=screenresolution list 21:16:47 INFO - Available Modes on Display 0 21:16:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:16:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:16:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:16:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:16:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:16:47 INFO - Intel Iris: 21:16:47 INFO - Chipset Model: Intel Iris 21:16:47 INFO - Type: GPU 21:16:47 INFO - Bus: Built-In 21:16:47 INFO - VRAM (Dynamic, Max): 1536 MB 21:16:47 INFO - Vendor: Intel (0x8086) 21:16:47 INFO - Device ID: 0x0a2e 21:16:47 INFO - Revision ID: 0x0009 21:16:47 INFO - Displays: 21:16:47 INFO - Display: 21:16:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:16:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:16:47 INFO - Display Serial Number: 1600x1200 60 21:16:47 INFO - Main Display: Yes 21:16:47 INFO - Mirror: Off 21:16:47 INFO - Online: Yes 21:16:47 INFO - Rotation: Supported 21:16:47 INFO - Return code: 0 21:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:16:47 INFO - Python 2.7.3 21:16:47 INFO - Return code: 0 21:16:47 INFO - grabbing minidump binary from tooltool 21:16:47 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:16:47 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 0x1064f5d30>, '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 0x10635bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064edb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:16:47 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:16:47 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:16:47 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:16:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:16:47 INFO - Return code: 0 21:16:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:16:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:16:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:16:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:16:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KgxR2yNaPV/Render', 21:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:16:47 INFO - 'HOME': '/Users/cltbld', 21:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:16:47 INFO - 'LOGNAME': 'cltbld', 21:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:47 INFO - 'MOZ_NO_REMOTE': '1', 21:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:16:47 INFO - 'NO_EM_RESTART': '1', 21:16:47 INFO - 'PAGER': '/bin/cat', 21:16:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:47 INFO - 'PWD': '/builds/slave/test', 21:16:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:16:47 INFO - 'SHELL': '/bin/bash', 21:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ebCV3ug9Yb/Listeners', 21:16:47 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 21:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:16:47 INFO - 'USER': 'cltbld', 21:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:47 INFO - 'XPC_FLAGS': '0x0', 21:16:47 INFO - 'XPC_SERVICE_NAME': '0', 21:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:16:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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:16:47 INFO - mozversion application_buildid: 20161020200849 21:16:47 INFO - mozversion application_changeset: 10be9d40fa865be7c3c203b9cd042722ab3069ca 21:16:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:16:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:16:47 INFO - mozversion application_name: Firefox 21:16:47 INFO - mozversion application_remotingname: firefox-dev 21:16:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:16:47 INFO - mozversion application_vendor: Mozilla 21:16:47 INFO - mozversion application_version: 51.0a2 21:16:47 INFO - mozversion platform_buildid: 20161020200849 21:16:47 INFO - mozversion platform_changeset: 10be9d40fa865be7c3c203b9cd042722ab3069ca 21:16:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:16:47 INFO - mozversion platform_version: 51.0a2 21:16:47 INFO - using testdate: 1477023407 21:16:47 INFO - actual date: 1477023407 21:16:47 INFO - starting webserver on 'localhost:49272' 21:16:47 INFO - SUITE-START | Running 2 tests 21:16:47 INFO - TEST-START | dromaeo_css 21:16:47 INFO - operating with platform_type : mac_ 21:16:47 INFO - Initialising browser for dromaeo_css test... 21:16:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpcEKzz_/profile http://localhost:49272/getInfo.html) 21:16:50 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:16:50 INFO - PROCESS | 1652 | colorDepth:24 21:16:50 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:16:50 INFO - PROCESS | 1652 | __metrics 21:16:50 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:16:50 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:16:50 INFO - TEST-INFO | 1652: exit 0 21:16:50 INFO - Browser initialized. 21:16:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:16:50 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpcEKzz_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:02 INFO - PROCESS | 1654 | RSS: Main: 219471872 21:17:02 INFO - PROCESS | 1654 | 21:17:53 INFO - PROCESS | 1654 | 1477023473655 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:20:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 21:20:07 INFO - PROCESS | 1654 | RSS: Main: 348889088 21:20:07 INFO - PROCESS | 1654 | 21:23:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 21:23:10 INFO - PROCESS | 1654 | RSS: Main: 350965760 21:23:10 INFO - PROCESS | 1654 | 21:26:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 21:26:13 INFO - PROCESS | 1654 | RSS: Main: 324317184 21:26:13 INFO - PROCESS | 1654 | 21:29:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 21:29:16 INFO - PROCESS | 1654 | RSS: Main: 319905792 21:29:16 INFO - PROCESS | 1654 | 21:32:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 21:32:20 INFO - PROCESS | 1654 | RSS: Main: 312590336 21:32:20 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 21:35:23 INFO - PROCESS | 1654 | RSS: Main: 396169216 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | __start_tp_report 21:35:23 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 21:35:23 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 21:35:23 INFO - PROCESS | 1654 | |i|pagename|runs| 21:35:23 INFO - PROCESS | 1654 | |0;dojo.html;3238.4008958342706;3248.5127230915364;3274.7871388359767;3300.5874265716784;3322.385358708639;5423.755930983105;5470.890582188354;5479.643823151498;5484.012877682016;5500.037493438647;5447.264619276397;5502.394736578983;5521;5531.695756733378;5536.474034966682;5002.074616196006;5041.798328066891;5046.3187469691675;5133.12736834739;5144.536991670749;5015.247712843066;5021.874453138683;5076.984603079381;5130.923036154442;5142.51146141116;5025.924611130836;5040.97479512602;5073.289739436482;5074.31496747938;5075.238714192864;4693.906121877543;5056;5071.239314102877;5077.213031980049;5136.871578210575;4962.033378780482;5049.242613607951;5050.292958985745;5053.620978426633;5059.544640982293;5318.787248510055;5338.572914166857;5350.250964864922;5413.972930135364;5446.618736688433;5849.093390524476;5854.590178687494;5863.5016023638045;5874.32445268791;5880.441358071019;5991.670458124801;6007.4893634041155;6056.818295451144;6061.939380606182;6062.9090563641585;5466.753996070226;5528.668279903219;5543.7782488700805;5552.86117847053;5603.607747457639;6240.31356550779;6260.780872669435;6273.811785646438;6280.811575652738;6290.182276304051;5906;5907.4683278505145;5910.202122713378;5921.134842524591;5949.3753155918;5860.355360910296;5892.351841297454;5898.8820223595285;5982.282126144803;6061.272647282266;5933.970330148321;5978.163057172;5994.970025149846;5999;5999.040153575407;5889.4993925515955;5967.16459695643;5968.552358573124;5977.3126090500145;5988.401159883977;4695.389599352063;4721.1265915805;4779.163646361872;4788.23388257884;4822.445418776885;4258.978705106455;4277.957220427756;4279.229738647074;4297.247981603269;4315.438992930899;5500.80747173855;5534.501894829485;5560.110382338888;5582.190582365534;5639.943600563942;6094.360092190344;6098.847528811815;6103.206583144163;6108.961476548909;6131;5413.593980451403;5483.150111732688;5542.168674698747;5557.305336832896;5557.888842223133;5109.616778741609;5177.3269474968765;5187.818426355059;5193;5199.168133098686;6242.625442473375;6300.464460520907;6300.842478938063;6316.242050953915;6330.746770129327;6020.638761674313;6049.455549000611;6080.787172448943;6091.062729893662;6094.421030002142;6112.868254062901;6310.274318453253;6315.778947736807;6326.114343991753;6336.429721325103;5770.5095066919785;5775.364709881826;5782.566307527037;5787.131930210502;5869.559783016376;5891.941080589139;5893.675847828239;5899.233099697012;5933.9109913352195;5935.851603709942;5525.668459892419;5697.57268204878;5714.914276285942;5770.307563092288;5774.653520788766;5681.261436013458;5732.598718089694;5734.598578099493;5736.971315143398;5750.568707347049;5663;5724.914126288192;5738.540916726568;5763.4812866842185;5776.104703770922;5839.912401313899;5842.065269556851;5843.678597677169;5844.47399734026;5856.472917437451;5502.0371434997915;5558.44415558441;5644.040513112698;5685.374608792947;5700.914486282626 21:35:23 INFO - PROCESS | 1654 | |1;ext.html;484.6946423753035;511.3403709215112;513.2532165698908;523.1342128776874;523.4817530644663;29854;30191.396172076544;31758.888438904614;38756.22487550247;40274.99312517189;37156.88529344124;41282.79358603203;41619.58380416195;41632;41812.16375672485;9016.459012459258;9779.82642082951;9785.902140978606;9786.461744604045;9804.558794854249;8692.608832602547;8890.73327800167;9653.75865603362;11580.6525804226;11877.7624447511;11924.344161071138;11941.880581194207;11992.7601447971;12089.758204835898;12109.757804843943;11964;12036.759264814655;12047.698807529794;12050.035997120298;12055;8556.61495232716;8777.517236551987;11478.311301321864;11790.469428875635;11804.173707840455;39475.407868881986;39787.80106099451;39799.602003980166;39803.8009809952;39813.402798958035;3308.7849289796086;3345.7156141727983;3360.260742636616;3398.575178102737;3635.3456377851976;27911.72088279132;30404.69595304041;30898.382032359226;31198.850253503162;31344.746210151567;3144.795588286754;3154.921126971821;3211.5343275225196;3213.742900567949;3250.2686895448574;462844.6857765723;469504;469750;470676;470851;61368;61913.690431547555;61948.69025654843;62047;62082.68958655178;64913;65051.02423463652;65073.67463162749;65106;65205;16505.927114737744;16777.83222167763;16786.4124755633;16810.15949202535;16818.57953551171;11562.653120406401;12405.75188496225;12430.254184748945;12451;12453.439595218237;15942.123183224801;15960.840391596168;16337.836621633869;18872.528186795167;19231.423057308304;6582.8354291143105;7603.099225193701;7771.6891324347525;7800.804979875548;7851.882221766678;849.2272032450564;979.7550612346913;990.4898977026837;1076.1229597877705;1084.5173897615484;29060.709392906225;29348.26629334241;29763.86216547123;30004.099877003726;30011.69988300089;1050.9579616815395;1054.1145437832258;1083.766990097117;1085.3921803789904;1191.1602320364123;15180.089194648357;15201.9358644896;15327.923360383127;15344.923275383775;15626.296816643278;722936;726792;728352;728584;729342;57201;57651.423485765445;57651.71174144186;57751.71124144436;58070;1361.2104979112091;1370.787527933172;1381.8272715910512;1386.230641993703;1391.7425276323913;28554.85722571374;28686;28957.420851583272;28965.710342896302;29607.111786646434;48640;48888.2666760006;48914;48922;48969.75515122402;614311;617145;618696;620071;621555;23014.539709206056;23559.76440235576;24808.379790505383;26229.73770262273;26391.736082639694;43066;43310.35034474423;44909;46461.07077858356;46687.29969050535;37485.4377184337;37511.43732843955;38359.04102397463;38570.421443678926;39780;35170.64829351674;37138.54024862686;37517.06207344838;37835;38459.80770096132;35911.28177436489;36795.08012299714;37204.44193337156;37607.811960940024;37702.811485942395;27408;31374.215644609067;33875;33968.98093057212;33991.830040849636;21249.487873852482;21294.78705212928;25118.3720406984;25344.239672809847;25510.87244563765 21:35:23 INFO - PROCESS | 1654 | |2;jquery.html;356.8287222133374;369.62298455575313;379.6564109480919;382.5046564698715;387.12509728014686;13468.66328341792;15304.234788260585;15332.386704531818;20881.68677469839;21417.46456338592;19199;19495.902520487412;20145.697814532792;20248.797512024874;20385.694214586754;5570.2480165177685;5809.692819115708;5827.125931110325;5828.0675091985295;5834.212381328509;5019.774110165033;6507;6592.769253076143;6647.069410282565;6662.800115996503;5767.798127065554;6082.543809214305;6582.243042050178;6606.900896486556;6611.603303801763;6112.480439162677;6124.540659450537;6153.753849846001;6158.3841615838055;6163.414475624831;5748.137779333092;5792.739326730307;5941.603723125062;5946.583739138262;5951.256092988377;12903.612891613267;13140.934295328461;13146.342682865818;22750.772492275195;23731.644025339632;2157.902894369757;2191.430228140679;2214.446388402899;2522.965584110506;2535.378832186108;9337.766555836091;9736.659216927374;10080.64717734883;10241.334313269688;10287.485625718684;1612.2100170916283;1829.0397541290795;1873.5222817466267;1880.7366968624267;1931.5750534882443;97531;108798;108905;110563.34154987682;126362.10456843155;10708.30396024256;11219.775604487864;11626.418679066182;11681.415929203506;11777.823332650018;14256.215908125152;14266.072705274124;14470.20413877247;14481.637959050897;14489.130652160904;7015.543989640657;8297.58512074394;8501;8625.051244363114;8641.740747777576;7619;8533.573321333908;8541.743747687578;8554.401191916506;8700;4247.660187185018;4437.267850804581;4449.488308844524;4450.666200034945;4529.5243999380245;1876.7841698204882;1918.8081191880701;1927.1018047223474;1927.874688145266;1928.4021953194554;828.2131974624131;838.3251482556478;869.913008699125;884.712468447757;1021.7394564386034;19588.16558658898;21117;21120;21229.893850530647;21440.78559214419;907.0657223060258;936.3726303376754;937.4328531238502;984.7981163861391;994.627014869424;10602.946985265024;10951.466794648755;11097.38964356952;11119.332840029625;11147.832782508269;571879;573841;589629;633331;635760.6423935794;90693.7009895911;125649;141811;144280.11439771147;148226.51773482343;831.1356189562787;892.7143314139413;896.6099746610246;898.3935843305873;900.5632268349846;18175;18663.066846657883;18893.859495663688;18964.810351896303;19074;54356.728216358664;56081.71959140178;56225.594360141324;57952.71023644855;58161.41838581729;78578;81596;82235;84963;85821;7559.092908850973;7736.31136093672;7884.566348850639;7977.800554986172;8204.876926845982;8793.604287806937;11065.170112241774;12066.396680166132;12326;12578.182418142791;10668.1998850085;10835.729106772395;10845.620403285848;10983.725406864893;11165.609203677832;10515.474226288808;10522;10645.361278323326;10689.198310126616;10831.945840271064;10938.507767150657;10981.560737570728;11034.779304414027;11072;11306.321620702784;7799.220077992155;7824.630689629178;7901.68393264286;8193.918060819555;8391.916080839357;8150.551719655476;9651.420914745138;10528.947355263175;11040.723981900517;11321.943390282995 21:35:23 INFO - PROCESS | 1654 | |3;mootools.html;1524.8246451658063;1538.2462593329271;1735.6181640039188;1829.1768704083165;1900.6103748731502;8498.830023399536;9053.592588333524;9055.094490550942;9057.411268267559;9076.183143517082;7858.489198202113;8055.838883222332;8068.031836179666;8523.531205783695;8831.602577883994;2380.7143142822842;2423.9636405453934;2428.5628586854446;2431.3192306154306;2435.208557218902;2300.8619482831;2373.335466069503;2409.6385542168728;2450.8529488230674;2456.6315052742143;2227.10915633747;2431.258466167818;2442.9022839086506;2446.9510609787794;2454.5090981803623;2404.350825277183;2411.7588241175918;2417.141914620302;2420.407000284924;2437.1348171399254;2392.4736557957394;2414.746451622572;2418.9637155442683;2421.9515609687883;2425.514897020585;8769.210771030574;8965.865512017324;8966.01373848876;8971.416857904216;8987.595558199897;5246.396664383607;5420.91868621971;5423.810166644188;5433.130699088167;5436.456354364572;3024.969750302491;3493.2140268439653;3702.9259414811822;3710.2023065041144;3713.591504934455;1059.036276987945;1087.6356420599109;1091.4309265245547;1104.9558017679283;1118.9888101119047;11535.538578456852;11625.186236963416;11652.592159274469;11681.415929203506;11685.766284674344;4607.95392046082;4673.6728429009645;4865.391826021747;4867.464578896389;4880.95119048805;10019.699409017596;10025.298229124037;10026.899731002597;10034.799304013879;10054.748631284276;5391.353037635509;5397.298351214396;5406.324209473816;5407.540359069444;5408.91886621701;4261.509926358446;4452.933206001912;4614.907701845944;4874.634402419832;4949.480304567968;3973.324534829086;3977.6817854571564;4001.459802926626;4104.794760262034;4110.77390743506;1310.1287643717012;1320.3332317179763;1321.8479874814327;1334.7130366971148;1336.9131006484547;663.8307231655897;879.3141349747208;888.8755574219614;904.6471875968377;905.9954700226457;5261.158214685632;5684.147377893349;5735.053716136874;5918.644881307136;6132.049532322497;863.5811631358786;988.2884323287221;1003.9146672532917;1016.4307987527009;1050.0811789684026;3769.679577235911;3811.275857587105;3886.630770076838;3982.601739825994;4008.238434697398;10577.471126443646;10825;10908.836367454494;10910.945445272722;10919.508622111865;10850.348979061282;10857.402842843561;10861.402622855661;10864.72838179036;10880.347179169275;8093.595320233965;8210.58947052657;8289.461185022954;8419.705310314232;8421.705240316682;5790.971045144747;5809.157672137601;5932.584719069796;5969;6079.878402432015;9771.267154963549;10030.147437467896;10301.072903438726;10314.43270620093;10322.380657160595;9876.358036727877;10230.539625716712;10353.4305613192;10402.687919362432;10449.791004180026;6925.757598484231;7100;7118.786436406916;7467.141278753013;7642.847143057219;7882.881756773768;7953.761387158163;7958.721444749406;8187.222213889671;8414.284785793032;6136.815895523141;6727.394534491919;7565.848683026198;7631.046119235096;7655.387568994578;7236.638168091469;7330.706771729071;7385.556866588022;7437.776866694008;7472;6238.500919926304;6609.537332386687;6748.055272261985;6801.659917004031;6926.688299026455;4876.171050921423;4934.703917764946;4934.938988117572;4939.777710002986;4966.130927087817;4764.356811830358;4789.521047895182;4885.7801398937845;4927.1131196384995;4974.5771609413605 21:35:23 INFO - PROCESS | 1654 | |4;prototype.html;251.44179920576323;299.13400704959145;306.2619087997925;310.49854485006705;313.0467725775015;4472.597466228039;5056.65998510395;5175.896482070356;5296.629235953485;5338.786448542059;4691.756684478616;4789.3294938708605;5011.574016208618;5149.2791009258735;5190.325257716501;3300.950485742716;3333.0667413124243;3541.698955588778;4035.757854528723;4044.170944956292;3659.2864391443677;3745.7565258258264;3788.4317352397225;3985;4041.979790101045;3459.4951196229595;3902.6682731967817;3920.1382990417014;4037.6164264394833;4050.9594904050878;3466.5666791651042;3653.725970552193;4002.858470718181;4021.6983726220506;4035.9103042178594;2876.798624096314;2896.811707239023;3477;3477.94783078254;3513.877014304487;4834.540718631724;5112.335396398482;5120.206368012927;5142.51146141116;5220.137098547086;3652.4703917932015;4475.507694153641;4530.546945305476;4535.682502224846;4563.475200351969;4728.598069164125;4841.636877234221;5060.51925067118;5580.349334066326;5613.522850557667;3212.5823642926503;3564.8574057037686;3750.79370634615;3844.461775351453;3848.9615103849164;5115.386153661584;5827.88344233113;5828.6502809831545;5848.473637372657;5861.677607731573;3294.1270563300745;3618.2763447310645;3818;3855.6722678572073;3869.303525365461;3284.474484082535;3641.289948460025;3921.137349783043;3940.802959851996;3947.519680119955;4223.986243301585;4241.533431322552;4481.708688935209;4499.5275496072445;4513.524586068709;5497.45025497447;5519.337679478408;5542.722863856791;5590.720463976785;5661.094224923992;1132.7451323452158;1184.3545267829054;1243.787307375302;1259.7480503899073;1320.3464285178898;705.7917914215216;742.2836962331376;799.9840003199903;846.7586737779703;861.3927181337142;3892.861422921773;4354.281543545343;4464.977675111603;4509.294423346032;4555.248384016666;4095.5494895561465;4152.91694166115;4158.584141585818;4357.477102747627;4760.714357138583;3618.069363815318;3784.848606055727;4039.4546736190237;4322.746403543;4395.692301538926;2188.890555472252;2454.3373289211813;2495.4759500504733;2534.961975570368;2540.9491810163695;4357.629601483909;4643;4655.135383524225;4908.509149085135;4996.600271978233;3972.503437070366;4638.83764068256;4644.991341252199;4868.269759536098;4868.805247790119;4132.752034877917;4793.760311984387;4856.68431551955;4872.4883887192755;4929.580985616191;4327.826886924614;4363.105563359441;4567.1550763108935;4643.164230438553;4671.006289622324;3938.177963435367;4093.65203957655;4316.503602085801;4711.057788442256;4746.644001699955;4024.8993775154686;4336.37122617225;4475.462944446687;4858.659893807399;4878.487758785418;2829.462402143586;2976.151796738006;3124.0471656145096;3131.545925840786;3167.904962851118;4142.855000074983;4360.498542667634;4399.956000440083;4741.976290118528;4767.067169585037;4059.011084568599;4189.685773566934;4278.529361770141;4579.176387716294;4679.415073115861;4607.83872564472;4620.653450991122;4639.768011599474;4646.953530464787;4666.546755400911;4118.6499147572795;4163.458750362433;4584.495705472462;4619.79885229836;4956.884700942259;4296.3555466679;4747.335373047707;4815.964567617979;5309.867253318698;5433.320834895638;5337.759800809051;5359.624826262124;5367.785288588413;5369.4630536946;5380.811671591632 21:35:23 INFO - PROCESS | 1654 | |5;yui.html;702.8524009957908;716.8494616130612;738.8596166728321;774.6281784743323;778.5678948183755;14957.850421495781;15590.14254216019;15921.36314547418;16195.595110122253;16252.593685157848;13615.863841361583;13773.793393099111;13803.65490862729;13843.792343114861;13855.792163117561;671.8320419895026;691.339770519153;692.9272426395231;818.4189225649781;825.3603457320564;846.0820010288844;846.3483117999137;857.498363457375;857.8284343131368;858.3819649852128;913.0413066280412;914.9542522873863;915.9862602060974;917.0966597901062;918.4535201555065;706.8338940349014;724.822418507469;730.883058710609;909.4043401571981;911.9817603647923;536.0244355273404;536.1180857489447;642.633698791689;657.6547312660844;661.2329697550817;14505.564833055025;14519.05626134298;14522.419103235858;14539.563813085519;14553.636159096108;12131.332776697278;13463.259520726357;13524.18854868711;13676.316184190751;13745.312734363342;9606.615735370577;12068.09489288307;12074.456649450707;12408.131430799847;12816.166949148275;4483.910321793546;4517.909641807146;4568.132054909556;4607;4736.242201247784;107923;111671;111708.88291117066;111998.44000780107;112338;9490.905090949002;10320.793584128425;10731.678049658523;10750;11039.116870650329;20818.27136050231;21019.579608407745;21065.15739370408;21159.942002899792;21192.36422907315;7613.581253031137;7769.844603107907;7788.104367997753;7855.685772569148;7916.604169791487;4350;4355.542668019875;4372.715773474714;4404.361367601679;4421.690481666253;3308.338332333543;3415.52182694423;3422.3326451342245;3428.7599868009;3431.0564594736147;645.0549944331577;645.7901182115737;666.7299743603849;667.866426714659;668.4652278177439;559.6278474814203;563.1749487001563;616.4267231474771;620.9753906054955;626.7618305044055;8269.255766981001;8391.24478796899;8915.369965860087;8973.508447268754;9032.412893161923;598.4733434577631;616.7563812294209;623.18985319085;640.6540468147241;645.0904225042667;4251.234777739975;4336.956630433655;4369.956300437018;4400.581944715247;4429.158459892675;96153.51923240339;96889.51555242178;103089.96910030954;163353;175638;142149;145566;147653;147986;153088;126737;127539.3623031879;129048;130005.34997324953;131477;8209.79475513117;8521.659133634834;8555.486670799772;8641.8703719443;8773.29813614922;46398.53601463942;50467;59224.40775592361;61183.38816611955;62746.37253627588;88117;91883.16233675423;92824.53587732019;93819;103555.4822225884;12625.621231363073;12909.419076141785;13021.153625014344;13397.397117129558;13444.795515100077;14513.854861451251;14821.481248156262;14856.40574377056;15021;15068.321925513597;13186.868131318948;13222.471101155847;13591.79612305836;13845.30773461343;14321;11779.293242405483;12915.483380665044;13377.464901404224;13772.65568360799;13990.68346091059;13167.144135631153;13662.11196272239;14094.859051409354;14106.929465352607;14207.786883196966;11383.260088094248;11401.885981140082;11613.767724645291;11886.583969561023;11944.402779860799;9993.800123997626;11094.278871873303;11464.426778660867;11713.707157321136;11719.824202636797 21:35:23 INFO - PROCESS | 1654 | __end_tp_report 21:35:23 INFO - PROCESS | 1654 | __start_cc_report 21:35:23 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1271 21:35:23 INFO - PROCESS | 1654 | __end_cc_report 21:35:23 INFO - PROCESS | 1654 | __startTimestamp1477024523722__endTimestamp 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | ------- Summary: start ------- 21:35:23 INFO - PROCESS | 1654 | Number of tests: 6 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5538.28 Median:5697.57 stddev:615.73 (10.8%) stddev-sans-first:590.60 21:35:23 INFO - PROCESS | 1654 | Values: 3238.4 3248.5 3274.8 3300.6 3322.4 5423.8 5470.9 5479.6 5484.0 5500.0 5447.3 5502.4 5521.0 5531.7 5536.5 5002.1 5041.8 5046.3 5133.1 5144.5 5015.2 5021.9 5077.0 5130.9 5142.5 5025.9 5041.0 5073.3 5074.3 5075.2 4693.9 5056.0 5071.2 5077.2 5136.9 4962.0 5049.2 5050.3 5053.6 5059.5 5318.8 5338.6 5350.3 5414.0 5446.6 5849.1 5854.6 5863.5 5874.3 5880.4 5991.7 6007.5 6056.8 6061.9 6062.9 5466.8 5528.7 5543.8 5552.9 5603.6 6240.3 6260.8 6273.8 6280.8 6290.2 5906.0 5907.5 5910.2 5921.1 5949.4 5860.4 5892.4 5898.9 5982.3 6061.3 5934.0 5978.2 5995.0 5999.0 5999.0 5889.5 5967.2 5968.6 5977.3 5988.4 4695.4 4721.1 4779.2 4788.2 4822.4 4259.0 4278.0 4279.2 4297.2 4315.4 5500.8 5534.5 5560.1 5582.2 5639.9 6094.4 6098.8 6103.2 6109.0 6131.0 5413.6 5483.2 5542.2 5557.3 5557.9 5109.6 5177.3 5187.8 5193.0 5199.2 6242.6 6300.5 6300.8 6316.2 6330.7 6020.6 6049.5 6080.8 6091.1 6094.4 6112.9 6310.3 6315.8 6326.1 6336.4 5770.5 5775.4 5782.6 5787.1 5869.6 5891.9 5893.7 5899.2 5933.9 5935.9 5525.7 5697.6 5714.9 5770.3 5774.7 5681.3 5732.6 5734.6 5737.0 5750.6 5663.0 5724.9 5738.5 5763.5 5776.1 5839.9 5842.1 5843.7 5844.5 5856.5 5502.0 5558.4 5644.0 5685.4 5700.9 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:72873.23 Median:19773.31 stddev:164663.91 (832.8%) stddev-sans-first:165036.14 21:35:23 INFO - PROCESS | 1654 | Values: 484.7 511.3 513.3 523.1 523.5 29854.0 30191.4 31758.9 38756.2 40275.0 37156.9 41282.8 41619.6 41632.0 41812.2 9016.5 9779.8 9785.9 9786.5 9804.6 8692.6 8890.7 9653.8 11580.7 11877.8 11924.3 11941.9 11992.8 12089.8 12109.8 11964.0 12036.8 12047.7 12050.0 12055.0 8556.6 8777.5 11478.3 11790.5 11804.2 39475.4 39787.8 39799.6 39803.8 39813.4 3308.8 3345.7 3360.3 3398.6 3635.3 27911.7 30404.7 30898.4 31198.9 31344.7 3144.8 3154.9 3211.5 3213.7 3250.3 462844.7 469504.0 469750.0 470676.0 470851.0 61368.0 61913.7 61948.7 62047.0 62082.7 64913.0 65051.0 65073.7 65106.0 65205.0 16505.9 16777.8 16786.4 16810.2 16818.6 11562.7 12405.8 12430.3 12451.0 12453.4 15942.1 15960.8 16337.8 18872.5 19231.4 6582.8 7603.1 7771.7 7800.8 7851.9 849.2 979.8 990.5 1076.1 1084.5 29060.7 29348.3 29763.9 30004.1 30011.7 1051.0 1054.1 1083.8 1085.4 1191.2 15180.1 15201.9 15327.9 15344.9 15626.3 722936.0 726792.0 728352.0 728584.0 729342.0 57201.0 57651.4 57651.7 57751.7 58070.0 1361.2 1370.8 1381.8 1386.2 1391.7 28554.9 28686.0 28957.4 28965.7 29607.1 48640.0 48888.3 48914.0 48922.0 48969.8 614311.0 617145.0 618696.0 620071.0 621555.0 23014.5 23559.8 24808.4 26229.7 26391.7 43066.0 43310.4 44909.0 46461.1 46687.3 37485.4 37511.4 38359.0 38570.4 39780.0 35170.6 37138.5 37517.1 37835.0 38459.8 35911.3 36795.1 37204.4 37607.8 37702.8 27408.0 31374.2 33875.0 33969.0 33991.8 21249.5 21294.8 25118.4 25344.2 25510.9 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:34775.99 Median:374.64 stddev:100482.95 (26821.2%) stddev-sans-first:100731.60 21:35:23 INFO - PROCESS | 1654 | Values: 356.8 369.6 379.7 382.5 387.1 13468.7 15304.2 15332.4 20881.7 21417.5 19199.0 19495.9 20145.7 20248.8 20385.7 5570.2 5809.7 5827.1 5828.1 5834.2 5019.8 6507.0 6592.8 6647.1 6662.8 5767.8 6082.5 6582.2 6606.9 6611.6 6112.5 6124.5 6153.8 6158.4 6163.4 5748.1 5792.7 5941.6 5946.6 5951.3 12903.6 13140.9 13146.3 22750.8 23731.6 2157.9 2191.4 2214.4 2523.0 2535.4 9337.8 9736.7 10080.6 10241.3 10287.5 1612.2 1829.0 1873.5 1880.7 1931.6 97531.0 108798.0 108905.0 110563.3 126362.1 10708.3 11219.8 11626.4 11681.4 11777.8 14256.2 14266.1 14470.2 14481.6 14489.1 7015.5 8297.6 8501.0 8625.1 8641.7 7619.0 8533.6 8541.7 8554.4 8700.0 4247.7 4437.3 4449.5 4450.7 4529.5 1876.8 1918.8 1927.1 1927.9 1928.4 828.2 838.3 869.9 884.7 1021.7 19588.2 21117.0 21120.0 21229.9 21440.8 907.1 936.4 937.4 984.8 994.6 10602.9 10951.5 11097.4 11119.3 11147.8 571879.0 573841.0 589629.0 633331.0 635760.6 90693.7 125649.0 141811.0 144280.1 148226.5 831.1 892.7 896.6 898.4 900.6 18175.0 18663.1 18893.9 18964.8 19074.0 54356.7 56081.7 56225.6 57952.7 58161.4 78578.0 81596.0 82235.0 84963.0 85821.0 7559.1 7736.3 7884.6 7977.8 8204.9 8793.6 11065.2 12066.4 12326.0 12578.2 10668.2 10835.7 10845.6 10983.7 11165.6 10515.5 10522.0 10645.4 10689.2 10831.9 10938.5 10981.6 11034.8 11072.0 11306.3 7799.2 7824.6 7901.7 8193.9 8391.9 8150.6 9651.4 10528.9 11040.7 11321.9 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5717.86 Median:4719.01 stddev:3203.35 (67.9%) stddev-sans-first:3196.83 21:35:23 INFO - PROCESS | 1654 | Values: 1524.8 1538.2 1735.6 1829.2 1900.6 8498.8 9053.6 9055.1 9057.4 9076.2 7858.5 8055.8 8068.0 8523.5 8831.6 2380.7 2424.0 2428.6 2431.3 2435.2 2300.9 2373.3 2409.6 2450.9 2456.6 2227.1 2431.3 2442.9 2447.0 2454.5 2404.4 2411.8 2417.1 2420.4 2437.1 2392.5 2414.7 2419.0 2422.0 2425.5 8769.2 8965.9 8966.0 8971.4 8987.6 5246.4 5420.9 5423.8 5433.1 5436.5 3025.0 3493.2 3702.9 3710.2 3713.6 1059.0 1087.6 1091.4 1105.0 1119.0 11535.5 11625.2 11652.6 11681.4 11685.8 4608.0 4673.7 4865.4 4867.5 4881.0 10019.7 10025.3 10026.9 10034.8 10054.7 5391.4 5397.3 5406.3 5407.5 5408.9 4261.5 4452.9 4614.9 4874.6 4949.5 3973.3 3977.7 4001.5 4104.8 4110.8 1310.1 1320.3 1321.8 1334.7 1336.9 663.8 879.3 888.9 904.6 906.0 5261.2 5684.1 5735.1 5918.6 6132.0 863.6 988.3 1003.9 1016.4 1050.1 3769.7 3811.3 3886.6 3982.6 4008.2 10577.5 10825.0 10908.8 10910.9 10919.5 10850.3 10857.4 10861.4 10864.7 10880.3 8093.6 8210.6 8289.5 8419.7 8421.7 5791.0 5809.2 5932.6 5969.0 6079.9 9771.3 10030.1 10301.1 10314.4 10322.4 9876.4 10230.5 10353.4 10402.7 10449.8 6925.8 7100.0 7118.8 7467.1 7642.8 7882.9 7953.8 7958.7 8187.2 8414.3 6136.8 6727.4 7565.8 7631.0 7655.4 7236.6 7330.7 7385.6 7437.8 7472.0 6238.5 6609.5 6748.1 6801.7 6926.7 4876.2 4934.7 4934.9 4939.8 4966.1 4764.4 4789.5 4885.8 4927.1 4974.6 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4055.21 Median:4379.40 stddev:1231.01 (28.1%) stddev-sans-first:1200.90 21:35:23 INFO - PROCESS | 1654 | Values: 251.4 299.1 306.3 310.5 313.0 4472.6 5056.7 5175.9 5296.6 5338.8 4691.8 4789.3 5011.6 5149.3 5190.3 3301.0 3333.1 3541.7 4035.8 4044.2 3659.3 3745.8 3788.4 3985.0 4042.0 3459.5 3902.7 3920.1 4037.6 4051.0 3466.6 3653.7 4002.9 4021.7 4035.9 2876.8 2896.8 3477.0 3477.9 3513.9 4834.5 5112.3 5120.2 5142.5 5220.1 3652.5 4475.5 4530.5 4535.7 4563.5 4728.6 4841.6 5060.5 5580.3 5613.5 3212.6 3564.9 3750.8 3844.5 3849.0 5115.4 5827.9 5828.7 5848.5 5861.7 3294.1 3618.3 3818.0 3855.7 3869.3 3284.5 3641.3 3921.1 3940.8 3947.5 4224.0 4241.5 4481.7 4499.5 4513.5 5497.5 5519.3 5542.7 5590.7 5661.1 1132.7 1184.4 1243.8 1259.7 1320.3 705.8 742.3 800.0 846.8 861.4 3892.9 4354.3 4465.0 4509.3 4555.2 4095.5 4152.9 4158.6 4357.5 4760.7 3618.1 3784.8 4039.5 4322.7 4395.7 2188.9 2454.3 2495.5 2535.0 2540.9 4357.6 4643.0 4655.1 4908.5 4996.6 3972.5 4638.8 4645.0 4868.3 4868.8 4132.8 4793.8 4856.7 4872.5 4929.6 4327.8 4363.1 4567.2 4643.2 4671.0 3938.2 4093.7 4316.5 4711.1 4746.6 4024.9 4336.4 4475.5 4858.7 4878.5 2829.5 2976.2 3124.0 3131.5 3167.9 4142.9 4360.5 4400.0 4742.0 4767.1 4059.0 4189.7 4278.5 4579.2 4679.4 4607.8 4620.7 4639.8 4647.0 4666.5 4118.6 4163.5 4584.5 4619.8 4956.9 4296.4 4747.3 4816.0 5309.9 5433.3 5337.8 5359.6 5367.8 5369.5 5380.8 21:35:23 INFO - PROCESS | 1654 | 21:35:23 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:25135.78 Median:3841.15 stddev:41063.18 (1069.0%) stddev-sans-first:41137.39 21:35:23 INFO - PROCESS | 1654 | Values: 702.9 716.8 738.9 774.6 778.6 14957.9 15590.1 15921.4 16195.6 16252.6 13615.9 13773.8 13803.7 13843.8 13855.8 671.8 691.3 692.9 818.4 825.4 846.1 846.3 857.5 857.8 858.4 913.0 915.0 916.0 917.1 918.5 706.8 724.8 730.9 909.4 912.0 536.0 536.1 642.6 657.7 661.2 14505.6 14519.1 14522.4 14539.6 14553.6 12131.3 13463.3 13524.2 13676.3 13745.3 9606.6 12068.1 12074.5 12408.1 12816.2 4483.9 4517.9 4568.1 4607.0 4736.2 107923.0 111671.0 111708.9 111998.4 112338.0 9490.9 10320.8 10731.7 10750.0 11039.1 20818.3 21019.6 21065.2 21159.9 21192.4 7613.6 7769.8 7788.1 7855.7 7916.6 4350.0 4355.5 4372.7 4404.4 4421.7 3308.3 3415.5 3422.3 3428.8 3431.1 645.1 645.8 666.7 667.9 668.5 559.6 563.2 616.4 621.0 626.8 8269.3 8391.2 8915.4 8973.5 9032.4 598.5 616.8 623.2 640.7 645.1 4251.2 4337.0 4370.0 4400.6 4429.2 96153.5 96889.5 103090.0 163353.0 175638.0 142149.0 145566.0 147653.0 147986.0 153088.0 126737.0 127539.4 129048.0 130005.3 131477.0 8209.8 8521.7 8555.5 8641.9 8773.3 46398.5 50467.0 59224.4 61183.4 62746.4 88117.0 91883.2 92824.5 93819.0 103555.5 12625.6 12909.4 13021.2 13397.4 13444.8 14513.9 14821.5 14856.4 15021.0 15068.3 13186.9 13222.5 13591.8 13845.3 14321.0 11779.3 12915.5 13377.5 13772.7 13990.7 13167.1 13662.1 14094.9 14106.9 14207.8 11383.3 11401.9 11613.8 11886.6 11944.4 9993.8 11094.3 11464.4 11713.7 11719.8 21:35:23 INFO - PROCESS | 1654 | -------- Summary: end -------- 21:35:23 INFO - PROCESS | 1654 | 21:35:24 INFO - TEST-INFO | 1654: exit 0 21:35:24 INFO - TEST-OK | dromaeo_css | took 1116614ms 21:35:24 INFO - TEST-START | kraken 21:35:24 INFO - operating with platform_type : mac_ 21:35:24 INFO - Initialising browser for kraken test... 21:35:24 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp0iUp9w/profile http://localhost:49272/getInfo.html) 21:35:26 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 21:35:26 INFO - PROCESS | 1664 | colorDepth:24 21:35:26 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 21:35:26 INFO - PROCESS | 1664 | __metrics 21:35:26 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:35:26 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:27 INFO - TEST-INFO | 1664: exit 0 21:35:27 INFO - Browser initialized. 21:35:27 INFO - Running cycle 1/1 for kraken test... 21:35:27 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp0iUp9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:39 INFO - PROCESS | 1665 | RSS: Main: 219205632 21:35:39 INFO - PROCESS | 1665 | 21:35:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 21:35:42 INFO - PROCESS | 1665 | RSS: Main: 270163968 21:35:42 INFO - PROCESS | 1665 | 21:35:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 21:35:46 INFO - PROCESS | 1665 | RSS: Main: 281841664 21:35:46 INFO - PROCESS | 1665 | 21:35:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 21:35:49 INFO - PROCESS | 1665 | RSS: Main: 378028032 21:35:49 INFO - PROCESS | 1665 | 21:35:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 21:35:52 INFO - PROCESS | 1665 | RSS: Main: 279224320 21:35:52 INFO - PROCESS | 1665 | 21:35:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:35:55 INFO - PROCESS | 1665 | RSS: Main: 279867392 21:35:55 INFO - PROCESS | 1665 | 21:35:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 21:35:58 INFO - PROCESS | 1665 | RSS: Main: 317403136 21:35:58 INFO - PROCESS | 1665 | 21:36:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 21:36:02 INFO - PROCESS | 1665 | RSS: Main: 319197184 21:36:02 INFO - PROCESS | 1665 | 21:36:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 21:36:05 INFO - PROCESS | 1665 | RSS: Main: 318935040 21:36:05 INFO - PROCESS | 1665 | 21:36:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:36:07 INFO - PROCESS | 1665 | RSS: Main: 289898496 21:36:07 INFO - PROCESS | 1665 | 21:36:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:36:10 INFO - PROCESS | 1665 | RSS: Main: 295346176 21:36:10 INFO - PROCESS | 1665 | 21:36:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:36:12 INFO - PROCESS | 1665 | RSS: Main: 298029056 21:36:12 INFO - PROCESS | 1665 | 21:36:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:36:16 INFO - PROCESS | 1665 | RSS: Main: 308719616 21:36:16 INFO - PROCESS | 1665 | 21:36:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:36:19 INFO - PROCESS | 1665 | RSS: Main: 308981760 21:36:19 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 21:36:21 INFO - PROCESS | 1665 | RSS: Main: 352485376 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | __start_tp_report 21:36:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 21:36:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 21:36:21 INFO - PROCESS | 1665 | |i|pagename|runs| 21:36:21 INFO - PROCESS | 1665 | |0;ai-astar;114;115;114;113;114;115;114;113;114;113 21:36:21 INFO - PROCESS | 1665 | |1;audio-beat-detection;142;112;107;142;113;137;139;105;139;110 21:36:21 INFO - PROCESS | 1665 | |2;audio-dft;183;184;185;184;181;184;184;184;185;185 21:36:21 INFO - PROCESS | 1665 | |3;audio-fft;81;60;70;114;87;80;60;57;85;58 21:36:21 INFO - PROCESS | 1665 | |4;audio-oscillator;88;73;97;70;68;69;93;68;68;90 21:36:21 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;85;87;84;88;131;96;85;87;84 21:36:21 INFO - PROCESS | 1665 | |6;imaging-darkroom;93;93;93;93;93;93;94;94;96;93 21:36:21 INFO - PROCESS | 1665 | |7;imaging-desaturate;85;85;85;84;85;84;84;86;86;84 21:36:21 INFO - PROCESS | 1665 | |8;json-parse-financial;58;52;53;54;56;58;58;58;57;57 21:36:21 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;63;64;75;75;71;68;70;68;69;70 21:36:21 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;83;83;82;85;80;83;82;82;86;82 21:36:21 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;139;138;141;137;139;139;141;142;176;151 21:36:21 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;164;163;164;162;162;163;162;162;163;163 21:36:21 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;66;67;67;67;67;66;67;67;67;70 21:36:21 INFO - PROCESS | 1665 | __end_tp_report 21:36:21 INFO - PROCESS | 1665 | __start_cc_report 21:36:21 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1925 21:36:21 INFO - PROCESS | 1665 | __end_cc_report 21:36:21 INFO - PROCESS | 1665 | __startTimestamp1477024581826__endTimestamp 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | ------- Summary: start ------- 21:36:21 INFO - PROCESS | 1665 | Number of tests: 14 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 21:36:21 INFO - PROCESS | 1665 | Values: 114.0 115.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 113.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:138.00 stddev:16.24 (11.8%) stddev-sans-first:15.96 21:36:21 INFO - PROCESS | 1665 | Values: 142.0 112.0 107.0 142.0 113.0 137.0 139.0 105.0 139.0 110.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 21:36:21 INFO - PROCESS | 1665 | Values: 183.0 184.0 185.0 184.0 181.0 184.0 184.0 184.0 185.0 185.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.00 stddev:17.99 (24.0%) stddev-sans-first:18.96 21:36:21 INFO - PROCESS | 1665 | Values: 81.0 60.0 70.0 114.0 87.0 80.0 60.0 57.0 85.0 58.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:80.50 stddev:12.01 (14.9%) stddev-sans-first:12.23 21:36:21 INFO - PROCESS | 1665 | Values: 88.0 73.0 97.0 70.0 68.0 69.0 93.0 68.0 68.0 90.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:87.00 stddev:14.34 (16.5%) stddev-sans-first:15.12 21:36:21 INFO - PROCESS | 1665 | Values: 87.0 85.0 87.0 84.0 88.0 131.0 96.0 85.0 87.0 84.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 21:36:21 INFO - PROCESS | 1665 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 94.0 94.0 96.0 93.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 21:36:21 INFO - PROCESS | 1665 | Values: 85.0 85.0 85.0 84.0 85.0 84.0 84.0 86.0 86.0 84.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.50 stddev:2.28 (4.0%) stddev-sans-first:2.32 21:36:21 INFO - PROCESS | 1665 | Values: 58.0 52.0 53.0 54.0 56.0 58.0 58.0 58.0 57.0 57.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:3.95 (5.6%) stddev-sans-first:3.46 21:36:21 INFO - PROCESS | 1665 | Values: 63.0 64.0 75.0 75.0 71.0 68.0 70.0 68.0 69.0 70.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.69 (2.0%) stddev-sans-first:1.79 21:36:21 INFO - PROCESS | 1665 | Values: 83.0 83.0 82.0 85.0 80.0 83.0 82.0 82.0 86.0 82.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:141.00 stddev:11.80 (8.4%) stddev-sans-first:12.36 21:36:21 INFO - PROCESS | 1665 | Values: 139.0 138.0 141.0 137.0 139.0 139.0 141.0 142.0 176.0 151.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 21:36:21 INFO - PROCESS | 1665 | Values: 164.0 163.0 164.0 162.0 162.0 163.0 162.0 162.0 163.0 163.0 21:36:21 INFO - PROCESS | 1665 | 21:36:21 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.09 21:36:21 INFO - PROCESS | 1665 | Values: 66.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 70.0 21:36:21 INFO - PROCESS | 1665 | -------- Summary: end -------- 21:36:21 INFO - PROCESS | 1665 | 21:36:22 INFO - TEST-INFO | 1665: exit 0 21:36:22 INFO - TEST-OK | kraken | took 58381ms 21:36:22 INFO - SUITE-END | took 1174s 21:36:22 INFO - Completed test suite (00:19:35) 21:36:22 INFO - javascript benchmark 21:36:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3238.4008958342706, 3248.5127230915364, 3274.7871388359767, 3300.5874265716784, 3322.385358708639, 5423.755930983105, 5470.890582188354, 5479.643823151498, 5484.012877682016, 5500.037493438647, 5447.264619276397, 5502.394736578983, 5521.0, 5531.695756733378, 5536.474034966682, 5002.074616196006, 5041.798328066891, 5046.3187469691675, 5133.12736834739, 5144.536991670749, 5015.247712843066, 5021.874453138683, 5076.984603079381, 5130.923036154442, 5142.51146141116, 5025.924611130836, 5040.97479512602, 5073.289739436482, 5074.31496747938, 5075.238714192864, 4693.906121877543, 5056.0, 5071.239314102877, 5077.213031980049, 5136.871578210575, 4962.033378780482, 5049.242613607951, 5050.292958985745, 5053.620978426633, 5059.544640982293, 5318.787248510055, 5338.572914166857, 5350.250964864922, 5413.972930135364, 5446.618736688433, 5849.093390524476, 5854.590178687494, 5863.5016023638045, 5874.32445268791, 5880.441358071019, 5991.670458124801, 6007.4893634041155, 6056.818295451144, 6061.939380606182, 6062.9090563641585, 5466.753996070226, 5528.668279903219, 5543.7782488700805, 5552.86117847053, 5603.607747457639, 6240.31356550779, 6260.780872669435, 6273.811785646438, 6280.811575652738, 6290.182276304051, 5906.0, 5907.4683278505145, 5910.202122713378, 5921.134842524591, 5949.3753155918, 5860.355360910296, 5892.351841297454, 5898.8820223595285, 5982.282126144803, 6061.272647282266, 5933.970330148321, 5978.163057172, 5994.970025149846, 5999.0, 5999.040153575407, 5889.4993925515955, 5967.16459695643, 5968.552358573124, 5977.3126090500145, 5988.401159883977, 4695.389599352063, 4721.1265915805, 4779.163646361872, 4788.23388257884, 4822.445418776885, 4258.978705106455, 4277.957220427756, 4279.229738647074, 4297.247981603269, 4315.438992930899, 5500.80747173855, 5534.501894829485, 5560.110382338888, 5582.190582365534, 5639.943600563942, 6094.360092190344, 6098.847528811815, 6103.206583144163, 6108.961476548909, 6131.0, 5413.593980451403, 5483.150111732688, 5542.168674698747, 5557.305336832896, 5557.888842223133, 5109.616778741609, 5177.3269474968765, 5187.818426355059, 5193.0, 5199.168133098686, 6242.625442473375, 6300.464460520907, 6300.842478938063, 6316.242050953915, 6330.746770129327, 6020.638761674313, 6049.455549000611, 6080.787172448943, 6091.062729893662, 6094.421030002142, 6112.868254062901, 6310.274318453253, 6315.778947736807, 6326.114343991753, 6336.429721325103, 5770.5095066919785, 5775.364709881826, 5782.566307527037, 5787.131930210502, 5869.559783016376, 5891.941080589139, 5893.675847828239, 5899.233099697012, 5933.9109913352195, 5935.851603709942, 5525.668459892419, 5697.57268204878, 5714.914276285942, 5770.307563092288, 5774.653520788766, 5681.261436013458, 5732.598718089694, 5734.598578099493, 5736.971315143398, 5750.568707347049, 5663.0, 5724.914126288192, 5738.540916726568, 5763.4812866842185, 5776.104703770922, 5839.912401313899, 5842.065269556851, 5843.678597677169, 5844.47399734026, 5856.472917437451, 5502.0371434997915, 5558.44415558441, 5644.040513112698, 5685.374608792947, 5700.914486282626], "value": 5498.55272505489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.6946423753035, 511.3403709215112, 513.2532165698908, 523.1342128776874, 523.4817530644663, 29854.0, 30191.396172076544, 31758.888438904614, 38756.22487550247, 40274.99312517189, 37156.88529344124, 41282.79358603203, 41619.58380416195, 41632.0, 41812.16375672485, 9016.459012459258, 9779.82642082951, 9785.902140978606, 9786.461744604045, 9804.558794854249, 8692.608832602547, 8890.73327800167, 9653.75865603362, 11580.6525804226, 11877.7624447511, 11924.344161071138, 11941.880581194207, 11992.7601447971, 12089.758204835898, 12109.757804843943, 11964.0, 12036.759264814655, 12047.698807529794, 12050.035997120298, 12055.0, 8556.61495232716, 8777.517236551987, 11478.311301321864, 11790.469428875635, 11804.173707840455, 39475.407868881986, 39787.80106099451, 39799.602003980166, 39803.8009809952, 39813.402798958035, 3308.7849289796086, 3345.7156141727983, 3360.260742636616, 3398.575178102737, 3635.3456377851976, 27911.72088279132, 30404.69595304041, 30898.382032359226, 31198.850253503162, 31344.746210151567, 3144.795588286754, 3154.921126971821, 3211.5343275225196, 3213.742900567949, 3250.2686895448574, 462844.6857765723, 469504.0, 469750.0, 470676.0, 470851.0, 61368.0, 61913.690431547555, 61948.69025654843, 62047.0, 62082.68958655178, 64913.0, 65051.02423463652, 65073.67463162749, 65106.0, 65205.0, 16505.927114737744, 16777.83222167763, 16786.4124755633, 16810.15949202535, 16818.57953551171, 11562.653120406401, 12405.75188496225, 12430.254184748945, 12451.0, 12453.439595218237, 15942.123183224801, 15960.840391596168, 16337.836621633869, 18872.528186795167, 19231.423057308304, 6582.8354291143105, 7603.099225193701, 7771.6891324347525, 7800.804979875548, 7851.882221766678, 849.2272032450564, 979.7550612346913, 990.4898977026837, 1076.1229597877705, 1084.5173897615484, 29060.709392906225, 29348.26629334241, 29763.86216547123, 30004.099877003726, 30011.69988300089, 1050.9579616815395, 1054.1145437832258, 1083.766990097117, 1085.3921803789904, 1191.1602320364123, 15180.089194648357, 15201.9358644896, 15327.923360383127, 15344.923275383775, 15626.296816643278, 722936.0, 726792.0, 728352.0, 728584.0, 729342.0, 57201.0, 57651.423485765445, 57651.71174144186, 57751.71124144436, 58070.0, 1361.2104979112091, 1370.787527933172, 1381.8272715910512, 1386.230641993703, 1391.7425276323913, 28554.85722571374, 28686.0, 28957.420851583272, 28965.710342896302, 29607.111786646434, 48640.0, 48888.2666760006, 48914.0, 48922.0, 48969.75515122402, 614311.0, 617145.0, 618696.0, 620071.0, 621555.0, 23014.539709206056, 23559.76440235576, 24808.379790505383, 26229.73770262273, 26391.736082639694, 43066.0, 43310.35034474423, 44909.0, 46461.07077858356, 46687.29969050535, 37485.4377184337, 37511.43732843955, 38359.04102397463, 38570.421443678926, 39780.0, 35170.64829351674, 37138.54024862686, 37517.06207344838, 37835.0, 38459.80770096132, 35911.28177436489, 36795.08012299714, 37204.44193337156, 37607.811960940024, 37702.811485942395, 27408.0, 31374.215644609067, 33875.0, 33968.98093057212, 33991.830040849636, 21249.487873852482, 21294.78705212928, 25118.3720406984, 25344.239672809847, 25510.87244563765], "value": 20072.985505360106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.8287222133374, 369.62298455575313, 379.6564109480919, 382.5046564698715, 387.12509728014686, 13468.66328341792, 15304.234788260585, 15332.386704531818, 20881.68677469839, 21417.46456338592, 19199.0, 19495.902520487412, 20145.697814532792, 20248.797512024874, 20385.694214586754, 5570.2480165177685, 5809.692819115708, 5827.125931110325, 5828.0675091985295, 5834.212381328509, 5019.774110165033, 6507.0, 6592.769253076143, 6647.069410282565, 6662.800115996503, 5767.798127065554, 6082.543809214305, 6582.243042050178, 6606.900896486556, 6611.603303801763, 6112.480439162677, 6124.540659450537, 6153.753849846001, 6158.3841615838055, 6163.414475624831, 5748.137779333092, 5792.739326730307, 5941.603723125062, 5946.583739138262, 5951.256092988377, 12903.612891613267, 13140.934295328461, 13146.342682865818, 22750.772492275195, 23731.644025339632, 2157.902894369757, 2191.430228140679, 2214.446388402899, 2522.965584110506, 2535.378832186108, 9337.766555836091, 9736.659216927374, 10080.64717734883, 10241.334313269688, 10287.485625718684, 1612.2100170916283, 1829.0397541290795, 1873.5222817466267, 1880.7366968624267, 1931.5750534882443, 97531.0, 108798.0, 108905.0, 110563.34154987682, 126362.10456843155, 10708.30396024256, 11219.775604487864, 11626.418679066182, 11681.415929203506, 11777.823332650018, 14256.215908125152, 14266.072705274124, 14470.20413877247, 14481.637959050897, 14489.130652160904, 7015.543989640657, 8297.58512074394, 8501.0, 8625.051244363114, 8641.740747777576, 7619.0, 8533.573321333908, 8541.743747687578, 8554.401191916506, 8700.0, 4247.660187185018, 4437.267850804581, 4449.488308844524, 4450.666200034945, 4529.5243999380245, 1876.7841698204882, 1918.8081191880701, 1927.1018047223474, 1927.874688145266, 1928.4021953194554, 828.2131974624131, 838.3251482556478, 869.913008699125, 884.712468447757, 1021.7394564386034, 19588.16558658898, 21117.0, 21120.0, 21229.893850530647, 21440.78559214419, 907.0657223060258, 936.3726303376754, 937.4328531238502, 984.7981163861391, 994.627014869424, 10602.946985265024, 10951.466794648755, 11097.38964356952, 11119.332840029625, 11147.832782508269, 571879.0, 573841.0, 589629.0, 633331.0, 635760.6423935794, 90693.7009895911, 125649.0, 141811.0, 144280.11439771147, 148226.51773482343, 831.1356189562787, 892.7143314139413, 896.6099746610246, 898.3935843305873, 900.5632268349846, 18175.0, 18663.066846657883, 18893.859495663688, 18964.810351896303, 19074.0, 54356.728216358664, 56081.71959140178, 56225.594360141324, 57952.71023644855, 58161.41838581729, 78578.0, 81596.0, 82235.0, 84963.0, 85821.0, 7559.092908850973, 7736.31136093672, 7884.566348850639, 7977.800554986172, 8204.876926845982, 8793.604287806937, 11065.170112241774, 12066.396680166132, 12326.0, 12578.182418142791, 10668.1998850085, 10835.729106772395, 10845.620403285848, 10983.725406864893, 11165.609203677832, 10515.474226288808, 10522.0, 10645.361278323326, 10689.198310126616, 10831.945840271064, 10938.507767150657, 10981.560737570728, 11034.779304414027, 11072.0, 11306.321620702784, 7799.220077992155, 7824.630689629178, 7901.68393264286, 8193.918060819555, 8391.916080839357, 8150.551719655476, 9651.420914745138, 10528.947355263175, 11040.723981900517, 11321.943390282995], "value": 9354.310666420693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.8246451658063, 1538.2462593329271, 1735.6181640039188, 1829.1768704083165, 1900.6103748731502, 8498.830023399536, 9053.592588333524, 9055.094490550942, 9057.411268267559, 9076.183143517082, 7858.489198202113, 8055.838883222332, 8068.031836179666, 8523.531205783695, 8831.602577883994, 2380.7143142822842, 2423.9636405453934, 2428.5628586854446, 2431.3192306154306, 2435.208557218902, 2300.8619482831, 2373.335466069503, 2409.6385542168728, 2450.8529488230674, 2456.6315052742143, 2227.10915633747, 2431.258466167818, 2442.9022839086506, 2446.9510609787794, 2454.5090981803623, 2404.350825277183, 2411.7588241175918, 2417.141914620302, 2420.407000284924, 2437.1348171399254, 2392.4736557957394, 2414.746451622572, 2418.9637155442683, 2421.9515609687883, 2425.514897020585, 8769.210771030574, 8965.865512017324, 8966.01373848876, 8971.416857904216, 8987.595558199897, 5246.396664383607, 5420.91868621971, 5423.810166644188, 5433.130699088167, 5436.456354364572, 3024.969750302491, 3493.2140268439653, 3702.9259414811822, 3710.2023065041144, 3713.591504934455, 1059.036276987945, 1087.6356420599109, 1091.4309265245547, 1104.9558017679283, 1118.9888101119047, 11535.538578456852, 11625.186236963416, 11652.592159274469, 11681.415929203506, 11685.766284674344, 4607.95392046082, 4673.6728429009645, 4865.391826021747, 4867.464578896389, 4880.95119048805, 10019.699409017596, 10025.298229124037, 10026.899731002597, 10034.799304013879, 10054.748631284276, 5391.353037635509, 5397.298351214396, 5406.324209473816, 5407.540359069444, 5408.91886621701, 4261.509926358446, 4452.933206001912, 4614.907701845944, 4874.634402419832, 4949.480304567968, 3973.324534829086, 3977.6817854571564, 4001.459802926626, 4104.794760262034, 4110.77390743506, 1310.1287643717012, 1320.3332317179763, 1321.8479874814327, 1334.7130366971148, 1336.9131006484547, 663.8307231655897, 879.3141349747208, 888.8755574219614, 904.6471875968377, 905.9954700226457, 5261.158214685632, 5684.147377893349, 5735.053716136874, 5918.644881307136, 6132.049532322497, 863.5811631358786, 988.2884323287221, 1003.9146672532917, 1016.4307987527009, 1050.0811789684026, 3769.679577235911, 3811.275857587105, 3886.630770076838, 3982.601739825994, 4008.238434697398, 10577.471126443646, 10825.0, 10908.836367454494, 10910.945445272722, 10919.508622111865, 10850.348979061282, 10857.402842843561, 10861.402622855661, 10864.72838179036, 10880.347179169275, 8093.595320233965, 8210.58947052657, 8289.461185022954, 8419.705310314232, 8421.705240316682, 5790.971045144747, 5809.157672137601, 5932.584719069796, 5969.0, 6079.878402432015, 9771.267154963549, 10030.147437467896, 10301.072903438726, 10314.43270620093, 10322.380657160595, 9876.358036727877, 10230.539625716712, 10353.4305613192, 10402.687919362432, 10449.791004180026, 6925.757598484231, 7100.0, 7118.786436406916, 7467.141278753013, 7642.847143057219, 7882.881756773768, 7953.761387158163, 7958.721444749406, 8187.222213889671, 8414.284785793032, 6136.815895523141, 6727.394534491919, 7565.848683026198, 7631.046119235096, 7655.387568994578, 7236.638168091469, 7330.706771729071, 7385.556866588022, 7437.776866694008, 7472.0, 6238.500919926304, 6609.537332386687, 6748.055272261985, 6801.659917004031, 6926.688299026455, 4876.171050921423, 4934.703917764946, 4934.938988117572, 4939.777710002986, 4966.130927087817, 4764.356811830358, 4789.521047895182, 4885.7801398937845, 4927.1131196384995, 4974.5771609413605], "value": 4611.183386337043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.44179920576323, 299.13400704959145, 306.2619087997925, 310.49854485006705, 313.0467725775015, 4472.597466228039, 5056.65998510395, 5175.896482070356, 5296.629235953485, 5338.786448542059, 4691.756684478616, 4789.3294938708605, 5011.574016208618, 5149.2791009258735, 5190.325257716501, 3300.950485742716, 3333.0667413124243, 3541.698955588778, 4035.757854528723, 4044.170944956292, 3659.2864391443677, 3745.7565258258264, 3788.4317352397225, 3985.0, 4041.979790101045, 3459.4951196229595, 3902.6682731967817, 3920.1382990417014, 4037.6164264394833, 4050.9594904050878, 3466.5666791651042, 3653.725970552193, 4002.858470718181, 4021.6983726220506, 4035.9103042178594, 2876.798624096314, 2896.811707239023, 3477.0, 3477.94783078254, 3513.877014304487, 4834.540718631724, 5112.335396398482, 5120.206368012927, 5142.51146141116, 5220.137098547086, 3652.4703917932015, 4475.507694153641, 4530.546945305476, 4535.682502224846, 4563.475200351969, 4728.598069164125, 4841.636877234221, 5060.51925067118, 5580.349334066326, 5613.522850557667, 3212.5823642926503, 3564.8574057037686, 3750.79370634615, 3844.461775351453, 3848.9615103849164, 5115.386153661584, 5827.88344233113, 5828.6502809831545, 5848.473637372657, 5861.677607731573, 3294.1270563300745, 3618.2763447310645, 3818.0, 3855.6722678572073, 3869.303525365461, 3284.474484082535, 3641.289948460025, 3921.137349783043, 3940.802959851996, 3947.519680119955, 4223.986243301585, 4241.533431322552, 4481.708688935209, 4499.5275496072445, 4513.524586068709, 5497.45025497447, 5519.337679478408, 5542.722863856791, 5590.720463976785, 5661.094224923992, 1132.7451323452158, 1184.3545267829054, 1243.787307375302, 1259.7480503899073, 1320.3464285178898, 705.7917914215216, 742.2836962331376, 799.9840003199903, 846.7586737779703, 861.3927181337142, 3892.861422921773, 4354.281543545343, 4464.977675111603, 4509.294423346032, 4555.248384016666, 4095.5494895561465, 4152.91694166115, 4158.584141585818, 4357.477102747627, 4760.714357138583, 3618.069363815318, 3784.848606055727, 4039.4546736190237, 4322.746403543, 4395.692301538926, 2188.890555472252, 2454.3373289211813, 2495.4759500504733, 2534.961975570368, 2540.9491810163695, 4357.629601483909, 4643.0, 4655.135383524225, 4908.509149085135, 4996.600271978233, 3972.503437070366, 4638.83764068256, 4644.991341252199, 4868.269759536098, 4868.805247790119, 4132.752034877917, 4793.760311984387, 4856.68431551955, 4872.4883887192755, 4929.580985616191, 4327.826886924614, 4363.105563359441, 4567.1550763108935, 4643.164230438553, 4671.006289622324, 3938.177963435367, 4093.65203957655, 4316.503602085801, 4711.057788442256, 4746.644001699955, 4024.8993775154686, 4336.37122617225, 4475.462944446687, 4858.659893807399, 4878.487758785418, 2829.462402143586, 2976.151796738006, 3124.0471656145096, 3131.545925840786, 3167.904962851118, 4142.855000074983, 4360.498542667634, 4399.956000440083, 4741.976290118528, 4767.067169585037, 4059.011084568599, 4189.685773566934, 4278.529361770141, 4579.176387716294, 4679.415073115861, 4607.83872564472, 4620.653450991122, 4639.768011599474, 4646.953530464787, 4666.546755400911, 4118.6499147572795, 4163.458750362433, 4584.495705472462, 4619.79885229836, 4956.884700942259, 4296.3555466679, 4747.335373047707, 4815.964567617979, 5309.867253318698, 5433.320834895638, 5337.759800809051, 5359.624826262124, 5367.785288588413, 5369.4630536946, 5380.811671591632], "value": 3671.7386171632725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8524009957908, 716.8494616130612, 738.8596166728321, 774.6281784743323, 778.5678948183755, 14957.850421495781, 15590.14254216019, 15921.36314547418, 16195.595110122253, 16252.593685157848, 13615.863841361583, 13773.793393099111, 13803.65490862729, 13843.792343114861, 13855.792163117561, 671.8320419895026, 691.339770519153, 692.9272426395231, 818.4189225649781, 825.3603457320564, 846.0820010288844, 846.3483117999137, 857.498363457375, 857.8284343131368, 858.3819649852128, 913.0413066280412, 914.9542522873863, 915.9862602060974, 917.0966597901062, 918.4535201555065, 706.8338940349014, 724.822418507469, 730.883058710609, 909.4043401571981, 911.9817603647923, 536.0244355273404, 536.1180857489447, 642.633698791689, 657.6547312660844, 661.2329697550817, 14505.564833055025, 14519.05626134298, 14522.419103235858, 14539.563813085519, 14553.636159096108, 12131.332776697278, 13463.259520726357, 13524.18854868711, 13676.316184190751, 13745.312734363342, 9606.615735370577, 12068.09489288307, 12074.456649450707, 12408.131430799847, 12816.166949148275, 4483.910321793546, 4517.909641807146, 4568.132054909556, 4607.0, 4736.242201247784, 107923.0, 111671.0, 111708.88291117066, 111998.44000780107, 112338.0, 9490.905090949002, 10320.793584128425, 10731.678049658523, 10750.0, 11039.116870650329, 20818.27136050231, 21019.579608407745, 21065.15739370408, 21159.942002899792, 21192.36422907315, 7613.581253031137, 7769.844603107907, 7788.104367997753, 7855.685772569148, 7916.604169791487, 4350.0, 4355.542668019875, 4372.715773474714, 4404.361367601679, 4421.690481666253, 3308.338332333543, 3415.52182694423, 3422.3326451342245, 3428.7599868009, 3431.0564594736147, 645.0549944331577, 645.7901182115737, 666.7299743603849, 667.866426714659, 668.4652278177439, 559.6278474814203, 563.1749487001563, 616.4267231474771, 620.9753906054955, 626.7618305044055, 8269.255766981001, 8391.24478796899, 8915.369965860087, 8973.508447268754, 9032.412893161923, 598.4733434577631, 616.7563812294209, 623.18985319085, 640.6540468147241, 645.0904225042667, 4251.234777739975, 4336.956630433655, 4369.956300437018, 4400.581944715247, 4429.158459892675, 96153.51923240339, 96889.51555242178, 103089.96910030954, 163353.0, 175638.0, 142149.0, 145566.0, 147653.0, 147986.0, 153088.0, 126737.0, 127539.3623031879, 129048.0, 130005.34997324953, 131477.0, 8209.79475513117, 8521.659133634834, 8555.486670799772, 8641.8703719443, 8773.29813614922, 46398.53601463942, 50467.0, 59224.40775592361, 61183.38816611955, 62746.37253627588, 88117.0, 91883.16233675423, 92824.53587732019, 93819.0, 103555.4822225884, 12625.621231363073, 12909.419076141785, 13021.153625014344, 13397.397117129558, 13444.795515100077, 14513.854861451251, 14821.481248156262, 14856.40574377056, 15021.0, 15068.321925513597, 13186.868131318948, 13222.471101155847, 13591.79612305836, 13845.30773461343, 14321.0, 11779.293242405483, 12915.483380665044, 13377.464901404224, 13772.65568360799, 13990.68346091059, 13167.144135631153, 13662.11196272239, 14094.859051409354, 14106.929465352607, 14207.786883196966, 11383.260088094248, 11401.885981140082, 11613.767724645291, 11886.583969561023, 11944.402779860799, 9993.800123997626, 11094.278871873303, 11464.426778660867, 11713.707157321136, 11719.824202636797], "value": 7711.421038773459, "unit": "score"}], "name": "dromaeo_css", "value": 7160.726827945888, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 107.0, 142.0, 113.0, 137.0, 139.0, 105.0, 139.0, 110.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 184.0, 181.0, 184.0, 184.0, 184.0, 185.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 70.0, 114.0, 87.0, 80.0, 60.0, 57.0, 85.0, 58.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 73.0, 97.0, 70.0, 68.0, 69.0, 93.0, 68.0, 68.0, 90.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 88.0, 131.0, 96.0, 85.0, 87.0, 84.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 96.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 86.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 53.0, 54.0, 56.0, 58.0, 58.0, 58.0, 57.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 75.0, 75.0, 71.0, 68.0, 70.0, 68.0, 69.0, 70.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 85.0, 80.0, 83.0, 82.0, 82.0, 86.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 141.0, 137.0, 139.0, 139.0, 141.0, 142.0, 176.0, 151.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 70.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1428.0999999999997, "alertThreshold": 2.0}]} 21:36:23 INFO - Return code: 0 21:36:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:36:23 INFO - # TBPL SUCCESS # 21:36:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:36:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:36:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:36:23 INFO - 2016-10-20 21:36:23.124 screenresolution[1669:9795] starting screenresolution argv=screenresolution get 21:36:23 INFO - 2016-10-20 21:36:23.126 screenresolution[1669:9795] Display 0: 1600x1200x32@60 21:36:23 INFO - 2016-10-20 21:36:23.132 screenresolution[1670:9798] starting screenresolution argv=screenresolution list 21:36:23 INFO - Available Modes on Display 0 21:36:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:36:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:36:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:36:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:36:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:36:23 INFO - Intel Iris: 21:36:23 INFO - Chipset Model: Intel Iris 21:36:23 INFO - Type: GPU 21:36:23 INFO - Bus: Built-In 21:36:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:36:23 INFO - Vendor: Intel (0x8086) 21:36:23 INFO - Device ID: 0x0a2e 21:36:23 INFO - Revision ID: 0x0009 21:36:23 INFO - Displays: 21:36:23 INFO - Display: 21:36:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:36:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:36:23 INFO - Display Serial Number: 1600x1200 60 21:36:23 INFO - Main Display: Yes 21:36:23 INFO - Mirror: Off 21:36:23 INFO - Online: Yes 21:36:23 INFO - Rotation: Supported 21:36:23 INFO - Return code: 0 21:36:23 INFO - Running post-action listener: _resource_record_post_action 21:36:23 INFO - [mozharness: 2016-10-21 04:36:23.369090Z] Finished run-tests step (success) 21:36:23 INFO - Running post-run listener: _resource_record_post_run 21:36:23 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37123072; Write bytes: 661236736; Read time: 237; Write time: 1879 21:36:23 INFO - TinderboxPrint: CPU usage
53.6% 21:36:23 INFO - TinderboxPrint: I/O read bytes / time
37,123,072 / 237 21:36:23 INFO - TinderboxPrint: I/O write bytes / time
661,236,736 / 1,879 21:36:23 INFO - TinderboxPrint: CPU idle
2,242.8 (46.4%) 21:36:23 INFO - TinderboxPrint: CPU system
967.6 (20.0%) 21:36:23 INFO - TinderboxPrint: CPU user
1,623.4 (33.6%) 21:36:23 INFO - TinderboxPrint: Swap in / out
400,371,712 / 0 21:36:23 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358666752; Write bytes: 355293184; Read time: 27642; Write time: 752 21:36:23 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35156992; Write bytes: 294913024; Read time: 220; Write time: 1090 21:36:23 INFO - Running post-run listener: _upload_blobber_files 21:36:23 INFO - Blob upload gear active. 21:36:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:36:23 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:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:36:24 INFO - (blobuploader) - INFO - Open directory for files ... 21:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:25 INFO - (blobuploader) - INFO - Done attempting. 21:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:26 INFO - (blobuploader) - INFO - Done attempting. 21:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:28 INFO - (blobuploader) - INFO - Done attempting. 21:36:28 INFO - (blobuploader) - INFO - Iteration through files over. 21:36:28 INFO - Return code: 0 21:36:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:36:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:36:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/134fc355246883d6039c680ba472aed837b019139a9f177ce2fa98251a59a1eb2a1b7adc7b1c11a857ccc39ac358893492455e608070b60520ec12e7dfa1080f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b565eb875ca17d2b14c470dfff4151abf59fb668c6bc8994fd2eacd6842bcb3efa087613ee5d5b16af4922298f37eb5d9f58bd71d9080e45badaa3f5854e3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a44ee5da54684b5a68a44f03e7c36458fe3dd1940ff138fbc47fbbbefa31aa5de97d3f0103a9b040f8df0d63e338e0ab07d0b4db9b7f39d531d9c601e63272"} 21:36:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:36:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:36:28 INFO - Contents: 21:36:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/134fc355246883d6039c680ba472aed837b019139a9f177ce2fa98251a59a1eb2a1b7adc7b1c11a857ccc39ac358893492455e608070b60520ec12e7dfa1080f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b565eb875ca17d2b14c470dfff4151abf59fb668c6bc8994fd2eacd6842bcb3efa087613ee5d5b16af4922298f37eb5d9f58bd71d9080e45badaa3f5854e3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a44ee5da54684b5a68a44f03e7c36458fe3dd1940ff138fbc47fbbbefa31aa5de97d3f0103a9b040f8df0d63e338e0ab07d0b4db9b7f39d531d9c601e63272"} 21:36:28 INFO - Running post-run listener: copy_logs_to_upload_dir 21:36:28 INFO - Copying logs to upload dir... 21:36:28 INFO - mkdir: /builds/slave/test/build/upload/logs 21:36:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.708113 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-20 21:36:28.634799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 21:36:28.641073) ========= 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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/134fc355246883d6039c680ba472aed837b019139a9f177ce2fa98251a59a1eb2a1b7adc7b1c11a857ccc39ac358893492455e608070b60520ec12e7dfa1080f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b565eb875ca17d2b14c470dfff4151abf59fb668c6bc8994fd2eacd6842bcb3efa087613ee5d5b16af4922298f37eb5d9f58bd71d9080e45badaa3f5854e3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a44ee5da54684b5a68a44f03e7c36458fe3dd1940ff138fbc47fbbbefa31aa5de97d3f0103a9b040f8df0d63e338e0ab07d0b4db9b7f39d531d9c601e63272"} build_url:https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011042 build_url: 'https://queue.taskcluster.net/v1/task/HpiwVN-7SyykqZxNX-qeGw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/134fc355246883d6039c680ba472aed837b019139a9f177ce2fa98251a59a1eb2a1b7adc7b1c11a857ccc39ac358893492455e608070b60520ec12e7dfa1080f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b565eb875ca17d2b14c470dfff4151abf59fb668c6bc8994fd2eacd6842bcb3efa087613ee5d5b16af4922298f37eb5d9f58bd71d9080e45badaa3f5854e3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a44ee5da54684b5a68a44f03e7c36458fe3dd1940ff138fbc47fbbbefa31aa5de97d3f0103a9b040f8df0d63e338e0ab07d0b4db9b7f39d531d9c601e63272"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 21:36:28.673293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:36:28.673647) ========= 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.KgxR2yNaPV/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.ebCV3ug9Yb/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005028 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:36:28.723451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 21:36:28.723771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 21:36:28.724071) ========= ========= Total master_lag: 0.17 =========