builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0251 starttime: 1484392620.58 results: success (0) buildid: 20170114004003 builduid: 6344143440664c00aadb28ebcc6dc215 revision: be9be2c13b4dc9038b331a91f923a4658014bae4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.583074) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.583506) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.583779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.611352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.611921) ========= 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.nejoJTZXAT/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.dTdt2K88Ad/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-14 03:17:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.40M=0.001s 2017-01-14 03:17:00 (8.40 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153896 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.882967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:00.883280) ========= 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.nejoJTZXAT/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.dTdt2K88Ad/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.020298 ========= master_lag: 0.75 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:01.656880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-14 03:17:01.657188) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev be9be2c13b4dc9038b331a91f923a4658014bae4 --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 be9be2c13b4dc9038b331a91f923a4658014bae4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nejoJTZXAT/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.dTdt2K88Ad/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-14 03:17:01,744 truncating revision to first 12 chars 2017-01-14 03:17:01,744 Setting DEBUG logging. 2017-01-14 03:17:01,744 attempt 1/10 2017-01-14 03:17:01,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/be9be2c13b4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-14 03:17:02,368 unpacking tar archive at: mozilla-aurora-be9be2c13b4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889872 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-14 03:17:03.111694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:03.118134) ========= script_repo_revision: be9be2c13b4dc9038b331a91f923a4658014bae4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:03.118606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:03.118889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-14 03:17:03.153793) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-14 03:17:03.154190) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nejoJTZXAT/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.dTdt2K88Ad/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:03 INFO - MultiFileLogger online at 20170114 03:17:03 in /builds/slave/test 03:17:03 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 03:17:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:17:03 INFO - {'append_to_log': False, 03:17:03 INFO - 'base_work_dir': '/builds/slave/test', 03:17:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:17:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:17:03 INFO - 'branch': 'Mozilla-Aurora', 03:17:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:03 INFO - 'config_files': ('talos/mac_config.py',), 03:17:03 INFO - 'default_actions': ('clobber', 03:17:03 INFO - 'read-buildbot-config', 03:17:03 INFO - 'download-and-extract', 03:17:03 INFO - 'populate-webroot', 03:17:03 INFO - 'create-virtualenv', 03:17:03 INFO - 'install', 03:17:03 INFO - 'run-tests'), 03:17:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:03 INFO - 'download_minidump_stackwalk': True, 03:17:03 INFO - 'download_symbols': 'ondemand', 03:17:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:03 INFO - 'installer_path': 'installer.exe', 03:17:03 INFO - 'log_level': 'info', 03:17:03 INFO - 'log_name': 'talos', 03:17:03 INFO - 'log_to_console': True, 03:17:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:17:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:17:03 INFO - 'opt_config_files': (), 03:17:03 INFO - 'pip_index': False, 03:17:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:17:03 INFO - 'cmd': ('bash', 03:17:03 INFO - '-c', 03:17:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:17:03 INFO - 'enabled': True, 03:17:03 INFO - 'halt_on_failure': False, 03:17:03 INFO - 'name': 'check_screen_resolution'},), 03:17:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:17:03 INFO - 'cmd': ('bash', 03:17:03 INFO - '-c', 03:17:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:17:03 INFO - 'enabled': True, 03:17:03 INFO - 'halt_on_failure': False, 03:17:03 INFO - 'name': 'check_screen_resolution'},), 03:17:03 INFO - 'run_cmd_checks_enabled': True, 03:17:03 INFO - 'sps_profile': False, 03:17:03 INFO - 'sps_profile_interval': 0, 03:17:03 INFO - 'suite': 'dromaeojs', 03:17:03 INFO - 'system_bits': '32', 03:17:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:03 INFO - 'title': 't-yosemite-r7-0251', 03:17:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:03 INFO - 'use_talos_json': True, 03:17:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:17:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:03 INFO - 'work_dir': 'build'} 03:17:03 INFO - [mozharness: 2017-01-14 11:17:03.357982Z] Running clobber step. 03:17:03 INFO - Running pre-action listener: _resource_record_pre_action 03:17:03 INFO - Running main action method: clobber 03:17:03 INFO - rmtree: /builds/slave/test/build 03:17:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:17:04 INFO - Running post-action listener: _resource_record_post_action 03:17:04 INFO - [mozharness: 2017-01-14 11:17:04.889157Z] Finished clobber step (success) 03:17:04 INFO - [mozharness: 2017-01-14 11:17:04.889279Z] Running read-buildbot-config step. 03:17:04 INFO - Running pre-action listener: _resource_record_pre_action 03:17:04 INFO - Running main action method: read_buildbot_config 03:17:04 INFO - Using buildbot properties: 03:17:04 INFO - { 03:17:04 INFO - "project": "", 03:17:04 INFO - "product": "firefox", 03:17:04 INFO - "script_repo_revision": "production", 03:17:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:17:04 INFO - "repository": "", 03:17:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:17:04 INFO - "buildid": "20170114004003", 03:17:04 INFO - "stage_platform": "macosx64", 03:17:04 INFO - "basedir": "/builds/slave/test", 03:17:04 INFO - "nightly_build": "True", 03:17:04 INFO - "buildnumber": 22, 03:17:04 INFO - "slavename": "t-yosemite-r7-0251", 03:17:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:17:04 INFO - "platform": "yosemite_r7", 03:17:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:17:04 INFO - "branch": "mozilla-aurora", 03:17:04 INFO - "repo_path": "releases/mozilla-aurora", 03:17:04 INFO - "revision": "be9be2c13b4dc9038b331a91f923a4658014bae4", 03:17:04 INFO - "pgo_build": "False", 03:17:04 INFO - "builduid": "6344143440664c00aadb28ebcc6dc215", 03:17:04 INFO - "slavebuilddir": "test" 03:17:04 INFO - } 03:17:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:17:04 INFO - Running post-action listener: _resource_record_post_action 03:17:04 INFO - [mozharness: 2017-01-14 11:17:04.892692Z] Finished read-buildbot-config step (success) 03:17:04 INFO - [mozharness: 2017-01-14 11:17:04.892843Z] Running download-and-extract step. 03:17:04 INFO - Running pre-action listener: _resource_record_pre_action 03:17:04 INFO - Running main action method: download_and_extract 03:17:04 INFO - mkdir: /builds/slave/test/build/tests 03:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:04 INFO - trying https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:17:04 INFO - Downloading https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 03:17:06 INFO - Downloaded 1199 bytes. 03:17:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:17:06 INFO - Using the following test package requirements: 03:17:06 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:17:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:17:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:17:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'jsshell-mac.zip'], 03:17:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:17:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:17:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:17:06 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:17:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:17:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:17:06 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:17:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:17:06 INFO - Http code: 200 03:17:06 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 03:17:06 INFO - x-amz-cf-id: DGBbR-7CfZ9OEHSoxPdEileUvvJsVEk1WEifKZmH7esinuFNMiduhQ== 03:17:06 INFO - x-amz-version-id: cOHy_nn0EPgaGxXLPw5vOJ0_3AZtLSk6 03:17:07 INFO - Expected file size: 16275886 03:17:07 INFO - Obtained file size: 16275886 03:17:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:17:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:17:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:17:13 INFO - Fetch https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:17:14 INFO - Http code: 200 03:17:14 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 03:17:14 INFO - x-amz-cf-id: 3wWwuammoNB83h2UuAKcYp--DR185HL0h0b1DdArGIfZF05QuLI42A== 03:17:14 INFO - x-amz-version-id: cOHy_nn0EPgaGxXLPw5vOJ0_3AZtLSk6 03:17:14 INFO - Expected file size: 16275886 03:17:14 INFO - Obtained file size: 16275886 03:17:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:17:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:17:21 INFO - Fetch https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:17:21 INFO - Http code: 200 03:17:21 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 03:17:21 INFO - x-amz-cf-id: rzR6p-dIQIUgzCnC2g-QgQEG9p3PU2BcdT88xu9LTHzco6DD-IoszQ== 03:17:21 INFO - x-amz-version-id: bPmPDeUzEmhHrmBmrtRtnFvoJ7RiKlQT 03:17:22 INFO - Expected file size: 14409038 03:17:22 INFO - Obtained file size: 14409038 03:17: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')]} 03:17:22 INFO - trying https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:17:22 INFO - Downloading https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 03:17:25 INFO - Downloaded 110048835 bytes. 03:17:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:17:25 INFO - mkdir: /builds/slave/test/properties 03:17:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:25 INFO - Contents: 03:17:25 INFO - build_url:https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:17:26 INFO - Running post-action listener: _resource_record_post_action 03:17:26 INFO - Running post-action listener: set_extra_try_arguments 03:17:26 INFO - [mozharness: 2017-01-14 11:17:26.286550Z] Finished download-and-extract step (success) 03:17:26 INFO - [mozharness: 2017-01-14 11:17:26.286703Z] Running populate-webroot step. 03:17:26 INFO - Running pre-action listener: _resource_record_pre_action 03:17:26 INFO - Running main action method: populate_webroot 03:17:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:26 INFO - '--tppagecycles', 03:17:26 INFO - '7'], 03:17:26 INFO - 'tests': ['tsvgm']}}, 03:17:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:17:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:17:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['damp', 'tps']}, 03:17:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'tests': ['damp', 'tps']}, 03:17:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['dromaeo_dom']}, 03:17:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['basic_compositor_video']}, 03:17:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:17:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['a11yr', 03:17:26 INFO - 'ts_paint', 03:17:26 INFO - 'tpaint', 03:17:26 INFO - 'sessionrestore', 03:17:26 INFO - 'sessionrestore_no_auto_restore', 03:17:26 INFO - 'tabpaint']}, 03:17:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:17:26 INFO - 'ts_paint', 03:17:26 INFO - 'tpaint', 03:17:26 INFO - 'sessionrestore', 03:17:26 INFO - 'sessionrestore_no_auto_restore', 03:17:26 INFO - 'tabpaint']}, 03:17:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:17:26 INFO - 'ts_paint', 03:17:26 INFO - 'tpaint', 03:17:26 INFO - 'sessionrestore', 03:17:26 INFO - 'sessionrestore_no_auto_restore', 03:17:26 INFO - 'tabpaint']}, 03:17:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:17:26 INFO - 'ts_paint', 03:17:26 INFO - 'tpaint', 03:17:26 INFO - 'sessionrestore', 03:17:26 INFO - 'sessionrestore_no_auto_restore', 03:17:26 INFO - 'tabpaint']}, 03:17:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['a11yr', 03:17:26 INFO - 'ts_paint', 03:17:26 INFO - 'tpaint', 03:17:26 INFO - 'sessionrestore', 03:17:26 INFO - 'sessionrestore_no_auto_restore', 03:17:26 INFO - 'tabpaint']}, 03:17:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['a11yr', 03:17:26 INFO - 'ts_paint', 03:17:26 INFO - 'tpaint', 03:17:26 INFO - 'sessionrestore', 03:17:26 INFO - 'sessionrestore_no_auto_restore', 03:17:26 INFO - 'tabpaint']}, 03:17:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['tsvgx', 03:17:26 INFO - 'tsvgr_opacity', 03:17:26 INFO - 'tart', 03:17:26 INFO - 'tscrollx', 03:17:26 INFO - 'cart']}, 03:17:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:17:26 INFO - 'tsvgr_opacity', 03:17:26 INFO - 'tart', 03:17:26 INFO - 'tscrollx', 03:17:26 INFO - 'cart']}, 03:17:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'talos_options': ['--disable-e10s'], 03:17:26 INFO - 'tests': ['tp5o']}, 03:17:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'tests': ['tp5o']}, 03:17:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'talos_options': ['--disable-e10s', 03:17:26 INFO - '--xperf_path', 03:17:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:26 INFO - 'tests': ['tp5n']}, 03:17:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:26 INFO - 'talos_options': ['--xperf_path', 03:17:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:26 INFO - 'tests': ['tp5n']}}, 03:17:26 INFO - 'talos.zip': {'path': '', 03:17:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:26 INFO - Running post-action listener: _resource_record_post_action 03:17:26 INFO - [mozharness: 2017-01-14 11:17:26.305707Z] Finished populate-webroot step (success) 03:17:26 INFO - [mozharness: 2017-01-14 11:17:26.305826Z] Running create-virtualenv step. 03:17:26 INFO - Running pre-action listener: _resource_record_pre_action 03:17:26 INFO - Running main action method: create_virtualenv 03:17:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:26 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 03:17:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:26 INFO - Using real prefix '/tools/python27' 03:17:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:30 INFO - Installing pip.................done. 03:17:30 INFO - Return code: 0 03:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:17:30 INFO - Reading from file tmpfile_stdout 03:17:30 INFO - Output received: 03:17:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:17:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17:30 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')]} 03:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:30 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')]} 03:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:30 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 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:30 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 03:17:30 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 03:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:30 INFO - 'HOME': '/Users/cltbld', 03:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:30 INFO - 'LOGNAME': 'cltbld', 03:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:30 INFO - 'MOZ_NO_REMOTE': '1', 03:17:30 INFO - 'NO_EM_RESTART': '1', 03:17:30 INFO - 'PAGER': '/bin/cat', 03:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:30 INFO - 'PWD': '/builds/slave/test', 03:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:30 INFO - 'SHELL': '/bin/bash', 03:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:30 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:30 INFO - 'USER': 'cltbld', 03:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:30 INFO - 'XPC_FLAGS': '0x0', 03:17:30 INFO - 'XPC_SERVICE_NAME': '0', 03:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:30 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 03:17:30 INFO - Cleaning up... 03:17:30 INFO - Return code: 0 03:17:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:17:30 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')]} 03:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:30 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')]} 03:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:30 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 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:30 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 03:17:30 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 03:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:30 INFO - 'HOME': '/Users/cltbld', 03:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:30 INFO - 'LOGNAME': 'cltbld', 03:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:30 INFO - 'MOZ_NO_REMOTE': '1', 03:17:30 INFO - 'NO_EM_RESTART': '1', 03:17:30 INFO - 'PAGER': '/bin/cat', 03:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:30 INFO - 'PWD': '/builds/slave/test', 03:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:30 INFO - 'SHELL': '/bin/bash', 03:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:30 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:30 INFO - 'USER': 'cltbld', 03:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:30 INFO - 'XPC_FLAGS': '0x0', 03:17:30 INFO - 'XPC_SERVICE_NAME': '0', 03:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:30 INFO - Downloading/unpacking psutil>=3.1.1 03:17:30 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 03:17:30 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 03:17:30 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 03:17:30 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 03:17:30 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 03:17:30 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 03:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:35 INFO - Installing collected packages: psutil 03:17:35 INFO - Running setup.py install for psutil 03:17:35 INFO - building 'psutil._psutil_osx' extension 03:17:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:17:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:17:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:17:35 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 03:17:35 INFO - building 'psutil._psutil_posix' extension 03:17:35 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 03:17:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:17:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:17:35 INFO - ^ 03:17:35 INFO - 1 warning generated. 03:17:35 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 03:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:35 INFO - Successfully installed psutil 03:17:35 INFO - Cleaning up... 03:17:36 INFO - Return code: 0 03:17:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:36 INFO - 'HOME': '/Users/cltbld', 03:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:36 INFO - 'LOGNAME': 'cltbld', 03:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:36 INFO - 'MOZ_NO_REMOTE': '1', 03:17:36 INFO - 'NO_EM_RESTART': '1', 03:17:36 INFO - 'PAGER': '/bin/cat', 03:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:36 INFO - 'PWD': '/builds/slave/test', 03:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:36 INFO - 'SHELL': '/bin/bash', 03:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:36 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:36 INFO - 'USER': 'cltbld', 03:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:36 INFO - 'XPC_FLAGS': '0x0', 03:17:36 INFO - 'XPC_SERVICE_NAME': '0', 03:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:36 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 03:17:36 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 03:17:36 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 03:17:36 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 03:17:36 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 03:17:36 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 03:17:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:39 INFO - Installing collected packages: mozsystemmonitor 03:17:39 INFO - Running setup.py install for mozsystemmonitor 03:17:39 INFO - Successfully installed mozsystemmonitor 03:17:39 INFO - Cleaning up... 03:17:39 INFO - Return code: 0 03:17:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:39 INFO - 'HOME': '/Users/cltbld', 03:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:39 INFO - 'LOGNAME': 'cltbld', 03:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:39 INFO - 'MOZ_NO_REMOTE': '1', 03:17:39 INFO - 'NO_EM_RESTART': '1', 03:17:39 INFO - 'PAGER': '/bin/cat', 03:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:39 INFO - 'PWD': '/builds/slave/test', 03:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:39 INFO - 'SHELL': '/bin/bash', 03:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:39 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:39 INFO - 'USER': 'cltbld', 03:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:39 INFO - 'XPC_FLAGS': '0x0', 03:17:39 INFO - 'XPC_SERVICE_NAME': '0', 03:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:42 INFO - warning: no files found matching '*.txt' 03:17:42 INFO - no previously-included directories found matching 'build' 03:17:42 INFO - no previously-included directories found matching 'dist' 03:17:42 INFO - no previously-included directories found matching '.git*' 03:17:42 INFO - Installing collected packages: jsonschema, functools32 03:17:42 INFO - Running setup.py install for functools32 03:17:42 INFO - warning: no files found matching '*.txt' 03:17:42 INFO - no previously-included directories found matching 'build' 03:17:42 INFO - no previously-included directories found matching 'dist' 03:17:42 INFO - no previously-included directories found matching '.git*' 03:17:42 INFO - Successfully installed jsonschema functools32 03:17:42 INFO - Cleaning up... 03:17:42 INFO - Return code: 0 03:17:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:42 INFO - 'HOME': '/Users/cltbld', 03:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:42 INFO - 'LOGNAME': 'cltbld', 03:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:42 INFO - 'MOZ_NO_REMOTE': '1', 03:17:42 INFO - 'NO_EM_RESTART': '1', 03:17:42 INFO - 'PAGER': '/bin/cat', 03:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:42 INFO - 'PWD': '/builds/slave/test', 03:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:42 INFO - 'SHELL': '/bin/bash', 03:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:42 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:42 INFO - 'USER': 'cltbld', 03:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:42 INFO - 'XPC_FLAGS': '0x0', 03:17:42 INFO - 'XPC_SERVICE_NAME': '0', 03:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:17:43 INFO - Cleaning up... 03:17:43 INFO - Return code: 0 03:17:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:43 INFO - 'HOME': '/Users/cltbld', 03:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:43 INFO - 'LOGNAME': 'cltbld', 03:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:43 INFO - 'MOZ_NO_REMOTE': '1', 03:17:43 INFO - 'NO_EM_RESTART': '1', 03:17:43 INFO - 'PAGER': '/bin/cat', 03:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:43 INFO - 'PWD': '/builds/slave/test', 03:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:43 INFO - 'SHELL': '/bin/bash', 03:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:43 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:43 INFO - 'USER': 'cltbld', 03:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:43 INFO - 'XPC_FLAGS': '0x0', 03:17:43 INFO - 'XPC_SERVICE_NAME': '0', 03:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:47 INFO - Downloading docopt-0.6.1.tar.gz 03:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:47 INFO - Running setup.py install for blobuploader 03:17:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:47 INFO - Running setup.py install for requests 03:17:48 INFO - Running setup.py install for docopt 03:17:48 INFO - Successfully installed blobuploader requests docopt 03:17:48 INFO - Cleaning up... 03:17:48 INFO - Return code: 0 03:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:48 INFO - 'HOME': '/Users/cltbld', 03:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:48 INFO - 'LOGNAME': 'cltbld', 03:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:48 INFO - 'MOZ_NO_REMOTE': '1', 03:17:48 INFO - 'NO_EM_RESTART': '1', 03:17:48 INFO - 'PAGER': '/bin/cat', 03:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:48 INFO - 'PWD': '/builds/slave/test', 03:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:48 INFO - 'SHELL': '/bin/bash', 03:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:48 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:48 INFO - 'USER': 'cltbld', 03:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:48 INFO - 'XPC_FLAGS': '0x0', 03:17:48 INFO - 'XPC_SERVICE_NAME': '0', 03:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:48 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-tNVgMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:48 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Bmg8qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:48 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-rZi8GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:48 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-RmPFYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-h0RkuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-1NU_Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-4xODTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-AMWaLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-RSCqB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-QL4a1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-SpPbKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-FeEyir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-922TGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:49 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-s7Qx1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:50 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-mbA3_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:50 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-r_lXxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:50 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-VdcUCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:50 INFO - Running setup.py install for manifestparser 03:17:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:50 INFO - Running setup.py install for mozcrash 03:17:50 INFO - Running setup.py install for mozdebug 03:17:50 INFO - Running setup.py install for mozdevice 03:17:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:17:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:50 INFO - Running setup.py install for mozfile 03:17:51 INFO - Running setup.py install for mozhttpd 03:17:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Running setup.py install for mozinfo 03:17:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Running setup.py install for mozInstall 03:17:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Running setup.py install for mozleak 03:17:51 INFO - Running setup.py install for mozlog 03:17:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Running setup.py install for moznetwork 03:17:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:51 INFO - Running setup.py install for mozprocess 03:17:52 INFO - Running setup.py install for mozprofile 03:17:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozrunner 03:17:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozscreenshot 03:17:52 INFO - Running setup.py install for moztest 03:17:52 INFO - Running setup.py install for mozversion 03:17:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:52 INFO - Cleaning up... 03:17:52 INFO - Return code: 0 03:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:52 INFO - 'HOME': '/Users/cltbld', 03:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:52 INFO - 'LOGNAME': 'cltbld', 03:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:52 INFO - 'MOZ_NO_REMOTE': '1', 03:17:52 INFO - 'NO_EM_RESTART': '1', 03:17:52 INFO - 'PAGER': '/bin/cat', 03:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:52 INFO - 'PWD': '/builds/slave/test', 03:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:52 INFO - 'SHELL': '/bin/bash', 03:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:52 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:52 INFO - 'USER': 'cltbld', 03:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:52 INFO - 'XPC_FLAGS': '0x0', 03:17:52 INFO - 'XPC_SERVICE_NAME': '0', 03:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-D1zVYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-pzrfuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-gYoHow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-qCf574-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-g7urpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-UtSfnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-_G01Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:53 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)) 03:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:53 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-yEKXpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-C2GsnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-RqAIIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-j7Zm_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-FU40oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-JxXa8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-w287GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-GMbTLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-_6JfIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:54 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-b4xCs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:57 INFO - Downloading blessings-1.6.tar.gz 03:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:57 INFO - Installing collected packages: blessings 03:17:57 INFO - Running setup.py install for blessings 03:17:57 INFO - Successfully installed blessings 03:17:57 INFO - Cleaning up... 03:17:58 INFO - Return code: 0 03:17:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:58 INFO - Reading from file tmpfile_stdout 03:17:58 INFO - Current package versions: 03:17:58 INFO - blessings == 1.6 03:17:58 INFO - blobuploader == 1.2.4 03:17:58 INFO - docopt == 0.6.1 03:17:58 INFO - functools32 == 3.2.3-2 03:17:58 INFO - jsonschema == 2.5.1 03:17:58 INFO - manifestparser == 1.1 03:17:58 INFO - mozInstall == 1.12 03:17:58 INFO - mozcrash == 1.0 03:17:58 INFO - mozdebug == 0.1 03:17:58 INFO - mozdevice == 0.48 03:17:58 INFO - mozfile == 1.2 03:17:58 INFO - mozhttpd == 0.7 03:17:58 INFO - mozinfo == 0.9 03:17:58 INFO - mozleak == 0.1 03:17:58 INFO - mozlog == 3.4 03:17:58 INFO - moznetwork == 0.27 03:17:58 INFO - mozprocess == 0.23 03:17:58 INFO - mozprofile == 0.28 03:17:58 INFO - mozrunner == 6.13 03:17:58 INFO - mozscreenshot == 0.1 03:17:58 INFO - mozsystemmonitor == 0.3 03:17:58 INFO - moztest == 0.8 03:17:58 INFO - mozversion == 1.4 03:17:58 INFO - psutil == 3.1.1 03:17:58 INFO - requests == 1.2.3 03:17:58 INFO - wsgiref == 0.1.2 03:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:58 INFO - 'HOME': '/Users/cltbld', 03:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:58 INFO - 'LOGNAME': 'cltbld', 03:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:58 INFO - 'MOZ_NO_REMOTE': '1', 03:17:58 INFO - 'NO_EM_RESTART': '1', 03:17:58 INFO - 'PAGER': '/bin/cat', 03:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:58 INFO - 'PWD': '/builds/slave/test', 03:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:58 INFO - 'SHELL': '/bin/bash', 03:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:58 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:58 INFO - 'USER': 'cltbld', 03:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:58 INFO - 'XPC_FLAGS': '0x0', 03:17:58 INFO - 'XPC_SERVICE_NAME': '0', 03:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:17:58 INFO - Cleaning up... 03:17:58 INFO - Return code: 0 03:17:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe019ccd700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, '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.nejoJTZXAT/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.dTdt2K88Ad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 03:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:58 INFO - 'HOME': '/Users/cltbld', 03:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:58 INFO - 'LOGNAME': 'cltbld', 03:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:58 INFO - 'MOZ_NO_REMOTE': '1', 03:17:58 INFO - 'NO_EM_RESTART': '1', 03:17:58 INFO - 'PAGER': '/bin/cat', 03:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:58 INFO - 'PWD': '/builds/slave/test', 03:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:58 INFO - 'SHELL': '/bin/bash', 03:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:17:58 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:58 INFO - 'USER': 'cltbld', 03:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:58 INFO - 'XPC_FLAGS': '0x0', 03:17:58 INFO - 'XPC_SERVICE_NAME': '0', 03:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:58 INFO - Cleaning up... 03:17:58 INFO - Return code: 0 03:17:58 INFO - Running post-action listener: _resource_record_post_action 03:17:58 INFO - Running post-action listener: _start_resource_monitoring 03:17:58 INFO - Starting resource monitoring. 03:17:58 INFO - [mozharness: 2017-01-14 11:17:58.851040Z] Finished create-virtualenv step (success) 03:17:58 INFO - [mozharness: 2017-01-14 11:17:58.852002Z] Running install step. 03:17:58 INFO - Running pre-action listener: _resource_record_pre_action 03:17:58 INFO - Running main action method: install 03:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:59 INFO - Reading from file tmpfile_stdout 03:17:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:59 INFO - Reading from file tmpfile_stdout 03:17:59 INFO - Output received: 03:17:59 INFO - Usage: mozinstall [options] installer 03:17:59 INFO - Options: 03:17:59 INFO - -h, --help show this help message and exit 03:17:59 INFO - -d DEST, --destination=DEST 03:17:59 INFO - Directory to install application into. [default: 03:17:59 INFO - "/builds/slave/test"] 03:17:59 INFO - --app=APP Application being installed. [default: firefox] 03:17:59 INFO - mkdir: /builds/slave/test/build/application 03:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:18:30 INFO - Reading from file tmpfile_stdout 03:18:30 INFO - Output received: 03:18:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:18:30 INFO - Running post-action listener: _resource_record_post_action 03:18:30 INFO - [mozharness: 2017-01-14 11:18:30.482018Z] Finished install step (success) 03:18:30 INFO - [mozharness: 2017-01-14 11:18:30.482182Z] Running run-tests step. 03:18:30 INFO - Running pre-action listener: _resource_record_pre_action 03:18:30 INFO - Running main action method: run_tests 03:18:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:18:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:18:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:18:30 INFO - 2017-01-14 03:18:30.496 screenresolution[1923:17778] starting screenresolution argv=screenresolution get 03:18:30 INFO - 2017-01-14 03:18:30.499 screenresolution[1923:17778] Display 0: 1600x1200x32@60 03:18:30 INFO - 2017-01-14 03:18:30.505 screenresolution[1924:17780] starting screenresolution argv=screenresolution list 03:18:30 INFO - Available Modes on Display 0 03:18:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:18:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:18:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:18:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:18:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:18:30 INFO - Intel Iris: 03:18:30 INFO - Chipset Model: Intel Iris 03:18:30 INFO - Type: GPU 03:18:30 INFO - Bus: Built-In 03:18:30 INFO - VRAM (Dynamic, Max): 1536 MB 03:18:30 INFO - Vendor: Intel (0x8086) 03:18:30 INFO - Device ID: 0x0a2e 03:18:30 INFO - Revision ID: 0x0009 03:18:30 INFO - Displays: 03:18:30 INFO - Display: 03:18:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:18:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:18:30 INFO - Display Serial Number: 1600x1200 60 03:18:30 INFO - Main Display: Yes 03:18:30 INFO - Mirror: Off 03:18:30 INFO - Online: Yes 03:18:30 INFO - Rotation: Supported 03:18:30 INFO - Return code: 0 03:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:30 INFO - Python 2.7.3 03:18:30 INFO - Return code: 0 03:18:30 INFO - grabbing minidump binary from tooltool 03:18:30 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')]} 03:18:30 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 0x107c31d30>, '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 0x107a97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c29b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:30 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 03:18:30 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 03:18:30 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 03:18:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:30 INFO - Return code: 0 03:18:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:18:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:18:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:30 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/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 03:18:30 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/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0251 --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 03:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nejoJTZXAT/Render', 03:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:18:30 INFO - 'HOME': '/Users/cltbld', 03:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:18:30 INFO - 'LOGNAME': 'cltbld', 03:18:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:30 INFO - 'MOZ_NO_REMOTE': '1', 03:18:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:30 INFO - 'NO_EM_RESTART': '1', 03:18:30 INFO - 'PAGER': '/bin/cat', 03:18:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:30 INFO - 'PWD': '/builds/slave/test', 03:18:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:18:30 INFO - 'SHELL': '/bin/bash', 03:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dTdt2K88Ad/Listeners', 03:18:30 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 03:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:18:30 INFO - 'USER': 'cltbld', 03:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:30 INFO - 'XPC_FLAGS': '0x0', 03:18:30 INFO - 'XPC_SERVICE_NAME': '0', 03:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:18:30 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/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 03:18:31 INFO - mozversion application_buildid: 20170114004003 03:18:31 INFO - mozversion application_changeset: be9be2c13b4dc9038b331a91f923a4658014bae4 03:18:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:18:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:31 INFO - mozversion application_name: Firefox 03:18:31 INFO - mozversion application_remotingname: firefox-dev 03:18:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:31 INFO - mozversion application_vendor: Mozilla 03:18:31 INFO - mozversion application_version: 52.0a2 03:18:31 INFO - mozversion platform_buildid: 20170114004003 03:18:31 INFO - mozversion platform_changeset: be9be2c13b4dc9038b331a91f923a4658014bae4 03:18:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:31 INFO - mozversion platform_version: 52.0a2 03:18:31 INFO - using testdate: 1484392711 03:18:31 INFO - actual date: 1484392711 03:18:31 INFO - starting webserver on 'localhost:52269' 03:18:31 INFO - SUITE-START | Running 2 tests 03:18:31 INFO - TEST-START | dromaeo_css 03:18:31 INFO - operating with platform_type : mac_ 03:18:31 INFO - Initialising browser for dromaeo_css test... 03:18:31 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpVP1QOo/profile http://localhost:52269/getInfo.html) 03:18:33 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 03:18:33 INFO - PROCESS | 1934 | colorDepth:24 03:18:33 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 03:18:33 INFO - PROCESS | 1934 | __metrics 03:18:34 INFO - PROCESS | 1934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:18:34 INFO - PROCESS | 1934 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:18:35 INFO - TEST-INFO | 1934: exit 0 03:18:35 INFO - Browser initialized. 03:18:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:35 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpVP1QOo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:47 INFO - PROCESS | 1937 | RSS: Main: 222121984 03:18:47 INFO - PROCESS | 1937 | 03:21:51 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52269/tests/dromaeo/cssquery-ext.html) 03:21:53 INFO - PROCESS | 1937 | RSS: Main: 366784512 03:21:53 INFO - PROCESS | 1937 | 03:24:56 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52269/tests/dromaeo/cssquery-ext.html (next: http://localhost:52269/tests/dromaeo/cssquery-jquery.html) 03:24:57 INFO - PROCESS | 1937 | RSS: Main: 350494720 03:24:57 INFO - PROCESS | 1937 | 03:27:59 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52269/tests/dromaeo/cssquery-mootools.html) 03:28:00 INFO - PROCESS | 1937 | RSS: Main: 308424704 03:28:00 INFO - PROCESS | 1937 | 03:31:02 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52269/tests/dromaeo/cssquery-prototype.html) 03:31:03 INFO - PROCESS | 1937 | RSS: Main: 336826368 03:31:03 INFO - PROCESS | 1937 | 03:34:06 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52269/tests/dromaeo/cssquery-yui.html) 03:34:07 INFO - PROCESS | 1937 | RSS: Main: 303730688 03:34:07 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52269/tests/dromaeo/cssquery-yui.html (next: http://localhost:52269/tests/dromaeo/cssquery-dojo.html) 03:37:10 INFO - PROCESS | 1937 | RSS: Main: 418672640 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | __start_tp_report 03:37:10 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 03:37:10 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 03:37:10 INFO - PROCESS | 1937 | |i|pagename|runs| 03:37:10 INFO - PROCESS | 1937 | |0;dojo.html;3336.783109097909;3338.5159151922962;3338.9666103338946;3349.8660053597855;3399.1672040350104;5666;5738.3974682658345;5751.971240143804;5760.107183386576;5777.884442311157;5481.369642491115;5528.44715528447;5540.833774986757;5550.972245138779;5583.748731307091;5009.499050094989;5041.243813427978;5050.3434553508;5077.314562534066;5090.618203634724;5137.101007323722;5167.3282473278605;5187.533122019017;5190.2474141249495;5190.858011237522;5241.816536421226;5252.763625636836;5269;5292.973535132319;5298.311219541473;4417.536158703354;5275.868103297429;5305;5318.202269659543;5340.145576707747;5187.481251874782;5264.184051472028;5290.259363689087;5302.231176479428;5336.332958380202;5647.830565083054;5663.716814159276;5689.7439615217;5706.172604972256;5706.3152421709665;6201.131841542187;6243.812685619393;6251.812445626639;6275.8744825103695;6306.1486699295465;6342.016987366966;6344.873102537924;6350.333215012403;6361.681915904186;6365.458935990447;5716.256886604798;5743.1385292206505;5789.594728368974;5823.359430462646;5855.151003104526;6264.812055638338;6288.465480434214;6292.811215663537;6320.71556779946;6334.588251763621;6188.257409110845;6188.845278868064;6191.690415479298;6211.9689401552705;6224.626522408579;6121.554446470009;6124.177795495351;6181.629102253879;6292.244930608356;6318.178636777189;6158.7228574714245;6162.414570615784;6164.229471316085;6201.286852011986;6233.96883015582;6254.562180647402;6280.497560195265;6298.905516417258;6310.558260921692;6315.778947736899;4253.80857861397;4927.655064145475;4970.726610036482;4982.252662100642;4983.90032199354;4387.429634147604;4409.33859921008;4416.24923762961;4427.712198707074;4483.798229079634;5793.073108302651;5797.739101740432;5830.8542286442325;5832;5844.327902291206;6156.384361563808;6159.969200153971;6165.660888651078;6249.0938813871735;6305.306416294204;5541.445855414507;5596.804111856066;5761.222234998221;5770.105633626795;5825.854353641108;5298.125809241432;5393.110136827458;5432.076546987022;5446;5474.233607294982;6293.937060629335;6331.9050214247745;6340.49276057905;6348.079528468346;6354.142190804182;4861.7326047066335;6296.905546416716;6302.621842689453;6331.9050214247745;6331.96834015827;6204.3795620437595;6225.657588832658;6252.1559589456665;6269.749210031548;6341.175647165839;6256.092866534418;6258.468030217483;6265.467435268053;6276.372362763687;6281.623102613858;6143.631382117087;6344.984802431589;6354.205724284465;6361.395667411589;6362.045693146065;5118.283440318284;5995.850103747442;6032.336442991355;6063.605865618721;6130.601510901777;6058.242719660043;6111.04482360895;6118.510519158545;6119.724612392542;6129.570930034854;5903.173555702119;5914.526837852875;5916.378780228186;5920.4671579556325;5927.288725352985;5983.700814959322;6080.331163572092;6103.42017508336;6123.632582045091;6142.3550527194;5913.201717768046;5992.910106348321;6025.427584379477;6043.244594425697;6049 03:37:10 INFO - PROCESS | 1937 | |1;ext.html;450.5877122432974;494.636442214972;503.8488453463961;506.59978616892636;531.1156923722003;25238.621420678704;30555.38889222217;30557;30560.84719576399;30562.694373056263;40048.599514004854;41260.79369603156;41375.75872723816;42647;42803.35794963078;8739.825203495942;9481.146696797286;9492.620295188184;9497.050294970482;9508.001659825723;9344.299177561676;9445.716628501155;9457.148856602904;9457.621695132186;9460.668876589321;9436.056394360578;9482.288828337867;9506.904930950706;9510.429374237534;9577.904220957806;8430.831383372359;9374.484403357812;9431.386959847589;9451.66919157833;9471.147596716293;9424.670136545188;9491;9503.714888553355;9506;9549.28380371468;39127.41308880369;39407;39488;39527.20945581072;39683.61107361257;3026.546018097281;3174.0953828159095;3240.4005259027153;3589.766665166756;3828.502294701671;28768.424631507463;29313.85343073271;29904.70095299041;30028;30752.53871191934;3073.078076577018;3140.136462472838;3149.0395429394025;3153.3693261347594;3167.2081979505124;458870;463387;463839;464140;472821.63589182176;32991.340173196404;33947.66052339445;33972;59605;60258.39741602616;34534.13664658403;34826.9551913443;34863;34886.476702849475;35001.29997400038;14117.576472705836;14274.500392486421;14280.928595357165;14297.85702142986;14308.928455357656;11933.582324618597;12048.698782530508;12052.879471205175;12053.63839084829;12085.093617978511;7667;7676.6161691916295;7756.883646745303;7763.107242667053;7783.182765809622;3147.512135618983;3189.7607679424136;3195.201199700075;3196.4246435641344;3220.2754380264255;756.9659365328573;862.1421685423044;952.3857112162616;1008.2891561449161;1103.5475455063386;27817;28386.574201386997;29105.981290654727;29135;29264.26839329034;798.2456578533346;942.4957647658607;1016.5730393234859;1025.3232866308201;1143.7655280667443;12105.697357565956;14318.642033949234;14749.705005900036;14758.40966361355;15285.235738213045;624041;633575;634110;635587;635664;54579;55095;55108.72445637746;55127;55212.72393638006;1193.6419074277856;1230;1293.224065560656;1322.8478724946563;1325.1320385147744;29113.27216819512;29652.55521167141;29702.554461683525;29858;30402.543961840147;47039.76480117578;47362.52637473719;47387.52612473969;47476.28785568288;47515;490209;490789;491938;492765;721298;34423.623055077514;38352.041198969135;40071.79964100278;40290.79854600826;40465;35762.463563047095;43715;43907.68276951696;44142.33786493269;45199.77400112979;36243.81878090592;36642;36723.44914826226;37181.81409093046;38250.42624360581;32216.67783322137;34827.30345393129;36957.26085478329;37025.444618330206;37857.2428551433;34067;35166;36737.632623673424;36998.6300137006;37136.6286337144;30432.695673042985;34178.65821341755;34266;34307.79922702693;34308;18400.631987360444;23938.28185154448;24880.50238995246;25413.110541130973;25550.488990220463 03:37:10 INFO - PROCESS | 1937 | |2;jquery.html;320.6729136280993;351.050408644616;375.8008255624519;380.30404360021146;404.82187837351563;14555.490557830479;14976.625584360383;15681.843181568182;19937.501562460908;20353.38939831804;19640.901795491038;19702.802971970275;19870.90064549679;20179.39461816144;20436.386908392735;5701.372848986608;5956.612820166675;5963.642181469126;5969.432903874125;5971.970140149293;4830.299606557047;5859.267591551056;5919.1713160157615;5924.318703349106;5926.992411290091;5613.66318020918;5775.075987841946;5873.500752436048;5877.9412205877825;5883.558733095014;5745.368009518949;5834.4165583441745;5856.7071646417935;5857.619254748428;5868.677222752747;4896.877578060577;5098.184290513537;5124.077666020152;5129.435762066169;5131.307273518065;23642.17252396175;24257.87871060651;24556.508869822683;24672.629910551357;24933.376665583324;2240.9663855042186;2302.102180149743;2397.280815755284;2624.475104979012;2668.559687651535;13871.514496992557;13914;14118.294085295694;14736.484223052248;15083.321250543751;1790.588164722108;1813.5647444613198;1831.249969083442;1880.097553174484;1893.3941138835578;76242;113157;115953.99999999916;123148.38425807813;127159;8936.24041956428;9512.619495220251;9720.708378748648;9878.506074696237;9987.60049598008;12407.503699852085;12526.436310366056;12538.561150359694;12545.184563003375;12551.748965020648;7635.847283054308;7833.882491762628;7874.803129921798;7904.4071694623135;7995.2804247618;8105.067917189481;8145.918540814635;8172.550509722022;8275.462094963808;8305.875411868827;3827.655511003967;3828.9617103829164;3829.7319187657154;3903.434002069684;3928.2339943710704;1451.5355086372472;1665.9421267495227;1815.3555487801905;1904.5809921817179;1918.0793219254836;710.9016569400289;800.8118092248317;859.6862145316915;926.1386910173603;930.1070971867083;15521.767173492406;20259.493512662302;20550.28074017402;20677.79322206789;20751.169953202007;850.5747126436781;899.8335307968047;899.9730008099767;926.9073092690812;998.0418797954045;10511.474426278655;10662.733431664115;10747.462626868626;10830.566777328977;10832.40421776794;534372;553526;566187;577469;579875;122840;127828;127834;130505.34747326202;130915;720.9891851622125;927.5455027036838;928.7399528132133;947.554649314821;948.5257371314343;13441;17312.826871731624;18429.53926151857;18691.439256822316;19051.523711906757;49023;50566.74716626394;51455;52937.67655808636;53368;71808.64095679489;72476;75303.87044194451;76939.2306076932;77071.45857082939;5328.440513746001;6467.547271690936;7711.650461169161;7820.960895195488;8098.230668086522;11940.880591193976;12024.939875300568;12043.578474753342;12396.690082748004;12468.812967805672;10290.279680422298;10504.53604965782;10729.302595331279;10794.73013174677;10863.293885897392;9123.315751318545;10232.948835255776;10567.471626418803;10591.629292974709;10696.62561810364;10682.83975740349;10687.51906164209;10761.139108871428;10843.403612801372;11189.944050279697;6813.1142951415995;7232.42140628759;7233.493655444068;7357.852842943218;7933.484323518953;8882.555872206234;9353.643721660457;9846;10644.574217031231;10958.068564172134 03:37:10 INFO - PROCESS | 1937 | |3;mootools.html;1283.4545318239748;1458.161557104665;1591.4032237910783;1796.712525995841;1831.3498707958665;8091.919080809197;8350.373721970855;8362.289205417539;8470.788230294245;8510;7433.108027036763;7666;7685.423593230502;8036.27673509384;8300.335973122152;2277.544491101782;2321.897098878028;2323.1520495019367;2324.1516846351046;2330.2776139396756;2241.887905604713;2304.68886700295;2352.9764702353013;2353.4587044979667;2356.905723771047;2255.154317131076;2270.8751018693965;2299.8160147188187;2324.6861673674093;2328.0222306631254;2230.3309007297826;2259.0399080390766;2262.4457008033137;2266.410733209361;2266.4220623741007;2237.966430503544;2259.175400978631;2265.6714776357335;2266;2267.557826223887;8231;8431.40980131391;8432.873506897402;8435.620397082146;8439.409241353107;5048.192289233705;5184.326037615086;5234.738263086831;5239.842804715865;5244.475552444725;3238.77328586999;3249.951250731241;3356.077078803324;3397.7621566490357;3403.2002479417315;1023.1303392116715;1050.4012712753733;1070.6948519671935;1072.8766191887876;1073.5222825842504;10658.520366583445;10999.835002474969;11001.559937602486;11052.005319521202;11057.944710276397;4256.851010214627;4373.518912919576;4450.488193857683;4467.821287148543;4489.932651010237;8647.870281945776;8651.221390074923;8656.52389118592;8658.610362533702;8702.086280940537;5079.4412614612365;5079.720615366116;5089.923651145235;5102.566281866083;5110.897782044338;4203.159368126326;4375.8030888609455;4702.6473014524045;4769.546893045155;4785.49752276013;3568.964310356915;3573.26748016656;3638.7089032877307;3666.6699997000396;3668.0829792551863;1099.1756182862853;1104.828751543512;1110.2616759854768;1112.6439539347493;1122.0294445304917;749.3068911257066;857.6183598298697;899.1143723432414;917.1699611851285;927.1979737526991;5528.723563821793;5563.13771365439;5570.693611851387;5792.8476873726395;5907.645541267538;875.1336177184669;916.706653870755;925.1488630459993;932.0845662164318;986.5116767200138;3395.898123056312;3670.596234414212;3747.831347589365;3819.2743378757946;3878.5733569307354;9779.559919803625;10130.442825644514;10267.94866025665;10269.537870795682;10294.17646588271;10200.489975501196;10203.795924081476;10218.693439196835;10228.590856365661;10235.181185505142;7565.167831538526;7811.336036436966;7867.921320786719;7931.881021784678;7960.363170946311;5434.64674796137;5579.4978451937895;5692.402297758841;5694.572907031907;5707.600467967202;9207.677731279373;9330.346875718635;9455;9540.618375264912;9551.044895510393;9452.43285402878;9578;9660.17888479459;9661.661841835783;9771.755706107404;6256.217972753406;6409.839754006187;6490.513211509061;6681.465482761465;6834.624095674786;7705.653245604073;7811.062672479339;7855.978722766004;7874.488158269924;7879;6955.547889387173;7014.754483593049;7055.611941343275;7058.153021637437;7186.928130718626;5842.503387212135;6917.757878474229;6934.133233345832;6962.686679099554;6987.6855541499735;6429.067785171217;6534.967325163534;6539.313372096051;6648.268690444144;6670.699818508082;4772.782940350188;4800.95199048019;4827.131116398941;4854.5873600744335;4882.2432522959;4533.523979982187;4598.758335249397;4766.499517550607;4775.570198681996;4930.137225985366 03:37:10 INFO - PROCESS | 1937 | |4;prototype.html;252.80533988828603;307.1491967250717;310.8958498902867;315.6811620263533;319.89603378901865;4385.451818522684;4752.382190315258;5318.946810531894;5397.892042159155;5434.755436005379;4194.349875769253;4277.700560960734;5000.0999820032375;5162.457941916101;5300.628955973083;4062.837486500536;4088.3458646616546;4094.4472496213075;4097.201045796071;4115.415565007464;3434.605020422646;3634.436662317345;4029.6171863672903;4094.34490481523;4107.549658287038;3601.333753255656;3941.4481972523868;4053.6757059435176;4056.9797151014204;4088.8568900088503;3732.9813350933073;3890.7081968852167;3902.161035377393;3999.820187903648;4037.596240375968;2831.348789778342;2887.6534815822024;3569.214772749991;3572.696320812734;3573.94639080414;4292.789213555022;4931.901361972777;5221.556167725748;5230.947690523084;5236.581073514109;4036.8898552897895;4625.259958406638;4635.46692130406;4639.840039990003;4657.278121891112;5517.200005999108;5586.804461843856;5597.720113994284;5598.412166722476;5661.753684736447;3729.272791805599;3922.8430862765454;3927.8428862845453;3929.98035009826;3947.743396679207;5075.796968121271;5490.835274941758;5837;5918.8816223675285;5932.673702946337;3603.4414665726854;3674.3386190485435;3861.9613803861603;3876.2635099331037;3881.573026967031;3445.0526105320737;3948.1314110895555;3950.545687245946;3951.5060617422823;3956.9604303957167;4300.827966881289;4439.311906654474;4549.727016379028;4550.658700597469;4653.046125544255;4690.437147542317;4863.732494712754;4953.405591329064;5290.444503327095;5606.411326810708;1037.3309215555923;1227.6255741998598;1251.5119103549623;1255.9937200314123;1276.4638851682316;836.3852568362249;865.7748985263877;870.7474832298562;873.3449912565576;876.2902049340055;4235.987905744747;4592.334111553806;4966.602671786249;4980.061763559517;5006.141586027166;4966.553010229097;5106.719130447861;5516.393196748354;5517.117261238182;5540.697935985121;4126.112885729583;4467.128909862546;4486.730796152241;4513.842015529506;4730.290456431563;2602.7137014928344;2647.5906924698434;2852.5863749756168;2897.246715853893;2917.4894393481054;4976.959446626865;5108.974455127701;5226.876221612371;5284.445133260952;5731.598788084877;4605.355250264965;5502.991408136001;5579.246801681802;5602.579806514527;5614.270144881221;5090.574639101058;5189.117849965515;5381.520081977487;5416.724975510295;5709.771609135588;4901.436334821541;5047.1419858623385;5330.413654498079;5412.268074216213;5477.260569823023;4804.645723595343;5283.89432211346;5299.290496652436;5357.78568857257;5396.83809485716;4981.975090124526;5402.864928376822;5581.358143813513;5671.744771485211;5719.596839880264;3565.1621868861316;3588.6411358863907;3662.670359667536;3669.798161101165;3919.804009799556;5610.635308705085;5818.24362832846;5820.185174075548;5842.3281322646735;5862.749506607675;4795.544423279783;5689.557817520341;5689.772409103755;5718.428157184415;5744.018313681773;4716.5990890774665;5464.726763661881;5465.562754979513;5577.972110139423;5611.38274789781;5293.421190670119;5490.945090549203;5507.834764957058;5547.8890422192135;5653.872672948688;5541.806036788693;5670.376258611467;5673.220122140204;5673.914891276551;5751.079827227623;4964.790668152637;5334.199870019373;5485.341758988947;5532.2254884315425;5614.803481878278 03:37:10 INFO - PROCESS | 1937 | |5;yui.html;571.3914680864879;683.6035099642208;710.321642831096;729.1687476277045;765.3226894198633;13879.653008674788;13917.721645567095;13970.720585588282;14350.425982960669;14511.637209069779;12448.875511244885;12484.687882802935;12498.750024999494;12518.12373133881;12602.306873121976;791.7703865878902;825.405707890318;829.2039641943742;830.9654480172194;832.9333653307721;820.3642177312571;820.5281962871343;822.0710597025353;822.7038266224155;824.2252282854098;861.483110133921;863.5509535041806;866.263675875504;867.1761826265042;868.2142660891903;854.9401541892039;856.6787454704486;861.2248975921658;861.6596444404488;863.48622569571;642.9099926010363;642.9228492580874;644.3234603666132;645.935406459355;645.9418652321314;14358.353874075692;14388.28058597066;14394.424223031067;14410.92794536031;14447.49433769813;12802.295873726942;12950.54673086447;13149.145305555205;13166.802497962539;13361.532346367927;11360;11369.31784092957;11535;11592.354784237354;11646.24299420535;3592.515010473579;3614.313280476701;3614.5843228028853;3625.4380571011534;3671.9265614687556;46590;76315.09633686321;84410.99999999939;85530.14469855285;85760.71358929621;9898.455584942898;10162.54268557902;10385.532651030722;10627.202959778047;10632.946835265775;19613.313534026525;19647.214111435384;19649.410517684206;19682.21271149138;19705.50736231577;5996.490298324604;6656.767013154613;6881.552699074544;6926.896096558556;7321.231270716605;4022.4971878515184;4059.878203653895;4229.788510574459;4261.403403523509;4393.802278897393;3298.6041674998673;3408.8636454541543;3412.607550131717;3414.146463384154;3414.402479566066;614.695725615823;627.3694936588699;640.1965533255827;642.4667525953447;653.7581094994882;579.901416759152;596.6420147911218;597.333972620525;656.5174596671443;660.3561527510735;8464.873026904601;9396.577154028086;9783.972682868338;9931;10117.59529618807;555.5028249716481;629.3014753623474;630.9747610095545;648.2339589352681;689.3210187964851;4188.078622703;4457.955420445819;4471.374007638933;4484.8430304939175;4521.977390113028;103616;105796;107767.46116269368;109236.36145457825;109578;91475;92061;93651.53174234086;95675.043249568;97430;59860.70069649624;84705;85062.5746871274;85954;87599.56200219085;8578.227959483676;8671.6097775599;8695.478271303742;8731.476111433334;8784.385093043426;48873;53139.46860531345;53967;54714.72642636761;55837.441625583226;74834.62582687051;76259.61870190613;77114.843277352;79913;82687.5865620668;10601.363918164934;10728.302660327367;11033.613823516138;11232.887671123184;11366.488508017324;11305.208635395773;12431.875681243071;12433.37833108359;12762.361881906054;12770.68073298175;11786.292822430682;12063.577774777841;12287.051107733902;12505.187162834387;12570.622881313575;11982.041436685218;11994.64016079519;12262.26426414418;12508.061895357703;12547.686307842378;11787.174897757075;12053.216540924812;12136.150469467053;12340.197887137307;12353.938230308791;9699.466529340954;9945.900540994788;10053.447060411747;10159.54282057324;10530.947345263225;9989.800203995734;10184.745381365525;10232.897671023195;10270.948645256725;10272.486375681037 03:37:10 INFO - PROCESS | 1937 | __end_tp_report 03:37:10 INFO - PROCESS | 1937 | __start_cc_report 03:37:10 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1721 03:37:10 INFO - PROCESS | 1937 | __end_cc_report 03:37:10 INFO - PROCESS | 1937 | __startTimestamp1484393830918__endTimestamp 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | ------- Summary: start ------- 03:37:10 INFO - PROCESS | 1937 | Number of tests: 6 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5738.25 Median:5927.29 stddev:666.42 (11.2%) stddev-sans-first:641.28 03:37:10 INFO - PROCESS | 1937 | Values: 3336.8 3338.5 3339.0 3349.9 3399.2 5666.0 5738.4 5752.0 5760.1 5777.9 5481.4 5528.4 5540.8 5551.0 5583.7 5009.5 5041.2 5050.3 5077.3 5090.6 5137.1 5167.3 5187.5 5190.2 5190.9 5241.8 5252.8 5269.0 5293.0 5298.3 4417.5 5275.9 5305.0 5318.2 5340.1 5187.5 5264.2 5290.3 5302.2 5336.3 5647.8 5663.7 5689.7 5706.2 5706.3 6201.1 6243.8 6251.8 6275.9 6306.1 6342.0 6344.9 6350.3 6361.7 6365.5 5716.3 5743.1 5789.6 5823.4 5855.2 6264.8 6288.5 6292.8 6320.7 6334.6 6188.3 6188.8 6191.7 6212.0 6224.6 6121.6 6124.2 6181.6 6292.2 6318.2 6158.7 6162.4 6164.2 6201.3 6234.0 6254.6 6280.5 6298.9 6310.6 6315.8 4253.8 4927.7 4970.7 4982.3 4983.9 4387.4 4409.3 4416.2 4427.7 4483.8 5793.1 5797.7 5830.9 5832.0 5844.3 6156.4 6160.0 6165.7 6249.1 6305.3 5541.4 5596.8 5761.2 5770.1 5825.9 5298.1 5393.1 5432.1 5446.0 5474.2 6293.9 6331.9 6340.5 6348.1 6354.1 4861.7 6296.9 6302.6 6331.9 6332.0 6204.4 6225.7 6252.2 6269.7 6341.2 6256.1 6258.5 6265.5 6276.4 6281.6 6143.6 6345.0 6354.2 6361.4 6362.0 5118.3 5995.9 6032.3 6063.6 6130.6 6058.2 6111.0 6118.5 6119.7 6129.6 5903.2 5914.5 5916.4 5920.5 5927.3 5983.7 6080.3 6103.4 6123.6 6142.4 5913.2 5992.9 6025.4 6043.2 6049.0 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:65851.18 Median:37159.22 stddev:147856.59 (397.9%) stddev-sans-first:148189.83 03:37:10 INFO - PROCESS | 1937 | Values: 450.6 494.6 503.8 506.6 531.1 25238.6 30555.4 30557.0 30560.8 30562.7 40048.6 41260.8 41375.8 42647.0 42803.4 8739.8 9481.1 9492.6 9497.1 9508.0 9344.3 9445.7 9457.1 9457.6 9460.7 9436.1 9482.3 9506.9 9510.4 9577.9 8430.8 9374.5 9431.4 9451.7 9471.1 9424.7 9491.0 9503.7 9506.0 9549.3 39127.4 39407.0 39488.0 39527.2 39683.6 3026.5 3174.1 3240.4 3589.8 3828.5 28768.4 29313.9 29904.7 30028.0 30752.5 3073.1 3140.1 3149.0 3153.4 3167.2 458870.0 463387.0 463839.0 464140.0 472821.6 32991.3 33947.7 33972.0 59605.0 60258.4 34534.1 34827.0 34863.0 34886.5 35001.3 14117.6 14274.5 14280.9 14297.9 14308.9 11933.6 12048.7 12052.9 12053.6 12085.1 7667.0 7676.6 7756.9 7763.1 7783.2 3147.5 3189.8 3195.2 3196.4 3220.3 757.0 862.1 952.4 1008.3 1103.5 27817.0 28386.6 29106.0 29135.0 29264.3 798.2 942.5 1016.6 1025.3 1143.8 12105.7 14318.6 14749.7 14758.4 15285.2 624041.0 633575.0 634110.0 635587.0 635664.0 54579.0 55095.0 55108.7 55127.0 55212.7 1193.6 1230.0 1293.2 1322.8 1325.1 29113.3 29652.6 29702.6 29858.0 30402.5 47039.8 47362.5 47387.5 47476.3 47515.0 490209.0 490789.0 491938.0 492765.0 721298.0 34423.6 38352.0 40071.8 40290.8 40465.0 35762.5 43715.0 43907.7 44142.3 45199.8 36243.8 36642.0 36723.4 37181.8 38250.4 32216.7 34827.3 36957.3 37025.4 37857.2 34067.0 35166.0 36737.6 36998.6 37136.6 30432.7 34178.7 34266.0 34307.8 34308.0 18400.6 23938.3 24880.5 25413.1 25550.5 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:33297.44 Median:3829.35 stddev:94159.87 (2458.9%) stddev-sans-first:94391.46 03:37:10 INFO - PROCESS | 1937 | Values: 320.7 351.1 375.8 380.3 404.8 14555.5 14976.6 15681.8 19937.5 20353.4 19640.9 19702.8 19870.9 20179.4 20436.4 5701.4 5956.6 5963.6 5969.4 5972.0 4830.3 5859.3 5919.2 5924.3 5927.0 5613.7 5775.1 5873.5 5877.9 5883.6 5745.4 5834.4 5856.7 5857.6 5868.7 4896.9 5098.2 5124.1 5129.4 5131.3 23642.2 24257.9 24556.5 24672.6 24933.4 2241.0 2302.1 2397.3 2624.5 2668.6 13871.5 13914.0 14118.3 14736.5 15083.3 1790.6 1813.6 1831.2 1880.1 1893.4 76242.0 113157.0 115954.0 123148.4 127159.0 8936.2 9512.6 9720.7 9878.5 9987.6 12407.5 12526.4 12538.6 12545.2 12551.7 7635.8 7833.9 7874.8 7904.4 7995.3 8105.1 8145.9 8172.6 8275.5 8305.9 3827.7 3829.0 3829.7 3903.4 3928.2 1451.5 1665.9 1815.4 1904.6 1918.1 710.9 800.8 859.7 926.1 930.1 15521.8 20259.5 20550.3 20677.8 20751.2 850.6 899.8 900.0 926.9 998.0 10511.5 10662.7 10747.5 10830.6 10832.4 534372.0 553526.0 566187.0 577469.0 579875.0 122840.0 127828.0 127834.0 130505.3 130915.0 721.0 927.5 928.7 947.6 948.5 13441.0 17312.8 18429.5 18691.4 19051.5 49023.0 50566.7 51455.0 52937.7 53368.0 71808.6 72476.0 75303.9 76939.2 77071.5 5328.4 6467.5 7711.7 7821.0 8098.2 11940.9 12024.9 12043.6 12396.7 12468.8 10290.3 10504.5 10729.3 10794.7 10863.3 9123.3 10232.9 10567.5 10591.6 10696.6 10682.8 10687.5 10761.1 10843.4 11189.9 6813.1 7232.4 7233.5 7357.9 7933.5 8882.6 9353.6 9846.0 10644.6 10958.1 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5386.02 Median:5079.58 stddev:2981.02 (58.7%) stddev-sans-first:2973.44 03:37:10 INFO - PROCESS | 1937 | Values: 1283.5 1458.2 1591.4 1796.7 1831.3 8091.9 8350.4 8362.3 8470.8 8510.0 7433.1 7666.0 7685.4 8036.3 8300.3 2277.5 2321.9 2323.2 2324.2 2330.3 2241.9 2304.7 2353.0 2353.5 2356.9 2255.2 2270.9 2299.8 2324.7 2328.0 2230.3 2259.0 2262.4 2266.4 2266.4 2238.0 2259.2 2265.7 2266.0 2267.6 8231.0 8431.4 8432.9 8435.6 8439.4 5048.2 5184.3 5234.7 5239.8 5244.5 3238.8 3250.0 3356.1 3397.8 3403.2 1023.1 1050.4 1070.7 1072.9 1073.5 10658.5 10999.8 11001.6 11052.0 11057.9 4256.9 4373.5 4450.5 4467.8 4489.9 8647.9 8651.2 8656.5 8658.6 8702.1 5079.4 5079.7 5089.9 5102.6 5110.9 4203.2 4375.8 4702.6 4769.5 4785.5 3569.0 3573.3 3638.7 3666.7 3668.1 1099.2 1104.8 1110.3 1112.6 1122.0 749.3 857.6 899.1 917.2 927.2 5528.7 5563.1 5570.7 5792.8 5907.6 875.1 916.7 925.1 932.1 986.5 3395.9 3670.6 3747.8 3819.3 3878.6 9779.6 10130.4 10267.9 10269.5 10294.2 10200.5 10203.8 10218.7 10228.6 10235.2 7565.2 7811.3 7867.9 7931.9 7960.4 5434.6 5579.5 5692.4 5694.6 5707.6 9207.7 9330.3 9455.0 9540.6 9551.0 9452.4 9578.0 9660.2 9661.7 9771.8 6256.2 6409.8 6490.5 6681.5 6834.6 7705.7 7811.1 7856.0 7874.5 7879.0 6955.5 7014.8 7055.6 7058.2 7186.9 5842.5 6917.8 6934.1 6962.7 6987.7 6429.1 6535.0 6539.3 6648.3 6670.7 4772.8 4801.0 4827.1 4854.6 4882.2 4533.5 4598.8 4766.5 4775.6 4930.1 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:4426.46 Median:4959.10 stddev:1359.35 (27.4%) stddev-sans-first:1326.57 03:37:10 INFO - PROCESS | 1937 | Values: 252.8 307.1 310.9 315.7 319.9 4385.5 4752.4 5318.9 5397.9 5434.8 4194.3 4277.7 5000.1 5162.5 5300.6 4062.8 4088.3 4094.4 4097.2 4115.4 3434.6 3634.4 4029.6 4094.3 4107.5 3601.3 3941.4 4053.7 4057.0 4088.9 3733.0 3890.7 3902.2 3999.8 4037.6 2831.3 2887.7 3569.2 3572.7 3573.9 4292.8 4931.9 5221.6 5230.9 5236.6 4036.9 4625.3 4635.5 4639.8 4657.3 5517.2 5586.8 5597.7 5598.4 5661.8 3729.3 3922.8 3927.8 3930.0 3947.7 5075.8 5490.8 5837.0 5918.9 5932.7 3603.4 3674.3 3862.0 3876.3 3881.6 3445.1 3948.1 3950.5 3951.5 3957.0 4300.8 4439.3 4549.7 4550.7 4653.0 4690.4 4863.7 4953.4 5290.4 5606.4 1037.3 1227.6 1251.5 1256.0 1276.5 836.4 865.8 870.7 873.3 876.3 4236.0 4592.3 4966.6 4980.1 5006.1 4966.6 5106.7 5516.4 5517.1 5540.7 4126.1 4467.1 4486.7 4513.8 4730.3 2602.7 2647.6 2852.6 2897.2 2917.5 4977.0 5109.0 5226.9 5284.4 5731.6 4605.4 5503.0 5579.2 5602.6 5614.3 5090.6 5189.1 5381.5 5416.7 5709.8 4901.4 5047.1 5330.4 5412.3 5477.3 4804.6 5283.9 5299.3 5357.8 5396.8 4982.0 5402.9 5581.4 5671.7 5719.6 3565.2 3588.6 3662.7 3669.8 3919.8 5610.6 5818.2 5820.2 5842.3 5862.7 4795.5 5689.6 5689.8 5718.4 5744.0 4716.6 5464.7 5465.6 5578.0 5611.4 5293.4 5490.9 5507.8 5547.9 5653.9 5541.8 5670.4 5673.2 5673.9 5751.1 4964.8 5334.2 5485.3 5532.2 5614.8 03:37:10 INFO - PROCESS | 1937 | 03:37:10 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:19782.04 Median:4503.41 stddev:29121.63 (646.7%) stddev-sans-first:29167.60 03:37:10 INFO - PROCESS | 1937 | Values: 571.4 683.6 710.3 729.2 765.3 13879.7 13917.7 13970.7 14350.4 14511.6 12448.9 12484.7 12498.8 12518.1 12602.3 791.8 825.4 829.2 831.0 832.9 820.4 820.5 822.1 822.7 824.2 861.5 863.6 866.3 867.2 868.2 854.9 856.7 861.2 861.7 863.5 642.9 642.9 644.3 645.9 645.9 14358.4 14388.3 14394.4 14410.9 14447.5 12802.3 12950.5 13149.1 13166.8 13361.5 11360.0 11369.3 11535.0 11592.4 11646.2 3592.5 3614.3 3614.6 3625.4 3671.9 46590.0 76315.1 84411.0 85530.1 85760.7 9898.5 10162.5 10385.5 10627.2 10632.9 19613.3 19647.2 19649.4 19682.2 19705.5 5996.5 6656.8 6881.6 6926.9 7321.2 4022.5 4059.9 4229.8 4261.4 4393.8 3298.6 3408.9 3412.6 3414.1 3414.4 614.7 627.4 640.2 642.5 653.8 579.9 596.6 597.3 656.5 660.4 8464.9 9396.6 9784.0 9931.0 10117.6 555.5 629.3 631.0 648.2 689.3 4188.1 4458.0 4471.4 4484.8 4522.0 103616.0 105796.0 107767.5 109236.4 109578.0 91475.0 92061.0 93651.5 95675.0 97430.0 59860.7 84705.0 85062.6 85954.0 87599.6 8578.2 8671.6 8695.5 8731.5 8784.4 48873.0 53139.5 53967.0 54714.7 55837.4 74834.6 76259.6 77114.8 79913.0 82687.6 10601.4 10728.3 11033.6 11232.9 11366.5 11305.2 12431.9 12433.4 12762.4 12770.7 11786.3 12063.6 12287.1 12505.2 12570.6 11982.0 11994.6 12262.3 12508.1 12547.7 11787.2 12053.2 12136.2 12340.2 12353.9 9699.5 9945.9 10053.4 10159.5 10530.9 9989.8 10184.7 10232.9 10270.9 10272.5 03:37:10 INFO - PROCESS | 1937 | -------- Summary: end -------- 03:37:10 INFO - PROCESS | 1937 | 03:37:11 INFO - TEST-INFO | 1937: exit 0 03:37:11 INFO - TEST-OK | dromaeo_css | took 1120583ms 03:37:11 INFO - TEST-START | kraken 03:37:11 INFO - operating with platform_type : mac_ 03:37:11 INFO - Initialising browser for kraken test... 03:37:11 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp5lttTg/profile http://localhost:52269/getInfo.html) 03:37:14 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 03:37:14 INFO - PROCESS | 1964 | colorDepth:24 03:37:14 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 03:37:14 INFO - PROCESS | 1964 | __metrics 03:37:14 INFO - PROCESS | 1964 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:37:14 INFO - PROCESS | 1964 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:37:15 INFO - TEST-INFO | 1964: exit 0 03:37:15 INFO - Browser initialized. 03:37:15 INFO - Running cycle 1/1 for kraken test... 03:37:15 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp5lttTg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:27 INFO - PROCESS | 1966 | RSS: Main: 222355456 03:37:27 INFO - PROCESS | 1966 | 03:37:30 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52269/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:31 INFO - PROCESS | 1966 | RSS: Main: 274169856 03:37:31 INFO - PROCESS | 1966 | 03:37:34 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52269/tests/kraken/driver.html?testName=audio-dft) 03:37:34 INFO - PROCESS | 1966 | RSS: Main: 285913088 03:37:34 INFO - PROCESS | 1966 | 03:37:37 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52269/tests/kraken/driver.html?testName=audio-fft) 03:37:38 INFO - PROCESS | 1966 | RSS: Main: 380960768 03:37:38 INFO - PROCESS | 1966 | 03:37:40 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52269/tests/kraken/driver.html?testName=audio-oscillator) 03:37:41 INFO - PROCESS | 1966 | RSS: Main: 283930624 03:37:41 INFO - PROCESS | 1966 | 03:37:43 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:43 INFO - PROCESS | 1966 | RSS: Main: 285052928 03:37:43 INFO - PROCESS | 1966 | 03:37:46 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52269/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:47 INFO - PROCESS | 1966 | RSS: Main: 325713920 03:37:47 INFO - PROCESS | 1966 | 03:37:50 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52269/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:50 INFO - PROCESS | 1966 | RSS: Main: 326946816 03:37:50 INFO - PROCESS | 1966 | 03:37:53 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52269/tests/kraken/driver.html?testName=json-parse-financial) 03:37:54 INFO - PROCESS | 1966 | RSS: Main: 323760128 03:37:54 INFO - PROCESS | 1966 | 03:37:55 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:56 INFO - PROCESS | 1966 | RSS: Main: 298278912 03:37:56 INFO - PROCESS | 1966 | 03:37:58 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:58 INFO - PROCESS | 1966 | RSS: Main: 301359104 03:37:58 INFO - PROCESS | 1966 | 03:38:01 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:01 INFO - PROCESS | 1966 | RSS: Main: 303882240 03:38:01 INFO - PROCESS | 1966 | 03:38:04 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:05 INFO - PROCESS | 1966 | RSS: Main: 322084864 03:38:05 INFO - PROCESS | 1966 | 03:38:08 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:08 INFO - PROCESS | 1966 | RSS: Main: 315183104 03:38:08 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52269/tests/kraken/driver.html?testName=ai-astar) 03:38:10 INFO - PROCESS | 1966 | RSS: Main: 359387136 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | __start_tp_report 03:38:10 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 03:38:10 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 03:38:10 INFO - PROCESS | 1966 | |i|pagename|runs| 03:38:10 INFO - PROCESS | 1966 | |0;ai-astar;115;114;111;114;114;113;112;154;167;135 03:38:10 INFO - PROCESS | 1966 | |1;audio-beat-detection;151;139;144;147;114;109;114;138;179;109 03:38:10 INFO - PROCESS | 1966 | |2;audio-dft;182;179;181;182;182;183;184;185;186;184 03:38:10 INFO - PROCESS | 1966 | |3;audio-fft;84;59;59;91;64;60;60;59;85;58 03:38:10 INFO - PROCESS | 1966 | |4;audio-oscillator;86;70;95;75;94;100;121;66;69;91 03:38:10 INFO - PROCESS | 1966 | |5;imaging-gaussian-blur;87;83;86;83;85;83;87;83;85;83 03:38:10 INFO - PROCESS | 1966 | |6;imaging-darkroom;95;96;115;161;105;94;95;95;95;95 03:38:10 INFO - PROCESS | 1966 | |7;imaging-desaturate;82;92;107;82;84;84;89;83;97;123 03:38:10 INFO - PROCESS | 1966 | |8;json-parse-financial;54;54;53;53;57;58;57;57;57;57 03:38:10 INFO - PROCESS | 1966 | |9;json-stringify-tinderbox;64;76;80;73;73;70;71;72;71;76 03:38:10 INFO - PROCESS | 1966 | |10;stanford-crypto-aes;83;82;85;83;83;83;82;83;84;84 03:38:10 INFO - PROCESS | 1966 | |11;stanford-crypto-ccm;143;148;151;155;128;148;154;157;176;151 03:38:10 INFO - PROCESS | 1966 | |12;stanford-crypto-pbkdf2;165;165;168;159;159;168;168;166;163;165 03:38:10 INFO - PROCESS | 1966 | |13;stanford-crypto-sha256-iterative;63;68;88;66;78;87;88;86;84;69 03:38:10 INFO - PROCESS | 1966 | __end_tp_report 03:38:10 INFO - PROCESS | 1966 | __start_cc_report 03:38:10 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,1918 03:38:10 INFO - PROCESS | 1966 | __end_cc_report 03:38:10 INFO - PROCESS | 1966 | __startTimestamp1484393890972__endTimestamp 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | ------- Summary: start ------- 03:38:10 INFO - PROCESS | 1966 | Number of tests: 14 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#0] ai-astar Cycles:10 Average:124.90 Median:114.50 stddev:20.21 (17.7%) stddev-sans-first:21.12 03:38:10 INFO - PROCESS | 1966 | Values: 115.0 114.0 111.0 114.0 114.0 113.0 112.0 154.0 167.0 135.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:141.50 stddev:22.78 (16.1%) stddev-sans-first:23.36 03:38:10 INFO - PROCESS | 1966 | Values: 151.0 139.0 144.0 147.0 114.0 109.0 114.0 138.0 179.0 109.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:2.04 (1.1%) stddev-sans-first:2.15 03:38:10 INFO - PROCESS | 1966 | Values: 182.0 179.0 181.0 182.0 182.0 183.0 184.0 185.0 186.0 184.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#3] audio-fft Cycles:10 Average:67.90 Median:62.00 stddev:13.17 (21.2%) stddev-sans-first:12.61 03:38:10 INFO - PROCESS | 1966 | Values: 84.0 59.0 59.0 91.0 64.0 60.0 60.0 59.0 85.0 58.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:80.50 stddev:17.17 (21.3%) stddev-sans-first:18.21 03:38:10 INFO - PROCESS | 1966 | Values: 86.0 70.0 95.0 75.0 94.0 100.0 121.0 66.0 69.0 91.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:85.00 stddev:1.72 (2.0%) stddev-sans-first:1.56 03:38:10 INFO - PROCESS | 1966 | Values: 87.0 83.0 86.0 83.0 85.0 83.0 87.0 83.0 85.0 83.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:95.00 stddev:20.91 (22.0%) stddev-sans-first:21.89 03:38:10 INFO - PROCESS | 1966 | Values: 95.0 96.0 115.0 161.0 105.0 94.0 95.0 95.0 95.0 95.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:84.00 stddev:13.45 (16.0%) stddev-sans-first:13.74 03:38:10 INFO - PROCESS | 1966 | Values: 82.0 92.0 107.0 82.0 84.0 84.0 89.0 83.0 97.0 123.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:57.00 stddev:1.95 (3.4%) stddev-sans-first:1.96 03:38:10 INFO - PROCESS | 1966 | Values: 54.0 54.0 53.0 53.0 57.0 58.0 57.0 57.0 57.0 57.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:4.27 (5.9%) stddev-sans-first:3.21 03:38:10 INFO - PROCESS | 1966 | Values: 64.0 76.0 80.0 73.0 73.0 70.0 71.0 72.0 71.0 76.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 03:38:10 INFO - PROCESS | 1966 | Values: 83.0 82.0 85.0 83.0 83.0 83.0 82.0 83.0 84.0 84.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:152.50 stddev:12.00 (7.9%) stddev-sans-first:12.37 03:38:10 INFO - PROCESS | 1966 | Values: 143.0 148.0 151.0 155.0 128.0 148.0 154.0 157.0 176.0 151.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.50 stddev:3.37 (2.0%) stddev-sans-first:3.57 03:38:10 INFO - PROCESS | 1966 | Values: 165.0 165.0 168.0 159.0 159.0 168.0 168.0 166.0 163.0 165.0 03:38:10 INFO - PROCESS | 1966 | 03:38:10 INFO - PROCESS | 1966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:85.00 stddev:10.17 (12.0%) stddev-sans-first:9.29 03:38:10 INFO - PROCESS | 1966 | Values: 63.0 68.0 88.0 66.0 78.0 87.0 88.0 86.0 84.0 69.0 03:38:10 INFO - PROCESS | 1966 | -------- Summary: end -------- 03:38:10 INFO - PROCESS | 1966 | 03:38:12 INFO - TEST-INFO | 1966: exit 0 03:38:12 INFO - TEST-OK | kraken | took 60402ms 03:38:12 INFO - SUITE-END | took 1180s 03:38:12 INFO - Completed test suite (00:19:41) 03:38:12 INFO - javascript benchmark 03:38:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.783109097909, 3338.5159151922962, 3338.9666103338946, 3349.8660053597855, 3399.1672040350104, 5666.0, 5738.3974682658345, 5751.971240143804, 5760.107183386576, 5777.884442311157, 5481.369642491115, 5528.44715528447, 5540.833774986757, 5550.972245138779, 5583.748731307091, 5009.499050094989, 5041.243813427978, 5050.3434553508, 5077.314562534066, 5090.618203634724, 5137.101007323722, 5167.3282473278605, 5187.533122019017, 5190.2474141249495, 5190.858011237522, 5241.816536421226, 5252.763625636836, 5269.0, 5292.973535132319, 5298.311219541473, 4417.536158703354, 5275.868103297429, 5305.0, 5318.202269659543, 5340.145576707747, 5187.481251874782, 5264.184051472028, 5290.259363689087, 5302.231176479428, 5336.332958380202, 5647.830565083054, 5663.716814159276, 5689.7439615217, 5706.172604972256, 5706.3152421709665, 6201.131841542187, 6243.812685619393, 6251.812445626639, 6275.8744825103695, 6306.1486699295465, 6342.016987366966, 6344.873102537924, 6350.333215012403, 6361.681915904186, 6365.458935990447, 5716.256886604798, 5743.1385292206505, 5789.594728368974, 5823.359430462646, 5855.151003104526, 6264.812055638338, 6288.465480434214, 6292.811215663537, 6320.71556779946, 6334.588251763621, 6188.257409110845, 6188.845278868064, 6191.690415479298, 6211.9689401552705, 6224.626522408579, 6121.554446470009, 6124.177795495351, 6181.629102253879, 6292.244930608356, 6318.178636777189, 6158.7228574714245, 6162.414570615784, 6164.229471316085, 6201.286852011986, 6233.96883015582, 6254.562180647402, 6280.497560195265, 6298.905516417258, 6310.558260921692, 6315.778947736899, 4253.80857861397, 4927.655064145475, 4970.726610036482, 4982.252662100642, 4983.90032199354, 4387.429634147604, 4409.33859921008, 4416.24923762961, 4427.712198707074, 4483.798229079634, 5793.073108302651, 5797.739101740432, 5830.8542286442325, 5832.0, 5844.327902291206, 6156.384361563808, 6159.969200153971, 6165.660888651078, 6249.0938813871735, 6305.306416294204, 5541.445855414507, 5596.804111856066, 5761.222234998221, 5770.105633626795, 5825.854353641108, 5298.125809241432, 5393.110136827458, 5432.076546987022, 5446.0, 5474.233607294982, 6293.937060629335, 6331.9050214247745, 6340.49276057905, 6348.079528468346, 6354.142190804182, 4861.7326047066335, 6296.905546416716, 6302.621842689453, 6331.9050214247745, 6331.96834015827, 6204.3795620437595, 6225.657588832658, 6252.1559589456665, 6269.749210031548, 6341.175647165839, 6256.092866534418, 6258.468030217483, 6265.467435268053, 6276.372362763687, 6281.623102613858, 6143.631382117087, 6344.984802431589, 6354.205724284465, 6361.395667411589, 6362.045693146065, 5118.283440318284, 5995.850103747442, 6032.336442991355, 6063.605865618721, 6130.601510901777, 6058.242719660043, 6111.04482360895, 6118.510519158545, 6119.724612392542, 6129.570930034854, 5903.173555702119, 5914.526837852875, 5916.378780228186, 5920.4671579556325, 5927.288725352985, 5983.700814959322, 6080.331163572092, 6103.42017508336, 6123.632582045091, 6142.3550527194, 5913.201717768046, 5992.910106348321, 6025.427584379477, 6043.244594425697, 6049.0], "value": 5694.937242685821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.5877122432974, 494.636442214972, 503.8488453463961, 506.59978616892636, 531.1156923722003, 25238.621420678704, 30555.38889222217, 30557.0, 30560.84719576399, 30562.694373056263, 40048.599514004854, 41260.79369603156, 41375.75872723816, 42647.0, 42803.35794963078, 8739.825203495942, 9481.146696797286, 9492.620295188184, 9497.050294970482, 9508.001659825723, 9344.299177561676, 9445.716628501155, 9457.148856602904, 9457.621695132186, 9460.668876589321, 9436.056394360578, 9482.288828337867, 9506.904930950706, 9510.429374237534, 9577.904220957806, 8430.831383372359, 9374.484403357812, 9431.386959847589, 9451.66919157833, 9471.147596716293, 9424.670136545188, 9491.0, 9503.714888553355, 9506.0, 9549.28380371468, 39127.41308880369, 39407.0, 39488.0, 39527.20945581072, 39683.61107361257, 3026.546018097281, 3174.0953828159095, 3240.4005259027153, 3589.766665166756, 3828.502294701671, 28768.424631507463, 29313.85343073271, 29904.70095299041, 30028.0, 30752.53871191934, 3073.078076577018, 3140.136462472838, 3149.0395429394025, 3153.3693261347594, 3167.2081979505124, 458870.0, 463387.0, 463839.0, 464140.0, 472821.63589182176, 32991.340173196404, 33947.66052339445, 33972.0, 59605.0, 60258.39741602616, 34534.13664658403, 34826.9551913443, 34863.0, 34886.476702849475, 35001.29997400038, 14117.576472705836, 14274.500392486421, 14280.928595357165, 14297.85702142986, 14308.928455357656, 11933.582324618597, 12048.698782530508, 12052.879471205175, 12053.63839084829, 12085.093617978511, 7667.0, 7676.6161691916295, 7756.883646745303, 7763.107242667053, 7783.182765809622, 3147.512135618983, 3189.7607679424136, 3195.201199700075, 3196.4246435641344, 3220.2754380264255, 756.9659365328573, 862.1421685423044, 952.3857112162616, 1008.2891561449161, 1103.5475455063386, 27817.0, 28386.574201386997, 29105.981290654727, 29135.0, 29264.26839329034, 798.2456578533346, 942.4957647658607, 1016.5730393234859, 1025.3232866308201, 1143.7655280667443, 12105.697357565956, 14318.642033949234, 14749.705005900036, 14758.40966361355, 15285.235738213045, 624041.0, 633575.0, 634110.0, 635587.0, 635664.0, 54579.0, 55095.0, 55108.72445637746, 55127.0, 55212.72393638006, 1193.6419074277856, 1230.0, 1293.224065560656, 1322.8478724946563, 1325.1320385147744, 29113.27216819512, 29652.55521167141, 29702.554461683525, 29858.0, 30402.543961840147, 47039.76480117578, 47362.52637473719, 47387.52612473969, 47476.28785568288, 47515.0, 490209.0, 490789.0, 491938.0, 492765.0, 721298.0, 34423.623055077514, 38352.041198969135, 40071.79964100278, 40290.79854600826, 40465.0, 35762.463563047095, 43715.0, 43907.68276951696, 44142.33786493269, 45199.77400112979, 36243.81878090592, 36642.0, 36723.44914826226, 37181.81409093046, 38250.42624360581, 32216.67783322137, 34827.30345393129, 36957.26085478329, 37025.444618330206, 37857.2428551433, 34067.0, 35166.0, 36737.632623673424, 36998.6300137006, 37136.6286337144, 30432.695673042985, 34178.65821341755, 34266.0, 34307.79922702693, 34308.0, 18400.631987360444, 23938.28185154448, 24880.50238995246, 25413.110541130973, 25550.488990220463], "value": 17925.228254784313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.6729136280993, 351.050408644616, 375.8008255624519, 380.30404360021146, 404.82187837351563, 14555.490557830479, 14976.625584360383, 15681.843181568182, 19937.501562460908, 20353.38939831804, 19640.901795491038, 19702.802971970275, 19870.90064549679, 20179.39461816144, 20436.386908392735, 5701.372848986608, 5956.612820166675, 5963.642181469126, 5969.432903874125, 5971.970140149293, 4830.299606557047, 5859.267591551056, 5919.1713160157615, 5924.318703349106, 5926.992411290091, 5613.66318020918, 5775.075987841946, 5873.500752436048, 5877.9412205877825, 5883.558733095014, 5745.368009518949, 5834.4165583441745, 5856.7071646417935, 5857.619254748428, 5868.677222752747, 4896.877578060577, 5098.184290513537, 5124.077666020152, 5129.435762066169, 5131.307273518065, 23642.17252396175, 24257.87871060651, 24556.508869822683, 24672.629910551357, 24933.376665583324, 2240.9663855042186, 2302.102180149743, 2397.280815755284, 2624.475104979012, 2668.559687651535, 13871.514496992557, 13914.0, 14118.294085295694, 14736.484223052248, 15083.321250543751, 1790.588164722108, 1813.5647444613198, 1831.249969083442, 1880.097553174484, 1893.3941138835578, 76242.0, 113157.0, 115953.99999999916, 123148.38425807813, 127159.0, 8936.24041956428, 9512.619495220251, 9720.708378748648, 9878.506074696237, 9987.60049598008, 12407.503699852085, 12526.436310366056, 12538.561150359694, 12545.184563003375, 12551.748965020648, 7635.847283054308, 7833.882491762628, 7874.803129921798, 7904.4071694623135, 7995.2804247618, 8105.067917189481, 8145.918540814635, 8172.550509722022, 8275.462094963808, 8305.875411868827, 3827.655511003967, 3828.9617103829164, 3829.7319187657154, 3903.434002069684, 3928.2339943710704, 1451.5355086372472, 1665.9421267495227, 1815.3555487801905, 1904.5809921817179, 1918.0793219254836, 710.9016569400289, 800.8118092248317, 859.6862145316915, 926.1386910173603, 930.1070971867083, 15521.767173492406, 20259.493512662302, 20550.28074017402, 20677.79322206789, 20751.169953202007, 850.5747126436781, 899.8335307968047, 899.9730008099767, 926.9073092690812, 998.0418797954045, 10511.474426278655, 10662.733431664115, 10747.462626868626, 10830.566777328977, 10832.40421776794, 534372.0, 553526.0, 566187.0, 577469.0, 579875.0, 122840.0, 127828.0, 127834.0, 130505.34747326202, 130915.0, 720.9891851622125, 927.5455027036838, 928.7399528132133, 947.554649314821, 948.5257371314343, 13441.0, 17312.826871731624, 18429.53926151857, 18691.439256822316, 19051.523711906757, 49023.0, 50566.74716626394, 51455.0, 52937.67655808636, 53368.0, 71808.64095679489, 72476.0, 75303.87044194451, 76939.2306076932, 77071.45857082939, 5328.440513746001, 6467.547271690936, 7711.650461169161, 7820.960895195488, 8098.230668086522, 11940.880591193976, 12024.939875300568, 12043.578474753342, 12396.690082748004, 12468.812967805672, 10290.279680422298, 10504.53604965782, 10729.302595331279, 10794.73013174677, 10863.293885897392, 9123.315751318545, 10232.948835255776, 10567.471626418803, 10591.629292974709, 10696.62561810364, 10682.83975740349, 10687.51906164209, 10761.139108871428, 10843.403612801372, 11189.944050279697, 6813.1142951415995, 7232.42140628759, 7233.493655444068, 7357.852842943218, 7933.484323518953, 8882.555872206234, 9353.643721660457, 9846.0, 10644.574217031231, 10958.068564172134], "value": 9107.485831805845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.4545318239748, 1458.161557104665, 1591.4032237910783, 1796.712525995841, 1831.3498707958665, 8091.919080809197, 8350.373721970855, 8362.289205417539, 8470.788230294245, 8510.0, 7433.108027036763, 7666.0, 7685.423593230502, 8036.27673509384, 8300.335973122152, 2277.544491101782, 2321.897098878028, 2323.1520495019367, 2324.1516846351046, 2330.2776139396756, 2241.887905604713, 2304.68886700295, 2352.9764702353013, 2353.4587044979667, 2356.905723771047, 2255.154317131076, 2270.8751018693965, 2299.8160147188187, 2324.6861673674093, 2328.0222306631254, 2230.3309007297826, 2259.0399080390766, 2262.4457008033137, 2266.410733209361, 2266.4220623741007, 2237.966430503544, 2259.175400978631, 2265.6714776357335, 2266.0, 2267.557826223887, 8231.0, 8431.40980131391, 8432.873506897402, 8435.620397082146, 8439.409241353107, 5048.192289233705, 5184.326037615086, 5234.738263086831, 5239.842804715865, 5244.475552444725, 3238.77328586999, 3249.951250731241, 3356.077078803324, 3397.7621566490357, 3403.2002479417315, 1023.1303392116715, 1050.4012712753733, 1070.6948519671935, 1072.8766191887876, 1073.5222825842504, 10658.520366583445, 10999.835002474969, 11001.559937602486, 11052.005319521202, 11057.944710276397, 4256.851010214627, 4373.518912919576, 4450.488193857683, 4467.821287148543, 4489.932651010237, 8647.870281945776, 8651.221390074923, 8656.52389118592, 8658.610362533702, 8702.086280940537, 5079.4412614612365, 5079.720615366116, 5089.923651145235, 5102.566281866083, 5110.897782044338, 4203.159368126326, 4375.8030888609455, 4702.6473014524045, 4769.546893045155, 4785.49752276013, 3568.964310356915, 3573.26748016656, 3638.7089032877307, 3666.6699997000396, 3668.0829792551863, 1099.1756182862853, 1104.828751543512, 1110.2616759854768, 1112.6439539347493, 1122.0294445304917, 749.3068911257066, 857.6183598298697, 899.1143723432414, 917.1699611851285, 927.1979737526991, 5528.723563821793, 5563.13771365439, 5570.693611851387, 5792.8476873726395, 5907.645541267538, 875.1336177184669, 916.706653870755, 925.1488630459993, 932.0845662164318, 986.5116767200138, 3395.898123056312, 3670.596234414212, 3747.831347589365, 3819.2743378757946, 3878.5733569307354, 9779.559919803625, 10130.442825644514, 10267.94866025665, 10269.537870795682, 10294.17646588271, 10200.489975501196, 10203.795924081476, 10218.693439196835, 10228.590856365661, 10235.181185505142, 7565.167831538526, 7811.336036436966, 7867.921320786719, 7931.881021784678, 7960.363170946311, 5434.64674796137, 5579.4978451937895, 5692.402297758841, 5694.572907031907, 5707.600467967202, 9207.677731279373, 9330.346875718635, 9455.0, 9540.618375264912, 9551.044895510393, 9452.43285402878, 9578.0, 9660.17888479459, 9661.661841835783, 9771.755706107404, 6256.217972753406, 6409.839754006187, 6490.513211509061, 6681.465482761465, 6834.624095674786, 7705.653245604073, 7811.062672479339, 7855.978722766004, 7874.488158269924, 7879.0, 6955.547889387173, 7014.754483593049, 7055.611941343275, 7058.153021637437, 7186.928130718626, 5842.503387212135, 6917.757878474229, 6934.133233345832, 6962.686679099554, 6987.6855541499735, 6429.067785171217, 6534.967325163534, 6539.313372096051, 6648.268690444144, 6670.699818508082, 4772.782940350188, 4800.95199048019, 4827.131116398941, 4854.5873600744335, 4882.2432522959, 4533.523979982187, 4598.758335249397, 4766.499517550607, 4775.570198681996, 4930.137225985366], "value": 4354.453867386975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.80533988828603, 307.1491967250717, 310.8958498902867, 315.6811620263533, 319.89603378901865, 4385.451818522684, 4752.382190315258, 5318.946810531894, 5397.892042159155, 5434.755436005379, 4194.349875769253, 4277.700560960734, 5000.0999820032375, 5162.457941916101, 5300.628955973083, 4062.837486500536, 4088.3458646616546, 4094.4472496213075, 4097.201045796071, 4115.415565007464, 3434.605020422646, 3634.436662317345, 4029.6171863672903, 4094.34490481523, 4107.549658287038, 3601.333753255656, 3941.4481972523868, 4053.6757059435176, 4056.9797151014204, 4088.8568900088503, 3732.9813350933073, 3890.7081968852167, 3902.161035377393, 3999.820187903648, 4037.596240375968, 2831.348789778342, 2887.6534815822024, 3569.214772749991, 3572.696320812734, 3573.94639080414, 4292.789213555022, 4931.901361972777, 5221.556167725748, 5230.947690523084, 5236.581073514109, 4036.8898552897895, 4625.259958406638, 4635.46692130406, 4639.840039990003, 4657.278121891112, 5517.200005999108, 5586.804461843856, 5597.720113994284, 5598.412166722476, 5661.753684736447, 3729.272791805599, 3922.8430862765454, 3927.8428862845453, 3929.98035009826, 3947.743396679207, 5075.796968121271, 5490.835274941758, 5837.0, 5918.8816223675285, 5932.673702946337, 3603.4414665726854, 3674.3386190485435, 3861.9613803861603, 3876.2635099331037, 3881.573026967031, 3445.0526105320737, 3948.1314110895555, 3950.545687245946, 3951.5060617422823, 3956.9604303957167, 4300.827966881289, 4439.311906654474, 4549.727016379028, 4550.658700597469, 4653.046125544255, 4690.437147542317, 4863.732494712754, 4953.405591329064, 5290.444503327095, 5606.411326810708, 1037.3309215555923, 1227.6255741998598, 1251.5119103549623, 1255.9937200314123, 1276.4638851682316, 836.3852568362249, 865.7748985263877, 870.7474832298562, 873.3449912565576, 876.2902049340055, 4235.987905744747, 4592.334111553806, 4966.602671786249, 4980.061763559517, 5006.141586027166, 4966.553010229097, 5106.719130447861, 5516.393196748354, 5517.117261238182, 5540.697935985121, 4126.112885729583, 4467.128909862546, 4486.730796152241, 4513.842015529506, 4730.290456431563, 2602.7137014928344, 2647.5906924698434, 2852.5863749756168, 2897.246715853893, 2917.4894393481054, 4976.959446626865, 5108.974455127701, 5226.876221612371, 5284.445133260952, 5731.598788084877, 4605.355250264965, 5502.991408136001, 5579.246801681802, 5602.579806514527, 5614.270144881221, 5090.574639101058, 5189.117849965515, 5381.520081977487, 5416.724975510295, 5709.771609135588, 4901.436334821541, 5047.1419858623385, 5330.413654498079, 5412.268074216213, 5477.260569823023, 4804.645723595343, 5283.89432211346, 5299.290496652436, 5357.78568857257, 5396.83809485716, 4981.975090124526, 5402.864928376822, 5581.358143813513, 5671.744771485211, 5719.596839880264, 3565.1621868861316, 3588.6411358863907, 3662.670359667536, 3669.798161101165, 3919.804009799556, 5610.635308705085, 5818.24362832846, 5820.185174075548, 5842.3281322646735, 5862.749506607675, 4795.544423279783, 5689.557817520341, 5689.772409103755, 5718.428157184415, 5744.018313681773, 4716.5990890774665, 5464.726763661881, 5465.562754979513, 5577.972110139423, 5611.38274789781, 5293.421190670119, 5490.945090549203, 5507.834764957058, 5547.8890422192135, 5653.872672948688, 5541.806036788693, 5670.376258611467, 5673.220122140204, 5673.914891276551, 5751.079827227623, 4964.790668152637, 5334.199870019373, 5485.341758988947, 5532.2254884315425, 5614.803481878278], "value": 3989.4754929773967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3914680864879, 683.6035099642208, 710.321642831096, 729.1687476277045, 765.3226894198633, 13879.653008674788, 13917.721645567095, 13970.720585588282, 14350.425982960669, 14511.637209069779, 12448.875511244885, 12484.687882802935, 12498.750024999494, 12518.12373133881, 12602.306873121976, 791.7703865878902, 825.405707890318, 829.2039641943742, 830.9654480172194, 832.9333653307721, 820.3642177312571, 820.5281962871343, 822.0710597025353, 822.7038266224155, 824.2252282854098, 861.483110133921, 863.5509535041806, 866.263675875504, 867.1761826265042, 868.2142660891903, 854.9401541892039, 856.6787454704486, 861.2248975921658, 861.6596444404488, 863.48622569571, 642.9099926010363, 642.9228492580874, 644.3234603666132, 645.935406459355, 645.9418652321314, 14358.353874075692, 14388.28058597066, 14394.424223031067, 14410.92794536031, 14447.49433769813, 12802.295873726942, 12950.54673086447, 13149.145305555205, 13166.802497962539, 13361.532346367927, 11360.0, 11369.31784092957, 11535.0, 11592.354784237354, 11646.24299420535, 3592.515010473579, 3614.313280476701, 3614.5843228028853, 3625.4380571011534, 3671.9265614687556, 46590.0, 76315.09633686321, 84410.99999999939, 85530.14469855285, 85760.71358929621, 9898.455584942898, 10162.54268557902, 10385.532651030722, 10627.202959778047, 10632.946835265775, 19613.313534026525, 19647.214111435384, 19649.410517684206, 19682.21271149138, 19705.50736231577, 5996.490298324604, 6656.767013154613, 6881.552699074544, 6926.896096558556, 7321.231270716605, 4022.4971878515184, 4059.878203653895, 4229.788510574459, 4261.403403523509, 4393.802278897393, 3298.6041674998673, 3408.8636454541543, 3412.607550131717, 3414.146463384154, 3414.402479566066, 614.695725615823, 627.3694936588699, 640.1965533255827, 642.4667525953447, 653.7581094994882, 579.901416759152, 596.6420147911218, 597.333972620525, 656.5174596671443, 660.3561527510735, 8464.873026904601, 9396.577154028086, 9783.972682868338, 9931.0, 10117.59529618807, 555.5028249716481, 629.3014753623474, 630.9747610095545, 648.2339589352681, 689.3210187964851, 4188.078622703, 4457.955420445819, 4471.374007638933, 4484.8430304939175, 4521.977390113028, 103616.0, 105796.0, 107767.46116269368, 109236.36145457825, 109578.0, 91475.0, 92061.0, 93651.53174234086, 95675.043249568, 97430.0, 59860.70069649624, 84705.0, 85062.5746871274, 85954.0, 87599.56200219085, 8578.227959483676, 8671.6097775599, 8695.478271303742, 8731.476111433334, 8784.385093043426, 48873.0, 53139.46860531345, 53967.0, 54714.72642636761, 55837.441625583226, 74834.62582687051, 76259.61870190613, 77114.843277352, 79913.0, 82687.5865620668, 10601.363918164934, 10728.302660327367, 11033.613823516138, 11232.887671123184, 11366.488508017324, 11305.208635395773, 12431.875681243071, 12433.37833108359, 12762.361881906054, 12770.68073298175, 11786.292822430682, 12063.577774777841, 12287.051107733902, 12505.187162834387, 12570.622881313575, 11982.041436685218, 11994.64016079519, 12262.26426414418, 12508.061895357703, 12547.686307842378, 11787.174897757075, 12053.216540924812, 12136.150469467053, 12340.197887137307, 12353.938230308791, 9699.466529340954, 9945.900540994788, 10053.447060411747, 10159.54282057324, 10530.947345263225, 9989.800203995734, 10184.745381365525, 10232.897671023195, 10270.948645256725, 10272.486375681037], "value": 7061.32672776197, "unit": "score"}], "name": "dromaeo_css", "value": 6963.945076928781, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 111.0, 114.0, 114.0, 113.0, 112.0, 154.0, 167.0, 135.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 139.0, 144.0, 147.0, 114.0, 109.0, 114.0, 138.0, 179.0, 109.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 181.0, 182.0, 182.0, 183.0, 184.0, 185.0, 186.0, 184.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 91.0, 64.0, 60.0, 60.0, 59.0, 85.0, 58.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 95.0, 75.0, 94.0, 100.0, 121.0, 66.0, 69.0, 91.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 83.0, 85.0, 83.0, 87.0, 83.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 115.0, 161.0, 105.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 92.0, 107.0, 82.0, 84.0, 84.0, 89.0, 83.0, 97.0, 123.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 80.0, 73.0, 73.0, 70.0, 71.0, 72.0, 71.0, 76.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 83.0, 83.0, 83.0, 82.0, 83.0, 84.0, 84.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 148.0, 151.0, 155.0, 128.0, 148.0, 154.0, 157.0, 176.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 159.0, 159.0, 168.0, 168.0, 166.0, 163.0, 165.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 88.0, 66.0, 78.0, 87.0, 88.0, 86.0, 84.0, 69.0], "value": 77.7, "unit": "score"}], "name": "kraken", "value": 1483.0, "alertThreshold": 2.0}]} 03:38:12 INFO - Return code: 0 03:38:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:12 INFO - # TBPL SUCCESS # 03:38:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:38:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:38:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:38:12 INFO - 2017-01-14 03:38:12.304 screenresolution[1970:20139] starting screenresolution argv=screenresolution get 03:38:12 INFO - 2017-01-14 03:38:12.307 screenresolution[1970:20139] Display 0: 1600x1200x32@60 03:38:12 INFO - 2017-01-14 03:38:12.313 screenresolution[1971:20142] starting screenresolution argv=screenresolution list 03:38:12 INFO - Available Modes on Display 0 03:38:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:38:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:38:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:38:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:38:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:38:12 INFO - Intel Iris: 03:38:12 INFO - Chipset Model: Intel Iris 03:38:12 INFO - Type: GPU 03:38:12 INFO - Bus: Built-In 03:38:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:38:12 INFO - Vendor: Intel (0x8086) 03:38:12 INFO - Device ID: 0x0a2e 03:38:12 INFO - Revision ID: 0x0009 03:38:12 INFO - Displays: 03:38:12 INFO - Display: 03:38:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:38:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:38:12 INFO - Display Serial Number: 1600x1200 60 03:38:12 INFO - Main Display: Yes 03:38:12 INFO - Mirror: Off 03:38:12 INFO - Online: Yes 03:38:12 INFO - Rotation: Supported 03:38:12 INFO - Return code: 0 03:38:12 INFO - Running post-action listener: _resource_record_post_action 03:38:12 INFO - [mozharness: 2017-01-14 11:38:12.558432Z] Finished run-tests step (success) 03:38:12 INFO - Running post-run listener: _resource_record_post_run 03:38:12 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 675840; Write bytes: 661664256; Read time: 8; Write time: 1943 03:38:12 INFO - TinderboxPrint: CPU usage
53.4% 03:38:12 INFO - TinderboxPrint: I/O read bytes / time
675,840 / 8 03:38:12 INFO - TinderboxPrint: I/O write bytes / time
661,664,256 / 1,943 03:38:12 INFO - TinderboxPrint: CPU idle
2,262.8 (46.6%) 03:38:12 INFO - TinderboxPrint: CPU system
970.7 (20.0%) 03:38:12 INFO - TinderboxPrint: CPU user
1,620.2 (33.4%) 03:38:12 INFO - TinderboxPrint: Swap in / out
349,732,864 / 0 03:38:12 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344091136; Write bytes: 345659392; Read time: 26809; Write time: 738 03:38:12 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 675840; Write bytes: 309049856; Read time: 8; Write time: 1175 03:38:13 INFO - Running post-run listener: _upload_blobber_files 03:38:13 INFO - Blob upload gear active. 03:38:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:13 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 03:38:13 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'] 03:38:13 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 03:38:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:38:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:38:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:14 INFO - (blobuploader) - INFO - Done attempting. 03:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:15 INFO - (blobuploader) - INFO - Done attempting. 03:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:17 INFO - (blobuploader) - INFO - Done attempting. 03:38:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:17 INFO - Return code: 0 03:38:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd793fb13428fb795baacee3ec25c79b2696dac1e89f572b8608fbc67adfd489932c52ced29934a782c3ac1c4dbe777bec5a6807a588519ff452745a930f95e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ac75e239de94138b1f2372dafc7f9558c07be7bd3401ecddbb6352399b522665f8e46b9a3c7d7f041a987d91a88a7c6b88421605a2d9c1d6b0bddfc74b0419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d00e740442485f222b6a4301399ce2f6d30ec0f9646e8c443f862c8e1d752a98baddeae590d00e7c012f98bcf5348a77ae0e4ecede96c5e671b96996b2f932b3"} 03:38:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:17 INFO - Contents: 03:38:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd793fb13428fb795baacee3ec25c79b2696dac1e89f572b8608fbc67adfd489932c52ced29934a782c3ac1c4dbe777bec5a6807a588519ff452745a930f95e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ac75e239de94138b1f2372dafc7f9558c07be7bd3401ecddbb6352399b522665f8e46b9a3c7d7f041a987d91a88a7c6b88421605a2d9c1d6b0bddfc74b0419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d00e740442485f222b6a4301399ce2f6d30ec0f9646e8c443f862c8e1d752a98baddeae590d00e7c012f98bcf5348a77ae0e4ecede96c5e671b96996b2f932b3"} 03:38:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:17 INFO - Copying logs to upload dir... 03:38:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.396805 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-14 03:38:17.589683) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 03:38:17.593274) ========= 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.nejoJTZXAT/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.dTdt2K88Ad/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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/fd793fb13428fb795baacee3ec25c79b2696dac1e89f572b8608fbc67adfd489932c52ced29934a782c3ac1c4dbe777bec5a6807a588519ff452745a930f95e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ac75e239de94138b1f2372dafc7f9558c07be7bd3401ecddbb6352399b522665f8e46b9a3c7d7f041a987d91a88a7c6b88421605a2d9c1d6b0bddfc74b0419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d00e740442485f222b6a4301399ce2f6d30ec0f9646e8c443f862c8e1d752a98baddeae590d00e7c012f98bcf5348a77ae0e4ecede96c5e671b96996b2f932b3"} build_url:https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010818 build_url: 'https://queue.taskcluster.net/v1/task/G85wfpZ5QFqUFB52mOglQg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd793fb13428fb795baacee3ec25c79b2696dac1e89f572b8608fbc67adfd489932c52ced29934a782c3ac1c4dbe777bec5a6807a588519ff452745a930f95e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ac75e239de94138b1f2372dafc7f9558c07be7bd3401ecddbb6352399b522665f8e46b9a3c7d7f041a987d91a88a7c6b88421605a2d9c1d6b0bddfc74b0419", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d00e740442485f222b6a4301399ce2f6d30ec0f9646e8c443f862c8e1d752a98baddeae590d00e7c012f98bcf5348a77ae0e4ecede96c5e671b96996b2f932b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-14 03:38:17.626198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 03:38:17.626505) ========= 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.nejoJTZXAT/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.dTdt2K88Ad/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-14 03:38:17.674292) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 03:38:17.674588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-14 03:38:17.674911) ========= ========= Total master_lag: 1.54 =========