builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0332 starttime: 1492679382.65 results: success (0) buildid: 20170420011827 builduid: 3e21b6ee033743fdb056d79150322f66 revision: cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.646785) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.647222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.647505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.675661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.676205) ========= 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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 --2017-04-20 02:09:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 124M=0s 2017-04-20 02:09:42 (124 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.841770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.846130) ========= 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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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.027348 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:42.896784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 02:09:42.897169) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 2017-04-20 02:09:43,022 truncating revision to first 12 chars 2017-04-20 02:09:43,022 Setting DEBUG logging. 2017-04-20 02:09:43,022 attempt 1/10 2017-04-20 02:09:43,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cf76e00dcd6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 02:09:44,501 unpacking tar archive at: mozilla-beta-cf76e00dcd6f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.751546 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 02:09:44.681639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:44.682149) ========= script_repo_revision: cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:44.682716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:44.683877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 02:09:44.706028) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-20 02:09:44.706498) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:09:44 INFO - MultiFileLogger online at 20170420 02:09:44 in /builds/slave/test 02:09:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:09:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:09:44 INFO - {'append_to_log': False, 02:09:44 INFO - 'base_work_dir': '/builds/slave/test', 02:09:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:09:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:09:44 INFO - 'branch': 'Mozilla-Beta', 02:09:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:44 INFO - 'config_files': ('talos/mac_config.py',), 02:09:44 INFO - 'default_actions': ('clobber', 02:09:44 INFO - 'read-buildbot-config', 02:09:44 INFO - 'download-and-extract', 02:09:44 INFO - 'populate-webroot', 02:09:44 INFO - 'create-virtualenv', 02:09:44 INFO - 'install', 02:09:44 INFO - 'run-tests'), 02:09:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:44 INFO - 'download_minidump_stackwalk': True, 02:09:44 INFO - 'download_symbols': 'ondemand', 02:09:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:44 INFO - 'gecko_profile': False, 02:09:44 INFO - 'gecko_profile_interval': 0, 02:09:44 INFO - 'installer_path': 'installer.exe', 02:09:44 INFO - 'log_level': 'info', 02:09:44 INFO - 'log_name': 'talos', 02:09:44 INFO - 'log_to_console': True, 02:09:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:09:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:09:44 INFO - 'opt_config_files': (), 02:09:44 INFO - 'pip_index': False, 02:09:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:09:44 INFO - 'cmd': ('bash', 02:09:44 INFO - '-c', 02:09:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:09:44 INFO - 'enabled': True, 02:09:44 INFO - 'halt_on_failure': False, 02:09:44 INFO - 'name': 'check_screen_resolution'},), 02:09:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:09:44 INFO - 'cmd': ('bash', 02:09:44 INFO - '-c', 02:09:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:09:44 INFO - 'enabled': True, 02:09:44 INFO - 'halt_on_failure': False, 02:09:44 INFO - 'name': 'check_screen_resolution'},), 02:09:44 INFO - 'run_cmd_checks_enabled': True, 02:09:44 INFO - 'suite': 'dromaeojs', 02:09:44 INFO - 'system_bits': '32', 02:09:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:44 INFO - 'title': 't-yosemite-r7-0332', 02:09:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:44 INFO - 'use_talos_json': True, 02:09:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:09:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:44 INFO - 'work_dir': 'build'} 02:09:44 INFO - [mozharness: 2017-04-20 09:09:44.935535Z] Running clobber step. 02:09:44 INFO - Running pre-action listener: _resource_record_pre_action 02:09:44 INFO - Running main action method: clobber 02:09:44 INFO - rmtree: /builds/slave/test/build 02:09:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:09:49 INFO - Running post-action listener: _resource_record_post_action 02:09:49 INFO - [mozharness: 2017-04-20 09:09:49.298523Z] Finished clobber step (success) 02:09:49 INFO - [mozharness: 2017-04-20 09:09:49.298654Z] Running read-buildbot-config step. 02:09:49 INFO - Running pre-action listener: _resource_record_pre_action 02:09:49 INFO - Running main action method: read_buildbot_config 02:09:49 INFO - Using buildbot properties: 02:09:49 INFO - { 02:09:49 INFO - "project": "", 02:09:49 INFO - "product": "firefox", 02:09:49 INFO - "script_repo_revision": "production", 02:09:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:09:49 INFO - "repository": "", 02:09:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:09:49 INFO - "buildid": "20170420011827", 02:09:49 INFO - "pgo_build": "False", 02:09:49 INFO - "basedir": "/builds/slave/test", 02:09:49 INFO - "buildnumber": 5, 02:09:49 INFO - "slavename": "t-yosemite-r7-0332", 02:09:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:09:49 INFO - "platform": "yosemite_r7", 02:09:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:09:49 INFO - "branch": "mozilla-beta", 02:09:49 INFO - "repo_path": "releases/mozilla-beta", 02:09:49 INFO - "revision": "cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31", 02:09:49 INFO - "stage_platform": "macosx64", 02:09:49 INFO - "builduid": "3e21b6ee033743fdb056d79150322f66", 02:09:49 INFO - "slavebuilddir": "test" 02:09:49 INFO - } 02:09:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 02:09:49 INFO - Running post-action listener: _resource_record_post_action 02:09:49 INFO - [mozharness: 2017-04-20 09:09:49.301846Z] Finished read-buildbot-config step (success) 02:09:49 INFO - [mozharness: 2017-04-20 09:09:49.301971Z] Running download-and-extract step. 02:09:49 INFO - Running pre-action listener: _resource_record_pre_action 02:09:49 INFO - Running main action method: download_and_extract 02:09:49 INFO - mkdir: /builds/slave/test/build/tests 02:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:49 INFO - trying https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 02:09:49 INFO - Downloading https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 02:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 02:09:50 INFO - Downloaded 1165 bytes. 02:09:50 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 02:09:50 INFO - Using the following test package requirements: 02:09:50 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 02:09:50 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 02:09:50 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 02:09:50 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:09:50 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 02:09:50 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 02:09:50 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 02:09:50 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 02:09:50 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 02:09:50 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:09:50 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 02:09:50 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 02:09:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 02:09:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 02:09:50 INFO - Fetch https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 02:09:51 INFO - Expected file size: 51220737 02:09:51 INFO - Obtained file size: 51220737 02:10:07 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 02:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 02:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 02:10:09 INFO - Expected file size: 51220737 02:10:09 INFO - Obtained file size: 51220737 02:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 02:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 02:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 02:10:25 INFO - Expected file size: 14404424 02:10:25 INFO - Obtained file size: 14404424 02:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:26 INFO - trying https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:10:26 INFO - Downloading https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 02:10:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 02:10:28 INFO - Downloaded 59226136 bytes. 02:10:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:10:28 INFO - mkdir: /builds/slave/test/properties 02:10:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:28 INFO - Contents: 02:10:28 INFO - build_url:https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:10:28 INFO - Running post-action listener: _resource_record_post_action 02:10:28 INFO - Running post-action listener: set_extra_try_arguments 02:10:28 INFO - [mozharness: 2017-04-20 09:10:28.800640Z] Finished download-and-extract step (success) 02:10:28 INFO - [mozharness: 2017-04-20 09:10:28.800792Z] Running populate-webroot step. 02:10:28 INFO - Running pre-action listener: _resource_record_pre_action 02:10:28 INFO - Running main action method: populate_webroot 02:10:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:28 INFO - '--tppagecycles', 02:10:28 INFO - '7'], 02:10:28 INFO - 'tests': ['tsvgm']}}, 02:10:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['damp', 'tps']}, 02:10:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'tests': ['damp', 'tps']}, 02:10:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['dromaeo_dom']}, 02:10:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['basic_compositor_video']}, 02:10:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:10:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['a11yr', 02:10:28 INFO - 'ts_paint', 02:10:28 INFO - 'tpaint', 02:10:28 INFO - 'sessionrestore', 02:10:28 INFO - 'sessionrestore_no_auto_restore', 02:10:28 INFO - 'tabpaint']}, 02:10:28 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:28 INFO - 'ts_paint', 02:10:28 INFO - 'tpaint', 02:10:28 INFO - 'sessionrestore', 02:10:28 INFO - 'sessionrestore_no_auto_restore', 02:10:28 INFO - 'tabpaint']}, 02:10:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:28 INFO - 'ts_paint', 02:10:28 INFO - 'tpaint', 02:10:28 INFO - 'sessionrestore', 02:10:28 INFO - 'sessionrestore_no_auto_restore', 02:10:28 INFO - 'tabpaint']}, 02:10:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:28 INFO - 'ts_paint', 02:10:28 INFO - 'tpaint', 02:10:28 INFO - 'sessionrestore', 02:10:28 INFO - 'sessionrestore_no_auto_restore', 02:10:28 INFO - 'tabpaint']}, 02:10:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['a11yr', 02:10:28 INFO - 'ts_paint', 02:10:28 INFO - 'tpaint', 02:10:28 INFO - 'sessionrestore', 02:10:28 INFO - 'sessionrestore_no_auto_restore', 02:10:28 INFO - 'tabpaint']}, 02:10:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['a11yr', 02:10:28 INFO - 'ts_paint', 02:10:28 INFO - 'tpaint', 02:10:28 INFO - 'sessionrestore', 02:10:28 INFO - 'sessionrestore_no_auto_restore', 02:10:28 INFO - 'tabpaint']}, 02:10:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['tsvgx', 02:10:28 INFO - 'tsvgr_opacity', 02:10:28 INFO - 'tart', 02:10:28 INFO - 'tscrollx', 02:10:28 INFO - 'cart', 02:10:28 INFO - 'tsvg_static']}, 02:10:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:28 INFO - 'tsvgr_opacity', 02:10:28 INFO - 'tart', 02:10:28 INFO - 'tscrollx', 02:10:28 INFO - 'cart', 02:10:28 INFO - 'tsvg_static']}, 02:10:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'talos_options': ['--disable-e10s'], 02:10:28 INFO - 'tests': ['tp5o']}, 02:10:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:10:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'talos_options': ['--disable-e10s', 02:10:28 INFO - '--xperf_path', 02:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:28 INFO - 'tests': ['tp5n']}, 02:10:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:10:28 INFO - 'talos_options': ['--xperf_path', 02:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:28 INFO - 'tests': ['tp5n']}}, 02:10:28 INFO - 'talos.zip': {'path': '', 02:10:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:28 INFO - Running post-action listener: _resource_record_post_action 02:10:28 INFO - [mozharness: 2017-04-20 09:10:28.819246Z] Finished populate-webroot step (success) 02:10:28 INFO - [mozharness: 2017-04-20 09:10:28.819390Z] Running create-virtualenv step. 02:10:28 INFO - Running pre-action listener: _resource_record_pre_action 02:10:28 INFO - Running main action method: create_virtualenv 02:10:28 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:10:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:28 INFO - Using real prefix '/tools/python27' 02:10:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:29 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:32 INFO - Installing pip.................done. 02:10:32 INFO - Return code: 0 02:10:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:10:33 INFO - Reading from file tmpfile_stdout 02:10:33 INFO - Output received: 02:10:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:33 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')]} 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 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')]} 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10:33 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 02:10:33 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 02:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:33 INFO - 'HOME': '/Users/cltbld', 02:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:33 INFO - 'LOGNAME': 'cltbld', 02:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:33 INFO - 'MOZ_NO_REMOTE': '1', 02:10:33 INFO - 'NO_EM_RESTART': '1', 02:10:33 INFO - 'PAGER': '/bin/cat', 02:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:33 INFO - 'PWD': '/builds/slave/test', 02:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:33 INFO - 'SHELL': '/bin/bash', 02:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:33 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:33 INFO - 'USER': 'cltbld', 02:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:33 INFO - 'XPC_FLAGS': '0x0', 02:10:33 INFO - 'XPC_SERVICE_NAME': '0', 02:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:33 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 02:10:33 INFO - Cleaning up... 02:10:33 INFO - Return code: 0 02:10:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10:33 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')]} 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 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')]} 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:33 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10:33 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 02:10:33 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 02:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:33 INFO - 'HOME': '/Users/cltbld', 02:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:33 INFO - 'LOGNAME': 'cltbld', 02:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:33 INFO - 'MOZ_NO_REMOTE': '1', 02:10:33 INFO - 'NO_EM_RESTART': '1', 02:10:33 INFO - 'PAGER': '/bin/cat', 02:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:33 INFO - 'PWD': '/builds/slave/test', 02:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:33 INFO - 'SHELL': '/bin/bash', 02:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:33 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:33 INFO - 'USER': 'cltbld', 02:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:33 INFO - 'XPC_FLAGS': '0x0', 02:10:33 INFO - 'XPC_SERVICE_NAME': '0', 02:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:33 INFO - Downloading/unpacking psutil>=3.1.1 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:37 INFO - Installing collected packages: psutil 02:10:37 INFO - Running setup.py install for psutil 02:10:37 INFO - building 'psutil._psutil_osx' extension 02:10:37 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 02:10:37 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 02:10:37 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 02:10:37 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 02:10:37 INFO - building 'psutil._psutil_posix' extension 02:10:37 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 02:10:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:10:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:10:38 INFO - ^ 02:10:38 INFO - 1 warning generated. 02:10:38 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 02:10:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:38 INFO - Successfully installed psutil 02:10:38 INFO - Cleaning up... 02:10:38 INFO - Return code: 0 02:10:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:39 INFO - 'HOME': '/Users/cltbld', 02:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:39 INFO - 'LOGNAME': 'cltbld', 02:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:39 INFO - 'MOZ_NO_REMOTE': '1', 02:10:39 INFO - 'NO_EM_RESTART': '1', 02:10:39 INFO - 'PAGER': '/bin/cat', 02:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:39 INFO - 'PWD': '/builds/slave/test', 02:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:39 INFO - 'SHELL': '/bin/bash', 02:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:39 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:39 INFO - 'USER': 'cltbld', 02:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:39 INFO - 'XPC_FLAGS': '0x0', 02:10:39 INFO - 'XPC_SERVICE_NAME': '0', 02:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:42 INFO - Installing collected packages: mozsystemmonitor 02:10:42 INFO - Running setup.py install for mozsystemmonitor 02:10:42 INFO - Successfully installed mozsystemmonitor 02:10:42 INFO - Cleaning up... 02:10:42 INFO - Return code: 0 02:10:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:42 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')]} 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:42 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')]} 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:42 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10:42 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 02:10:42 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 02:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:42 INFO - 'HOME': '/Users/cltbld', 02:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:42 INFO - 'LOGNAME': 'cltbld', 02:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:42 INFO - 'MOZ_NO_REMOTE': '1', 02:10:42 INFO - 'NO_EM_RESTART': '1', 02:10:42 INFO - 'PAGER': '/bin/cat', 02:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:42 INFO - 'PWD': '/builds/slave/test', 02:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:42 INFO - 'SHELL': '/bin/bash', 02:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:42 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:42 INFO - 'USER': 'cltbld', 02:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:42 INFO - 'XPC_FLAGS': '0x0', 02:10:42 INFO - 'XPC_SERVICE_NAME': '0', 02:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:42 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:45 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 02:10:45 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 02:10:45 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 02:10:45 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 02:10:45 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 02:10:45 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 02:10:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:45 INFO - warning: no files found matching '*.txt' 02:10:45 INFO - no previously-included directories found matching 'build' 02:10:45 INFO - no previously-included directories found matching 'dist' 02:10:45 INFO - no previously-included directories found matching '.git*' 02:10:45 INFO - Installing collected packages: jsonschema, functools32 02:10:45 INFO - Running setup.py install for functools32 02:10:45 INFO - warning: no files found matching '*.txt' 02:10:45 INFO - no previously-included directories found matching 'build' 02:10:45 INFO - no previously-included directories found matching 'dist' 02:10:45 INFO - no previously-included directories found matching '.git*' 02:10:45 INFO - Successfully installed jsonschema functools32 02:10:45 INFO - Cleaning up... 02:10:46 INFO - Return code: 0 02:10:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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', '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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:10: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 functools32==3.2.3-2 02:10:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:46 INFO - 'HOME': '/Users/cltbld', 02:10:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:46 INFO - 'LOGNAME': 'cltbld', 02:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:46 INFO - 'MOZ_NO_REMOTE': '1', 02:10:46 INFO - 'NO_EM_RESTART': '1', 02:10:46 INFO - 'PAGER': '/bin/cat', 02:10:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:46 INFO - 'PWD': '/builds/slave/test', 02:10:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:46 INFO - 'SHELL': '/bin/bash', 02:10:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:46 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:46 INFO - 'USER': 'cltbld', 02:10:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:46 INFO - 'XPC_FLAGS': '0x0', 02:10:46 INFO - 'XPC_SERVICE_NAME': '0', 02:10:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:10:46 INFO - Cleaning up... 02:10:46 INFO - Return code: 0 02:10:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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', '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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:10: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 blobuploader==1.2.4 02:10:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:46 INFO - 'HOME': '/Users/cltbld', 02:10:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:46 INFO - 'LOGNAME': 'cltbld', 02:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:46 INFO - 'MOZ_NO_REMOTE': '1', 02:10:46 INFO - 'NO_EM_RESTART': '1', 02:10:46 INFO - 'PAGER': '/bin/cat', 02:10:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:46 INFO - 'PWD': '/builds/slave/test', 02:10:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:46 INFO - 'SHELL': '/bin/bash', 02:10:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:46 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:46 INFO - 'USER': 'cltbld', 02:10:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:46 INFO - 'XPC_FLAGS': '0x0', 02:10:46 INFO - 'XPC_SERVICE_NAME': '0', 02:10:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:49 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 02:10:49 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 02:10:49 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 02:10:49 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 02:10:49 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 02:10:49 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 02:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:50 INFO - Downloading docopt-0.6.1.tar.gz 02:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:50 INFO - Running setup.py install for blobuploader 02:10:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:50 INFO - Running setup.py install for requests 02:10:51 INFO - Running setup.py install for docopt 02:10:51 INFO - Successfully installed blobuploader requests docopt 02:10:51 INFO - Cleaning up... 02:10:51 INFO - Return code: 0 02:10:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:51 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')]} 02:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:51 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')]} 02:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:51 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10:51 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 02:10:51 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 02:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:51 INFO - 'HOME': '/Users/cltbld', 02:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:51 INFO - 'LOGNAME': 'cltbld', 02:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:51 INFO - 'MOZ_NO_REMOTE': '1', 02:10:51 INFO - 'NO_EM_RESTART': '1', 02:10:51 INFO - 'PAGER': '/bin/cat', 02:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:51 INFO - 'PWD': '/builds/slave/test', 02:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:51 INFO - 'SHELL': '/bin/bash', 02:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:51 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:51 INFO - 'USER': 'cltbld', 02:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:51 INFO - 'XPC_FLAGS': '0x0', 02:10:51 INFO - 'XPC_SERVICE_NAME': '0', 02:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:51 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-rl_TQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:51 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-1G5D6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-7N2LeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-QqwVzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-2fx9Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-UWQ0CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Z6xTp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-afNtPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-7N7AmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-vlyUPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-9JS6is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-sYarQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-JRywcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-qA5GtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-bfS9aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-NPRw2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-lBgXin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:53 INFO - Running setup.py install for manifestparser 02:10:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozcrash 02:10:53 INFO - Running setup.py install for mozdebug 02:10:54 INFO - Running setup.py install for mozdevice 02:10:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozfile 02:10:54 INFO - Running setup.py install for mozhttpd 02:10:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozinfo 02:10:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozInstall 02:10:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Running setup.py install for mozleak 02:10:54 INFO - Running setup.py install for mozlog 02:10:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Running setup.py install for moznetwork 02:10:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Running setup.py install for mozprocess 02:10:55 INFO - Running setup.py install for mozprofile 02:10:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Running setup.py install for mozrunner 02:10:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:55 INFO - Running setup.py install for mozscreenshot 02:10:55 INFO - Running setup.py install for moztest 02:10:56 INFO - Running setup.py install for mozversion 02:10:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:56 INFO - Cleaning up... 02:10:56 INFO - Return code: 0 02:10:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:56 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')]} 02:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:56 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')]} 02:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:56 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:10:56 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 02:10:56 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 02:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:56 INFO - 'HOME': '/Users/cltbld', 02:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:56 INFO - 'LOGNAME': 'cltbld', 02:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:56 INFO - 'MOZ_NO_REMOTE': '1', 02:10:56 INFO - 'NO_EM_RESTART': '1', 02:10:56 INFO - 'PAGER': '/bin/cat', 02:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:56 INFO - 'PWD': '/builds/slave/test', 02:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:56 INFO - 'SHELL': '/bin/bash', 02:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:10:56 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:56 INFO - 'USER': 'cltbld', 02:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:56 INFO - 'XPC_FLAGS': '0x0', 02:10:56 INFO - 'XPC_SERVICE_NAME': '0', 02:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:56 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-HWFN5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:56 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)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:56 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-qkC2CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:56 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-nvZlZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:56 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)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:56 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-5EMyHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:56 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-vAdsRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:56 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)) 02:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:56 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-IncIA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-TOsB3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Oqqc5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Uik3aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-4ST1ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-aRIoTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-IgUWGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ykVdN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:57 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)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-VrOafQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:57 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ZC1gsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:58 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)) 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:58 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-0aGukN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:58 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-diJByo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:58 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)) 02:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:10:58 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)) 02:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:10:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:11:00 INFO - Downloading blessings-1.6.tar.gz 02:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:11:01 INFO - Installing collected packages: blessings 02:11:01 INFO - Running setup.py install for blessings 02:11:01 INFO - Successfully installed blessings 02:11:01 INFO - Cleaning up... 02:11:01 INFO - Return code: 0 02:11:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:01 INFO - Reading from file tmpfile_stdout 02:11:01 INFO - Current package versions: 02:11:01 INFO - blessings == 1.6 02:11:01 INFO - blobuploader == 1.2.4 02:11:01 INFO - docopt == 0.6.1 02:11:01 INFO - functools32 == 3.2.3-2 02:11:01 INFO - jsonschema == 2.5.1 02:11:01 INFO - manifestparser == 1.1 02:11:01 INFO - mozInstall == 1.12 02:11:01 INFO - mozcrash == 1.0 02:11:01 INFO - mozdebug == 0.1 02:11:01 INFO - mozdevice == 0.49 02:11:01 INFO - mozfile == 1.2 02:11:01 INFO - mozhttpd == 0.7 02:11:01 INFO - mozinfo == 0.9 02:11:01 INFO - mozleak == 0.1 02:11:01 INFO - mozlog == 3.4 02:11:01 INFO - moznetwork == 0.27 02:11:01 INFO - mozprocess == 0.25 02:11:01 INFO - mozprofile == 0.28 02:11:01 INFO - mozrunner == 6.13 02:11:01 INFO - mozscreenshot == 0.1 02:11:01 INFO - mozsystemmonitor == 0.3 02:11:01 INFO - moztest == 0.8 02:11:01 INFO - mozversion == 1.4 02:11:01 INFO - psutil == 3.1.1 02:11:01 INFO - requests == 1.2.3 02:11:01 INFO - wsgiref == 0.1.2 02:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:11:01 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 02:11:01 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 02:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:01 INFO - 'HOME': '/Users/cltbld', 02:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:01 INFO - 'LOGNAME': 'cltbld', 02:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:01 INFO - 'MOZ_NO_REMOTE': '1', 02:11:01 INFO - 'NO_EM_RESTART': '1', 02:11:01 INFO - 'PAGER': '/bin/cat', 02:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:01 INFO - 'PWD': '/builds/slave/test', 02:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:01 INFO - 'SHELL': '/bin/bash', 02:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:11:01 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:01 INFO - 'USER': 'cltbld', 02:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:01 INFO - 'XPC_FLAGS': '0x0', 02:11:01 INFO - 'XPC_SERVICE_NAME': '0', 02:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 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)) 02:11:01 INFO - Cleaning up... 02:11:01 INFO - Return code: 0 02:11:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:01 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 0x10f75cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f75f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5b47a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, '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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 02:11:01 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 02:11:01 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 02:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:01 INFO - 'HOME': '/Users/cltbld', 02:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:01 INFO - 'LOGNAME': 'cltbld', 02:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:01 INFO - 'MOZ_NO_REMOTE': '1', 02:11:01 INFO - 'NO_EM_RESTART': '1', 02:11:01 INFO - 'PAGER': '/bin/cat', 02:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:01 INFO - 'PWD': '/builds/slave/test', 02:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:01 INFO - 'SHELL': '/bin/bash', 02:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:11:01 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:01 INFO - 'USER': 'cltbld', 02:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:01 INFO - 'XPC_FLAGS': '0x0', 02:11:01 INFO - 'XPC_SERVICE_NAME': '0', 02:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:11:02 INFO - Cleaning up... 02:11:02 INFO - Return code: 0 02:11:02 INFO - Running post-action listener: _resource_record_post_action 02:11:02 INFO - Running post-action listener: _start_resource_monitoring 02:11:02 INFO - Starting resource monitoring. 02:11:02 INFO - [mozharness: 2017-04-20 09:11:02.142181Z] Finished create-virtualenv step (success) 02:11:02 INFO - [mozharness: 2017-04-20 09:11:02.143155Z] Running install step. 02:11:02 INFO - Running pre-action listener: _resource_record_pre_action 02:11:02 INFO - Running main action method: install 02:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:02 INFO - Reading from file tmpfile_stdout 02:11:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:02 INFO - Reading from file tmpfile_stdout 02:11:02 INFO - Output received: 02:11:02 INFO - Usage: mozinstall [options] installer 02:11:02 INFO - Options: 02:11:02 INFO - -h, --help show this help message and exit 02:11:02 INFO - -d DEST, --destination=DEST 02:11:02 INFO - Directory to install application into. [default: 02:11:02 INFO - "/builds/slave/test"] 02:11:02 INFO - --app=APP Application being installed. [default: firefox] 02:11:02 INFO - mkdir: /builds/slave/test/build/application 02:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 02:11:17 INFO - Reading from file tmpfile_stdout 02:11:17 INFO - Output received: 02:11:17 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:11:17 INFO - Running post-action listener: _resource_record_post_action 02:11:17 INFO - [mozharness: 2017-04-20 09:11:17.178631Z] Finished install step (success) 02:11:17 INFO - [mozharness: 2017-04-20 09:11:17.178763Z] Running run-tests step. 02:11:17 INFO - Running pre-action listener: _resource_record_pre_action 02:11:17 INFO - Running main action method: run_tests 02:11:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:11:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:11:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:11:17 INFO - 2017-04-20 02:11:17.191 screenresolution[1630:7568] starting screenresolution argv=screenresolution get 02:11:17 INFO - 2017-04-20 02:11:17.194 screenresolution[1630:7568] Display 0: 1600x1200x32@60 02:11:17 INFO - 2017-04-20 02:11:17.199 screenresolution[1631:7570] starting screenresolution argv=screenresolution list 02:11:17 INFO - Available Modes on Display 0 02:11:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:11:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:11:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:11:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:11:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:11:17 INFO - Intel Iris: 02:11:17 INFO - Chipset Model: Intel Iris 02:11:17 INFO - Type: GPU 02:11:17 INFO - Bus: Built-In 02:11:17 INFO - VRAM (Dynamic, Max): 1536 MB 02:11:17 INFO - Vendor: Intel (0x8086) 02:11:17 INFO - Device ID: 0x0a2e 02:11:17 INFO - Revision ID: 0x0009 02:11:17 INFO - Displays: 02:11:17 INFO - Display: 02:11:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:11:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:11:17 INFO - Display Serial Number: 1600x1200 60 02:11:17 INFO - Main Display: Yes 02:11:17 INFO - Mirror: Off 02:11:17 INFO - Online: Yes 02:11:17 INFO - Rotation: Supported 02:11:17 INFO - Return code: 0 02:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:17 INFO - Python 2.7.3 02:11:17 INFO - Return code: 0 02:11:17 INFO - grabbing minidump binary from tooltool 02:11:17 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')]} 02:11:17 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 0x10f53ad30>, '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 0x10f461db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f52fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:17 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 02:11:17 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 02:11:17 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 02:11:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:17 INFO - Return code: 0 02:11:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:11:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:17 INFO - ENV: RUST_BACKTRACE is now 1 02:11:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:11:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0332', '--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 02:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0332 --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 02:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dgke5wpLkd/Render', 02:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:17 INFO - 'HOME': '/Users/cltbld', 02:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:17 INFO - 'LOGNAME': 'cltbld', 02:11:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:17 INFO - 'MOZ_NO_REMOTE': '1', 02:11:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:17 INFO - 'NO_EM_RESTART': '1', 02:11:17 INFO - 'PAGER': '/bin/cat', 02:11:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:17 INFO - 'PWD': '/builds/slave/test', 02:11:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:17 INFO - 'RUST_BACKTRACE': '1', 02:11:17 INFO - 'SHELL': '/bin/bash', 02:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7rHaqT7rIJ/Listeners', 02:11:17 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 02:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:17 INFO - 'USER': 'cltbld', 02:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:17 INFO - 'XPC_FLAGS': '0x0', 02:11:17 INFO - 'XPC_SERVICE_NAME': '0', 02:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0332', '--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 02:11:17 INFO - mozversion application_buildid: 20170420011827 02:11:17 INFO - mozversion application_changeset: cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31 02:11:17 INFO - mozversion application_display_name: Firefox 02:11:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:17 INFO - mozversion application_name: Firefox 02:11:17 INFO - mozversion application_remotingname: firefox 02:11:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:11:17 INFO - mozversion application_vendor: Mozilla 02:11:17 INFO - mozversion application_version: 54.0 02:11:17 INFO - mozversion platform_buildid: 20170420011827 02:11:17 INFO - mozversion platform_changeset: cf76e00dcd6f142acf5b49f8beeb0ac95b2afa31 02:11:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:11:17 INFO - mozversion platform_version: 54.0 02:11:17 INFO - using testdate: 1492679477 02:11:17 INFO - actual date: 1492679477 02:11:17 INFO - starting webserver on 'localhost:49247' 02:11:17 INFO - SUITE-START | Running 2 tests 02:11:17 INFO - TEST-START | dromaeo_css 02:11:17 INFO - operating with platform_type : mac_ 02:11:17 INFO - Initialising browser for dromaeo_css test... 02:11:17 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpjyyf8v/profile http://localhost:49247/getInfo.html) 02:11:20 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 02:11:20 INFO - PROCESS | 1641 | colorDepth:24 02:11:20 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 02:11:20 INFO - PROCESS | 1641 | __metrics 02:11:20 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:11:20 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:20 INFO - TEST-INFO | 1641: exit 0 02:11:20 INFO - Browser initialized. 02:11:20 INFO - Running cycle 1/1 for dromaeo_css test... 02:11:20 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpjyyf8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:32 INFO - PROCESS | 1644 | RSS: Main: 165224448 02:11:32 INFO - PROCESS | 1644 | 02:14:36 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 02:14:38 INFO - PROCESS | 1644 | RSS: Main: 374886400 02:14:38 INFO - PROCESS | 1644 | 02:17:41 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 02:17:42 INFO - PROCESS | 1644 | RSS: Main: 306044928 02:17:42 INFO - PROCESS | 1644 | 02:20:44 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 02:20:45 INFO - PROCESS | 1644 | RSS: Main: 297934848 02:20:45 INFO - PROCESS | 1644 | 02:23:47 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 02:23:48 INFO - PROCESS | 1644 | RSS: Main: 264531968 02:23:48 INFO - PROCESS | 1644 | 02:26:51 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 02:26:52 INFO - PROCESS | 1644 | RSS: Main: 263942144 02:26:52 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 02:29:55 INFO - PROCESS | 1644 | RSS: Main: 319991808 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | __start_tp_report 02:29:55 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 02:29:55 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 02:29:55 INFO - PROCESS | 1644 | |i|pagename|runs| 02:29:55 INFO - PROCESS | 1644 | |0;dojo.html;3375.1730825947648;3548.6628770266825;3573.8213089345527;3592.1019745063736;3619.0771353304904;6053.424924632159;6140.232470941132;6150.66171360575;6151.323354431014;6180;5163.199704045869;5995.5503337249775;6130.632162070267;6132.662703551314;6145.661988590626;5454.945450545503;5490.615656904019;5505.6696598204235;5516.117421212607;5629.521490673298;5417.918731219035;5419.132938729804;5427.104527752916;5613.635113717595;5619.775208991636;5515.641483303572;5568.582356323272;5602.691851948141;5602.7758889644565;5604.859878503029;5588.189712491666;5596.328440587135;5614.6631202128;5629.099344104923;5631.099024156136;5474.37044739856;5508.64193827404;5526.806561770319;5549.500544950974;5566.332040155166;5913.408659134096;5958.957182493046;5973.910391344133;6189.102580125857;6201.844953876144;6342.048692696087;6378.138951241615;6385.840353991141;6392.936070639281;6395.552311338208;5306.893862122774;5313.760880760375;6477.805665830033;6495.382938620824;6501.609903405811;4588.747618880993;6021.54838387114;6110.663913484756;6218.5647004710145;6276.748930042792;6459.677016149174;6476.773312934119;6531.8693626127215;6553.017047442826;6580.5722628029025;6332.208473940757;6361.650109244036;6365.936340636627;6376.521760867953;6385.776497822647;6400.743970241231;6414.198225221848;6444.581102228341;6471.967640161769;6481.189851268591;6320.146780184617;6339.302676705559;6371.139896114058;6381.521385896076;6384.297727249998;6318.210223722035;6367.617942923347;6380;6415.390537898892;6427.260865000491;5030.84907452777;5112.539871411591;5153.587712982952;5160.741962901915;5168.586513078944;4540.114677637895;4640.141573808856;4678.134545109166;4686.133065382847;4744.976275118603;6367.267764207176;6385.425311721968;6387.680615969183;6393.29673735898;6400.0719895614875;6458.031295305648;6475;6492.383223593751;6497.545171837926;6538.084668146464;6135.693215339215;6165.229346331708;6194.946859033975;6202;6391.808245752635;5642.830715078554;5657.886842263131;5660.490555849993;5669.461401166883;5673.461021202979;6554.606723596599;6610;6617;6617.371349721769;6618.768343108064;6346.238451385863;6385.265694445013;6395.616263024233;6450.677466126769;6497.772577959749;6856.314368563104;6861.2795656455355;6862.4853136014;6865.485088618473;6867;6400.167978162809;6412.711427985845;6416.101745755504;6416.711247993945;6420.775272865428;4980.228064649985;6215.005599104122;6279.874402511833;6310.2743184534365;6369.267534233622;6147.0779383092895;6265.404786545271;6333.524985626189;6366.9681651591445;6369.8726025480155;6326.715297811702;6359.650219237987;6380.202474690664;6389.520785941166;6392.296847346695;6357.3006969234275;6363.5545511813725;6368.936310637019;6371.808845734636;6436.517261205335;6259.092431597484;6267.749290028348;6302.684865756602;6347.428731414195;6381.106645069787;5249.422563517934;6278.591891527036;6356.396142366468;6370.235571731237;6374.649394283359 02:29:55 INFO - PROCESS | 1644 | |1;ext.html;686.3891136888169;811.5293129984609;886.6364790435919;895.0110128308223;898.3801177187736;40775.79612101939;41456.378154327635;41457.75626731199;41504.169916601684;41619.167616647646;41852.162956740845;42054.94862628436;42101.36847947283;42159.946001349985;42215.788921055355;7935.047794264697;8083;9627.614895404193;9770.413775173512;9774;9980.251481138906;10991.835122473169;11159.163062770283;11702.8244576331;11833.230839995416;11898.881011189864;11942.880571194264;11962;11962.940185299105;11982.281063136195;11803.645890623253;11864.703382415422;11876.287422754576;11877.287362758176;11886;11631.418429078596;11689.181757276994;11697.94151029248;11703;11706.356150411724;39896.40155397642;40150;40168.59831401678;40171.7991410044;40289.59710402917;3960.960390396088;4008.6191811777835;4033.3546632538655;4044.2720310344125;4045.0696339842;28891.988780392796;29344.559831602543;30090.54864177039;30928.38143237145;30940.845295773375;3296.8186749728757;3302.752293577967;3311.337732453495;3432.9141771455916;3448.103493091789;311685;315146;315970;316000.9999999977;316095;43232.567674322854;43769.562304377185;51644;51794.74102629463;51819;52381.95236095333;53014.204786928225;55169.724151378985;55201;56599;14997.475088371855;15137.470188543348;15144.469943551923;15150.090994540364;15210.543683689508;12916.031297652526;12921.612351629467;12926.935365323114;12929.418176182095;12937.54718584845;11918.52325906954;11921;11946.402679866145;11970.700732481584;12056.578019769266;5256.737163141827;5283.286756287852;5288.286081379041;5296.417394086648;5297.894042119213;1087.787117364149;1095.4358505369742;1146.9770604587861;1201.7776711308436;1215.2769102384068;27025.864870675912;27201;27503.86248068747;27584.172474825788;27773.8890444384;995.7610173558294;1151.9020883225019;1274.9305103202762;1294.6569159172827;1322.4445732792058;14487.348069336906;14508.709825803426;14700.41198352054;14727.705445891022;14787.704245915236;495918.5204074029;496736;496891;497284;498531;60033.09950350748;60040.69979650161;60114.699426502586;60218;60387.39612603818;1464.348364977596;1480.5262316058759;1488.5013520470548;1489.6722721001363;1495.783111448812;26999;27710.307242319104;28036.719632804226;28211.43577128487;28234;38462.6153738459;38511.80744096261;38535.80732096321;38610;38653.613463866124;377082;441434;442311;442472;443057;20016.799832001492;24547.75452245526;29077.418451630427;29568.55647165251;29746.702532975258;38830;39347.606523934395;39359.60640393559;39759;40112.39831402589;27938.441231175668;28513.00204492833;28692.713072869003;28813;29720.959766408072;27832.86083569569;28887.422251555272;28903.277418063877;29203.39381334047;29591.260218493848;32935.17662058372;34122.31755364829;34712;34741.305173896886;34811.30377392387;24365.634515482638;26636.7336326642;29368.853155734083;29524.704752952195;29965.70034299629;22272.331830045125;22883;22928.656070159293;23287.53424931458;23922.64116038226 02:29:55 INFO - PROCESS | 1644 | |2;jquery.html;422.4128461438599;428.98498552550666;436.5547141915247;438.8897970506208;441.13097198518926;16208.270627821747;20154.697679534802;22109.447263818412;22117.889410552943;22205.000774965127;22566.323010309676;23009.769902300974;23432;23763.5247295054;23931.521369572598;6702.530822842416;6945.131858517685;6991.755288564876;7033.788986330393;7043.295670432942;6736.562123461959;6844.589324640513;6967.4774391920555;6968.128983877015;6976.5116441849095;6595.802125936206;6859.211190713082;6951.443884489228;6956.478264130185;6967.79096627102;6520.706568204395;6797.966010169967;6849.863002739942;6853.211880633741;6936.479764017694;6581.2760596334365;6627.1716035495565;6662;6665.800025999228;6676.26561078281;27888;28094;28180.295492612644;28463;28855.990040348486;3031.6058912341473;3064;3093.551435041929;3098.643655979569;3099;16419.261133249034;16902.408415705515;17076.31694732209;17327.480175594625;17446;2151.816500924501;2152.461884528868;2198.1866709317496;2198.626233540286;2211.292386436341;112956.4322607078;124967.37516312451;125123;125587.37206314;140337;13846.792298115537;16533.6693266134;20785.58428831415;21021.78978210229;21204.681929771064;32505.51241731376;32925.01224963255;32971.50542741861;33046;33070.50394244088;10451.954804519639;10637.202209834139;10847.51186196623;10869.130469562417;11010.669679909615;8907.064758200426;8947.463152210888;8950.820983580423;9112.726618201465;9145.451272923647;7545.886811697829;9473.47895865734;9578.616855325849;9599.568019439143;9640.79490063742;3389.949045858747;3975.6620687241907;4017.1879684221162;4035.596440355941;4049.190161967618;1029.6756521695643;1052.4685034057752;1073.9946300268448;1119.832025196227;1120.9239130434712;22041.11835526561;22281.331560053226;22281.66577501339;22315.77684223137;22364.55270894573;1105.795427845851;1108.6729414822485;1121.5289578376937;1123.1239633086207;1132.416805345248;11018.779624407467;11640.941795291139;11809.586664466702;11810.232334898204;11837.585684501173;665725;773600;810257;821746;827888;125872.26596675416;158331;160589.19705401632;163213;169568;1059.4596755654518;1212.3392750950752;1240.1814802230485;1283.8523569789406;1288.8582255951837;20212.696809547575;20470.897645511675;20957.58084838325;20969.685454718496;21013.789862101185;64879;65131.674341627986;65649.34350656433;66843;66920;89167.55416222877;90040.49797510229;90158.54920725616;92203;92564;11370.32797292619;11881.346525941157;12013.519459221534;12076.75846483083;12087.335196563921;9619.663311784054;13041.869581304065;13117;13278.601641950758;13435.664108397368;11374.488148033524;11591.478383472595;11633.38248893992;11652.009579185526;11835.11236657237;10631.043206111177;10654.14766818668;10787.352758834495;10907.345559266469;11044.447777610927;11536.82694759596;11789.705257368634;11891.82162267584;11973.76052478963;11989.820152697543;11594.71013224676;11602.361870097226;11935.701607459883;11978.76042479163;11987.700307492034;9770.85343719859;11336.773264534499;11452.656420307405;11489.482973266391;11520.366379848854 02:29:55 INFO - PROCESS | 1644 | |3;mootools.html;1589.6184915620254;1628.8534031937124;1651.5210588929208;1655.4619748581713;1666.3584519959816;10788.73028174296;11339.659810205687;11343.262687925278;11360.60237891674;11386.089112870972;10852.294600850939;11213.10295176386;11339.979401853832;11369.260998035143;11388.658340249805;2460.6678098456705;2501.7873480754156;2503.349129226396;2507.674002379688;2514.735952724965;2443;2445.7798798108165;2478.8264821462503;2491.638712386703;2498.837575557592;2446.4373194165264;2473.1467643662995;2484.0808900706766;2495.4260520080393;2498.5502609530276;2426.5874801283826;2439.597466418039;2463.4580392313665;2470.110760126353;2480.0575781203206;2452.865092419916;2466.4203912080648;2478.429961108937;2479.504099180171;2479.838810477313;11029.724256893642;11250.268732532359;11254.212205145643;11264.380459074748;11277.943610281978;5963.940360596382;6117.143599896018;6135.049067394561;6135.969320153371;6140.754369825202;3455.809930453824;3496.17839807645;3535.1869070114017;3579.8926032218815;3588.102974256436;1225.8099994500867;1233;1263.8041103628952;1279.1365828066018;1281.4046512092411;13901.930490347484;14197.645058873508;14489.565313040732;15755.606109847231;15925.362985480568;4128.236276288896;4687.296905464208;4818.204996175592;4839.685420447659;4850.199717046718;11974.341411222467;11991.400429978466;11993.220440671328;11996.940015299868;12004;4998.725070121178;5183.429822719498;5207.4011488678525;5209.374875015023;5214.895702085937;4505.864824055284;4795.880102997453;5411.485908838654;5473.616846820764;5489.917651235235;3891.669208117342;3936.940945885814;4025.376066709665;4028.3151864182573;4033.8184781684895;1027.8920713324994;1052.4001319247955;1067.0769784136667;1067.604986155112;1072.0833687197335;814.9877751833727;949.3829011142813;968;1008.8335424654849;1022.7494263905241;6573.375529324707;6663.600183988976;6734.562253453608;6791.660416979132;6856.691448884812;981.622075500923;990.9554070066864;1022.8619136416488;1036.1917704190744;1047.8166320893813;3632.9464455308193;4205.432266643964;4238.7032907696785;4291.806868690916;4357.847475338348;11325.943370283096;14357.282135893163;14362.281885905662;14379;14386.992910496165;13092.476300947856;13580.827067669126;14261.92869035669;14267.714645707236;14280.50018249377;10143.34068285559;10436.060754532129;10439.37363758177;10456.424896630606;10458;6456.7740129095255;6777.356151165632;6792.47169386884;6834.179898412222;6918.481113916376;12187.085968552217;12399.442025108712;12677.936610316889;12692.428840702376;12722.173058751152;12614.432350544064;12758.48966041348;12840.617732991355;12858.292793896426;12949;9359.85960210611;9360.297977651839;9515.619375224913;9535.809283814424;9648.469334186688;10014.549345279625;10601.204909631655;10730.946345268223;10738.516766745672;10739.14086873064;8686.478811271343;8690.435121717068;8711.825763484821;8817.206451419403;8849.69026084084;7490.325870671666;8720.21518063352;8754.737357879274;8776.868346974672;8803.823923521622;7809.180036096128;7870.921290787248;7939.761807145795;7942.841143176988;7968.0438347398685;5847.38602446737;5853.853653658693;5974.312954010345;5994.28068631767;6050.818475445743;5963.850903727442;6021.6085954414575;6063.151158837854;6149.938500614937;6206.968965155326 02:29:55 INFO - PROCESS | 1644 | |4;prototype.html;387.30865405251626;388.67157252121945;394.3296396126585;398.551629416906;398.5814894360922;4583.977080114603;5091.949080509194;5184.559312458441;5184.611154163439;5214.096854648054;4150.501939767225;4467.374567560544;4490.820367185317;5022.171341728619;5137.280780690707;3670.4677821715836;4098.815553300109;4205.044654235772;4263.616274535291;4333.371661109138;3611.783293002415;3693.6675699187067;3896.4544963705102;4248.426462427579;4338.631216346615;4158.08522125132;4202.928253295406;4219.894502637428;4384.514311122649;4426.867193984185;4014.956111411025;4212.852550160745;4221.620054195122;4255.510616279136;4287.721298115613;3692.658144379341;3895.6493915547735;3927.7446965947124;3955.7230993830444;4017.658499027586;4141.358089496133;4234.788260586958;4934.901301973976;5123.2315152727015;5142.357205349332;4225.852095176654;4492.640588752892;4984.401871775374;5060.722674796356;5099.69401835891;4902.656814022984;5166.664166829144;5374.683202615384;5397.649152805055;5492.267295000967;3802.0874990002476;4048.1903619275968;4403.3174857897075;4495.505494395614;4497.617702495259;4772.880677983008;4865.927011094836;4945.986072855092;5719.196734171771;5842.649441033552;4035.4753881995152;4116;4302.9569704303185;4496.460424748986;4550.226461501553;4222.282212023963;4497.460304763449;4672.369230153954;4691.765411729468;4767.69010014348;4576.336431217454;4684.367610372556;4973.875653108701;5002.949380630036;5051.20682157836;5083.271687626151;5222.973885130626;5467.890642187134;5485.025390859288;5501.799280287917;1357.2060344698264;1417.87948024417;1430.5207755402057;1543.5909483986752;1596.9920150399405;1085.8218832566754;1107.9778404431866;1184.7867383870987;1213.7511810078913;1231.9199252048588;4422.800973956179;5322.840314790563;5324.41431442541;5399.2980912481125;5424.321959755031;4714.528547145258;5335.439778823245;5367.892642147213;5775.306963164363;5779.283736643771;4178.456800615962;4819.662623616313;5072.9746351268;5289.629725919149;5297.735113244399;2752.8575641109114;2772.0436449424915;2864.627598412193;2874.152125123094;2960.4671159191553;4687.7656117194;5179.689218646893;5934.851628709317;5943.55423343251;5964.880702385928;5160.664556803796;5412.621116521806;5448.722752639159;5661.518770904437;5731.512821410227;4850.587700045536;4860.691171693417;5270.789168433374;5368.302120724281;5765.88468230633;4961.900761984813;5423.810166644149;5541.476094074162;5685.346185188756;5688.800891968926;4639.443266808004;4950.45544990058;5180.818671346485;5586.681527166181;5630.521405680399;4919.532644398776;5474.315710536183;5907.025340818716;5937.9406205937385;5952.672603006703;4033.858814941463;4385.342198670098;4445.844395446144;4463.308187230984;4545.840895568772;5035.748212589429;5048.293238946624;5200.817971370984;5278.762455689426;5818.2436283282905;4550.977245113886;5089.00764350948;5328.733563321741;5390.568754499709;5568.693721845338;5060.130248911245;5413.160960051198;5453.781848726166;5463.9180412294645;5551.528120109836;4896.902061958812;5002.949970500248;5236.293100431393;5362.812301569426;5385.865353366197;4811.9518804811505;4820.975190420102;4839.790052486878;5452.563794896319;5485.232067510631;4849.066314879447;4862.343583616166;5146.228065790161;5206.750379908719;5306.920396193983 02:29:55 INFO - PROCESS | 1644 | |5;yui.html;759.6315786843384;778.739122393998;804.8068463568745;898.748917619659;904.9457032578043;15375.923120384396;16428.671426571476;16987.320507179713;17724.822751772477;17827.91086044571;15716.214189290547;16134;16162;16208.83791162088;16322.75515867263;937.653068364706;1003.9447830369345;1009.5759780892043;1009.8283291840405;1009.9799202805146;989.5052473763119;1001.9949900250489;1002.2783595811004;1007.8639383683219;1019.8521214423904;911.444019148319;1068.4123731947436;1071.7213524483611;1073.0128281980558;1073.4471747050275;1068.839674048895;1069.7432616172064;1070.1866581398194;1071.6570697376842;1077.5312738958578;799.7081065411084;800.1638287989007;800.7317548621161;802.0455657767238;803.8352137811735;17369.565760855952;17510.299588016464;17602.295908163785;18018;18367.540811479685;14725.852741472556;14854.851451485454;14983.850161498463;15034.994644947592;15221.847781522154;12052.13340601619;12316.630501084981;12372.072094592851;12458.875411245863;12921;3828.1003964068423;3891.5299365651595;3955.7428767130045;3994.4208089827102;4085;56450;87345.56327218386;106705.46647266713;110826;115173;11597.304161750153;11650.126240531994;11716.824247636292;12036.699082523008;12296.692582685504;23265.651015234784;23396.181133660582;23993.880030599736;24010.639840402408;24022.39944001414;8274.255317021498;8360.372972027122;8361.03848057469;8419.831603367898;8486.660533578712;4502.797374118172;4504.932426013613;4609.95390046102;4613.8846528836375;4796.784144713496;3654.780713157219;3727.9440808387894;3741.8690345837763;3746.5316835395574;3748.3627783276906;598.6828976252262;628.8050704281687;677.1028387386634;695.3498478922224;696.022088965005;500.464502981806;512.0808149371886;592.9495992840571;601.5472633589832;624.3600309682521;10285.588576457008;10548.789024219474;10555.313904596176;10582.870737509882;11204.383758893176;587.9088741245114;599.9950083610023;615.7536985205863;622.5237693164732;635.732992143301;4990.800367985313;5262.631615786858;5266.710330931835;5277.8416647500635;5278.577713782888;99277.50361248148;100925.49537252267;101962.49018755007;104160.47919760353;105368;77723.22276777274;81072.78390824143;81679;82353.17646823575;82432;78573.60713196626;79426;81503.59248203722;82138.17861821425;82155.5892220535;10934.289271197347;11120.555177792798;11255.380954047607;11305.095592352756;11432.599859004895;40806.59193408028;48149.51850481451;49270.01459970852;49292.26061609007;49719.751401242764;69838.65080674565;71031;71508;72688.63655681688;73864.63067684627;12848.678783030125;12871.613851584092;13020.9583233343;13417.396217170446;13424.664383390493;14906.627334316296;14944.7758283628;15250.313735882133;15263.618409539851;15374.077555346716;13885.444582216598;13981;14203.928980355033;14343.56969290923;14511.782323264948;13558;14103.435862565793;14238;14375.281235937951;14508;13566.59300220995;13864.584062478141;14019.789703154256;14036.228007459687;14154.221517816619;9991.100800927952;10376.429296388771;10386.844197337197;10942.781144376908;11015.228933974546;10122.21452113952;11307.623389416161;11404.600838970597;11545.942270288595;11561 02:29:55 INFO - PROCESS | 1644 | __end_tp_report 02:29:55 INFO - PROCESS | 1644 | __start_cc_report 02:29:55 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2104 02:29:55 INFO - PROCESS | 1644 | __end_cc_report 02:29:55 INFO - PROCESS | 1644 | __startTimestamp1492680595520__endTimestamp 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | ------- Summary: start ------- 02:29:55 INFO - PROCESS | 1644 | Number of tests: 6 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:6000.97 Median:6318.21 stddev:667.87 (10.6%) stddev-sans-first:637.36 02:29:55 INFO - PROCESS | 1644 | Values: 3375.2 3548.7 3573.8 3592.1 3619.1 6053.4 6140.2 6150.7 6151.3 6180.0 5163.2 5995.6 6130.6 6132.7 6145.7 5454.9 5490.6 5505.7 5516.1 5629.5 5417.9 5419.1 5427.1 5613.6 5619.8 5515.6 5568.6 5602.7 5602.8 5604.9 5588.2 5596.3 5614.7 5629.1 5631.1 5474.4 5508.6 5526.8 5549.5 5566.3 5913.4 5959.0 5973.9 6189.1 6201.8 6342.0 6378.1 6385.8 6392.9 6395.6 5306.9 5313.8 6477.8 6495.4 6501.6 4588.7 6021.5 6110.7 6218.6 6276.7 6459.7 6476.8 6531.9 6553.0 6580.6 6332.2 6361.7 6365.9 6376.5 6385.8 6400.7 6414.2 6444.6 6472.0 6481.2 6320.1 6339.3 6371.1 6381.5 6384.3 6318.2 6367.6 6380.0 6415.4 6427.3 5030.8 5112.5 5153.6 5160.7 5168.6 4540.1 4640.1 4678.1 4686.1 4745.0 6367.3 6385.4 6387.7 6393.3 6400.1 6458.0 6475.0 6492.4 6497.5 6538.1 6135.7 6165.2 6194.9 6202.0 6391.8 5642.8 5657.9 5660.5 5669.5 5673.5 6554.6 6610.0 6617.0 6617.4 6618.8 6346.2 6385.3 6395.6 6450.7 6497.8 6856.3 6861.3 6862.5 6865.5 6867.0 6400.2 6412.7 6416.1 6416.7 6420.8 4980.2 6215.0 6279.9 6310.3 6369.3 6147.1 6265.4 6333.5 6367.0 6369.9 6326.7 6359.7 6380.2 6389.5 6392.3 6357.3 6363.6 6368.9 6371.8 6436.5 6259.1 6267.7 6302.7 6347.4 6381.1 5249.4 6278.6 6356.4 6370.2 6374.6 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:55235.71 Median:30509.47 stddev:111772.62 (366.4%) stddev-sans-first:112011.14 02:29:55 INFO - PROCESS | 1644 | Values: 686.4 811.5 886.6 895.0 898.4 40775.8 41456.4 41457.8 41504.2 41619.2 41852.2 42054.9 42101.4 42159.9 42215.8 7935.0 8083.0 9627.6 9770.4 9774.0 9980.3 10991.8 11159.2 11702.8 11833.2 11898.9 11942.9 11962.0 11962.9 11982.3 11803.6 11864.7 11876.3 11877.3 11886.0 11631.4 11689.2 11697.9 11703.0 11706.4 39896.4 40150.0 40168.6 40171.8 40289.6 3961.0 4008.6 4033.4 4044.3 4045.1 28892.0 29344.6 30090.5 30928.4 30940.8 3296.8 3302.8 3311.3 3432.9 3448.1 311685.0 315146.0 315970.0 316001.0 316095.0 43232.6 43769.6 51644.0 51794.7 51819.0 52382.0 53014.2 55169.7 55201.0 56599.0 14997.5 15137.5 15144.5 15150.1 15210.5 12916.0 12921.6 12926.9 12929.4 12937.5 11918.5 11921.0 11946.4 11970.7 12056.6 5256.7 5283.3 5288.3 5296.4 5297.9 1087.8 1095.4 1147.0 1201.8 1215.3 27025.9 27201.0 27503.9 27584.2 27773.9 995.8 1151.9 1274.9 1294.7 1322.4 14487.3 14508.7 14700.4 14727.7 14787.7 495918.5 496736.0 496891.0 497284.0 498531.0 60033.1 60040.7 60114.7 60218.0 60387.4 1464.3 1480.5 1488.5 1489.7 1495.8 26999.0 27710.3 28036.7 28211.4 28234.0 38462.6 38511.8 38535.8 38610.0 38653.6 377082.0 441434.0 442311.0 442472.0 443057.0 20016.8 24547.8 29077.4 29568.6 29746.7 38830.0 39347.6 39359.6 39759.0 40112.4 27938.4 28513.0 28692.7 28813.0 29721.0 27832.9 28887.4 28903.3 29203.4 29591.3 32935.2 34122.3 34712.0 34741.3 34811.3 24365.6 26636.7 29368.9 29524.7 29965.7 22272.3 22883.0 22928.7 23287.5 23922.6 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:43637.37 Median:12160.37 stddev:129695.97 (1066.5%) stddev-sans-first:130019.21 02:29:55 INFO - PROCESS | 1644 | Values: 422.4 429.0 436.6 438.9 441.1 16208.3 20154.7 22109.4 22117.9 22205.0 22566.3 23009.8 23432.0 23763.5 23931.5 6702.5 6945.1 6991.8 7033.8 7043.3 6736.6 6844.6 6967.5 6968.1 6976.5 6595.8 6859.2 6951.4 6956.5 6967.8 6520.7 6798.0 6849.9 6853.2 6936.5 6581.3 6627.2 6662.0 6665.8 6676.3 27888.0 28094.0 28180.3 28463.0 28856.0 3031.6 3064.0 3093.6 3098.6 3099.0 16419.3 16902.4 17076.3 17327.5 17446.0 2151.8 2152.5 2198.2 2198.6 2211.3 112956.4 124967.4 125123.0 125587.4 140337.0 13846.8 16533.7 20785.6 21021.8 21204.7 32505.5 32925.0 32971.5 33046.0 33070.5 10452.0 10637.2 10847.5 10869.1 11010.7 8907.1 8947.5 8950.8 9112.7 9145.5 7545.9 9473.5 9578.6 9599.6 9640.8 3389.9 3975.7 4017.2 4035.6 4049.2 1029.7 1052.5 1074.0 1119.8 1120.9 22041.1 22281.3 22281.7 22315.8 22364.6 1105.8 1108.7 1121.5 1123.1 1132.4 11018.8 11640.9 11809.6 11810.2 11837.6 665725.0 773600.0 810257.0 821746.0 827888.0 125872.3 158331.0 160589.2 163213.0 169568.0 1059.5 1212.3 1240.2 1283.9 1288.9 20212.7 20470.9 20957.6 20969.7 21013.8 64879.0 65131.7 65649.3 66843.0 66920.0 89167.6 90040.5 90158.5 92203.0 92564.0 11370.3 11881.3 12013.5 12076.8 12087.3 9619.7 13041.9 13117.0 13278.6 13435.7 11374.5 11591.5 11633.4 11652.0 11835.1 10631.0 10654.1 10787.4 10907.3 11044.4 11536.8 11789.7 11891.8 11973.8 11989.8 11594.7 11602.4 11935.7 11978.8 11987.7 9770.9 11336.8 11452.7 11489.5 11520.4 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:6823.94 Median:2482.07 stddev:4270.64 (172.1%) stddev-sans-first:4264.51 02:29:55 INFO - PROCESS | 1644 | Values: 1589.6 1628.9 1651.5 1655.5 1666.4 10788.7 11339.7 11343.3 11360.6 11386.1 10852.3 11213.1 11340.0 11369.3 11388.7 2460.7 2501.8 2503.3 2507.7 2514.7 2443.0 2445.8 2478.8 2491.6 2498.8 2446.4 2473.1 2484.1 2495.4 2498.6 2426.6 2439.6 2463.5 2470.1 2480.1 2452.9 2466.4 2478.4 2479.5 2479.8 11029.7 11250.3 11254.2 11264.4 11277.9 5963.9 6117.1 6135.0 6136.0 6140.8 3455.8 3496.2 3535.2 3579.9 3588.1 1225.8 1233.0 1263.8 1279.1 1281.4 13901.9 14197.6 14489.6 15755.6 15925.4 4128.2 4687.3 4818.2 4839.7 4850.2 11974.3 11991.4 11993.2 11996.9 12004.0 4998.7 5183.4 5207.4 5209.4 5214.9 4505.9 4795.9 5411.5 5473.6 5489.9 3891.7 3936.9 4025.4 4028.3 4033.8 1027.9 1052.4 1067.1 1067.6 1072.1 815.0 949.4 968.0 1008.8 1022.7 6573.4 6663.6 6734.6 6791.7 6856.7 981.6 991.0 1022.9 1036.2 1047.8 3632.9 4205.4 4238.7 4291.8 4357.8 11325.9 14357.3 14362.3 14379.0 14387.0 13092.5 13580.8 14261.9 14267.7 14280.5 10143.3 10436.1 10439.4 10456.4 10458.0 6456.8 6777.4 6792.5 6834.2 6918.5 12187.1 12399.4 12677.9 12692.4 12722.2 12614.4 12758.5 12840.6 12858.3 12949.0 9359.9 9360.3 9515.6 9535.8 9648.5 10014.5 10601.2 10730.9 10738.5 10739.1 8686.5 8690.4 8711.8 8817.2 8849.7 7490.3 8720.2 8754.7 8776.9 8803.8 7809.2 7870.9 7939.8 7942.8 7968.0 5847.4 5853.9 5974.3 5994.3 6050.8 5963.9 6021.6 6063.2 6149.9 6207.0 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4526.30 Median:4881.41 stddev:1250.43 (25.6%) stddev-sans-first:1214.74 02:29:55 INFO - PROCESS | 1644 | Values: 387.3 388.7 394.3 398.6 398.6 4584.0 5091.9 5184.6 5184.6 5214.1 4150.5 4467.4 4490.8 5022.2 5137.3 3670.5 4098.8 4205.0 4263.6 4333.4 3611.8 3693.7 3896.5 4248.4 4338.6 4158.1 4202.9 4219.9 4384.5 4426.9 4015.0 4212.9 4221.6 4255.5 4287.7 3692.7 3895.6 3927.7 3955.7 4017.7 4141.4 4234.8 4934.9 5123.2 5142.4 4225.9 4492.6 4984.4 5060.7 5099.7 4902.7 5166.7 5374.7 5397.6 5492.3 3802.1 4048.2 4403.3 4495.5 4497.6 4772.9 4865.9 4946.0 5719.2 5842.6 4035.5 4116.0 4303.0 4496.5 4550.2 4222.3 4497.5 4672.4 4691.8 4767.7 4576.3 4684.4 4973.9 5002.9 5051.2 5083.3 5223.0 5467.9 5485.0 5501.8 1357.2 1417.9 1430.5 1543.6 1597.0 1085.8 1108.0 1184.8 1213.8 1231.9 4422.8 5322.8 5324.4 5399.3 5424.3 4714.5 5335.4 5367.9 5775.3 5779.3 4178.5 4819.7 5073.0 5289.6 5297.7 2752.9 2772.0 2864.6 2874.2 2960.5 4687.8 5179.7 5934.9 5943.6 5964.9 5160.7 5412.6 5448.7 5661.5 5731.5 4850.6 4860.7 5270.8 5368.3 5765.9 4961.9 5423.8 5541.5 5685.3 5688.8 4639.4 4950.5 5180.8 5586.7 5630.5 4919.5 5474.3 5907.0 5937.9 5952.7 4033.9 4385.3 4445.8 4463.3 4545.8 5035.7 5048.3 5200.8 5278.8 5818.2 4551.0 5089.0 5328.7 5390.6 5568.7 5060.1 5413.2 5453.8 5463.9 5551.5 4896.9 5002.9 5236.3 5362.8 5385.9 4812.0 4821.0 4839.8 5452.6 5485.2 4849.1 4862.3 5146.2 5206.8 5306.9 02:29:55 INFO - PROCESS | 1644 | 02:29:55 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20555.16 Median:17178.44 stddev:28414.03 (165.4%) stddev-sans-first:28454.86 02:29:55 INFO - PROCESS | 1644 | Values: 759.6 778.7 804.8 898.7 904.9 15375.9 16428.7 16987.3 17724.8 17827.9 15716.2 16134.0 16162.0 16208.8 16322.8 937.7 1003.9 1009.6 1009.8 1010.0 989.5 1002.0 1002.3 1007.9 1019.9 911.4 1068.4 1071.7 1073.0 1073.4 1068.8 1069.7 1070.2 1071.7 1077.5 799.7 800.2 800.7 802.0 803.8 17369.6 17510.3 17602.3 18018.0 18367.5 14725.9 14854.9 14983.9 15035.0 15221.8 12052.1 12316.6 12372.1 12458.9 12921.0 3828.1 3891.5 3955.7 3994.4 4085.0 56450.0 87345.6 106705.5 110826.0 115173.0 11597.3 11650.1 11716.8 12036.7 12296.7 23265.7 23396.2 23993.9 24010.6 24022.4 8274.3 8360.4 8361.0 8419.8 8486.7 4502.8 4504.9 4610.0 4613.9 4796.8 3654.8 3727.9 3741.9 3746.5 3748.4 598.7 628.8 677.1 695.3 696.0 500.5 512.1 592.9 601.5 624.4 10285.6 10548.8 10555.3 10582.9 11204.4 587.9 600.0 615.8 622.5 635.7 4990.8 5262.6 5266.7 5277.8 5278.6 99277.5 100925.5 101962.5 104160.5 105368.0 77723.2 81072.8 81679.0 82353.2 82432.0 78573.6 79426.0 81503.6 82138.2 82155.6 10934.3 11120.6 11255.4 11305.1 11432.6 40806.6 48149.5 49270.0 49292.3 49719.8 69838.7 71031.0 71508.0 72688.6 73864.6 12848.7 12871.6 13021.0 13417.4 13424.7 14906.6 14944.8 15250.3 15263.6 15374.1 13885.4 13981.0 14203.9 14343.6 14511.8 13558.0 14103.4 14238.0 14375.3 14508.0 13566.6 13864.6 14019.8 14036.2 14154.2 9991.1 10376.4 10386.8 10942.8 11015.2 10122.2 11307.6 11404.6 11545.9 11561.0 02:29:55 INFO - PROCESS | 1644 | -------- Summary: end -------- 02:29:55 INFO - PROCESS | 1644 | 02:29:56 INFO - TEST-INFO | 1644: exit 0 02:29:56 INFO - TEST-OK | dromaeo_css | took 1118379ms 02:29:56 INFO - TEST-START | kraken 02:29:56 INFO - operating with platform_type : mac_ 02:29:56 INFO - Initialising browser for kraken test... 02:29:56 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmptMBOWv/profile http://localhost:49247/getInfo.html) 02:29:58 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 02:29:58 INFO - PROCESS | 1654 | colorDepth:24 02:29:58 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 02:29:58 INFO - PROCESS | 1654 | __metrics 02:29:58 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:29:58 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:58 INFO - TEST-INFO | 1654: exit 0 02:29:58 INFO - Browser initialized. 02:29:58 INFO - Running cycle 1/1 for kraken test... 02:29:58 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmptMBOWv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:10 INFO - PROCESS | 1656 | RSS: Main: 164941824 02:30:10 INFO - PROCESS | 1656 | 02:30:13 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 02:30:14 INFO - PROCESS | 1656 | RSS: Main: 216117248 02:30:14 INFO - PROCESS | 1656 | 02:30:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 02:30:17 INFO - PROCESS | 1656 | RSS: Main: 231985152 02:30:17 INFO - PROCESS | 1656 | 02:30:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 02:30:21 INFO - PROCESS | 1656 | RSS: Main: 328470528 02:30:21 INFO - PROCESS | 1656 | 02:30:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 02:30:24 INFO - PROCESS | 1656 | RSS: Main: 230924288 02:30:24 INFO - PROCESS | 1656 | 02:30:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:26 INFO - PROCESS | 1656 | RSS: Main: 231936000 02:30:26 INFO - PROCESS | 1656 | 02:30:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:30 INFO - PROCESS | 1656 | RSS: Main: 273240064 02:30:30 INFO - PROCESS | 1656 | 02:30:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:33 INFO - PROCESS | 1656 | RSS: Main: 272666624 02:30:33 INFO - PROCESS | 1656 | 02:30:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 02:30:37 INFO - PROCESS | 1656 | RSS: Main: 270577664 02:30:37 INFO - PROCESS | 1656 | 02:30:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:39 INFO - PROCESS | 1656 | RSS: Main: 246697984 02:30:39 INFO - PROCESS | 1656 | 02:30:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:41 INFO - PROCESS | 1656 | RSS: Main: 251572224 02:30:41 INFO - PROCESS | 1656 | 02:30:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:44 INFO - PROCESS | 1656 | RSS: Main: 255385600 02:30:44 INFO - PROCESS | 1656 | 02:30:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:48 INFO - PROCESS | 1656 | RSS: Main: 271364096 02:30:48 INFO - PROCESS | 1656 | 02:30:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:51 INFO - PROCESS | 1656 | RSS: Main: 265453568 02:30:51 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 02:30:53 INFO - PROCESS | 1656 | RSS: Main: 310026240 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | __start_tp_report 02:30:53 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 02:30:53 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 02:30:53 INFO - PROCESS | 1656 | |i|pagename|runs| 02:30:53 INFO - PROCESS | 1656 | |0;ai-astar;105;116;116;116;115;113;116;116;117;116 02:30:53 INFO - PROCESS | 1656 | |1;audio-beat-detection;166;135;131;142;109;108;109;107;126;110 02:30:53 INFO - PROCESS | 1656 | |2;audio-dft;186;184;182;185;187;186;182;184;186;185 02:30:53 INFO - PROCESS | 1656 | |3;audio-fft;81;58;58;89;57;62;59;59;73;57 02:30:53 INFO - PROCESS | 1656 | |4;audio-oscillator;88;69;87;70;69;69;81;69;69;82 02:30:53 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;88;88;86;88;87;87;88;88;87;87 02:30:53 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;94;96;94;95;95;94;95;95;94 02:30:53 INFO - PROCESS | 1656 | |7;imaging-desaturate;85;86;86;83;85;84;85;84;86;83 02:30:53 INFO - PROCESS | 1656 | |8;json-parse-financial;61;59;61;59;63;64;63;63;63;63 02:30:53 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;60;56;68;60;63;57;58;56;58;59 02:30:53 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;84;81;83;81;90;95;95;79;82;80 02:30:53 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;136;132;135;141;120;148;157;141;196;136 02:30:53 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;167;162;162;163;167;168;163;161;164;160 02:30:53 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;64;64;64;63;65;61;63;62;63;62 02:30:53 INFO - PROCESS | 1656 | __end_tp_report 02:30:53 INFO - PROCESS | 1656 | __start_cc_report 02:30:53 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2112 02:30:53 INFO - PROCESS | 1656 | __end_cc_report 02:30:53 INFO - PROCESS | 1656 | __startTimestamp1492680653611__endTimestamp 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | ------- Summary: start ------- 02:30:53 INFO - PROCESS | 1656 | Number of tests: 14 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.00 stddev:3.53 (3.0%) stddev-sans-first:1.12 02:30:53 INFO - PROCESS | 1656 | Values: 105.0 116.0 116.0 116.0 115.0 113.0 116.0 116.0 117.0 116.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:128.50 stddev:19.58 (15.2%) stddev-sans-first:13.78 02:30:53 INFO - PROCESS | 1656 | Values: 166.0 135.0 131.0 142.0 109.0 108.0 109.0 107.0 126.0 110.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:1.70 (0.9%) stddev-sans-first:1.74 02:30:53 INFO - PROCESS | 1656 | Values: 186.0 184.0 182.0 185.0 187.0 186.0 182.0 184.0 186.0 185.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.50 stddev:11.56 (19.1%) stddev-sans-first:10.77 02:30:53 INFO - PROCESS | 1656 | Values: 81.0 58.0 58.0 89.0 57.0 62.0 59.0 59.0 73.0 57.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:75.50 stddev:8.18 (10.8%) stddev-sans-first:7.27 02:30:53 INFO - PROCESS | 1656 | Values: 88.0 69.0 87.0 70.0 69.0 69.0 81.0 69.0 69.0 82.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 02:30:53 INFO - PROCESS | 1656 | Values: 88.0 88.0 86.0 88.0 87.0 87.0 88.0 88.0 87.0 87.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:30:53 INFO - PROCESS | 1656 | Values: 94.0 94.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 02:30:53 INFO - PROCESS | 1656 | Values: 85.0 86.0 86.0 83.0 85.0 84.0 85.0 84.0 86.0 83.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:63.00 stddev:1.79 (2.8%) stddev-sans-first:1.87 02:30:53 INFO - PROCESS | 1656 | Values: 61.0 59.0 61.0 59.0 63.0 64.0 63.0 63.0 63.0 63.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:3.66 (6.1%) stddev-sans-first:3.88 02:30:53 INFO - PROCESS | 1656 | Values: 60.0 56.0 68.0 60.0 63.0 57.0 58.0 56.0 58.0 59.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.50 stddev:6.07 (7.3%) stddev-sans-first:6.43 02:30:53 INFO - PROCESS | 1656 | Values: 84.0 81.0 83.0 81.0 90.0 95.0 95.0 79.0 82.0 80.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:141.00 stddev:20.64 (14.6%) stddev-sans-first:21.68 02:30:53 INFO - PROCESS | 1656 | Values: 136.0 132.0 135.0 141.0 120.0 148.0 157.0 141.0 196.0 136.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.50 stddev:2.75 (1.7%) stddev-sans-first:2.65 02:30:53 INFO - PROCESS | 1656 | Values: 167.0 162.0 162.0 163.0 167.0 168.0 163.0 161.0 164.0 160.0 02:30:53 INFO - PROCESS | 1656 | 02:30:53 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.20 (1.9%) stddev-sans-first:1.22 02:30:53 INFO - PROCESS | 1656 | Values: 64.0 64.0 64.0 63.0 65.0 61.0 63.0 62.0 63.0 62.0 02:30:53 INFO - PROCESS | 1656 | -------- Summary: end -------- 02:30:53 INFO - PROCESS | 1656 | 02:30:54 INFO - TEST-INFO | 1656: exit 0 02:30:54 INFO - TEST-OK | kraken | took 58304ms 02:30:54 INFO - SUITE-END | took 1176s 02:30:54 INFO - Completed test suite (00:19:36) 02:30:54 INFO - javascript benchmark 02:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7825.316135178255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.1730825947648, 3548.6628770266825, 3573.8213089345527, 3592.1019745063736, 3619.0771353304904, 6053.424924632159, 6140.232470941132, 6150.66171360575, 6151.323354431014, 6180.0, 5163.199704045869, 5995.5503337249775, 6130.632162070267, 6132.662703551314, 6145.661988590626, 5454.945450545503, 5490.615656904019, 5505.6696598204235, 5516.117421212607, 5629.521490673298, 5417.918731219035, 5419.132938729804, 5427.104527752916, 5613.635113717595, 5619.775208991636, 5515.641483303572, 5568.582356323272, 5602.691851948141, 5602.7758889644565, 5604.859878503029, 5588.189712491666, 5596.328440587135, 5614.6631202128, 5629.099344104923, 5631.099024156136, 5474.37044739856, 5508.64193827404, 5526.806561770319, 5549.500544950974, 5566.332040155166, 5913.408659134096, 5958.957182493046, 5973.910391344133, 6189.102580125857, 6201.844953876144, 6342.048692696087, 6378.138951241615, 6385.840353991141, 6392.936070639281, 6395.552311338208, 5306.893862122774, 5313.760880760375, 6477.805665830033, 6495.382938620824, 6501.609903405811, 4588.747618880993, 6021.54838387114, 6110.663913484756, 6218.5647004710145, 6276.748930042792, 6459.677016149174, 6476.773312934119, 6531.8693626127215, 6553.017047442826, 6580.5722628029025, 6332.208473940757, 6361.650109244036, 6365.936340636627, 6376.521760867953, 6385.776497822647, 6400.743970241231, 6414.198225221848, 6444.581102228341, 6471.967640161769, 6481.189851268591, 6320.146780184617, 6339.302676705559, 6371.139896114058, 6381.521385896076, 6384.297727249998, 6318.210223722035, 6367.617942923347, 6380.0, 6415.390537898892, 6427.260865000491, 5030.84907452777, 5112.539871411591, 5153.587712982952, 5160.741962901915, 5168.586513078944, 4540.114677637895, 4640.141573808856, 4678.134545109166, 4686.133065382847, 4744.976275118603, 6367.267764207176, 6385.425311721968, 6387.680615969183, 6393.29673735898, 6400.0719895614875, 6458.031295305648, 6475.0, 6492.383223593751, 6497.545171837926, 6538.084668146464, 6135.693215339215, 6165.229346331708, 6194.946859033975, 6202.0, 6391.808245752635, 5642.830715078554, 5657.886842263131, 5660.490555849993, 5669.461401166883, 5673.461021202979, 6554.606723596599, 6610.0, 6617.0, 6617.371349721769, 6618.768343108064, 6346.238451385863, 6385.265694445013, 6395.616263024233, 6450.677466126769, 6497.772577959749, 6856.314368563104, 6861.2795656455355, 6862.4853136014, 6865.485088618473, 6867.0, 6400.167978162809, 6412.711427985845, 6416.101745755504, 6416.711247993945, 6420.775272865428, 4980.228064649985, 6215.005599104122, 6279.874402511833, 6310.2743184534365, 6369.267534233622, 6147.0779383092895, 6265.404786545271, 6333.524985626189, 6366.9681651591445, 6369.8726025480155, 6326.715297811702, 6359.650219237987, 6380.202474690664, 6389.520785941166, 6392.296847346695, 6357.3006969234275, 6363.5545511813725, 6368.936310637019, 6371.808845734636, 6436.517261205335, 6259.092431597484, 6267.749290028348, 6302.684865756602, 6347.428731414195, 6381.106645069787, 5249.422563517934, 6278.591891527036, 6356.396142366468, 6370.235571731237, 6374.649394283359], "value": 5960.953970301575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.3891136888169, 811.5293129984609, 886.6364790435919, 895.0110128308223, 898.3801177187736, 40775.79612101939, 41456.378154327635, 41457.75626731199, 41504.169916601684, 41619.167616647646, 41852.162956740845, 42054.94862628436, 42101.36847947283, 42159.946001349985, 42215.788921055355, 7935.047794264697, 8083.0, 9627.614895404193, 9770.413775173512, 9774.0, 9980.251481138906, 10991.835122473169, 11159.163062770283, 11702.8244576331, 11833.230839995416, 11898.881011189864, 11942.880571194264, 11962.0, 11962.940185299105, 11982.281063136195, 11803.645890623253, 11864.703382415422, 11876.287422754576, 11877.287362758176, 11886.0, 11631.418429078596, 11689.181757276994, 11697.94151029248, 11703.0, 11706.356150411724, 39896.40155397642, 40150.0, 40168.59831401678, 40171.7991410044, 40289.59710402917, 3960.960390396088, 4008.6191811777835, 4033.3546632538655, 4044.2720310344125, 4045.0696339842, 28891.988780392796, 29344.559831602543, 30090.54864177039, 30928.38143237145, 30940.845295773375, 3296.8186749728757, 3302.752293577967, 3311.337732453495, 3432.9141771455916, 3448.103493091789, 311685.0, 315146.0, 315970.0, 316000.9999999977, 316095.0, 43232.567674322854, 43769.562304377185, 51644.0, 51794.74102629463, 51819.0, 52381.95236095333, 53014.204786928225, 55169.724151378985, 55201.0, 56599.0, 14997.475088371855, 15137.470188543348, 15144.469943551923, 15150.090994540364, 15210.543683689508, 12916.031297652526, 12921.612351629467, 12926.935365323114, 12929.418176182095, 12937.54718584845, 11918.52325906954, 11921.0, 11946.402679866145, 11970.700732481584, 12056.578019769266, 5256.737163141827, 5283.286756287852, 5288.286081379041, 5296.417394086648, 5297.894042119213, 1087.787117364149, 1095.4358505369742, 1146.9770604587861, 1201.7776711308436, 1215.2769102384068, 27025.864870675912, 27201.0, 27503.86248068747, 27584.172474825788, 27773.8890444384, 995.7610173558294, 1151.9020883225019, 1274.9305103202762, 1294.6569159172827, 1322.4445732792058, 14487.348069336906, 14508.709825803426, 14700.41198352054, 14727.705445891022, 14787.704245915236, 495918.5204074029, 496736.0, 496891.0, 497284.0, 498531.0, 60033.09950350748, 60040.69979650161, 60114.699426502586, 60218.0, 60387.39612603818, 1464.348364977596, 1480.5262316058759, 1488.5013520470548, 1489.6722721001363, 1495.783111448812, 26999.0, 27710.307242319104, 28036.719632804226, 28211.43577128487, 28234.0, 38462.6153738459, 38511.80744096261, 38535.80732096321, 38610.0, 38653.613463866124, 377082.0, 441434.0, 442311.0, 442472.0, 443057.0, 20016.799832001492, 24547.75452245526, 29077.418451630427, 29568.55647165251, 29746.702532975258, 38830.0, 39347.606523934395, 39359.60640393559, 39759.0, 40112.39831402589, 27938.441231175668, 28513.00204492833, 28692.713072869003, 28813.0, 29720.959766408072, 27832.86083569569, 28887.422251555272, 28903.277418063877, 29203.39381334047, 29591.260218493848, 32935.17662058372, 34122.31755364829, 34712.0, 34741.305173896886, 34811.30377392387, 24365.634515482638, 26636.7336326642, 29368.853155734083, 29524.704752952195, 29965.70034299629, 22272.331830045125, 22883.0, 22928.656070159293, 23287.53424931458, 23922.64116038226], "value": 18897.666685839173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.4128461438599, 428.98498552550666, 436.5547141915247, 438.8897970506208, 441.13097198518926, 16208.270627821747, 20154.697679534802, 22109.447263818412, 22117.889410552943, 22205.000774965127, 22566.323010309676, 23009.769902300974, 23432.0, 23763.5247295054, 23931.521369572598, 6702.530822842416, 6945.131858517685, 6991.755288564876, 7033.788986330393, 7043.295670432942, 6736.562123461959, 6844.589324640513, 6967.4774391920555, 6968.128983877015, 6976.5116441849095, 6595.802125936206, 6859.211190713082, 6951.443884489228, 6956.478264130185, 6967.79096627102, 6520.706568204395, 6797.966010169967, 6849.863002739942, 6853.211880633741, 6936.479764017694, 6581.2760596334365, 6627.1716035495565, 6662.0, 6665.800025999228, 6676.26561078281, 27888.0, 28094.0, 28180.295492612644, 28463.0, 28855.990040348486, 3031.6058912341473, 3064.0, 3093.551435041929, 3098.643655979569, 3099.0, 16419.261133249034, 16902.408415705515, 17076.31694732209, 17327.480175594625, 17446.0, 2151.816500924501, 2152.461884528868, 2198.1866709317496, 2198.626233540286, 2211.292386436341, 112956.4322607078, 124967.37516312451, 125123.0, 125587.37206314, 140337.0, 13846.792298115537, 16533.6693266134, 20785.58428831415, 21021.78978210229, 21204.681929771064, 32505.51241731376, 32925.01224963255, 32971.50542741861, 33046.0, 33070.50394244088, 10451.954804519639, 10637.202209834139, 10847.51186196623, 10869.130469562417, 11010.669679909615, 8907.064758200426, 8947.463152210888, 8950.820983580423, 9112.726618201465, 9145.451272923647, 7545.886811697829, 9473.47895865734, 9578.616855325849, 9599.568019439143, 9640.79490063742, 3389.949045858747, 3975.6620687241907, 4017.1879684221162, 4035.596440355941, 4049.190161967618, 1029.6756521695643, 1052.4685034057752, 1073.9946300268448, 1119.832025196227, 1120.9239130434712, 22041.11835526561, 22281.331560053226, 22281.66577501339, 22315.77684223137, 22364.55270894573, 1105.795427845851, 1108.6729414822485, 1121.5289578376937, 1123.1239633086207, 1132.416805345248, 11018.779624407467, 11640.941795291139, 11809.586664466702, 11810.232334898204, 11837.585684501173, 665725.0, 773600.0, 810257.0, 821746.0, 827888.0, 125872.26596675416, 158331.0, 160589.19705401632, 163213.0, 169568.0, 1059.4596755654518, 1212.3392750950752, 1240.1814802230485, 1283.8523569789406, 1288.8582255951837, 20212.696809547575, 20470.897645511675, 20957.58084838325, 20969.685454718496, 21013.789862101185, 64879.0, 65131.674341627986, 65649.34350656433, 66843.0, 66920.0, 89167.55416222877, 90040.49797510229, 90158.54920725616, 92203.0, 92564.0, 11370.32797292619, 11881.346525941157, 12013.519459221534, 12076.75846483083, 12087.335196563921, 9619.663311784054, 13041.869581304065, 13117.0, 13278.601641950758, 13435.664108397368, 11374.488148033524, 11591.478383472595, 11633.38248893992, 11652.009579185526, 11835.11236657237, 10631.043206111177, 10654.14766818668, 10787.352758834495, 10907.345559266469, 11044.447777610927, 11536.82694759596, 11789.705257368634, 11891.82162267584, 11973.76052478963, 11989.820152697543, 11594.71013224676, 11602.361870097226, 11935.701607459883, 11978.76042479163, 11987.700307492034, 9770.85343719859, 11336.773264534499, 11452.656420307405, 11489.482973266391, 11520.366379848854], "value": 11846.298872585832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1589.6184915620254, 1628.8534031937124, 1651.5210588929208, 1655.4619748581713, 1666.3584519959816, 10788.73028174296, 11339.659810205687, 11343.262687925278, 11360.60237891674, 11386.089112870972, 10852.294600850939, 11213.10295176386, 11339.979401853832, 11369.260998035143, 11388.658340249805, 2460.6678098456705, 2501.7873480754156, 2503.349129226396, 2507.674002379688, 2514.735952724965, 2443.0, 2445.7798798108165, 2478.8264821462503, 2491.638712386703, 2498.837575557592, 2446.4373194165264, 2473.1467643662995, 2484.0808900706766, 2495.4260520080393, 2498.5502609530276, 2426.5874801283826, 2439.597466418039, 2463.4580392313665, 2470.110760126353, 2480.0575781203206, 2452.865092419916, 2466.4203912080648, 2478.429961108937, 2479.504099180171, 2479.838810477313, 11029.724256893642, 11250.268732532359, 11254.212205145643, 11264.380459074748, 11277.943610281978, 5963.940360596382, 6117.143599896018, 6135.049067394561, 6135.969320153371, 6140.754369825202, 3455.809930453824, 3496.17839807645, 3535.1869070114017, 3579.8926032218815, 3588.102974256436, 1225.8099994500867, 1233.0, 1263.8041103628952, 1279.1365828066018, 1281.4046512092411, 13901.930490347484, 14197.645058873508, 14489.565313040732, 15755.606109847231, 15925.362985480568, 4128.236276288896, 4687.296905464208, 4818.204996175592, 4839.685420447659, 4850.199717046718, 11974.341411222467, 11991.400429978466, 11993.220440671328, 11996.940015299868, 12004.0, 4998.725070121178, 5183.429822719498, 5207.4011488678525, 5209.374875015023, 5214.895702085937, 4505.864824055284, 4795.880102997453, 5411.485908838654, 5473.616846820764, 5489.917651235235, 3891.669208117342, 3936.940945885814, 4025.376066709665, 4028.3151864182573, 4033.8184781684895, 1027.8920713324994, 1052.4001319247955, 1067.0769784136667, 1067.604986155112, 1072.0833687197335, 814.9877751833727, 949.3829011142813, 968.0, 1008.8335424654849, 1022.7494263905241, 6573.375529324707, 6663.600183988976, 6734.562253453608, 6791.660416979132, 6856.691448884812, 981.622075500923, 990.9554070066864, 1022.8619136416488, 1036.1917704190744, 1047.8166320893813, 3632.9464455308193, 4205.432266643964, 4238.7032907696785, 4291.806868690916, 4357.847475338348, 11325.943370283096, 14357.282135893163, 14362.281885905662, 14379.0, 14386.992910496165, 13092.476300947856, 13580.827067669126, 14261.92869035669, 14267.714645707236, 14280.50018249377, 10143.34068285559, 10436.060754532129, 10439.37363758177, 10456.424896630606, 10458.0, 6456.7740129095255, 6777.356151165632, 6792.47169386884, 6834.179898412222, 6918.481113916376, 12187.085968552217, 12399.442025108712, 12677.936610316889, 12692.428840702376, 12722.173058751152, 12614.432350544064, 12758.48966041348, 12840.617732991355, 12858.292793896426, 12949.0, 9359.85960210611, 9360.297977651839, 9515.619375224913, 9535.809283814424, 9648.469334186688, 10014.549345279625, 10601.204909631655, 10730.946345268223, 10738.516766745672, 10739.14086873064, 8686.478811271343, 8690.435121717068, 8711.825763484821, 8817.206451419403, 8849.69026084084, 7490.325870671666, 8720.21518063352, 8754.737357879274, 8776.868346974672, 8803.823923521622, 7809.180036096128, 7870.921290787248, 7939.761807145795, 7942.841143176988, 7968.0438347398685, 5847.38602446737, 5853.853653658693, 5974.312954010345, 5994.28068631767, 6050.818475445743, 5963.850903727442, 6021.6085954414575, 6063.151158837854, 6149.938500614937, 6206.968965155326], "value": 5217.267312244145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.30865405251626, 388.67157252121945, 394.3296396126585, 398.551629416906, 398.5814894360922, 4583.977080114603, 5091.949080509194, 5184.559312458441, 5184.611154163439, 5214.096854648054, 4150.501939767225, 4467.374567560544, 4490.820367185317, 5022.171341728619, 5137.280780690707, 3670.4677821715836, 4098.815553300109, 4205.044654235772, 4263.616274535291, 4333.371661109138, 3611.783293002415, 3693.6675699187067, 3896.4544963705102, 4248.426462427579, 4338.631216346615, 4158.08522125132, 4202.928253295406, 4219.894502637428, 4384.514311122649, 4426.867193984185, 4014.956111411025, 4212.852550160745, 4221.620054195122, 4255.510616279136, 4287.721298115613, 3692.658144379341, 3895.6493915547735, 3927.7446965947124, 3955.7230993830444, 4017.658499027586, 4141.358089496133, 4234.788260586958, 4934.901301973976, 5123.2315152727015, 5142.357205349332, 4225.852095176654, 4492.640588752892, 4984.401871775374, 5060.722674796356, 5099.69401835891, 4902.656814022984, 5166.664166829144, 5374.683202615384, 5397.649152805055, 5492.267295000967, 3802.0874990002476, 4048.1903619275968, 4403.3174857897075, 4495.505494395614, 4497.617702495259, 4772.880677983008, 4865.927011094836, 4945.986072855092, 5719.196734171771, 5842.649441033552, 4035.4753881995152, 4116.0, 4302.9569704303185, 4496.460424748986, 4550.226461501553, 4222.282212023963, 4497.460304763449, 4672.369230153954, 4691.765411729468, 4767.69010014348, 4576.336431217454, 4684.367610372556, 4973.875653108701, 5002.949380630036, 5051.20682157836, 5083.271687626151, 5222.973885130626, 5467.890642187134, 5485.025390859288, 5501.799280287917, 1357.2060344698264, 1417.87948024417, 1430.5207755402057, 1543.5909483986752, 1596.9920150399405, 1085.8218832566754, 1107.9778404431866, 1184.7867383870987, 1213.7511810078913, 1231.9199252048588, 4422.800973956179, 5322.840314790563, 5324.41431442541, 5399.2980912481125, 5424.321959755031, 4714.528547145258, 5335.439778823245, 5367.892642147213, 5775.306963164363, 5779.283736643771, 4178.456800615962, 4819.662623616313, 5072.9746351268, 5289.629725919149, 5297.735113244399, 2752.8575641109114, 2772.0436449424915, 2864.627598412193, 2874.152125123094, 2960.4671159191553, 4687.7656117194, 5179.689218646893, 5934.851628709317, 5943.55423343251, 5964.880702385928, 5160.664556803796, 5412.621116521806, 5448.722752639159, 5661.518770904437, 5731.512821410227, 4850.587700045536, 4860.691171693417, 5270.789168433374, 5368.302120724281, 5765.88468230633, 4961.900761984813, 5423.810166644149, 5541.476094074162, 5685.346185188756, 5688.800891968926, 4639.443266808004, 4950.45544990058, 5180.818671346485, 5586.681527166181, 5630.521405680399, 4919.532644398776, 5474.315710536183, 5907.025340818716, 5937.9406205937385, 5952.672603006703, 4033.858814941463, 4385.342198670098, 4445.844395446144, 4463.308187230984, 4545.840895568772, 5035.748212589429, 5048.293238946624, 5200.817971370984, 5278.762455689426, 5818.2436283282905, 4550.977245113886, 5089.00764350948, 5328.733563321741, 5390.568754499709, 5568.693721845338, 5060.130248911245, 5413.160960051198, 5453.781848726166, 5463.9180412294645, 5551.528120109836, 4896.902061958812, 5002.949970500248, 5236.293100431393, 5362.812301569426, 5385.865353366197, 4811.9518804811505, 4820.975190420102, 4839.790052486878, 5452.563794896319, 5485.232067510631, 4849.066314879447, 4862.343583616166, 5146.228065790161, 5206.750379908719, 5306.920396193983], "value": 4168.588065185325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.6315786843384, 778.739122393998, 804.8068463568745, 898.748917619659, 904.9457032578043, 15375.923120384396, 16428.671426571476, 16987.320507179713, 17724.822751772477, 17827.91086044571, 15716.214189290547, 16134.0, 16162.0, 16208.83791162088, 16322.75515867263, 937.653068364706, 1003.9447830369345, 1009.5759780892043, 1009.8283291840405, 1009.9799202805146, 989.5052473763119, 1001.9949900250489, 1002.2783595811004, 1007.8639383683219, 1019.8521214423904, 911.444019148319, 1068.4123731947436, 1071.7213524483611, 1073.0128281980558, 1073.4471747050275, 1068.839674048895, 1069.7432616172064, 1070.1866581398194, 1071.6570697376842, 1077.5312738958578, 799.7081065411084, 800.1638287989007, 800.7317548621161, 802.0455657767238, 803.8352137811735, 17369.565760855952, 17510.299588016464, 17602.295908163785, 18018.0, 18367.540811479685, 14725.852741472556, 14854.851451485454, 14983.850161498463, 15034.994644947592, 15221.847781522154, 12052.13340601619, 12316.630501084981, 12372.072094592851, 12458.875411245863, 12921.0, 3828.1003964068423, 3891.5299365651595, 3955.7428767130045, 3994.4208089827102, 4085.0, 56450.0, 87345.56327218386, 106705.46647266713, 110826.0, 115173.0, 11597.304161750153, 11650.126240531994, 11716.824247636292, 12036.699082523008, 12296.692582685504, 23265.651015234784, 23396.181133660582, 23993.880030599736, 24010.639840402408, 24022.39944001414, 8274.255317021498, 8360.372972027122, 8361.03848057469, 8419.831603367898, 8486.660533578712, 4502.797374118172, 4504.932426013613, 4609.95390046102, 4613.8846528836375, 4796.784144713496, 3654.780713157219, 3727.9440808387894, 3741.8690345837763, 3746.5316835395574, 3748.3627783276906, 598.6828976252262, 628.8050704281687, 677.1028387386634, 695.3498478922224, 696.022088965005, 500.464502981806, 512.0808149371886, 592.9495992840571, 601.5472633589832, 624.3600309682521, 10285.588576457008, 10548.789024219474, 10555.313904596176, 10582.870737509882, 11204.383758893176, 587.9088741245114, 599.9950083610023, 615.7536985205863, 622.5237693164732, 635.732992143301, 4990.800367985313, 5262.631615786858, 5266.710330931835, 5277.8416647500635, 5278.577713782888, 99277.50361248148, 100925.49537252267, 101962.49018755007, 104160.47919760353, 105368.0, 77723.22276777274, 81072.78390824143, 81679.0, 82353.17646823575, 82432.0, 78573.60713196626, 79426.0, 81503.59248203722, 82138.17861821425, 82155.5892220535, 10934.289271197347, 11120.555177792798, 11255.380954047607, 11305.095592352756, 11432.599859004895, 40806.59193408028, 48149.51850481451, 49270.01459970852, 49292.26061609007, 49719.751401242764, 69838.65080674565, 71031.0, 71508.0, 72688.63655681688, 73864.63067684627, 12848.678783030125, 12871.613851584092, 13020.9583233343, 13417.396217170446, 13424.664383390493, 14906.627334316296, 14944.7758283628, 15250.313735882133, 15263.618409539851, 15374.077555346716, 13885.444582216598, 13981.0, 14203.928980355033, 14343.56969290923, 14511.782323264948, 13558.0, 14103.435862565793, 14238.0, 14375.281235937951, 14508.0, 13566.59300220995, 13864.584062478141, 14019.789703154256, 14036.228007459687, 14154.221517816619, 9991.100800927952, 10376.429296388771, 10386.844197337197, 10942.781144376908, 11015.228933974546, 10122.21452113952, 11307.623389416161, 11404.600838970597, 11545.942270288595, 11561.0], "value": 7910.989791230662, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1408.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 116.0, 116.0, 115.0, 113.0, 116.0, 116.0, 117.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 135.0, 131.0, 142.0, 109.0, 108.0, 109.0, 107.0, 126.0, 110.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 182.0, 185.0, 187.0, 186.0, 182.0, 184.0, 186.0, 185.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 89.0, 57.0, 62.0, 59.0, 59.0, 73.0, 57.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 87.0, 70.0, 69.0, 69.0, 81.0, 69.0, 69.0, 82.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 88.0, 87.0, 87.0, 88.0, 88.0, 87.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 83.0, 85.0, 84.0, 85.0, 84.0, 86.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 61.0, 59.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 68.0, 60.0, 63.0, 57.0, 58.0, 56.0, 58.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 81.0, 90.0, 95.0, 95.0, 79.0, 82.0, 80.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 135.0, 141.0, 120.0, 148.0, 157.0, 141.0, 196.0, 136.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 162.0, 163.0, 167.0, 168.0, 163.0, 161.0, 164.0, 160.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 61.0, 63.0, 62.0, 63.0, 62.0], "value": 63.1, "unit": "score"}]}]} 02:30:54 INFO - Return code: 0 02:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:54 INFO - # TBPL SUCCESS # 02:30:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:30:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:30:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:30:54 INFO - 2017-04-20 02:30:54.921 screenresolution[1661:10058] starting screenresolution argv=screenresolution get 02:30:54 INFO - 2017-04-20 02:30:54.923 screenresolution[1661:10058] Display 0: 1600x1200x32@60 02:30:54 INFO - 2017-04-20 02:30:54.929 screenresolution[1662:10062] starting screenresolution argv=screenresolution list 02:30:54 INFO - Available Modes on Display 0 02:30:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:30:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:30:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:30:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:30:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:30:55 INFO - Intel Iris: 02:30:55 INFO - Chipset Model: Intel Iris 02:30:55 INFO - Type: GPU 02:30:55 INFO - Bus: Built-In 02:30:55 INFO - VRAM (Dynamic, Max): 1536 MB 02:30:55 INFO - Vendor: Intel (0x8086) 02:30:55 INFO - Device ID: 0x0a2e 02:30:55 INFO - Revision ID: 0x0009 02:30:55 INFO - Displays: 02:30:55 INFO - Display: 02:30:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:30:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:30:55 INFO - Display Serial Number: 1600x1200 60 02:30:55 INFO - Main Display: Yes 02:30:55 INFO - Mirror: Off 02:30:55 INFO - Online: Yes 02:30:55 INFO - Rotation: Supported 02:30:55 INFO - Return code: 0 02:30:55 INFO - Running post-action listener: _resource_record_post_action 02:30:55 INFO - [mozharness: 2017-04-20 09:30:55.165631Z] Finished run-tests step (success) 02:30:55 INFO - Running post-run listener: _resource_record_post_run 02:30:55 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 38384640; Write bytes: 421123072; Read time: 240; Write time: 1361 02:30:55 INFO - TinderboxPrint: CPU usage
54.0% 02:30:55 INFO - TinderboxPrint: I/O read bytes / time
38,384,640 / 240 02:30:55 INFO - TinderboxPrint: I/O write bytes / time
421,123,072 / 1,361 02:30:55 INFO - TinderboxPrint: CPU idle
2,193.9 (46.0%) 02:30:55 INFO - TinderboxPrint: CPU system
957.1 (20.1%) 02:30:55 INFO - TinderboxPrint: CPU user
1,618.6 (33.9%) 02:30:55 INFO - TinderboxPrint: Swap in / out
160,178,176 / 0 02:30:55 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122765824; Write bytes: 124315648; Read time: 11121; Write time: 292 02:30:55 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34419712; Write bytes: 295406592; Read time: 215; Write time: 1065 02:30:55 INFO - Running post-run listener: _upload_blobber_files 02:30:55 INFO - Blob upload gear active. 02:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:55 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 02:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:30:56 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:57 INFO - (blobuploader) - INFO - Done attempting. 02:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:58 INFO - (blobuploader) - INFO - Done attempting. 02:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:59 INFO - (blobuploader) - INFO - Done attempting. 02:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:01 INFO - (blobuploader) - INFO - Done attempting. 02:31:01 INFO - (blobuploader) - INFO - Iteration through files over. 02:31:01 INFO - Return code: 0 02:31:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:31:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:31:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2b7da95b984dc4a39488e6f93defad6c7081262d082c156b29135f78a5395a65e3b597fed7c956d1c08eca42d5fd4459a814381a186f485c87972b15abd9f49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d434ffc624879e9b11c77325f0fab43861316b76aeaf19c234134f35d8a9df4ef7304f931cb966ae598f723890fa520a7c6102b19b205042ff12dfa44e5091b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbf2eef4188e966a5b40cae8238fb2ca93300e53526fff27dee8ed76fcf57efc043eaa1312b36767494c124b482113ca4e776a2ef4f498b61bbe4d32d9e066d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/344a17de3fc68a9eef1367f2220fd5ba443c8d62dc94f5b9afda97c02c884d90fd61c6ef8dafcb3e8148fd1fb10a2826c755017ed8207e33eeaed3a8ce241e57"} 02:31:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:31:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:31:01 INFO - Contents: 02:31:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2b7da95b984dc4a39488e6f93defad6c7081262d082c156b29135f78a5395a65e3b597fed7c956d1c08eca42d5fd4459a814381a186f485c87972b15abd9f49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d434ffc624879e9b11c77325f0fab43861316b76aeaf19c234134f35d8a9df4ef7304f931cb966ae598f723890fa520a7c6102b19b205042ff12dfa44e5091b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbf2eef4188e966a5b40cae8238fb2ca93300e53526fff27dee8ed76fcf57efc043eaa1312b36767494c124b482113ca4e776a2ef4f498b61bbe4d32d9e066d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/344a17de3fc68a9eef1367f2220fd5ba443c8d62dc94f5b9afda97c02c884d90fd61c6ef8dafcb3e8148fd1fb10a2826c755017ed8207e33eeaed3a8ce241e57"} 02:31:01 INFO - Running post-run listener: copy_logs_to_upload_dir 02:31:01 INFO - Copying logs to upload dir... 02:31:01 INFO - mkdir: /builds/slave/test/build/upload/logs 02:31:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.810486 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-20 02:31:01.551267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 02:31:01.554522) ========= 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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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-Beta/sha512/e2b7da95b984dc4a39488e6f93defad6c7081262d082c156b29135f78a5395a65e3b597fed7c956d1c08eca42d5fd4459a814381a186f485c87972b15abd9f49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d434ffc624879e9b11c77325f0fab43861316b76aeaf19c234134f35d8a9df4ef7304f931cb966ae598f723890fa520a7c6102b19b205042ff12dfa44e5091b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbf2eef4188e966a5b40cae8238fb2ca93300e53526fff27dee8ed76fcf57efc043eaa1312b36767494c124b482113ca4e776a2ef4f498b61bbe4d32d9e066d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/344a17de3fc68a9eef1367f2220fd5ba443c8d62dc94f5b9afda97c02c884d90fd61c6ef8dafcb3e8148fd1fb10a2826c755017ed8207e33eeaed3a8ce241e57"} build_url:https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/YEI2sxvDSaSgTVP3A2vpEA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2b7da95b984dc4a39488e6f93defad6c7081262d082c156b29135f78a5395a65e3b597fed7c956d1c08eca42d5fd4459a814381a186f485c87972b15abd9f49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d434ffc624879e9b11c77325f0fab43861316b76aeaf19c234134f35d8a9df4ef7304f931cb966ae598f723890fa520a7c6102b19b205042ff12dfa44e5091b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbf2eef4188e966a5b40cae8238fb2ca93300e53526fff27dee8ed76fcf57efc043eaa1312b36767494c124b482113ca4e776a2ef4f498b61bbe4d32d9e066d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/344a17de3fc68a9eef1367f2220fd5ba443c8d62dc94f5b9afda97c02c884d90fd61c6ef8dafcb3e8148fd1fb10a2826c755017ed8207e33eeaed3a8ce241e57"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 02:31:01.591563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:31:01.591907) ========= 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.Dgke5wpLkd/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.7rHaqT7rIJ/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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.005020 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 02:31:01.640983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 02:31:01.641315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 02:31:01.641644) ========= ========= Total master_lag: 0.19 =========