builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0308 starttime: 1475238207.5 results: success (0) buildid: 20160930032420 builduid: 45cdcd58ba9343b9a28b915360ede9f4 revision: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:27.496292) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:27.496722) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:27.497041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:27.523326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-30 05:23:27.523597) ========= 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.pP7nOCNfe9/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.p9KDzafm4a/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-30 05:23:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2016-09-30 05:23:27 (19.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134641 ========= master_lag: 1.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-30 05:23:29.589526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:29.589919) ========= 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.pP7nOCNfe9/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.p9KDzafm4a/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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.026736 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:29.640648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-09-30 05:23:29.644052) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2684459e8b6a5ea18efc14ed7561de39bc73eb15 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2684459e8b6a5ea18efc14ed7561de39bc73eb15 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pP7nOCNfe9/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.p9KDzafm4a/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-30 05:23:29,724 truncating revision to first 12 chars 2016-09-30 05:23:29,724 Setting DEBUG logging. 2016-09-30 05:23:29,724 attempt 1/10 2016-09-30 05:23:29,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2684459e8b6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 05:23:33,556 unpacking tar archive at: mozilla-aurora-2684459e8b6a/testing/mozharness/ program finished with exit code 0 elapsedTime=4.085972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-09-30 05:23:33.753112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:33.753527) ========= script_repo_revision: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:33.753980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:33.754274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 05:23:33.778451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-30 05:23:33.778851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pP7nOCNfe9/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.p9KDzafm4a/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:23:33 INFO - MultiFileLogger online at 20160930 05:23:33 in /builds/slave/test 05:23:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:23:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:33 INFO - {'append_to_log': False, 05:23:33 INFO - 'base_work_dir': '/builds/slave/test', 05:23:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:23:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:33 INFO - 'branch': 'Mozilla-Aurora', 05:23:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:33 INFO - 'config_files': ('talos/mac_config.py',), 05:23:33 INFO - 'default_actions': ('clobber', 05:23:33 INFO - 'read-buildbot-config', 05:23:33 INFO - 'download-and-extract', 05:23:33 INFO - 'populate-webroot', 05:23:33 INFO - 'create-virtualenv', 05:23:33 INFO - 'install', 05:23:33 INFO - 'run-tests'), 05:23:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:33 INFO - 'download_minidump_stackwalk': True, 05:23:33 INFO - 'download_symbols': 'ondemand', 05:23:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:33 INFO - 'installer_path': 'installer.exe', 05:23:33 INFO - 'log_level': 'info', 05:23:33 INFO - 'log_name': 'talos', 05:23:33 INFO - 'log_to_console': True, 05:23:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:23:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:23:33 INFO - 'opt_config_files': (), 05:23:33 INFO - 'pip_index': False, 05:23:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:33 INFO - 'cmd': ('bash', 05:23:33 INFO - '-c', 05:23:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:33 INFO - 'enabled': True, 05:23:33 INFO - 'halt_on_failure': False, 05:23:33 INFO - 'name': 'check_screen_resolution'},), 05:23:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:33 INFO - 'cmd': ('bash', 05:23:33 INFO - '-c', 05:23:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:33 INFO - 'enabled': True, 05:23:33 INFO - 'halt_on_failure': False, 05:23:33 INFO - 'name': 'check_screen_resolution'},), 05:23:33 INFO - 'run_cmd_checks_enabled': True, 05:23:33 INFO - 'sps_profile': False, 05:23:33 INFO - 'sps_profile_interval': 0, 05:23:33 INFO - 'suite': 'dromaeojs', 05:23:33 INFO - 'system_bits': '32', 05:23:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:33 INFO - 'title': 't-yosemite-r7-0308', 05:23:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:33 INFO - 'use_talos_json': True, 05:23:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:33 INFO - 'work_dir': 'build'} 05:23:33 INFO - [mozharness: 2016-09-30 12:23:33.969895Z] Running clobber step. 05:23:33 INFO - Running pre-action listener: _resource_record_pre_action 05:23:33 INFO - Running main action method: clobber 05:23:33 INFO - rmtree: /builds/slave/test/build 05:23:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - [mozharness: 2016-09-30 12:23:36.011921Z] Finished clobber step (success) 05:23:36 INFO - [mozharness: 2016-09-30 12:23:36.012060Z] Running read-buildbot-config step. 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: read_buildbot_config 05:23:36 INFO - Using buildbot properties: 05:23:36 INFO - { 05:23:36 INFO - "project": "", 05:23:36 INFO - "product": "firefox", 05:23:36 INFO - "script_repo_revision": "production", 05:23:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:23:36 INFO - "repository": "", 05:23:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:23:36 INFO - "buildid": "20160930032420", 05:23:36 INFO - "pgo_build": "False", 05:23:36 INFO - "basedir": "/builds/slave/test", 05:23:36 INFO - "buildnumber": 25, 05:23:36 INFO - "slavename": "t-yosemite-r7-0308", 05:23:36 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:23:36 INFO - "platform": "yosemite_r7", 05:23:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:23:36 INFO - "branch": "mozilla-aurora", 05:23:36 INFO - "repo_path": "releases/mozilla-aurora", 05:23:36 INFO - "revision": "2684459e8b6a5ea18efc14ed7561de39bc73eb15", 05:23:36 INFO - "stage_platform": "macosx64", 05:23:36 INFO - "builduid": "45cdcd58ba9343b9a28b915360ede9f4", 05:23:36 INFO - "slavebuilddir": "test" 05:23:36 INFO - } 05:23:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - [mozharness: 2016-09-30 12:23:36.016069Z] Finished read-buildbot-config step (success) 05:23:36 INFO - [mozharness: 2016-09-30 12:23:36.016209Z] Running download-and-extract step. 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: download_and_extract 05:23:36 INFO - mkdir: /builds/slave/test/build/tests 05:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:36 INFO - trying https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:23:36 INFO - Downloading https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 05:23:36 INFO - Downloaded 1199 bytes. 05:23:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:23:36 INFO - Using the following test package requirements: 05:23:36 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:23:36 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:23:36 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:23:36 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'jsshell-mac.zip'], 05:23:36 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:23:36 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:23:36 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:23:36 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:23:36 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:23:36 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:23:36 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:23:36 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:23:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:23:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:23:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:23:37 INFO - Expected file size: 16433839 05:23:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:23:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:23:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:23:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:23:45 INFO - Expected file size: 16433839 05:23:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:23:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:23:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:23:52 INFO - Expected file size: 14414059 05:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:53 INFO - trying https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:23:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 05:23:56 INFO - Downloaded 115276619 bytes. 05:23:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:23:56 INFO - mkdir: /builds/slave/test/properties 05:23:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:56 INFO - Contents: 05:23:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:23:56 INFO - Running post-action listener: _resource_record_post_action 05:23:56 INFO - Running post-action listener: set_extra_try_arguments 05:23:56 INFO - [mozharness: 2016-09-30 12:23:56.861684Z] Finished download-and-extract step (success) 05:23:56 INFO - [mozharness: 2016-09-30 12:23:56.861823Z] Running populate-webroot step. 05:23:56 INFO - Running pre-action listener: _resource_record_pre_action 05:23:56 INFO - Running main action method: populate_webroot 05:23:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:56 INFO - '--tppagecycles', 05:23:56 INFO - '7'], 05:23:56 INFO - 'tests': ['tsvgm']}}, 05:23:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:23:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:23:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['damp', 'tps']}, 05:23:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'tests': ['damp', 'tps']}, 05:23:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['dromaeo_dom']}, 05:23:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['basic_compositor_video']}, 05:23:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:23:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['a11yr', 05:23:56 INFO - 'ts_paint', 05:23:56 INFO - 'tpaint', 05:23:56 INFO - 'sessionrestore', 05:23:56 INFO - 'sessionrestore_no_auto_restore', 05:23:56 INFO - 'tabpaint']}, 05:23:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:23:56 INFO - 'ts_paint', 05:23:56 INFO - 'tpaint', 05:23:56 INFO - 'sessionrestore', 05:23:56 INFO - 'sessionrestore_no_auto_restore', 05:23:56 INFO - 'tabpaint']}, 05:23:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:23:56 INFO - 'ts_paint', 05:23:56 INFO - 'tpaint', 05:23:56 INFO - 'sessionrestore', 05:23:56 INFO - 'sessionrestore_no_auto_restore', 05:23:56 INFO - 'tabpaint']}, 05:23:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:23:56 INFO - 'ts_paint', 05:23:56 INFO - 'tpaint', 05:23:56 INFO - 'sessionrestore', 05:23:56 INFO - 'sessionrestore_no_auto_restore', 05:23:56 INFO - 'tabpaint']}, 05:23:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['a11yr', 05:23:56 INFO - 'ts_paint', 05:23:56 INFO - 'tpaint', 05:23:56 INFO - 'sessionrestore', 05:23:56 INFO - 'sessionrestore_no_auto_restore', 05:23:56 INFO - 'tabpaint']}, 05:23:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['a11yr', 05:23:56 INFO - 'ts_paint', 05:23:56 INFO - 'tpaint', 05:23:56 INFO - 'sessionrestore', 05:23:56 INFO - 'sessionrestore_no_auto_restore', 05:23:56 INFO - 'tabpaint']}, 05:23:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['tsvgx', 05:23:56 INFO - 'tsvgr_opacity', 05:23:56 INFO - 'tart', 05:23:56 INFO - 'tscrollx', 05:23:56 INFO - 'cart']}, 05:23:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:23:56 INFO - 'tsvgr_opacity', 05:23:56 INFO - 'tart', 05:23:56 INFO - 'tscrollx', 05:23:56 INFO - 'cart']}, 05:23:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'talos_options': ['--disable-e10s'], 05:23:56 INFO - 'tests': ['tp5o']}, 05:23:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'tests': ['tp5o']}, 05:23:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'talos_options': ['--disable-e10s', 05:23:56 INFO - '--xperf_path', 05:23:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:56 INFO - 'tests': ['tp5n']}, 05:23:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:56 INFO - 'talos_options': ['--xperf_path', 05:23:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:56 INFO - 'tests': ['tp5n']}}, 05:23:56 INFO - 'talos.zip': {'path': '', 05:23:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:56 INFO - Running post-action listener: _resource_record_post_action 05:23:56 INFO - [mozharness: 2016-09-30 12:23:56.880285Z] Finished populate-webroot step (success) 05:23:56 INFO - [mozharness: 2016-09-30 12:23:56.880415Z] Running create-virtualenv step. 05:23:56 INFO - Running pre-action listener: _resource_record_pre_action 05:23:56 INFO - Running main action method: create_virtualenv 05:23:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:56 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 05:23:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:57 INFO - Using real prefix '/tools/python27' 05:23:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:00 INFO - Installing pip.................done. 05:24:00 INFO - Return code: 0 05:24:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:00 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')]} 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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')]} 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:00 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 05:24:00 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 05:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:00 INFO - 'HOME': '/Users/cltbld', 05:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:00 INFO - 'LOGNAME': 'cltbld', 05:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:00 INFO - 'MOZ_NO_REMOTE': '1', 05:24:00 INFO - 'NO_EM_RESTART': '1', 05:24:00 INFO - 'PAGER': '/bin/cat', 05:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:00 INFO - 'PWD': '/builds/slave/test', 05:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:00 INFO - 'SHELL': '/bin/bash', 05:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:00 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:00 INFO - 'USER': 'cltbld', 05:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:00 INFO - 'XPC_FLAGS': '0x0', 05:24:00 INFO - 'XPC_SERVICE_NAME': '0', 05:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:00 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 05:24:00 INFO - Cleaning up... 05:24:00 INFO - Return code: 0 05:24:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24:00 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')]} 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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')]} 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:00 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 05:24:00 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 05:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:00 INFO - 'HOME': '/Users/cltbld', 05:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:00 INFO - 'LOGNAME': 'cltbld', 05:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:00 INFO - 'MOZ_NO_REMOTE': '1', 05:24:00 INFO - 'NO_EM_RESTART': '1', 05:24:00 INFO - 'PAGER': '/bin/cat', 05:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:00 INFO - 'PWD': '/builds/slave/test', 05:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:00 INFO - 'SHELL': '/bin/bash', 05:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:00 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:00 INFO - 'USER': 'cltbld', 05:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:00 INFO - 'XPC_FLAGS': '0x0', 05:24:00 INFO - 'XPC_SERVICE_NAME': '0', 05:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:01 INFO - Downloading/unpacking psutil>=3.1.1 05:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:04 INFO - Installing collected packages: psutil 05:24:04 INFO - Running setup.py install for psutil 05:24:04 INFO - building 'psutil._psutil_osx' extension 05:24:04 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 05:24:05 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 05:24:05 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 05:24:05 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 05:24:05 INFO - building 'psutil._psutil_posix' extension 05:24:05 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 05:24:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:24:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:24:05 INFO - ^ 05:24:05 INFO - 1 warning generated. 05:24:05 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 05:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:05 INFO - Successfully installed psutil 05:24:05 INFO - Cleaning up... 05:24:05 INFO - Return code: 0 05:24:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24:05 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')]} 05:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:05 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')]} 05:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:05 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:05 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 05:24:05 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 05:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:05 INFO - 'HOME': '/Users/cltbld', 05:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:05 INFO - 'LOGNAME': 'cltbld', 05:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:05 INFO - 'MOZ_NO_REMOTE': '1', 05:24:05 INFO - 'NO_EM_RESTART': '1', 05:24:05 INFO - 'PAGER': '/bin/cat', 05:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:05 INFO - 'PWD': '/builds/slave/test', 05:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:05 INFO - 'SHELL': '/bin/bash', 05:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:05 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:05 INFO - 'USER': 'cltbld', 05:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:05 INFO - 'XPC_FLAGS': '0x0', 05:24:05 INFO - 'XPC_SERVICE_NAME': '0', 05:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24:06 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 05:24:06 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 05:24:06 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 05:24:06 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 05:24:06 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 05:24:06 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 05:24:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:08 INFO - Installing collected packages: mozsystemmonitor 05:24:08 INFO - Running setup.py install for mozsystemmonitor 05:24:08 INFO - Successfully installed mozsystemmonitor 05:24:08 INFO - Cleaning up... 05:24:08 INFO - Return code: 0 05:24:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:08 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 05:24:08 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 05:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:08 INFO - 'HOME': '/Users/cltbld', 05:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:08 INFO - 'LOGNAME': 'cltbld', 05:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:08 INFO - 'MOZ_NO_REMOTE': '1', 05:24:08 INFO - 'NO_EM_RESTART': '1', 05:24:08 INFO - 'PAGER': '/bin/cat', 05:24:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:08 INFO - 'PWD': '/builds/slave/test', 05:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:08 INFO - 'SHELL': '/bin/bash', 05:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:08 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:08 INFO - 'USER': 'cltbld', 05:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:08 INFO - 'XPC_FLAGS': '0x0', 05:24:08 INFO - 'XPC_SERVICE_NAME': '0', 05:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 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 05:24:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:12 INFO - warning: no files found matching '*.txt' 05:24:12 INFO - no previously-included directories found matching 'build' 05:24:12 INFO - no previously-included directories found matching 'dist' 05:24:12 INFO - no previously-included directories found matching '.git*' 05:24:12 INFO - Installing collected packages: jsonschema, functools32 05:24:12 INFO - Running setup.py install for functools32 05:24:12 INFO - warning: no files found matching '*.txt' 05:24:12 INFO - no previously-included directories found matching 'build' 05:24:12 INFO - no previously-included directories found matching 'dist' 05:24:12 INFO - no previously-included directories found matching '.git*' 05:24:12 INFO - Successfully installed jsonschema functools32 05:24:12 INFO - Cleaning up... 05:24:12 INFO - Return code: 0 05:24:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:12 INFO - 'HOME': '/Users/cltbld', 05:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:12 INFO - 'LOGNAME': 'cltbld', 05:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:12 INFO - 'MOZ_NO_REMOTE': '1', 05:24:12 INFO - 'NO_EM_RESTART': '1', 05:24:12 INFO - 'PAGER': '/bin/cat', 05:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:12 INFO - 'PWD': '/builds/slave/test', 05:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:12 INFO - 'SHELL': '/bin/bash', 05:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:12 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:12 INFO - 'USER': 'cltbld', 05:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:12 INFO - 'XPC_FLAGS': '0x0', 05:24:12 INFO - 'XPC_SERVICE_NAME': '0', 05:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:24:12 INFO - Cleaning up... 05:24:12 INFO - Return code: 0 05:24:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:12 INFO - 'HOME': '/Users/cltbld', 05:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:12 INFO - 'LOGNAME': 'cltbld', 05:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:12 INFO - 'MOZ_NO_REMOTE': '1', 05:24:12 INFO - 'NO_EM_RESTART': '1', 05:24:12 INFO - 'PAGER': '/bin/cat', 05:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:12 INFO - 'PWD': '/builds/slave/test', 05:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:12 INFO - 'SHELL': '/bin/bash', 05:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:12 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:12 INFO - 'USER': 'cltbld', 05:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:12 INFO - 'XPC_FLAGS': '0x0', 05:24:12 INFO - 'XPC_SERVICE_NAME': '0', 05:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:15 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:16 INFO - Downloading docopt-0.6.1.tar.gz 05:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:16 INFO - Running setup.py install for blobuploader 05:24:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:16 INFO - Running setup.py install for requests 05:24:17 INFO - Running setup.py install for docopt 05:24:17 INFO - Successfully installed blobuploader requests docopt 05:24:17 INFO - Cleaning up... 05:24:17 INFO - Return code: 0 05:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:17 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:17 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 05:24:17 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 05:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:17 INFO - 'HOME': '/Users/cltbld', 05:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:17 INFO - 'LOGNAME': 'cltbld', 05:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:17 INFO - 'MOZ_NO_REMOTE': '1', 05:24:17 INFO - 'NO_EM_RESTART': '1', 05:24:17 INFO - 'PAGER': '/bin/cat', 05:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:17 INFO - 'PWD': '/builds/slave/test', 05:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:17 INFO - 'SHELL': '/bin/bash', 05:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:17 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:17 INFO - 'USER': 'cltbld', 05:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:17 INFO - 'XPC_FLAGS': '0x0', 05:24:17 INFO - 'XPC_SERVICE_NAME': '0', 05:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:17 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-OUyov3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:17 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-9GHTxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-UFA7wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-EPe2zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-65bNgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-oQKt0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Msf5_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-zmCIuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-oWwnSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-NoanR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-C9Bwo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:18 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-cp6nfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:19 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-WmgDYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:19 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-54L4Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:19 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-JNq6rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:19 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-5s8Zso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:19 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-p6tzmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:19 INFO - Running setup.py install for manifestparser 05:24:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:19 INFO - Running setup.py install for mozcrash 05:24:19 INFO - Running setup.py install for mozdebug 05:24:20 INFO - Running setup.py install for mozdevice 05:24:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Running setup.py install for mozfile 05:24:20 INFO - Running setup.py install for mozhttpd 05:24:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Running setup.py install for mozinfo 05:24:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Running setup.py install for mozInstall 05:24:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:20 INFO - Running setup.py install for mozleak 05:24:20 INFO - Running setup.py install for mozlog 05:24:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:21 INFO - Running setup.py install for moznetwork 05:24:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:21 INFO - Running setup.py install for mozprocess 05:24:21 INFO - Running setup.py install for mozprofile 05:24:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:21 INFO - Running setup.py install for mozrunner 05:24:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:21 INFO - Running setup.py install for mozscreenshot 05:24:21 INFO - Running setup.py install for moztest 05:24:21 INFO - Running setup.py install for mozversion 05:24:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:22 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')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 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')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:22 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 05:24:22 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 05:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:22 INFO - 'HOME': '/Users/cltbld', 05:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PAGER': '/bin/cat', 05:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:22 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - 'XPC_FLAGS': '0x0', 05:24:22 INFO - 'XPC_SERVICE_NAME': '0', 05:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:22 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-uUDec0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:22 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)) 05:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:22 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-owH_Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:22 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-kyClWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:22 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)) 05:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:22 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-wxGlW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:22 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-CplIBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:22 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)) 05:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:22 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-9lbzhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-oQScry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-6hReS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-U0h7l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-SaE6xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-viKbMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-7VFaJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-z9iD1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:23 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)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-LPi2_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:23 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-YJxy9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:24 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)) 05:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:24 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-jLjjYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:24 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-d1AjZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:24 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)) 05:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:24 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)) 05:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:24 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 05:24:24 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 05:24:24 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 05:24:24 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 05:24:24 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 05:24:24 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 05:24:27 INFO - Downloading blessings-1.6.tar.gz 05:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:27 INFO - Installing collected packages: blessings 05:24:27 INFO - Running setup.py install for blessings 05:24:27 INFO - Successfully installed blessings 05:24:27 INFO - Cleaning up... 05:24:27 INFO - Return code: 0 05:24:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:27 INFO - Reading from file tmpfile_stdout 05:24:27 INFO - Current package versions: 05:24:27 INFO - blessings == 1.6 05:24:27 INFO - blobuploader == 1.2.4 05:24:27 INFO - docopt == 0.6.1 05:24:27 INFO - functools32 == 3.2.3-2 05:24:27 INFO - jsonschema == 2.5.1 05:24:27 INFO - manifestparser == 1.1 05:24:27 INFO - mozInstall == 1.12 05:24:27 INFO - mozcrash == 0.17 05:24:27 INFO - mozdebug == 0.1 05:24:27 INFO - mozdevice == 0.48 05:24:27 INFO - mozfile == 1.2 05:24:27 INFO - mozhttpd == 0.7 05:24:27 INFO - mozinfo == 0.9 05:24:27 INFO - mozleak == 0.1 05:24:27 INFO - mozlog == 3.4 05:24:27 INFO - moznetwork == 0.27 05:24:27 INFO - mozprocess == 0.23 05:24:27 INFO - mozprofile == 0.28 05:24:27 INFO - mozrunner == 6.12 05:24:27 INFO - mozscreenshot == 0.1 05:24:27 INFO - mozsystemmonitor == 0.3 05:24:27 INFO - moztest == 0.7 05:24:27 INFO - mozversion == 1.4 05:24:27 INFO - psutil == 3.1.1 05:24:27 INFO - requests == 1.2.3 05:24:27 INFO - wsgiref == 0.1.2 05:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 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')]} 05:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:28 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 05:24:28 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 05:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:28 INFO - 'HOME': '/Users/cltbld', 05:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:28 INFO - 'LOGNAME': 'cltbld', 05:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:28 INFO - 'MOZ_NO_REMOTE': '1', 05:24:28 INFO - 'NO_EM_RESTART': '1', 05:24:28 INFO - 'PAGER': '/bin/cat', 05:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:28 INFO - 'PWD': '/builds/slave/test', 05:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:28 INFO - 'SHELL': '/bin/bash', 05:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:28 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:28 INFO - 'USER': 'cltbld', 05:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:28 INFO - 'XPC_FLAGS': '0x0', 05:24:28 INFO - 'XPC_SERVICE_NAME': '0', 05:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 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)) 05:24:28 INFO - Cleaning up... 05:24:28 INFO - Return code: 0 05:24:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:28 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')]} 05:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 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')]} 05:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 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 0x109052490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9431d16a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, '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.pP7nOCNfe9/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.p9KDzafm4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 05:24:28 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 05:24:28 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 05:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:28 INFO - 'HOME': '/Users/cltbld', 05:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:28 INFO - 'LOGNAME': 'cltbld', 05:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:28 INFO - 'MOZ_NO_REMOTE': '1', 05:24:28 INFO - 'NO_EM_RESTART': '1', 05:24:28 INFO - 'PAGER': '/bin/cat', 05:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:28 INFO - 'PWD': '/builds/slave/test', 05:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:28 INFO - 'SHELL': '/bin/bash', 05:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:24:28 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:28 INFO - 'USER': 'cltbld', 05:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:28 INFO - 'XPC_FLAGS': '0x0', 05:24:28 INFO - 'XPC_SERVICE_NAME': '0', 05:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:28 INFO - Cleaning up... 05:24:28 INFO - Return code: 0 05:24:28 INFO - Running post-action listener: _resource_record_post_action 05:24:28 INFO - Running post-action listener: _start_resource_monitoring 05:24:28 INFO - Starting resource monitoring. 05:24:28 INFO - [mozharness: 2016-09-30 12:24:28.679162Z] Finished create-virtualenv step (success) 05:24:28 INFO - [mozharness: 2016-09-30 12:24:28.680123Z] Running install step. 05:24:28 INFO - Running pre-action listener: _resource_record_pre_action 05:24:28 INFO - Running main action method: install 05:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:28 INFO - Reading from file tmpfile_stdout 05:24:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:29 INFO - Reading from file tmpfile_stdout 05:24:29 INFO - Output received: 05:24:29 INFO - Usage: mozinstall [options] installer 05:24:29 INFO - Options: 05:24:29 INFO - -h, --help show this help message and exit 05:24:29 INFO - -d DEST, --destination=DEST 05:24:29 INFO - Directory to install application into. [default: 05:24:29 INFO - "/builds/slave/test"] 05:24:29 INFO - --app=APP Application being installed. [default: firefox] 05:24:29 INFO - mkdir: /builds/slave/test/build/application 05:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:25:01 INFO - Reading from file tmpfile_stdout 05:25:01 INFO - Output received: 05:25:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:25:01 INFO - Running post-action listener: _resource_record_post_action 05:25:01 INFO - [mozharness: 2016-09-30 12:25:01.493324Z] Finished install step (success) 05:25:01 INFO - [mozharness: 2016-09-30 12:25:01.493472Z] Running run-tests step. 05:25:01 INFO - Running pre-action listener: _resource_record_pre_action 05:25:01 INFO - Running main action method: run_tests 05:25:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:01 INFO - 2016-09-30 05:25:01.508 screenresolution[1641:7566] starting screenresolution argv=screenresolution get 05:25:01 INFO - 2016-09-30 05:25:01.510 screenresolution[1641:7566] Display 0: 1600x1200x32@60 05:25:01 INFO - 2016-09-30 05:25:01.517 screenresolution[1642:7568] starting screenresolution argv=screenresolution list 05:25:01 INFO - Available Modes on Display 0 05:25:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:01 INFO - Intel Iris: 05:25:01 INFO - Chipset Model: Intel Iris 05:25:01 INFO - Type: GPU 05:25:01 INFO - Bus: Built-In 05:25:01 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:01 INFO - Vendor: Intel (0x8086) 05:25:01 INFO - Device ID: 0x0a2e 05:25:01 INFO - Revision ID: 0x0009 05:25:01 INFO - Displays: 05:25:01 INFO - Display: 05:25:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:01 INFO - Display Serial Number: 1600x1200 60 05:25:01 INFO - Main Display: Yes 05:25:01 INFO - Mirror: Off 05:25:01 INFO - Online: Yes 05:25:01 INFO - Rotation: Supported 05:25:01 INFO - Return code: 0 05:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:01 INFO - Python 2.7.3 05:25:01 INFO - Return code: 0 05:25:01 INFO - grabbing minidump binary from tooltool 05:25: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')]} 05:25:01 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 0x108e66d30>, '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 0x108cccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e5eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:01 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 05:25:01 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 05:25:01 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 05:25:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:01 INFO - Return code: 0 05:25:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:25:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:25:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0308', '--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 05:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0308 --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 05:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pP7nOCNfe9/Render', 05:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:01 INFO - 'HOME': '/Users/cltbld', 05:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:01 INFO - 'LOGNAME': 'cltbld', 05:25:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:01 INFO - 'MOZ_NO_REMOTE': '1', 05:25:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:01 INFO - 'NO_EM_RESTART': '1', 05:25:01 INFO - 'PAGER': '/bin/cat', 05:25:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:01 INFO - 'PWD': '/builds/slave/test', 05:25:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:01 INFO - 'SHELL': '/bin/bash', 05:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p9KDzafm4a/Listeners', 05:25:01 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 05:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:01 INFO - 'USER': 'cltbld', 05:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:01 INFO - 'XPC_FLAGS': '0x0', 05:25:01 INFO - 'XPC_SERVICE_NAME': '0', 05:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0308', '--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 05:25:02 INFO - mozversion application_buildid: 20160930032420 05:25:02 INFO - mozversion application_changeset: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 05:25:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:25:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:02 INFO - mozversion application_name: Firefox 05:25:02 INFO - mozversion application_remotingname: firefox-dev 05:25:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:25:02 INFO - mozversion application_vendor: Mozilla 05:25:02 INFO - mozversion application_version: 51.0a2 05:25:02 INFO - mozversion platform_buildid: 20160930032420 05:25:02 INFO - mozversion platform_changeset: 2684459e8b6a5ea18efc14ed7561de39bc73eb15 05:25:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:25:02 INFO - mozversion platform_version: 51.0a2 05:25:02 INFO - using testdate: 1475238302 05:25:02 INFO - actual date: 1475238302 05:25:02 INFO - starting webserver on 'localhost:49271' 05:25:02 INFO - SUITE-START | Running 2 tests 05:25:02 INFO - TEST-START | dromaeo_css 05:25:02 INFO - operating with platform_type : mac_ 05:25:02 INFO - Initialising browser for dromaeo_css test... 05:25:02 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmp2_a0G8/profile http://localhost:49271/getInfo.html) 05:25:04 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 05:25:04 INFO - PROCESS | 1652 | colorDepth:24 05:25:04 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 05:25:04 INFO - PROCESS | 1652 | __metrics 05:25:04 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:25:04 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:05 INFO - TEST-INFO | 1652: exit 0 05:25:05 INFO - Browser initialized. 05:25:05 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:05 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmp2_a0G8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:17 INFO - PROCESS | 1654 | RSS: Main: 219246592 05:25:17 INFO - PROCESS | 1654 | 05:26:08 INFO - PROCESS | 1654 | 1475238368272 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:28:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 05:28:21 INFO - PROCESS | 1654 | RSS: Main: 358854656 05:28:21 INFO - PROCESS | 1654 | 05:31:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 05:31:25 INFO - PROCESS | 1654 | RSS: Main: 362582016 05:31:25 INFO - PROCESS | 1654 | 05:34:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 05:34:28 INFO - PROCESS | 1654 | RSS: Main: 346214400 05:34:28 INFO - PROCESS | 1654 | 05:37:30 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 05:37:31 INFO - PROCESS | 1654 | RSS: Main: 324014080 05:37:31 INFO - PROCESS | 1654 | 05:40:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 05:40:35 INFO - PROCESS | 1654 | RSS: Main: 309927936 05:40:35 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 05:43:38 INFO - PROCESS | 1654 | RSS: Main: 365789184 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | __start_tp_report 05:43:38 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 05:43:38 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 05:43:38 INFO - PROCESS | 1654 | |i|pagename|runs| 05:43:38 INFO - PROCESS | 1654 | |0;dojo.html;3224.8871289504873;3244.918877028075;3304.5869266341724;3314.2542927841255;3341.6992470677633;5475.850071484993;5496.615236933416;5584.636998595089;5604.915926261109;5605.355384130826;4680.836170734025;5544.667319960805;5580.944190558093;5596.748146333414;5617.129344951539;5079.187330027196;5086.516780905808;5093.312402825627;5186.8703282418055;5204.32343795306;5096.719680417576;5101.438841727407;5129.461406552315;5191.143461328877;5191.247269145972;5070.5183007614405;5156.690598564098;5164.8708782280555;5190.299309593213;5191.870203244911;5121.385433747937;5141.331626888481;5163.7159956202395;5165.845024649267;5210.322658054429;4270.252705776476;5043.949560504385;5156.896862062776;5171.327727395452;5178.844634660966;5433.1850222466555;5487.6981766002855;5615.887682246333;5625.1843482695185;5678.063119585264;5999.160117583542;6023.548233882432;6033.456988870978;6041.969790151065;6055.12200730896;6052.54605904559;6109.602875813058;6154.446099851035;6192.442680158807;6215.968920155416;5682.232898558683;5701.144828275792;5709.8287051388525;5711.000574899376;5711.571632127607;6130.386961303923;6193.071039344044;6224.253089629183;6254.15568898202;6257.124002639634;5981.7607295707685;6047.818565443044;6062.727177277033;6069.635821850703;6095.664738439428;6160.907586386208;6163.537734669828;6165.32181460039;6175.84560385994;6180.042093475518;5918.171455996164;5983.760649573968;6006.699665016732;6075.453209211192;6109.969450152809;6020.217371741645;6114.631938157225;6142.754289828446;6154.753809847645;6174.413430724164;4844.491328410466;4850.102730994778;4861.878453038632;4874.317595536628;4890.877728056756;3526.964730352715;4361.934570981438;4363.629091527256;4390.670699697535;4402.3176407656865;5566.332040155207;5610.859728506738;5634.746436410372;5686.2039314496005;5695.658260504383;6223.595466294676;6242.15730876335;6252.593581417284;6253.405926436982;6254.186955695822;5660.264165658438;5672.574556908248;5679.943200568024;5686.5735069869925;5716.514096301861;5209.739513024334;5212.244224587414;5235.528802407725;5292.973535132377;5343.919841202385;5132.332796736475;6283.7800676976085;6311.305756366704;6313.968430157912;6329.936700632935;6120.296165940974;6127.958247097915;6133.98789199777;6134;6136.539759517965;6175.907361389673;6224.968875155595;6275.152854364603;6298.71655775482;6303.810885673437;5995.370486098896;6050.818475445743;6060.121282414113;6107.006761825863;6113.415495409546;5170.40540337866;6103.511719062553;6131.785387511416;6218.098375735583;6225.937740622536;5761.510271626791;5919.082542205965;6007.729652165575;6015.248093988252;6019.097135429721;5907.881842363215;5923.200367950271;5932.584719069624;5971.880562388815;6009.098635204754;5865.3254875689845;5870.354261031198;5871.970640146772;5874.500667443144;5875.735591898289;6000.919834429845;6023.66869822164;6024.90962635552;6025.517958563217;6030.39696030411;5625.437456254505;5703.600747947604;5707.942920570741;5757.165211044291;5757.992351338583 05:43:38 INFO - PROCESS | 1654 | |1;ext.html;465.813674530188;471.85136681945164;479.20212845612036;525.1309083466863;540.1303900719843;28392.43215135696;41115.58884411155;42479.78760106195;42631.934201644974;44864.551354486444;44538.554614453846;44886;44919.1016179677;45008.77495612526;45069;8521.233089021987;8734.650613975433;9775.217982561397;9829.606815727362;9927.751806204866;8749.606267717936;11992.340421276826;12209.267443953391;12238.81641775374;12437.937810310936;12233.021358291315;12301.970174921173;12309.938450307736;12322.01423886087;12329.260244385365;12208.267503949703;12265.570705025326;12314.75370492594;12345;12430;12081.214721043192;12155.453004614814;12170.208936419105;12186.329751863645;12192.451339689735;41674.37488437676;41904.37143442851;41952.160956781;42039.94900127491;42043.36934945978;3248.6751324867323;3358.4458564336855;3364.62989071202;3386.6782655647676;3386.7121294689982;31090.222744431343;31562.684373156433;31643.525347119583;31895.681043189503;32407;2755.6830964439146;3273.688999545039;3308.239105005838;3322.601287845474;3324.3185147044796;390770;392000;392425;393703;398473.00763496285;33971.83014084963;63577.72844543083;64092;64130;64163.35836641667;34031.97904062882;34465;35441.29117417689;35822.8208858954;35904;15042.548723538093;15186.544403667687;15191.392344306325;15203;15210.163441010629;11561.537538498365;11808.52765889372;11811.645650630495;12791.872081279069;12900.225986440844;7373.631318434057;7416.443766717518;7437.925620743831;7800.297973182441;7875.56684382353;3259.1037464696924;3282.7045565899184;3285.178705323669;3295.143262751702;3313.436715758327;885.6059053721033;916.1983264643437;967.260046064761;1065.3268323621498;1120.0647459371353;24176;30263.697363026087;30589.69410305913;31234.375312493623;31346;915.4827522449795;1044.1281529922448;1070.5664205996584;1167.3229526874393;1175.0305997552055;15146.545603631908;15622.531324060297;15670.843291567166;15680.529584112495;15992.440264590916;718589;730251;730624;731030;731219;58524.707376462844;59072.818543628884;59100.40899590949;59171.40828591745;59259.703701481216;1254.993725031369;1281.6923938254938;1376.800363947242;1378.9931050344685;1407.5706909392734;29904.953326633462;31538.369232615678;31664;31775;32473.863414780368;50953.745231273606;51633.483665162865;51634;51680.74159629178;51818.74090629523;480625;565699;568784;569287;569841;27291.31771705723;27317.453650926473;27876.86061569679;28053.85973070203;28880.85559572189;38784.80607596944;48841.755791220814;48908.02183956372;49111.75444122757;49226.75386623044;38855.222895542494;39866.60133398629;40352.596474034886;40427;41620.58379416167;40421.797891010356;41609.58390416178;41734.16531669289;41818.74543763692;41848;38750.61249387583;39364;39790.60209397869;39999.600003999585;40128;31084.844575776977;34607.82696086604;35113.297734045686;35262.47106293356;35545.289094217456;25854.353641159123;25867.22398327978;25947.870260648575;26175.73824261733;26273.97849247361 05:43:38 INFO - PROCESS | 1654 | |2;jquery.html;352.652637152405;366.50521795575975;370.83312509370774;379.4346423828496;402.40645048553387;11317.094632429407;15129.394824207033;16075.356985720557;20416.877071761046;20742.585148297025;19305.71041434376;19538.218471261167;20103.994800260003;20292.492687682814;20375.694364584542;5922.141289513018;6041.818745437622;6062.939370606304;6139.263288405397;6195.721192546346;3775.848966041355;4473.709208901428;4502.8874278142985;6026.728797204114;6093.817185484442;4361.214981303364;6497.870042599146;6817.216020157671;6830.897536536956;6881;6544.9345506544805;6714.093597364342;6754.3921047105505;6803.353681400308;6862.970554416827;5636.436356364372;5852.941470585282;5853.707314634294;5854.238948936653;5870.823875283749;25352.859121339585;25499.745002549924;25501.872490637612;25802.74197258022;25875.870620646965;2224.655178447343;2709.837409755421;3117.9688203117908;3148.7166155045925;3158.0525842247234;14626.268686565736;15000.624984375369;15149.545513634608;15520.5343839685;15919.124448155348;1651.6283836136893;1784.5895444047942;1863.813618638139;1888.8394486468667;1962.0582120582058;111863;112214;112421.43789281083;115404;115798.42100789526;10293.330933489298;10574.577016919391;10693.144548436107;10905.309677000077;11101;13695.726085478434;13728.244946527837;13744.725105497833;13756.105853119516;13758;8387.245147936594;8596.742097737078;8597.570121494025;8705.738827835175;8753.037165911745;7357.822748360237;8677.262432693291;8731.126887311219;8732.8690069649;8895.73312800617;6445.871082578322;6519.217693876765;6528.08606795049;6542.21493420783;6552.705128269144;1532.9003614765004;1691.8984860908386;1755.0522717732538;1797.7123660214304;1876.4933467963847;888.3293113699116;902.7382059202889;905.2757793764962;1019.6788011776267;1035.8394448860438;16692.165391730367;19213.23147074129;20702.068406921724;22718.772812271996;22727.545449090925;941.1341565759518;947.4457442396275;996.4320337407753;1008.7326858382535;1041.9479026048666;11491.885081149248;11676.76646467066;11944.581939632071;11980.820287695691;12073.396330183456;562371.1881440567;600918;623231.883840587;630262;631768;120498;124228.37885810513;126977.36511317384;127188;127697;903.8011637439753;994.572333896417;1013.1843865688045;1035.1563475767225;1038.2887721910515;14885.404583816526;20071.39785806428;20870.895645521676;20878.582428351652;20881;43249.56750432456;49432.75283623559;51533;53156.734216328674;53198;73972.63013685112;74432.62783686047;75227.24772752421;76482.61758691394;76743.46513069818;6837.453003759787;7640.73257435987;7667.118281397487;7936.801579960316;8074.192580741878;12339.197952133083;12443.377831108228;12446.751064978831;12882;12978.870211297766;10578.471076446302;10765.677029689123;10781.353118812896;10857.131429485464;11023.779524409307;10796.622118225825;10809.945950270512;11026.889731102907;11068.889311106786;11158.330500170016;10369.481525923824;10744.560014681747;11111.666650000512;11125.16561257925;11257.774844503228;7895.249951254622;7938.126806051214;8120.959395202986;8280.58597070132;8284.212999765012;7869.763907082796;10405.167586592903;10746.08658264025;10832.891671083504;11107.05590024857 05:43:38 INFO - PROCESS | 1654 | |3;mootools.html;1328.6346254779937;1505.3677455468703;1665.6085819832338;1823.5623450371897;1885.7925628180897;8692.130786921312;9164.083591640832;9172.633094676214;9179.862302065458;9197.494137822418;7556.773296801091;8033;8242;8784.51685157316;9022.413543119708;2390.5457962987066;2422.8546287222734;2427.186892391051;2437.768412000857;2442.24290469954;2379.9048038078454;2382.7855493005627;2429.7327293997646;2431.8540887546715;2432.0514999150346;2413.4569721812627;2424.187897054489;2425.2845410603827;2440.036185706645;2445.217530390276;2382.332946774906;2385.5348207099623;2400.3639035655565;2410.3733029412306;2425.5876500994873;2344.0858065354523;2383.535210633927;2383.7020372453444;2386.6300723387903;2399.892004859768;9094.99955004949;9194.724158275263;9210.769730756785;9214.493202873839;9265.444073355553;5309;5460.590455715837;5460.672359658433;5466.398696143421;5478.260434841285;2937.941241175186;3686.060054686038;3698.8335524901445;3703.333399988001;3713.1459764254105;942.2603256443728;1076.5048077884105;1099.5052226498108;1112.3326004397377;1128.531659361364;12125.39373031345;12181.634550963397;12184.451699673536;12189.51241950321;12189.634310970685;4721.197396442544;4727.49552633624;4758.524147585283;4895.461499235082;4898.314236006961;10145.985401459942;10258.743531411625;10303.124234440156;10308.845367319496;10353.482325883826;5392.352917649907;5397.541208997201;5400.378956420062;5407.242985981966;5408.242846001563;4465.821367145278;4573.6569757268335;4603.194440972817;4899.657024008286;4910.631702622318;3988.641022308006;4023.5775243599587;4087.550369459357;4111.712180147361;4125.628693417607;1089.9618513351995;1288.916220445668;1309.109805332383;1309.1817613991254;1318.3935389720837;907.3149771922157;917.9908200918039;922.6922771648559;924.6671198368582;954.427343593852;5821.38875418075;5851.361618746758;5933.465988061095;6059.182010428536;6232.127502149703;438.3796927347831;446.09665427509555;446.9128519938646;453.19331589770263;455.6195576693432;3641.5979847758804;3756.38019726742;3983.541892682321;3993.6805055595482;4069.084455997436;9020.458772473541;10792;11145.777084458265;11162.939520745678;11215.271007384494;10991.120710343153;11149.832752508557;11159.721006974729;11165.218434709492;11186.776264474665;7076.893846592306;8317.334613230927;8351.1648835116;8384.832303353776;8397.916020839835;5833.883322333445;5924.31870334917;5991.88016239664;6009.311888377065;6112.847178820387;9942.502874856373;9976.20190384782;10138.493075346056;10305.74235644115;10325.535350909076;8916.420432671855;10145.03622155894;10432.947835260775;10530.736731581772;10622.681319560426;7091.1490621125795;7314.451416143704;7442.665080071301;7530.096388433423;7661.195574464824;8534.914650853412;8629.39594228398;8633.223009928884;8711.869321960303;8720.738377848675;7604.277593628596;7677.424193185422;7719.768406947801;7811.023622047244;7864.174261702439;7369.484136110421;7503.5497870127965;7527.322540971339;7547.132079810673;7612.162662107275;7049.436045116481;7177.389921856492;7179.820504487429;7186.784396468114;7191.137063552407;4918.065567542156;4963.677360971526;5073.148300870082;5079.898402031865;5210.609204309616;4995.400551933792;5074.16276314404;5126.307948426915;5138.563222126161;5163.4578369270685 05:43:38 INFO - PROCESS | 1654 | |4;prototype.html;258.67665418227216;302.4027545597444;308.91350421881873;312.8404513698015;315.8278738087742;4371.606555410012;4408.647308215343;5162.948370516294;5389.407165211824;5515.613907026514;4847.781849816758;5175.508326708957;5273.6572122811995;5279.313689220406;5391.32608423947;3219.1952011997;3830.1382189007527;3971.761694298337;4123.907164601383;4160.375943608453;3934.9016274593077;4020.7989600520004;4057.2696914555368;4165.187788381251;4193.979030104861;3381.9661803381896;3809.6190380961957;4063.2889244382263;4088.693347998897;4152.487744914329;3549.964500354989;3970.8087573727767;4039.808256564321;4115.42384066231;4133.379993001059;2955.3645966117174;3597.6402359764074;3598.1289729340856;3604.6215147409407;3630.49173115764;5136.820211292624;5243.134882744343;5252.422233554306;5281.841544753664;5333.226682131108;4416.514183439819;4501.144782491349;4706.27052806812;4726.196546587088;4745.383100196987;4521.547845215452;5639.887202255932;5678.551969247816;5703.914441283384;5748.626339287975;3703.2223233121076;3925.5878132796215;3926.7630696330566;3934.449177115206;3958.485396898385;5908.704564771744;5955.285365756137;5962.582619216657;5972.432618901197;6017.608855424427;3212.9678703212667;3369.3261347730554;3444.9655503445147;4029.174019326031;4033.778142202207;3986.6412022918075;3988.960110398917;4014.699764249089;4069.9796501017304;4101.52832424275;4239.749273964127;4284.528701842794;4388.902774306423;4720;4720.527947205252;5736.77052917887;5755.510781583613;5795.88408231833;5797.188393624896;5953.434423729739;974.9685052308754;1073.4203530093662;1267.2322110655584;1319.6700824793802;1344.1531834943924;849.2399302624117;858.9355798315152;865.4807115730512;867.4318321499302;874.9606267717968;4308.849190278325;4570.337301091323;4579.702319349231;4653.232216684277;4654.86035418938;4174.039970806732;4480.103979204172;4505.43682039745;4766.284137710421;4940.530649588355;4969.875753106201;5533.711373685426;5551.666899985933;5561.6663000220115;5577.470140336662;2585.4699786543715;2741.300968253083;2808.6770021447387;2991.6089018606017;3071.4624940635745;4799.928001079987;5552;5954.519133566924;6094.329623741385;6112.227454038279;5309;5460.6177567570685;5967.46292833647;6016.969915150396;6040.218135649994;5099.923501147486;5458.536024437967;5727.8830628027135;6078.939210607926;6085.939140608626;5622.867316156374;5736.827895163152;5806.1000544915605;5844.736986835517;5907.438793314628;5714.371404149797;5793.91309130355;5800.39095894925;5823.922574323764;5829.280362293049;4951.9490120078035;4992.226204938241;5687.289088863892;5728.41973766396;6129.2305232282715;3854.2291541692334;3868.226354729009;3871.4773505576386;3881.7476864003747;3881.961180388273;4704.859289023554;5565.30433695788;5794.188813566188;5797.623154494944;5877.73628669838;5333.146696528537;5446.529437052053;5641.768673494879;5698.430156984434;5831.4168583141345;5076.923846142385;5318.97340513295;5321.521063104185;5766.308043034863;5821.147637657433;4799.928001079917;5404;5588.413216612197;5656.462636049569;5728.455796699307;4482.708623939434;4890.2370160859;5177.1784377513595;5177.352830896138;5400.459954004726;4440.578145076212;5557.360903495988;5664.915026274692;5669.744861481326;5678.488935995781 05:43:38 INFO - PROCESS | 1654 | |5;yui.html;658.8188248231736;789.3685051958432;798.3732769775727;809.7530253272749;810.7365106340441;15308;16325.020498770067;16433.26050327735;16737.665246695058;17212.56968575783;16134.515964521053;16502.587435314123;16528.66942661149;16565.83434165658;16628.251728672207;830.9584520773952;861.8836457078309;867.319154463746;867.3321542412339;868.2489646455801;681.1961884975726;698.0611078099947;700.0933790741003;834.6661335465832;849.0448245723561;904.3082042237694;905.3888625177979;906.2161230535572;906.6917248135633;909.6543313540845;897.7890195803981;898.1871406377239;899.2536194958202;899.2581120575519;899.9235065019416;530.5039787798421;542.4954792043437;654.5777973207303;671.0672165689696;679.6669631880393;14870.405183792634;15278.236088195657;15442.768358474632;15449.691006179926;15465.536033919001;13314.334283285894;13618.046736728433;13710.24593647349;13773.862261377459;14136.62286262628;12255.509779608805;12691.555795547203;12769.103944443132;12925.612231633066;13570.796438053438;4594.747442677279;4607.516210797885;4662.6269898408045;4772.76136193189;4773.307870358779;112467.51958742406;114109.42945285303;116054;119720;121267.78732212742;10458.320209186379;10774.461276936121;10809.83785243222;10876.238663293494;11003.394813285186;20990.580188396147;21024.15903363879;21092.78907210939;21101.9449027548;21118.732876027487;6470.838229044311;7932.365410767125;8079.151689072681;8110.797230069177;8158.67365305393;4324.286492728727;4458.264386376277;4490.416245888014;4493.977530112394;4634.814607415666;3497.720182385403;3649.4525821127045;3652.817359132086;3656.2504686539196;3657.5976642569826;642.5189937194717;659.3670076726396;668.0947316386324;674.2684187656448;679.9014142949344;443.5298583501499;677.2719326723792;682.4063065133266;687.2474640268897;699.2343383994518;7955.965724455784;8269.09040005599;9092.681756138636;9520.8571871422;9585.233181345475;634.4924060751381;645.5255387290338;677.891537354021;683.6718375179942;691.3708525242006;4425.181341451842;4621.376114224604;4720.480747117815;4750.762461876892;4789.473157952622;107095;152144.2392788029;153738;153959;164990.175049124;89942.55028724814;121448.39275803741;121727;122996.77003229853;125783.37108314583;28882.133535993955;28913.85543072229;28974.71025289762;29215.41569168605;39075.80462097671;9043.140901614335;9116.4074335168;9126.224270937044;9142.405743626643;9175.632974680939;51853.96292074213;60248;62401.68799155975;64145.679271603345;65427.01859472207;84232.73650895119;88137;89900.5504972471;92324;93068.53465732628;12882.67793305175;13150.60548183556;13419.597412077654;13497.32513374347;13606.727865442437;13460.125091868997;14194;15234.847651523787;15255.056051076022;15982.120983345563;13505.257210853497;14184.57446276572;14314.498992535211;14764.852351476347;14840.628984275048;11473;13338.93330533341;13876.58370248894;14241.928790356396;14284.57146285613;11613.941930290295;13397.866021340053;13779.724405512034;13864.098833575785;14027.719445611236;11226.410396853125;11552.42237888119;11782.351970641697;11883.702907427383;11928.165028447926;11426.97157255851;11566.183159557495;11878.643640690792;11902.821457677968;11911.344876031555 05:43:38 INFO - PROCESS | 1654 | __end_tp_report 05:43:38 INFO - PROCESS | 1654 | __start_cc_report 05:43:38 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1318 05:43:38 INFO - PROCESS | 1654 | __end_cc_report 05:43:38 INFO - PROCESS | 1654 | __startTimestamp1475239418670__endTimestamp 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | ------- Summary: start ------- 05:43:38 INFO - PROCESS | 1654 | Number of tests: 6 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5627.47 Median:5761.51 stddev:654.82 (11.4%) stddev-sans-first:629.12 05:43:38 INFO - PROCESS | 1654 | Values: 3224.9 3244.9 3304.6 3314.3 3341.7 5475.9 5496.6 5584.6 5604.9 5605.4 4680.8 5544.7 5580.9 5596.7 5617.1 5079.2 5086.5 5093.3 5186.9 5204.3 5096.7 5101.4 5129.5 5191.1 5191.2 5070.5 5156.7 5164.9 5190.3 5191.9 5121.4 5141.3 5163.7 5165.8 5210.3 4270.3 5043.9 5156.9 5171.3 5178.8 5433.2 5487.7 5615.9 5625.2 5678.1 5999.2 6023.5 6033.5 6042.0 6055.1 6052.5 6109.6 6154.4 6192.4 6216.0 5682.2 5701.1 5709.8 5711.0 5711.6 6130.4 6193.1 6224.3 6254.2 6257.1 5981.8 6047.8 6062.7 6069.6 6095.7 6160.9 6163.5 6165.3 6175.8 6180.0 5918.2 5983.8 6006.7 6075.5 6110.0 6020.2 6114.6 6142.8 6154.8 6174.4 4844.5 4850.1 4861.9 4874.3 4890.9 3527.0 4361.9 4363.6 4390.7 4402.3 5566.3 5610.9 5634.7 5686.2 5695.7 6223.6 6242.2 6252.6 6253.4 6254.2 5660.3 5672.6 5679.9 5686.6 5716.5 5209.7 5212.2 5235.5 5293.0 5343.9 5132.3 6283.8 6311.3 6314.0 6329.9 6120.3 6128.0 6134.0 6134.0 6136.5 6175.9 6225.0 6275.2 6298.7 6303.8 5995.4 6050.8 6060.1 6107.0 6113.4 5170.4 6103.5 6131.8 6218.1 6225.9 5761.5 5919.1 6007.7 6015.2 6019.1 5907.9 5923.2 5932.6 5971.9 6009.1 5865.3 5870.4 5872.0 5874.5 5875.7 6000.9 6023.7 6024.9 6025.5 6030.4 5625.4 5703.6 5707.9 5757.2 5758.0 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:68728.49 Median:34860.56 stddev:154112.12 (442.1%) stddev-sans-first:154459.22 05:43:38 INFO - PROCESS | 1654 | Values: 465.8 471.9 479.2 525.1 540.1 28392.4 41115.6 42479.8 42631.9 44864.6 44538.6 44886.0 44919.1 45008.8 45069.0 8521.2 8734.7 9775.2 9829.6 9927.8 8749.6 11992.3 12209.3 12238.8 12437.9 12233.0 12302.0 12309.9 12322.0 12329.3 12208.3 12265.6 12314.8 12345.0 12430.0 12081.2 12155.5 12170.2 12186.3 12192.5 41674.4 41904.4 41952.2 42039.9 42043.4 3248.7 3358.4 3364.6 3386.7 3386.7 31090.2 31562.7 31643.5 31895.7 32407.0 2755.7 3273.7 3308.2 3322.6 3324.3 390770.0 392000.0 392425.0 393703.0 398473.0 33971.8 63577.7 64092.0 64130.0 64163.4 34032.0 34465.0 35441.3 35822.8 35904.0 15042.5 15186.5 15191.4 15203.0 15210.2 11561.5 11808.5 11811.6 12791.9 12900.2 7373.6 7416.4 7437.9 7800.3 7875.6 3259.1 3282.7 3285.2 3295.1 3313.4 885.6 916.2 967.3 1065.3 1120.1 24176.0 30263.7 30589.7 31234.4 31346.0 915.5 1044.1 1070.6 1167.3 1175.0 15146.5 15622.5 15670.8 15680.5 15992.4 718589.0 730251.0 730624.0 731030.0 731219.0 58524.7 59072.8 59100.4 59171.4 59259.7 1255.0 1281.7 1376.8 1379.0 1407.6 29905.0 31538.4 31664.0 31775.0 32473.9 50953.7 51633.5 51634.0 51680.7 51818.7 480625.0 565699.0 568784.0 569287.0 569841.0 27291.3 27317.5 27876.9 28053.9 28880.9 38784.8 48841.8 48908.0 49111.8 49226.8 38855.2 39866.6 40352.6 40427.0 41620.6 40421.8 41609.6 41734.2 41818.7 41848.0 38750.6 39364.0 39790.6 39999.6 40128.0 31084.8 34607.8 35113.3 35262.5 35545.3 25854.4 25867.2 25947.9 26175.7 26274.0 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35062.11 Median:22723.16 stddev:101517.62 (446.8%) stddev-sans-first:101768.95 05:43:38 INFO - PROCESS | 1654 | Values: 352.7 366.5 370.8 379.4 402.4 11317.1 15129.4 16075.4 20416.9 20742.6 19305.7 19538.2 20104.0 20292.5 20375.7 5922.1 6041.8 6062.9 6139.3 6195.7 3775.8 4473.7 4502.9 6026.7 6093.8 4361.2 6497.9 6817.2 6830.9 6881.0 6544.9 6714.1 6754.4 6803.4 6863.0 5636.4 5852.9 5853.7 5854.2 5870.8 25352.9 25499.7 25501.9 25802.7 25875.9 2224.7 2709.8 3118.0 3148.7 3158.1 14626.3 15000.6 15149.5 15520.5 15919.1 1651.6 1784.6 1863.8 1888.8 1962.1 111863.0 112214.0 112421.4 115404.0 115798.4 10293.3 10574.6 10693.1 10905.3 11101.0 13695.7 13728.2 13744.7 13756.1 13758.0 8387.2 8596.7 8597.6 8705.7 8753.0 7357.8 8677.3 8731.1 8732.9 8895.7 6445.9 6519.2 6528.1 6542.2 6552.7 1532.9 1691.9 1755.1 1797.7 1876.5 888.3 902.7 905.3 1019.7 1035.8 16692.2 19213.2 20702.1 22718.8 22727.5 941.1 947.4 996.4 1008.7 1041.9 11491.9 11676.8 11944.6 11980.8 12073.4 562371.2 600918.0 623231.9 630262.0 631768.0 120498.0 124228.4 126977.4 127188.0 127697.0 903.8 994.6 1013.2 1035.2 1038.3 14885.4 20071.4 20870.9 20878.6 20881.0 43249.6 49432.8 51533.0 53156.7 53198.0 73972.6 74432.6 75227.2 76482.6 76743.5 6837.5 7640.7 7667.1 7936.8 8074.2 12339.2 12443.4 12446.8 12882.0 12978.9 10578.5 10765.7 10781.4 10857.1 11023.8 10796.6 10809.9 11026.9 11068.9 11158.3 10369.5 10744.6 11111.7 11125.2 11257.8 7895.2 7938.1 8121.0 8280.6 8284.2 7869.8 10405.2 10746.1 10832.9 11107.1 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5805.87 Median:4826.99 stddev:3305.04 (68.5%) stddev-sans-first:3297.18 05:43:38 INFO - PROCESS | 1654 | Values: 1328.6 1505.4 1665.6 1823.6 1885.8 8692.1 9164.1 9172.6 9179.9 9197.5 7556.8 8033.0 8242.0 8784.5 9022.4 2390.5 2422.9 2427.2 2437.8 2442.2 2379.9 2382.8 2429.7 2431.9 2432.1 2413.5 2424.2 2425.3 2440.0 2445.2 2382.3 2385.5 2400.4 2410.4 2425.6 2344.1 2383.5 2383.7 2386.6 2399.9 9095.0 9194.7 9210.8 9214.5 9265.4 5309.0 5460.6 5460.7 5466.4 5478.3 2937.9 3686.1 3698.8 3703.3 3713.1 942.3 1076.5 1099.5 1112.3 1128.5 12125.4 12181.6 12184.5 12189.5 12189.6 4721.2 4727.5 4758.5 4895.5 4898.3 10146.0 10258.7 10303.1 10308.8 10353.5 5392.4 5397.5 5400.4 5407.2 5408.2 4465.8 4573.7 4603.2 4899.7 4910.6 3988.6 4023.6 4087.6 4111.7 4125.6 1090.0 1288.9 1309.1 1309.2 1318.4 907.3 918.0 922.7 924.7 954.4 5821.4 5851.4 5933.5 6059.2 6232.1 438.4 446.1 446.9 453.2 455.6 3641.6 3756.4 3983.5 3993.7 4069.1 9020.5 10792.0 11145.8 11162.9 11215.3 10991.1 11149.8 11159.7 11165.2 11186.8 7076.9 8317.3 8351.2 8384.8 8397.9 5833.9 5924.3 5991.9 6009.3 6112.8 9942.5 9976.2 10138.5 10305.7 10325.5 8916.4 10145.0 10432.9 10530.7 10622.7 7091.1 7314.5 7442.7 7530.1 7661.2 8534.9 8629.4 8633.2 8711.9 8720.7 7604.3 7677.4 7719.8 7811.0 7864.2 7369.5 7503.5 7527.3 7547.1 7612.2 7049.4 7177.4 7179.8 7186.8 7191.1 4918.1 4963.7 5073.1 5079.9 5210.6 4995.4 5074.2 5126.3 5138.6 5163.5 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4524.15 Median:4981.05 stddev:1419.19 (28.5%) stddev-sans-first:1386.59 05:43:38 INFO - PROCESS | 1654 | Values: 258.7 302.4 308.9 312.8 315.8 4371.6 4408.6 5162.9 5389.4 5515.6 4847.8 5175.5 5273.7 5279.3 5391.3 3219.2 3830.1 3971.8 4123.9 4160.4 3934.9 4020.8 4057.3 4165.2 4194.0 3382.0 3809.6 4063.3 4088.7 4152.5 3550.0 3970.8 4039.8 4115.4 4133.4 2955.4 3597.6 3598.1 3604.6 3630.5 5136.8 5243.1 5252.4 5281.8 5333.2 4416.5 4501.1 4706.3 4726.2 4745.4 4521.5 5639.9 5678.6 5703.9 5748.6 3703.2 3925.6 3926.8 3934.4 3958.5 5908.7 5955.3 5962.6 5972.4 6017.6 3213.0 3369.3 3445.0 4029.2 4033.8 3986.6 3989.0 4014.7 4070.0 4101.5 4239.7 4284.5 4388.9 4720.0 4720.5 5736.8 5755.5 5795.9 5797.2 5953.4 975.0 1073.4 1267.2 1319.7 1344.2 849.2 858.9 865.5 867.4 875.0 4308.8 4570.3 4579.7 4653.2 4654.9 4174.0 4480.1 4505.4 4766.3 4940.5 4969.9 5533.7 5551.7 5561.7 5577.5 2585.5 2741.3 2808.7 2991.6 3071.5 4799.9 5552.0 5954.5 6094.3 6112.2 5309.0 5460.6 5967.5 6017.0 6040.2 5099.9 5458.5 5727.9 6078.9 6085.9 5622.9 5736.8 5806.1 5844.7 5907.4 5714.4 5793.9 5800.4 5823.9 5829.3 4951.9 4992.2 5687.3 5728.4 6129.2 3854.2 3868.2 3871.5 3881.7 3882.0 4704.9 5565.3 5794.2 5797.6 5877.7 5333.1 5446.5 5641.8 5698.4 5831.4 5076.9 5319.0 5321.5 5766.3 5821.1 4799.9 5404.0 5588.4 5656.5 5728.5 4482.7 4890.2 5177.2 5177.4 5400.5 4440.6 5557.4 5664.9 5669.7 5678.5 05:43:38 INFO - PROCESS | 1654 | 05:43:38 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:22501.58 Median:3654.53 stddev:36203.09 (990.6%) stddev-sans-first:36267.50 05:43:38 INFO - PROCESS | 1654 | Values: 658.8 789.4 798.4 809.8 810.7 15308.0 16325.0 16433.3 16737.7 17212.6 16134.5 16502.6 16528.7 16565.8 16628.3 831.0 861.9 867.3 867.3 868.2 681.2 698.1 700.1 834.7 849.0 904.3 905.4 906.2 906.7 909.7 897.8 898.2 899.3 899.3 899.9 530.5 542.5 654.6 671.1 679.7 14870.4 15278.2 15442.8 15449.7 15465.5 13314.3 13618.0 13710.2 13773.9 14136.6 12255.5 12691.6 12769.1 12925.6 13570.8 4594.7 4607.5 4662.6 4772.8 4773.3 112467.5 114109.4 116054.0 119720.0 121267.8 10458.3 10774.5 10809.8 10876.2 11003.4 20990.6 21024.2 21092.8 21101.9 21118.7 6470.8 7932.4 8079.2 8110.8 8158.7 4324.3 4458.3 4490.4 4494.0 4634.8 3497.7 3649.5 3652.8 3656.3 3657.6 642.5 659.4 668.1 674.3 679.9 443.5 677.3 682.4 687.2 699.2 7956.0 8269.1 9092.7 9520.9 9585.2 634.5 645.5 677.9 683.7 691.4 4425.2 4621.4 4720.5 4750.8 4789.5 107095.0 152144.2 153738.0 153959.0 164990.2 89942.6 121448.4 121727.0 122996.8 125783.4 28882.1 28913.9 28974.7 29215.4 39075.8 9043.1 9116.4 9126.2 9142.4 9175.6 51854.0 60248.0 62401.7 64145.7 65427.0 84232.7 88137.0 89900.6 92324.0 93068.5 12882.7 13150.6 13419.6 13497.3 13606.7 13460.1 14194.0 15234.8 15255.1 15982.1 13505.3 14184.6 14314.5 14764.9 14840.6 11473.0 13338.9 13876.6 14241.9 14284.6 11613.9 13397.9 13779.7 13864.1 14027.7 11226.4 11552.4 11782.4 11883.7 11928.2 11427.0 11566.2 11878.6 11902.8 11911.3 05:43:38 INFO - PROCESS | 1654 | -------- Summary: end -------- 05:43:38 INFO - PROCESS | 1654 | 05:43:39 INFO - TEST-INFO | 1654: exit 0 05:43:39 INFO - TEST-OK | dromaeo_css | took 1117188ms 05:43:39 INFO - TEST-START | kraken 05:43:39 INFO - operating with platform_type : mac_ 05:43:39 INFO - Initialising browser for kraken test... 05:43:39 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmprHgMam/profile http://localhost:49271/getInfo.html) 05:43:41 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:43:41 INFO - PROCESS | 1661 | colorDepth:24 05:43:41 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:43:41 INFO - PROCESS | 1661 | __metrics 05:43:41 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:43:41 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:43:42 INFO - TEST-INFO | 1661: exit 0 05:43:42 INFO - Browser initialized. 05:43:42 INFO - Running cycle 1/1 for kraken test... 05:43:42 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmprHgMam/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:54 INFO - PROCESS | 1662 | RSS: Main: 219107328 05:43:54 INFO - PROCESS | 1662 | 05:43:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:58 INFO - PROCESS | 1662 | RSS: Main: 269185024 05:43:58 INFO - PROCESS | 1662 | 05:44:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 05:44:01 INFO - PROCESS | 1662 | RSS: Main: 280649728 05:44:01 INFO - PROCESS | 1662 | 05:44:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 05:44:05 INFO - PROCESS | 1662 | RSS: Main: 379355136 05:44:05 INFO - PROCESS | 1662 | 05:44:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 05:44:07 INFO - PROCESS | 1662 | RSS: Main: 279179264 05:44:07 INFO - PROCESS | 1662 | 05:44:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:10 INFO - PROCESS | 1662 | RSS: Main: 279506944 05:44:10 INFO - PROCESS | 1662 | 05:44:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:13 INFO - PROCESS | 1662 | RSS: Main: 317386752 05:44:13 INFO - PROCESS | 1662 | 05:44:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:17 INFO - PROCESS | 1662 | RSS: Main: 319709184 05:44:17 INFO - PROCESS | 1662 | 05:44:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 05:44:20 INFO - PROCESS | 1662 | RSS: Main: 318242816 05:44:20 INFO - PROCESS | 1662 | 05:44:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:22 INFO - PROCESS | 1662 | RSS: Main: 295059456 05:44:22 INFO - PROCESS | 1662 | 05:44:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:25 INFO - PROCESS | 1662 | RSS: Main: 297447424 05:44:25 INFO - PROCESS | 1662 | 05:44:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:28 INFO - PROCESS | 1662 | RSS: Main: 295260160 05:44:28 INFO - PROCESS | 1662 | 05:44:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:31 INFO - PROCESS | 1662 | RSS: Main: 312029184 05:44:31 INFO - PROCESS | 1662 | 05:44:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:35 INFO - PROCESS | 1662 | RSS: Main: 308363264 05:44:35 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 05:44:37 INFO - PROCESS | 1662 | RSS: Main: 351494144 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | __start_tp_report 05:44:37 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:44:37 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:44:37 INFO - PROCESS | 1662 | |i|pagename|runs| 05:44:37 INFO - PROCESS | 1662 | |0;ai-astar;116;116;115;121;166;165;113;114;113;114 05:44:37 INFO - PROCESS | 1662 | |1;audio-beat-detection;169;139;110;143;109;109;110;108;139;110 05:44:37 INFO - PROCESS | 1662 | |2;audio-dft;184;185;186;182;184;183;183;182;185;184 05:44:37 INFO - PROCESS | 1662 | |3;audio-fft;81;59;58;88;62;64;58;58;85;58 05:44:37 INFO - PROCESS | 1662 | |4;audio-oscillator;85;70;93;69;67;69;92;67;69;90 05:44:37 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;86;83;88;131;134;84;88;84;88;84 05:44:37 INFO - PROCESS | 1662 | |6;imaging-darkroom;136;128;93;93;93;92;94;93;92;91 05:44:37 INFO - PROCESS | 1662 | |7;imaging-desaturate;83;85;85;84;85;86;86;85;84;88 05:44:37 INFO - PROCESS | 1662 | |8;json-parse-financial;53;56;52;53;56;57;56;56;56;56 05:44:37 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;63;64;79;76;72;66;68;69;67;68 05:44:37 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;85;85;81;82;85;83;102;72;93;105 05:44:37 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;148;159;150;149;147;143;135;136;175;131 05:44:37 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;171;226;196;161;221;217;163;180;226;204 05:44:37 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;59;84;84;67;60;87;83;85;71;66 05:44:37 INFO - PROCESS | 1662 | __end_tp_report 05:44:37 INFO - PROCESS | 1662 | __start_cc_report 05:44:37 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2011 05:44:37 INFO - PROCESS | 1662 | __end_cc_report 05:44:37 INFO - PROCESS | 1662 | __startTimestamp1475239477674__endTimestamp 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:44:37 INFO - PROCESS | 1662 | Number of tests: 14 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:125.30 Median:116.00 stddev:21.31 (18.4%) stddev-sans-first:22.34 05:44:37 INFO - PROCESS | 1662 | Values: 116.0 116.0 115.0 121.0 166.0 165.0 113.0 114.0 113.0 114.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:124.50 stddev:21.41 (17.2%) stddev-sans-first:15.56 05:44:37 INFO - PROCESS | 1662 | Values: 169.0 139.0 110.0 143.0 109.0 109.0 110.0 108.0 139.0 110.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.32 (0.7%) stddev-sans-first:1.39 05:44:37 INFO - PROCESS | 1662 | Values: 184.0 185.0 186.0 182.0 184.0 183.0 183.0 182.0 185.0 184.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:67.10 Median:63.00 stddev:12.40 (19.7%) stddev-sans-first:12.08 05:44:37 INFO - PROCESS | 1662 | Values: 81.0 59.0 58.0 88.0 62.0 64.0 58.0 58.0 85.0 58.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.50 stddev:11.33 (14.6%) stddev-sans-first:11.65 05:44:37 INFO - PROCESS | 1662 | Values: 85.0 70.0 93.0 69.0 67.0 69.0 92.0 67.0 69.0 90.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:85.00 stddev:19.87 (23.4%) stddev-sans-first:20.80 05:44:37 INFO - PROCESS | 1662 | Values: 86.0 83.0 88.0 131.0 134.0 84.0 88.0 84.0 88.0 84.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:93.00 stddev:16.73 (18.0%) stddev-sans-first:11.82 05:44:37 INFO - PROCESS | 1662 | Values: 136.0 128.0 93.0 93.0 93.0 92.0 94.0 93.0 92.0 91.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.37 (1.6%) stddev-sans-first:1.22 05:44:37 INFO - PROCESS | 1662 | Values: 83.0 85.0 85.0 84.0 85.0 86.0 86.0 85.0 84.0 88.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.73 (3.1%) stddev-sans-first:1.66 05:44:37 INFO - PROCESS | 1662 | Values: 53.0 56.0 52.0 53.0 56.0 57.0 56.0 56.0 56.0 56.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:68.50 stddev:5.09 (7.4%) stddev-sans-first:4.88 05:44:37 INFO - PROCESS | 1662 | Values: 63.0 64.0 79.0 76.0 72.0 66.0 68.0 69.0 67.0 68.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.00 stddev:9.99 (11.9%) stddev-sans-first:10.56 05:44:37 INFO - PROCESS | 1662 | Values: 85.0 85.0 81.0 82.0 85.0 83.0 102.0 72.0 93.0 105.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:148.50 stddev:12.82 (8.6%) stddev-sans-first:13.59 05:44:37 INFO - PROCESS | 1662 | Values: 148.0 159.0 150.0 149.0 147.0 143.0 135.0 136.0 175.0 131.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.50 Median:210.50 stddev:26.08 (12.4%) stddev-sans-first:25.98 05:44:37 INFO - PROCESS | 1662 | Values: 171.0 226.0 196.0 161.0 221.0 217.0 163.0 180.0 226.0 204.0 05:44:37 INFO - PROCESS | 1662 | 05:44:37 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:83.50 stddev:11.11 (13.3%) stddev-sans-first:10.25 05:44:37 INFO - PROCESS | 1662 | Values: 59.0 84.0 84.0 67.0 60.0 87.0 83.0 85.0 71.0 66.0 05:44:37 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:44:37 INFO - PROCESS | 1662 | 05:44:38 INFO - TEST-INFO | 1662: exit 0 05:44:38 INFO - TEST-OK | kraken | took 59312ms 05:44:38 INFO - SUITE-END | took 1176s 05:44:38 INFO - Completed test suite (00:19:36) 05:44:38 INFO - javascript benchmark 05:44:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.8871289504873, 3244.918877028075, 3304.5869266341724, 3314.2542927841255, 3341.6992470677633, 5475.850071484993, 5496.615236933416, 5584.636998595089, 5604.915926261109, 5605.355384130826, 4680.836170734025, 5544.667319960805, 5580.944190558093, 5596.748146333414, 5617.129344951539, 5079.187330027196, 5086.516780905808, 5093.312402825627, 5186.8703282418055, 5204.32343795306, 5096.719680417576, 5101.438841727407, 5129.461406552315, 5191.143461328877, 5191.247269145972, 5070.5183007614405, 5156.690598564098, 5164.8708782280555, 5190.299309593213, 5191.870203244911, 5121.385433747937, 5141.331626888481, 5163.7159956202395, 5165.845024649267, 5210.322658054429, 4270.252705776476, 5043.949560504385, 5156.896862062776, 5171.327727395452, 5178.844634660966, 5433.1850222466555, 5487.6981766002855, 5615.887682246333, 5625.1843482695185, 5678.063119585264, 5999.160117583542, 6023.548233882432, 6033.456988870978, 6041.969790151065, 6055.12200730896, 6052.54605904559, 6109.602875813058, 6154.446099851035, 6192.442680158807, 6215.968920155416, 5682.232898558683, 5701.144828275792, 5709.8287051388525, 5711.000574899376, 5711.571632127607, 6130.386961303923, 6193.071039344044, 6224.253089629183, 6254.15568898202, 6257.124002639634, 5981.7607295707685, 6047.818565443044, 6062.727177277033, 6069.635821850703, 6095.664738439428, 6160.907586386208, 6163.537734669828, 6165.32181460039, 6175.84560385994, 6180.042093475518, 5918.171455996164, 5983.760649573968, 6006.699665016732, 6075.453209211192, 6109.969450152809, 6020.217371741645, 6114.631938157225, 6142.754289828446, 6154.753809847645, 6174.413430724164, 4844.491328410466, 4850.102730994778, 4861.878453038632, 4874.317595536628, 4890.877728056756, 3526.964730352715, 4361.934570981438, 4363.629091527256, 4390.670699697535, 4402.3176407656865, 5566.332040155207, 5610.859728506738, 5634.746436410372, 5686.2039314496005, 5695.658260504383, 6223.595466294676, 6242.15730876335, 6252.593581417284, 6253.405926436982, 6254.186955695822, 5660.264165658438, 5672.574556908248, 5679.943200568024, 5686.5735069869925, 5716.514096301861, 5209.739513024334, 5212.244224587414, 5235.528802407725, 5292.973535132377, 5343.919841202385, 5132.332796736475, 6283.7800676976085, 6311.305756366704, 6313.968430157912, 6329.936700632935, 6120.296165940974, 6127.958247097915, 6133.98789199777, 6134.0, 6136.539759517965, 6175.907361389673, 6224.968875155595, 6275.152854364603, 6298.71655775482, 6303.810885673437, 5995.370486098896, 6050.818475445743, 6060.121282414113, 6107.006761825863, 6113.415495409546, 5170.40540337866, 6103.511719062553, 6131.785387511416, 6218.098375735583, 6225.937740622536, 5761.510271626791, 5919.082542205965, 6007.729652165575, 6015.248093988252, 6019.097135429721, 5907.881842363215, 5923.200367950271, 5932.584719069624, 5971.880562388815, 6009.098635204754, 5865.3254875689845, 5870.354261031198, 5871.970640146772, 5874.500667443144, 5875.735591898289, 6000.919834429845, 6023.66869822164, 6024.90962635552, 6025.517958563217, 6030.39696030411, 5625.437456254505, 5703.600747947604, 5707.942920570741, 5757.165211044291, 5757.992351338583], "value": 5584.914398091463, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.813674530188, 471.85136681945164, 479.20212845612036, 525.1309083466863, 540.1303900719843, 28392.43215135696, 41115.58884411155, 42479.78760106195, 42631.934201644974, 44864.551354486444, 44538.554614453846, 44886.0, 44919.1016179677, 45008.77495612526, 45069.0, 8521.233089021987, 8734.650613975433, 9775.217982561397, 9829.606815727362, 9927.751806204866, 8749.606267717936, 11992.340421276826, 12209.267443953391, 12238.81641775374, 12437.937810310936, 12233.021358291315, 12301.970174921173, 12309.938450307736, 12322.01423886087, 12329.260244385365, 12208.267503949703, 12265.570705025326, 12314.75370492594, 12345.0, 12430.0, 12081.214721043192, 12155.453004614814, 12170.208936419105, 12186.329751863645, 12192.451339689735, 41674.37488437676, 41904.37143442851, 41952.160956781, 42039.94900127491, 42043.36934945978, 3248.6751324867323, 3358.4458564336855, 3364.62989071202, 3386.6782655647676, 3386.7121294689982, 31090.222744431343, 31562.684373156433, 31643.525347119583, 31895.681043189503, 32407.0, 2755.6830964439146, 3273.688999545039, 3308.239105005838, 3322.601287845474, 3324.3185147044796, 390770.0, 392000.0, 392425.0, 393703.0, 398473.00763496285, 33971.83014084963, 63577.72844543083, 64092.0, 64130.0, 64163.35836641667, 34031.97904062882, 34465.0, 35441.29117417689, 35822.8208858954, 35904.0, 15042.548723538093, 15186.544403667687, 15191.392344306325, 15203.0, 15210.163441010629, 11561.537538498365, 11808.52765889372, 11811.645650630495, 12791.872081279069, 12900.225986440844, 7373.631318434057, 7416.443766717518, 7437.925620743831, 7800.297973182441, 7875.56684382353, 3259.1037464696924, 3282.7045565899184, 3285.178705323669, 3295.143262751702, 3313.436715758327, 885.6059053721033, 916.1983264643437, 967.260046064761, 1065.3268323621498, 1120.0647459371353, 24176.0, 30263.697363026087, 30589.69410305913, 31234.375312493623, 31346.0, 915.4827522449795, 1044.1281529922448, 1070.5664205996584, 1167.3229526874393, 1175.0305997552055, 15146.545603631908, 15622.531324060297, 15670.843291567166, 15680.529584112495, 15992.440264590916, 718589.0, 730251.0, 730624.0, 731030.0, 731219.0, 58524.707376462844, 59072.818543628884, 59100.40899590949, 59171.40828591745, 59259.703701481216, 1254.993725031369, 1281.6923938254938, 1376.800363947242, 1378.9931050344685, 1407.5706909392734, 29904.953326633462, 31538.369232615678, 31664.0, 31775.0, 32473.863414780368, 50953.745231273606, 51633.483665162865, 51634.0, 51680.74159629178, 51818.74090629523, 480625.0, 565699.0, 568784.0, 569287.0, 569841.0, 27291.31771705723, 27317.453650926473, 27876.86061569679, 28053.85973070203, 28880.85559572189, 38784.80607596944, 48841.755791220814, 48908.02183956372, 49111.75444122757, 49226.75386623044, 38855.222895542494, 39866.60133398629, 40352.596474034886, 40427.0, 41620.58379416167, 40421.797891010356, 41609.58390416178, 41734.16531669289, 41818.74543763692, 41848.0, 38750.61249387583, 39364.0, 39790.60209397869, 39999.600003999585, 40128.0, 31084.844575776977, 34607.82696086604, 35113.297734045686, 35262.47106293356, 35545.289094217456, 25854.353641159123, 25867.22398327978, 25947.870260648575, 26175.73824261733, 26273.97849247361], "value": 19275.616696559933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.652637152405, 366.50521795575975, 370.83312509370774, 379.4346423828496, 402.40645048553387, 11317.094632429407, 15129.394824207033, 16075.356985720557, 20416.877071761046, 20742.585148297025, 19305.71041434376, 19538.218471261167, 20103.994800260003, 20292.492687682814, 20375.694364584542, 5922.141289513018, 6041.818745437622, 6062.939370606304, 6139.263288405397, 6195.721192546346, 3775.848966041355, 4473.709208901428, 4502.8874278142985, 6026.728797204114, 6093.817185484442, 4361.214981303364, 6497.870042599146, 6817.216020157671, 6830.897536536956, 6881.0, 6544.9345506544805, 6714.093597364342, 6754.3921047105505, 6803.353681400308, 6862.970554416827, 5636.436356364372, 5852.941470585282, 5853.707314634294, 5854.238948936653, 5870.823875283749, 25352.859121339585, 25499.745002549924, 25501.872490637612, 25802.74197258022, 25875.870620646965, 2224.655178447343, 2709.837409755421, 3117.9688203117908, 3148.7166155045925, 3158.0525842247234, 14626.268686565736, 15000.624984375369, 15149.545513634608, 15520.5343839685, 15919.124448155348, 1651.6283836136893, 1784.5895444047942, 1863.813618638139, 1888.8394486468667, 1962.0582120582058, 111863.0, 112214.0, 112421.43789281083, 115404.0, 115798.42100789526, 10293.330933489298, 10574.577016919391, 10693.144548436107, 10905.309677000077, 11101.0, 13695.726085478434, 13728.244946527837, 13744.725105497833, 13756.105853119516, 13758.0, 8387.245147936594, 8596.742097737078, 8597.570121494025, 8705.738827835175, 8753.037165911745, 7357.822748360237, 8677.262432693291, 8731.126887311219, 8732.8690069649, 8895.73312800617, 6445.871082578322, 6519.217693876765, 6528.08606795049, 6542.21493420783, 6552.705128269144, 1532.9003614765004, 1691.8984860908386, 1755.0522717732538, 1797.7123660214304, 1876.4933467963847, 888.3293113699116, 902.7382059202889, 905.2757793764962, 1019.6788011776267, 1035.8394448860438, 16692.165391730367, 19213.23147074129, 20702.068406921724, 22718.772812271996, 22727.545449090925, 941.1341565759518, 947.4457442396275, 996.4320337407753, 1008.7326858382535, 1041.9479026048666, 11491.885081149248, 11676.76646467066, 11944.581939632071, 11980.820287695691, 12073.396330183456, 562371.1881440567, 600918.0, 623231.883840587, 630262.0, 631768.0, 120498.0, 124228.37885810513, 126977.36511317384, 127188.0, 127697.0, 903.8011637439753, 994.572333896417, 1013.1843865688045, 1035.1563475767225, 1038.2887721910515, 14885.404583816526, 20071.39785806428, 20870.895645521676, 20878.582428351652, 20881.0, 43249.56750432456, 49432.75283623559, 51533.0, 53156.734216328674, 53198.0, 73972.63013685112, 74432.62783686047, 75227.24772752421, 76482.61758691394, 76743.46513069818, 6837.453003759787, 7640.73257435987, 7667.118281397487, 7936.801579960316, 8074.192580741878, 12339.197952133083, 12443.377831108228, 12446.751064978831, 12882.0, 12978.870211297766, 10578.471076446302, 10765.677029689123, 10781.353118812896, 10857.131429485464, 11023.779524409307, 10796.622118225825, 10809.945950270512, 11026.889731102907, 11068.889311106786, 11158.330500170016, 10369.481525923824, 10744.560014681747, 11111.666650000512, 11125.16561257925, 11257.774844503228, 7895.249951254622, 7938.126806051214, 8120.959395202986, 8280.58597070132, 8284.212999765012, 7869.763907082796, 10405.167586592903, 10746.08658264025, 10832.891671083504, 11107.05590024857], "value": 9708.57900897931, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.6346254779937, 1505.3677455468703, 1665.6085819832338, 1823.5623450371897, 1885.7925628180897, 8692.130786921312, 9164.083591640832, 9172.633094676214, 9179.862302065458, 9197.494137822418, 7556.773296801091, 8033.0, 8242.0, 8784.51685157316, 9022.413543119708, 2390.5457962987066, 2422.8546287222734, 2427.186892391051, 2437.768412000857, 2442.24290469954, 2379.9048038078454, 2382.7855493005627, 2429.7327293997646, 2431.8540887546715, 2432.0514999150346, 2413.4569721812627, 2424.187897054489, 2425.2845410603827, 2440.036185706645, 2445.217530390276, 2382.332946774906, 2385.5348207099623, 2400.3639035655565, 2410.3733029412306, 2425.5876500994873, 2344.0858065354523, 2383.535210633927, 2383.7020372453444, 2386.6300723387903, 2399.892004859768, 9094.99955004949, 9194.724158275263, 9210.769730756785, 9214.493202873839, 9265.444073355553, 5309.0, 5460.590455715837, 5460.672359658433, 5466.398696143421, 5478.260434841285, 2937.941241175186, 3686.060054686038, 3698.8335524901445, 3703.333399988001, 3713.1459764254105, 942.2603256443728, 1076.5048077884105, 1099.5052226498108, 1112.3326004397377, 1128.531659361364, 12125.39373031345, 12181.634550963397, 12184.451699673536, 12189.51241950321, 12189.634310970685, 4721.197396442544, 4727.49552633624, 4758.524147585283, 4895.461499235082, 4898.314236006961, 10145.985401459942, 10258.743531411625, 10303.124234440156, 10308.845367319496, 10353.482325883826, 5392.352917649907, 5397.541208997201, 5400.378956420062, 5407.242985981966, 5408.242846001563, 4465.821367145278, 4573.6569757268335, 4603.194440972817, 4899.657024008286, 4910.631702622318, 3988.641022308006, 4023.5775243599587, 4087.550369459357, 4111.712180147361, 4125.628693417607, 1089.9618513351995, 1288.916220445668, 1309.109805332383, 1309.1817613991254, 1318.3935389720837, 907.3149771922157, 917.9908200918039, 922.6922771648559, 924.6671198368582, 954.427343593852, 5821.38875418075, 5851.361618746758, 5933.465988061095, 6059.182010428536, 6232.127502149703, 438.3796927347831, 446.09665427509555, 446.9128519938646, 453.19331589770263, 455.6195576693432, 3641.5979847758804, 3756.38019726742, 3983.541892682321, 3993.6805055595482, 4069.084455997436, 9020.458772473541, 10792.0, 11145.777084458265, 11162.939520745678, 11215.271007384494, 10991.120710343153, 11149.832752508557, 11159.721006974729, 11165.218434709492, 11186.776264474665, 7076.893846592306, 8317.334613230927, 8351.1648835116, 8384.832303353776, 8397.916020839835, 5833.883322333445, 5924.31870334917, 5991.88016239664, 6009.311888377065, 6112.847178820387, 9942.502874856373, 9976.20190384782, 10138.493075346056, 10305.74235644115, 10325.535350909076, 8916.420432671855, 10145.03622155894, 10432.947835260775, 10530.736731581772, 10622.681319560426, 7091.1490621125795, 7314.451416143704, 7442.665080071301, 7530.096388433423, 7661.195574464824, 8534.914650853412, 8629.39594228398, 8633.223009928884, 8711.869321960303, 8720.738377848675, 7604.277593628596, 7677.424193185422, 7719.768406947801, 7811.023622047244, 7864.174261702439, 7369.484136110421, 7503.5497870127965, 7527.322540971339, 7547.132079810673, 7612.162662107275, 7049.436045116481, 7177.389921856492, 7179.820504487429, 7186.784396468114, 7191.137063552407, 4918.065567542156, 4963.677360971526, 5073.148300870082, 5079.898402031865, 5210.609204309616, 4995.400551933792, 5074.16276314404, 5126.307948426915, 5138.563222126161, 5163.4578369270685], "value": 4573.280689853098, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.67665418227216, 302.4027545597444, 308.91350421881873, 312.8404513698015, 315.8278738087742, 4371.606555410012, 4408.647308215343, 5162.948370516294, 5389.407165211824, 5515.613907026514, 4847.781849816758, 5175.508326708957, 5273.6572122811995, 5279.313689220406, 5391.32608423947, 3219.1952011997, 3830.1382189007527, 3971.761694298337, 4123.907164601383, 4160.375943608453, 3934.9016274593077, 4020.7989600520004, 4057.2696914555368, 4165.187788381251, 4193.979030104861, 3381.9661803381896, 3809.6190380961957, 4063.2889244382263, 4088.693347998897, 4152.487744914329, 3549.964500354989, 3970.8087573727767, 4039.808256564321, 4115.42384066231, 4133.379993001059, 2955.3645966117174, 3597.6402359764074, 3598.1289729340856, 3604.6215147409407, 3630.49173115764, 5136.820211292624, 5243.134882744343, 5252.422233554306, 5281.841544753664, 5333.226682131108, 4416.514183439819, 4501.144782491349, 4706.27052806812, 4726.196546587088, 4745.383100196987, 4521.547845215452, 5639.887202255932, 5678.551969247816, 5703.914441283384, 5748.626339287975, 3703.2223233121076, 3925.5878132796215, 3926.7630696330566, 3934.449177115206, 3958.485396898385, 5908.704564771744, 5955.285365756137, 5962.582619216657, 5972.432618901197, 6017.608855424427, 3212.9678703212667, 3369.3261347730554, 3444.9655503445147, 4029.174019326031, 4033.778142202207, 3986.6412022918075, 3988.960110398917, 4014.699764249089, 4069.9796501017304, 4101.52832424275, 4239.749273964127, 4284.528701842794, 4388.902774306423, 4720.0, 4720.527947205252, 5736.77052917887, 5755.510781583613, 5795.88408231833, 5797.188393624896, 5953.434423729739, 974.9685052308754, 1073.4203530093662, 1267.2322110655584, 1319.6700824793802, 1344.1531834943924, 849.2399302624117, 858.9355798315152, 865.4807115730512, 867.4318321499302, 874.9606267717968, 4308.849190278325, 4570.337301091323, 4579.702319349231, 4653.232216684277, 4654.86035418938, 4174.039970806732, 4480.103979204172, 4505.43682039745, 4766.284137710421, 4940.530649588355, 4969.875753106201, 5533.711373685426, 5551.666899985933, 5561.6663000220115, 5577.470140336662, 2585.4699786543715, 2741.300968253083, 2808.6770021447387, 2991.6089018606017, 3071.4624940635745, 4799.928001079987, 5552.0, 5954.519133566924, 6094.329623741385, 6112.227454038279, 5309.0, 5460.6177567570685, 5967.46292833647, 6016.969915150396, 6040.218135649994, 5099.923501147486, 5458.536024437967, 5727.8830628027135, 6078.939210607926, 6085.939140608626, 5622.867316156374, 5736.827895163152, 5806.1000544915605, 5844.736986835517, 5907.438793314628, 5714.371404149797, 5793.91309130355, 5800.39095894925, 5823.922574323764, 5829.280362293049, 4951.9490120078035, 4992.226204938241, 5687.289088863892, 5728.41973766396, 6129.2305232282715, 3854.2291541692334, 3868.226354729009, 3871.4773505576386, 3881.7476864003747, 3881.961180388273, 4704.859289023554, 5565.30433695788, 5794.188813566188, 5797.623154494944, 5877.73628669838, 5333.146696528537, 5446.529437052053, 5641.768673494879, 5698.430156984434, 5831.4168583141345, 5076.923846142385, 5318.97340513295, 5321.521063104185, 5766.308043034863, 5821.147637657433, 4799.928001079917, 5404.0, 5588.413216612197, 5656.462636049569, 5728.455796699307, 4482.708623939434, 4890.2370160859, 5177.1784377513595, 5177.352830896138, 5400.459954004726, 4440.578145076212, 5557.360903495988, 5664.915026274692, 5669.744861481326, 5678.488935995781], "value": 4064.9920282099692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.8188248231736, 789.3685051958432, 798.3732769775727, 809.7530253272749, 810.7365106340441, 15308.0, 16325.020498770067, 16433.26050327735, 16737.665246695058, 17212.56968575783, 16134.515964521053, 16502.587435314123, 16528.66942661149, 16565.83434165658, 16628.251728672207, 830.9584520773952, 861.8836457078309, 867.319154463746, 867.3321542412339, 868.2489646455801, 681.1961884975726, 698.0611078099947, 700.0933790741003, 834.6661335465832, 849.0448245723561, 904.3082042237694, 905.3888625177979, 906.2161230535572, 906.6917248135633, 909.6543313540845, 897.7890195803981, 898.1871406377239, 899.2536194958202, 899.2581120575519, 899.9235065019416, 530.5039787798421, 542.4954792043437, 654.5777973207303, 671.0672165689696, 679.6669631880393, 14870.405183792634, 15278.236088195657, 15442.768358474632, 15449.691006179926, 15465.536033919001, 13314.334283285894, 13618.046736728433, 13710.24593647349, 13773.862261377459, 14136.62286262628, 12255.509779608805, 12691.555795547203, 12769.103944443132, 12925.612231633066, 13570.796438053438, 4594.747442677279, 4607.516210797885, 4662.6269898408045, 4772.76136193189, 4773.307870358779, 112467.51958742406, 114109.42945285303, 116054.0, 119720.0, 121267.78732212742, 10458.320209186379, 10774.461276936121, 10809.83785243222, 10876.238663293494, 11003.394813285186, 20990.580188396147, 21024.15903363879, 21092.78907210939, 21101.9449027548, 21118.732876027487, 6470.838229044311, 7932.365410767125, 8079.151689072681, 8110.797230069177, 8158.67365305393, 4324.286492728727, 4458.264386376277, 4490.416245888014, 4493.977530112394, 4634.814607415666, 3497.720182385403, 3649.4525821127045, 3652.817359132086, 3656.2504686539196, 3657.5976642569826, 642.5189937194717, 659.3670076726396, 668.0947316386324, 674.2684187656448, 679.9014142949344, 443.5298583501499, 677.2719326723792, 682.4063065133266, 687.2474640268897, 699.2343383994518, 7955.965724455784, 8269.09040005599, 9092.681756138636, 9520.8571871422, 9585.233181345475, 634.4924060751381, 645.5255387290338, 677.891537354021, 683.6718375179942, 691.3708525242006, 4425.181341451842, 4621.376114224604, 4720.480747117815, 4750.762461876892, 4789.473157952622, 107095.0, 152144.2392788029, 153738.0, 153959.0, 164990.175049124, 89942.55028724814, 121448.39275803741, 121727.0, 122996.77003229853, 125783.37108314583, 28882.133535993955, 28913.85543072229, 28974.71025289762, 29215.41569168605, 39075.80462097671, 9043.140901614335, 9116.4074335168, 9126.224270937044, 9142.405743626643, 9175.632974680939, 51853.96292074213, 60248.0, 62401.68799155975, 64145.679271603345, 65427.01859472207, 84232.73650895119, 88137.0, 89900.5504972471, 92324.0, 93068.53465732628, 12882.67793305175, 13150.60548183556, 13419.597412077654, 13497.32513374347, 13606.727865442437, 13460.125091868997, 14194.0, 15234.847651523787, 15255.056051076022, 15982.120983345563, 13505.257210853497, 14184.57446276572, 14314.498992535211, 14764.852351476347, 14840.628984275048, 11473.0, 13338.93330533341, 13876.58370248894, 14241.928790356396, 14284.57146285613, 11613.941930290295, 13397.866021340053, 13779.724405512034, 13864.098833575785, 14027.719445611236, 11226.410396853125, 11552.42237888119, 11782.351970641697, 11883.702907427383, 11928.165028447926, 11426.97157255851, 11566.183159557495, 11878.643640690792, 11902.821457677968, 11911.344876031555], "value": 7638.608836895251, "unit": "score"}], "name": "dromaeo_css", "value": 7276.479497610549, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 115.0, 121.0, 166.0, 165.0, 113.0, 114.0, 113.0, 114.0], "value": 125.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 139.0, 110.0, 143.0, 109.0, 109.0, 110.0, 108.0, 139.0, 110.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 186.0, 182.0, 184.0, 183.0, 183.0, 182.0, 185.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 62.0, 64.0, 58.0, 58.0, 85.0, 58.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 93.0, 69.0, 67.0, 69.0, 92.0, 67.0, 69.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 88.0, 131.0, 134.0, 84.0, 88.0, 84.0, 88.0, 84.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 128.0, 93.0, 93.0, 93.0, 92.0, 94.0, 93.0, 92.0, 91.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 84.0, 85.0, 86.0, 86.0, 85.0, 84.0, 88.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 52.0, 53.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 79.0, 76.0, 72.0, 66.0, 68.0, 69.0, 67.0, 68.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 81.0, 82.0, 85.0, 83.0, 102.0, 72.0, 93.0, 105.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 159.0, 150.0, 149.0, 147.0, 143.0, 135.0, 136.0, 175.0, 131.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 226.0, 196.0, 161.0, 221.0, 217.0, 163.0, 180.0, 226.0, 204.0], "value": 196.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 84.0, 84.0, 67.0, 60.0, 87.0, 83.0, 85.0, 71.0, 66.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1488.5, "alertThreshold": 2.0}]} 05:44:38 INFO - Return code: 0 05:44:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:44:38 INFO - # TBPL SUCCESS # 05:44:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:44:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:44:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:44:38 INFO - 2016-09-30 05:44:38.982 screenresolution[1666:9852] starting screenresolution argv=screenresolution get 05:44:38 INFO - 2016-09-30 05:44:38.984 screenresolution[1666:9852] Display 0: 1600x1200x32@60 05:44:38 INFO - 2016-09-30 05:44:38.991 screenresolution[1667:9855] starting screenresolution argv=screenresolution list 05:44:38 INFO - Available Modes on Display 0 05:44:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:44:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:44:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:44:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:44:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:44:39 INFO - Intel Iris: 05:44:39 INFO - Chipset Model: Intel Iris 05:44:39 INFO - Type: GPU 05:44:39 INFO - Bus: Built-In 05:44:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:44:39 INFO - Vendor: Intel (0x8086) 05:44:39 INFO - Device ID: 0x0a2e 05:44:39 INFO - Revision ID: 0x0009 05:44:39 INFO - Displays: 05:44:39 INFO - Display: 05:44:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:44:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:44:39 INFO - Display Serial Number: 1600x1200 60 05:44:39 INFO - Main Display: Yes 05:44:39 INFO - Mirror: Off 05:44:39 INFO - Online: Yes 05:44:39 INFO - Rotation: Supported 05:44:39 INFO - Return code: 0 05:44:39 INFO - Running post-action listener: _resource_record_post_action 05:44:39 INFO - [mozharness: 2016-09-30 12:44:39.230332Z] Finished run-tests step (success) 05:44:39 INFO - Running post-run listener: _resource_record_post_run 05:44:39 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37311488; Write bytes: 662972928; Read time: 242; Write time: 1887 05:44:39 INFO - TinderboxPrint: CPU usage
53.5% 05:44:39 INFO - TinderboxPrint: I/O read bytes / time
37,311,488 / 242 05:44:39 INFO - TinderboxPrint: I/O write bytes / time
662,972,928 / 1,887 05:44:39 INFO - TinderboxPrint: CPU idle
2,249.0 (46.5%) 05:44:39 INFO - TinderboxPrint: CPU system
976.1 (20.2%) 05:44:39 INFO - TinderboxPrint: CPU user
1,616.7 (33.4%) 05:44:39 INFO - TinderboxPrint: Swap in / out
400,314,368 / 0 05:44:39 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 360348160; Write bytes: 357735936; Read time: 27833; Write time: 751 05:44:39 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31022080; Write bytes: 295054336; Read time: 184; Write time: 1104 05:44:39 INFO - Running post-run listener: _upload_blobber_files 05:44:39 INFO - Blob upload gear active. 05:44:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:39 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 05:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:44:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:40 INFO - (blobuploader) - INFO - Done attempting. 05:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:44:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:41 INFO - (blobuploader) - INFO - Done attempting. 05:44:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:44:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:44 INFO - (blobuploader) - INFO - Done attempting. 05:44:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:44 INFO - Return code: 0 05:44:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9236e7a91554d9cb05f2cf22c86f2859f4e2a3bd0319cb4615473000e5b4f134b322760d531719bfb10f1fe13423dacb805dc222ac6c55cb9045a2d2eb57841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e400b3905c6e0846dd2d498cdbb02b5a38e8d531dda24ee8ce1005b1095ce430df21a1fa0676b5d30545a8e8537483ef88e077177e6a7fe26f549f3176aad968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5677277da020b0451173f83029ecb96b70e6656592ad25cadd9bdfde4f6a122c9d51a3d30abbd569ca8defc301972bbb6c646e866bd656e031f6b0f71fb30149"} 05:44:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:44 INFO - Contents: 05:44:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9236e7a91554d9cb05f2cf22c86f2859f4e2a3bd0319cb4615473000e5b4f134b322760d531719bfb10f1fe13423dacb805dc222ac6c55cb9045a2d2eb57841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e400b3905c6e0846dd2d498cdbb02b5a38e8d531dda24ee8ce1005b1095ce430df21a1fa0676b5d30545a8e8537483ef88e077177e6a7fe26f549f3176aad968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5677277da020b0451173f83029ecb96b70e6656592ad25cadd9bdfde4f6a122c9d51a3d30abbd569ca8defc301972bbb6c646e866bd656e031f6b0f71fb30149"} 05:44:44 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:44 INFO - Copying logs to upload dir... 05:44:44 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.335435 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-30 05:44:44.162069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 05:44:44.165346) ========= 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.pP7nOCNfe9/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.p9KDzafm4a/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9236e7a91554d9cb05f2cf22c86f2859f4e2a3bd0319cb4615473000e5b4f134b322760d531719bfb10f1fe13423dacb805dc222ac6c55cb9045a2d2eb57841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e400b3905c6e0846dd2d498cdbb02b5a38e8d531dda24ee8ce1005b1095ce430df21a1fa0676b5d30545a8e8537483ef88e077177e6a7fe26f549f3176aad968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5677277da020b0451173f83029ecb96b70e6656592ad25cadd9bdfde4f6a122c9d51a3d30abbd569ca8defc301972bbb6c646e866bd656e031f6b0f71fb30149"} build_url:https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/ISs3WJliT-SWnlIy3mTivA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9236e7a91554d9cb05f2cf22c86f2859f4e2a3bd0319cb4615473000e5b4f134b322760d531719bfb10f1fe13423dacb805dc222ac6c55cb9045a2d2eb57841", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e400b3905c6e0846dd2d498cdbb02b5a38e8d531dda24ee8ce1005b1095ce430df21a1fa0676b5d30545a8e8537483ef88e077177e6a7fe26f549f3176aad968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5677277da020b0451173f83029ecb96b70e6656592ad25cadd9bdfde4f6a122c9d51a3d30abbd569ca8defc301972bbb6c646e866bd656e031f6b0f71fb30149"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 05:44:44.198483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 05:44:44.198829) ========= 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.pP7nOCNfe9/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.p9KDzafm4a/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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.005102 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 05:44:44.247054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 05:44:44.247371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 05:44:44.247729) ========= ========= Total master_lag: 2.09 =========