builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1486766618.5 results: success (0) buildid: 20170210124219 builduid: 393548b62fd04a5393588ffd00896719 revision: fe1a313151e8ffec4016ec1da4c8100a9fa2d850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.502733) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.503564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.504110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.531392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.532036) ========= 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.kwGT10mSEB/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.m5YHpMZtGb/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-02-10 14:43:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.10M=0.001s 2017-02-10 14:43:38 (9.10 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093506 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.655601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.656352) ========= 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.kwGT10mSEB/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.m5YHpMZtGb/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.027537 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:38.709878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 14:43:38.710737) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fe1a313151e8ffec4016ec1da4c8100a9fa2d850 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fe1a313151e8ffec4016ec1da4c8100a9fa2d850 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kwGT10mSEB/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.m5YHpMZtGb/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-02-10 14:43:38,816 truncating revision to first 12 chars 2017-02-10 14:43:38,816 Setting DEBUG logging. 2017-02-10 14:43:38,816 attempt 1/10 2017-02-10 14:43:38,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fe1a313151e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 14:43:39,744 unpacking tar archive at: mozilla-beta-fe1a313151e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.202448 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 14:43:39.942057) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:39.942728) ========= script_repo_revision: fe1a313151e8ffec4016ec1da4c8100a9fa2d850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:39.943372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:39.943702) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 14:43:39.964107) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-10 14:43:39.964456) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kwGT10mSEB/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.m5YHpMZtGb/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:43:40 INFO - MultiFileLogger online at 20170210 14:43:40 in /builds/slave/test 14:43:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:43:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:43:40 INFO - {'append_to_log': False, 14:43:40 INFO - 'base_work_dir': '/builds/slave/test', 14:43:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:43:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:43:40 INFO - 'branch': 'Mozilla-Beta', 14:43:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:43:40 INFO - 'config_files': ('talos/mac_config.py',), 14:43:40 INFO - 'default_actions': ('clobber', 14:43:40 INFO - 'read-buildbot-config', 14:43:40 INFO - 'download-and-extract', 14:43:40 INFO - 'populate-webroot', 14:43:40 INFO - 'create-virtualenv', 14:43:40 INFO - 'install', 14:43:40 INFO - 'run-tests'), 14:43:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:43:40 INFO - 'download_minidump_stackwalk': True, 14:43:40 INFO - 'download_symbols': 'ondemand', 14:43:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:43:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:43:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:43:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:43:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:43:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:43:40 INFO - 'installer_path': 'installer.exe', 14:43:40 INFO - 'log_level': 'info', 14:43:40 INFO - 'log_name': 'talos', 14:43:40 INFO - 'log_to_console': True, 14:43:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:43:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:43:40 INFO - 'opt_config_files': (), 14:43:40 INFO - 'pip_index': False, 14:43:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:43:40 INFO - 'cmd': ('bash', 14:43:40 INFO - '-c', 14:43:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:43:40 INFO - 'enabled': True, 14:43:40 INFO - 'halt_on_failure': False, 14:43:40 INFO - 'name': 'check_screen_resolution'},), 14:43:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:43:40 INFO - 'cmd': ('bash', 14:43:40 INFO - '-c', 14:43:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:43:40 INFO - 'enabled': True, 14:43:40 INFO - 'halt_on_failure': False, 14:43:40 INFO - 'name': 'check_screen_resolution'},), 14:43:40 INFO - 'run_cmd_checks_enabled': True, 14:43:40 INFO - 'sps_profile': False, 14:43:40 INFO - 'sps_profile_interval': 0, 14:43:40 INFO - 'suite': 'dromaeojs', 14:43:40 INFO - 'system_bits': '32', 14:43:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:43:40 INFO - 'title': 't-yosemite-r7-0026', 14:43:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:43:40 INFO - 'use_talos_json': True, 14:43:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:43:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:43:40 INFO - 'work_dir': 'build'} 14:43:40 INFO - [mozharness: 2017-02-10 22:43:40.180085Z] Running clobber step. 14:43:40 INFO - Running pre-action listener: _resource_record_pre_action 14:43:40 INFO - Running main action method: clobber 14:43:40 INFO - rmtree: /builds/slave/test/build 14:43:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:43:43 INFO - Running post-action listener: _resource_record_post_action 14:43:43 INFO - [mozharness: 2017-02-10 22:43:43.212484Z] Finished clobber step (success) 14:43:43 INFO - [mozharness: 2017-02-10 22:43:43.212638Z] Running read-buildbot-config step. 14:43:43 INFO - Running pre-action listener: _resource_record_pre_action 14:43:43 INFO - Running main action method: read_buildbot_config 14:43:43 INFO - Using buildbot properties: 14:43:43 INFO - { 14:43:43 INFO - "project": "", 14:43:43 INFO - "product": "firefox", 14:43:43 INFO - "script_repo_revision": "production", 14:43:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:43:43 INFO - "repository": "", 14:43:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:43:43 INFO - "buildid": "20170210124219", 14:43:43 INFO - "pgo_build": "False", 14:43:43 INFO - "basedir": "/builds/slave/test", 14:43:43 INFO - "buildnumber": 3, 14:43:43 INFO - "slavename": "t-yosemite-r7-0026", 14:43:43 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:43:43 INFO - "platform": "yosemite_r7", 14:43:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:43:43 INFO - "branch": "mozilla-beta", 14:43:43 INFO - "repo_path": "releases/mozilla-beta", 14:43:43 INFO - "revision": "fe1a313151e8ffec4016ec1da4c8100a9fa2d850", 14:43:43 INFO - "stage_platform": "macosx64", 14:43:43 INFO - "builduid": "393548b62fd04a5393588ffd00896719", 14:43:43 INFO - "slavebuilddir": "test" 14:43:43 INFO - } 14:43:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:43:43 INFO - Running post-action listener: _resource_record_post_action 14:43:43 INFO - [mozharness: 2017-02-10 22:43:43.216840Z] Finished read-buildbot-config step (success) 14:43:43 INFO - [mozharness: 2017-02-10 22:43:43.217010Z] Running download-and-extract step. 14:43:43 INFO - Running pre-action listener: _resource_record_pre_action 14:43:43 INFO - Running main action method: download_and_extract 14:43:43 INFO - mkdir: /builds/slave/test/build/tests 14:43: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')]} 14:43:43 INFO - trying https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:43:43 INFO - Downloading https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 14:43:44 INFO - Downloaded 1165 bytes. 14:43:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:43:44 INFO - Using the following test package requirements: 14:43:44 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:43:44 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:43:44 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:43:44 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:43:44 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:43:44 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:43:44 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:43:44 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:43:44 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:43:44 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:43:44 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:43:44 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:43:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:43:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:43:44 INFO - Fetch https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:43:44 INFO - Http code: 200 14:43:44 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 14:43:44 INFO - x-amz-cf-id: VMsxGApR9V4sEWPMqk2fqiHQbMEGqQA7TWsvtCPUHCYj0-4ueXSdzA== 14:43:44 INFO - x-amz-version-id: FUr_3ZsvchabiE8U43WE3dB9Iu5akz_s 14:43:45 INFO - Expected file size: 16094070 14:43:45 INFO - Obtained file size: 16094070 14:43:51 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:43:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:43:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:43:51 INFO - Fetch https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:43:52 INFO - Http code: 200 14:43:52 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 14:43:52 INFO - x-amz-cf-id: GThzkZaUs_Qh0dSeetz29YivPT_opaYvl2HY2dHlJwHtDGtgRBKZYg== 14:43:52 INFO - x-amz-version-id: FUr_3ZsvchabiE8U43WE3dB9Iu5akz_s 14:43:52 INFO - Expected file size: 16094070 14:43:52 INFO - Obtained file size: 16094070 14:43:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:43:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:43:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:43:59 INFO - Http code: 200 14:43:59 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 14:43:59 INFO - x-amz-cf-id: TEbw-FLfPi6bia8sFBk7bvsQLfkI5zVI_TzQpSJTo_tIci5B0S7qKg== 14:43:59 INFO - x-amz-version-id: Pkb3itpa2_8R9r8LqYxVBklpJp8aJYNO 14:43:59 INFO - Expected file size: 14403005 14:43:59 INFO - Obtained file size: 14403005 14:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:00 INFO - trying https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:44:00 INFO - Downloading https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 14:44:02 INFO - Downloaded 82132005 bytes. 14:44:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:44:02 INFO - mkdir: /builds/slave/test/properties 14:44:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:44:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:44:02 INFO - Contents: 14:44:02 INFO - build_url:https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:44:03 INFO - Running post-action listener: _resource_record_post_action 14:44:03 INFO - Running post-action listener: set_extra_try_arguments 14:44:03 INFO - [mozharness: 2017-02-10 22:44:03.147673Z] Finished download-and-extract step (success) 14:44:03 INFO - [mozharness: 2017-02-10 22:44:03.147830Z] Running populate-webroot step. 14:44:03 INFO - Running pre-action listener: _resource_record_pre_action 14:44:03 INFO - Running main action method: populate_webroot 14:44:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:44:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:44:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:44:03 INFO - '--tppagecycles', 14:44:03 INFO - '7'], 14:44:03 INFO - 'tests': ['tsvgm']}}, 14:44:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:44:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:44:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:44:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:44:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:44:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:44:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['damp', 'tps']}, 14:44:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'tests': ['damp', 'tps']}, 14:44:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['dromaeo_dom']}, 14:44:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:44:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['basic_compositor_video']}, 14:44:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:44:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['a11yr', 14:44:03 INFO - 'ts_paint', 14:44:03 INFO - 'tpaint', 14:44:03 INFO - 'sessionrestore', 14:44:03 INFO - 'sessionrestore_no_auto_restore', 14:44:03 INFO - 'tabpaint']}, 14:44:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:44:03 INFO - 'ts_paint', 14:44:03 INFO - 'tpaint', 14:44:03 INFO - 'sessionrestore', 14:44:03 INFO - 'sessionrestore_no_auto_restore', 14:44:03 INFO - 'tabpaint']}, 14:44:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:44:03 INFO - 'ts_paint', 14:44:03 INFO - 'tpaint', 14:44:03 INFO - 'sessionrestore', 14:44:03 INFO - 'sessionrestore_no_auto_restore', 14:44:03 INFO - 'tabpaint']}, 14:44:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:44:03 INFO - 'ts_paint', 14:44:03 INFO - 'tpaint', 14:44:03 INFO - 'sessionrestore', 14:44:03 INFO - 'sessionrestore_no_auto_restore', 14:44:03 INFO - 'tabpaint']}, 14:44:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['a11yr', 14:44:03 INFO - 'ts_paint', 14:44:03 INFO - 'tpaint', 14:44:03 INFO - 'sessionrestore', 14:44:03 INFO - 'sessionrestore_no_auto_restore', 14:44:03 INFO - 'tabpaint']}, 14:44:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['a11yr', 14:44:03 INFO - 'ts_paint', 14:44:03 INFO - 'tpaint', 14:44:03 INFO - 'sessionrestore', 14:44:03 INFO - 'sessionrestore_no_auto_restore', 14:44:03 INFO - 'tabpaint']}, 14:44:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['tsvgx', 14:44:03 INFO - 'tsvgr_opacity', 14:44:03 INFO - 'tart', 14:44:03 INFO - 'tscrollx', 14:44:03 INFO - 'cart']}, 14:44:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:44:03 INFO - 'tsvgr_opacity', 14:44:03 INFO - 'tart', 14:44:03 INFO - 'tscrollx', 14:44:03 INFO - 'cart']}, 14:44:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'talos_options': ['--disable-e10s'], 14:44:03 INFO - 'tests': ['tp5o']}, 14:44:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'tests': ['tp5o']}, 14:44:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'talos_options': ['--disable-e10s', 14:44:03 INFO - '--xperf_path', 14:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:44:03 INFO - 'tests': ['tp5n']}, 14:44:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:03 INFO - 'talos_options': ['--xperf_path', 14:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:44:03 INFO - 'tests': ['tp5n']}}, 14:44:03 INFO - 'talos.zip': {'path': '', 14:44:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:44:03 INFO - Running post-action listener: _resource_record_post_action 14:44:03 INFO - [mozharness: 2017-02-10 22:44:03.166660Z] Finished populate-webroot step (success) 14:44:03 INFO - [mozharness: 2017-02-10 22:44:03.166797Z] Running create-virtualenv step. 14:44:03 INFO - Running pre-action listener: _resource_record_pre_action 14:44:03 INFO - Running main action method: create_virtualenv 14:44:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:44:03 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 14:44:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:44:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:44:03 INFO - Using real prefix '/tools/python27' 14:44:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:44:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:44:06 INFO - Installing pip.................done. 14:44:06 INFO - Return code: 0 14:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:44:07 INFO - Reading from file tmpfile_stdout 14:44:07 INFO - Output received: 14:44:07 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) 14:44:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:44:07 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')]} 14:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:07 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')]} 14:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:07 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:07 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 14:44:07 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 14:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:07 INFO - 'HOME': '/Users/cltbld', 14:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:07 INFO - 'LOGNAME': 'cltbld', 14:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:07 INFO - 'MOZ_NO_REMOTE': '1', 14:44:07 INFO - 'NO_EM_RESTART': '1', 14:44:07 INFO - 'PAGER': '/bin/cat', 14:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:07 INFO - 'PWD': '/builds/slave/test', 14:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:07 INFO - 'SHELL': '/bin/bash', 14:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:07 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:07 INFO - 'USER': 'cltbld', 14:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:07 INFO - 'XPC_FLAGS': '0x0', 14:44:07 INFO - 'XPC_SERVICE_NAME': '0', 14:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:07 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 14:44:07 INFO - Cleaning up... 14:44:07 INFO - Return code: 0 14:44:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:44:07 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')]} 14:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:07 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')]} 14:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:07 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:07 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 14:44:07 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 14:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:07 INFO - 'HOME': '/Users/cltbld', 14:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:07 INFO - 'LOGNAME': 'cltbld', 14:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:07 INFO - 'MOZ_NO_REMOTE': '1', 14:44:07 INFO - 'NO_EM_RESTART': '1', 14:44:07 INFO - 'PAGER': '/bin/cat', 14:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:07 INFO - 'PWD': '/builds/slave/test', 14:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:07 INFO - 'SHELL': '/bin/bash', 14:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:07 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:07 INFO - 'USER': 'cltbld', 14:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:07 INFO - 'XPC_FLAGS': '0x0', 14:44:07 INFO - 'XPC_SERVICE_NAME': '0', 14:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:07 INFO - Downloading/unpacking psutil>=3.1.1 14:44:07 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 14:44:07 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 14:44:07 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 14:44:07 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 14:44:07 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 14:44:07 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 14:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:44:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:44:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:44:11 INFO - Installing collected packages: psutil 14:44:11 INFO - Running setup.py install for psutil 14:44:11 INFO - building 'psutil._psutil_osx' extension 14:44:11 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 14:44:11 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 14:44:11 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 14:44:11 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 14:44:12 INFO - building 'psutil._psutil_posix' extension 14:44:12 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 14:44:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:44:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:44:12 INFO - ^ 14:44:12 INFO - 1 warning generated. 14:44:12 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 14:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:44:12 INFO - Successfully installed psutil 14:44:12 INFO - Cleaning up... 14:44:12 INFO - Return code: 0 14:44:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:12 INFO - 'HOME': '/Users/cltbld', 14:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:12 INFO - 'LOGNAME': 'cltbld', 14:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:12 INFO - 'MOZ_NO_REMOTE': '1', 14:44:12 INFO - 'NO_EM_RESTART': '1', 14:44:12 INFO - 'PAGER': '/bin/cat', 14:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:12 INFO - 'PWD': '/builds/slave/test', 14:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:12 INFO - 'SHELL': '/bin/bash', 14:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:12 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:12 INFO - 'USER': 'cltbld', 14:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:12 INFO - 'XPC_FLAGS': '0x0', 14:44:12 INFO - 'XPC_SERVICE_NAME': '0', 14:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:44:15 INFO - Installing collected packages: mozsystemmonitor 14:44:15 INFO - Running setup.py install for mozsystemmonitor 14:44:15 INFO - Successfully installed mozsystemmonitor 14:44:15 INFO - Cleaning up... 14:44:15 INFO - Return code: 0 14:44:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:44:15 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')]} 14:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:15 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')]} 14:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:15 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:15 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 14:44:15 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 14:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:15 INFO - 'HOME': '/Users/cltbld', 14:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:15 INFO - 'LOGNAME': 'cltbld', 14:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:15 INFO - 'MOZ_NO_REMOTE': '1', 14:44:15 INFO - 'NO_EM_RESTART': '1', 14:44:15 INFO - 'PAGER': '/bin/cat', 14:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:15 INFO - 'PWD': '/builds/slave/test', 14:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:15 INFO - 'SHELL': '/bin/bash', 14:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:15 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:15 INFO - 'USER': 'cltbld', 14:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:15 INFO - 'XPC_FLAGS': '0x0', 14:44:15 INFO - 'XPC_SERVICE_NAME': '0', 14:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:15 INFO - Downloading/unpacking jsonschema==2.5.1 14:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:44:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:44:18 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 14:44:18 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 14:44:18 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 14:44:18 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 14:44:18 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 14:44:18 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 14:44:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:44:18 INFO - warning: no files found matching '*.txt' 14:44:18 INFO - no previously-included directories found matching 'build' 14:44:18 INFO - no previously-included directories found matching 'dist' 14:44:18 INFO - no previously-included directories found matching '.git*' 14:44:18 INFO - Installing collected packages: jsonschema, functools32 14:44:18 INFO - Running setup.py install for functools32 14:44:19 INFO - warning: no files found matching '*.txt' 14:44:19 INFO - no previously-included directories found matching 'build' 14:44:19 INFO - no previously-included directories found matching 'dist' 14:44:19 INFO - no previously-included directories found matching '.git*' 14:44:19 INFO - Successfully installed jsonschema functools32 14:44:19 INFO - Cleaning up... 14:44:19 INFO - Return code: 0 14:44:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:44:19 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')]} 14:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:19 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')]} 14:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:19 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:19 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 14:44:19 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 14:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:19 INFO - 'HOME': '/Users/cltbld', 14:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:19 INFO - 'LOGNAME': 'cltbld', 14:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:19 INFO - 'MOZ_NO_REMOTE': '1', 14:44:19 INFO - 'NO_EM_RESTART': '1', 14:44:19 INFO - 'PAGER': '/bin/cat', 14:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:19 INFO - 'PWD': '/builds/slave/test', 14:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:19 INFO - 'SHELL': '/bin/bash', 14:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:19 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:19 INFO - 'USER': 'cltbld', 14:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:19 INFO - 'XPC_FLAGS': '0x0', 14:44:19 INFO - 'XPC_SERVICE_NAME': '0', 14:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:44:19 INFO - Cleaning up... 14:44:19 INFO - Return code: 0 14:44:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:44:19 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')]} 14:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:19 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')]} 14:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:19 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:19 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 14:44:19 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 14:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:19 INFO - 'HOME': '/Users/cltbld', 14:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:19 INFO - 'LOGNAME': 'cltbld', 14:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:19 INFO - 'MOZ_NO_REMOTE': '1', 14:44:19 INFO - 'NO_EM_RESTART': '1', 14:44:19 INFO - 'PAGER': '/bin/cat', 14:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:19 INFO - 'PWD': '/builds/slave/test', 14:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:19 INFO - 'SHELL': '/bin/bash', 14:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:19 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:19 INFO - 'USER': 'cltbld', 14:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:19 INFO - 'XPC_FLAGS': '0x0', 14:44:19 INFO - 'XPC_SERVICE_NAME': '0', 14:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:22 INFO - Downloading blobuploader-1.2.4.tar.gz 14:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:44:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:44:22 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 14:44:22 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 14:44:22 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 14:44:22 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 14:44:22 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 14:44:22 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 14:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:44:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:44:23 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 14:44:23 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 14:44:23 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 14:44:23 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 14:44:23 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 14:44:23 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 14:44:23 INFO - Downloading docopt-0.6.1.tar.gz 14:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:44:23 INFO - Installing collected packages: blobuploader, requests, docopt 14:44:23 INFO - Running setup.py install for blobuploader 14:44:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:44:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:44:23 INFO - Running setup.py install for requests 14:44:24 INFO - Running setup.py install for docopt 14:44:24 INFO - Successfully installed blobuploader requests docopt 14:44:24 INFO - Cleaning up... 14:44:24 INFO - Return code: 0 14:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:24 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')]} 14:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:24 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')]} 14:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:24 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:24 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 14:44:24 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 14:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:24 INFO - 'HOME': '/Users/cltbld', 14:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:24 INFO - 'LOGNAME': 'cltbld', 14:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:24 INFO - 'MOZ_NO_REMOTE': '1', 14:44:24 INFO - 'NO_EM_RESTART': '1', 14:44:24 INFO - 'PAGER': '/bin/cat', 14:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:24 INFO - 'PWD': '/builds/slave/test', 14:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:24 INFO - 'SHELL': '/bin/bash', 14:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:24 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:24 INFO - 'USER': 'cltbld', 14:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:24 INFO - 'XPC_FLAGS': '0x0', 14:44:24 INFO - 'XPC_SERVICE_NAME': '0', 14:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:44:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GAI_E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:44:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ZmHBAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:44:24 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-fBsJUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-u7VSsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-YIZ0vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-dXxQcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-NVPRZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-pOLsQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-lY0_mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0F8qzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-sQfsVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-993Dkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:44:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-JhGk0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:44:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-n1cpVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-RDg8hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:44:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HcqP2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:44:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-_Njthk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:44:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:44:26 INFO - Running setup.py install for manifestparser 14:44:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:44:26 INFO - Running setup.py install for mozcrash 14:44:26 INFO - Running setup.py install for mozdebug 14:44:26 INFO - Running setup.py install for mozdevice 14:44:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Running setup.py install for mozfile 14:44:27 INFO - Running setup.py install for mozhttpd 14:44:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Running setup.py install for mozinfo 14:44:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Running setup.py install for mozInstall 14:44:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Running setup.py install for mozleak 14:44:27 INFO - Running setup.py install for mozlog 14:44:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:44:27 INFO - Running setup.py install for moznetwork 14:44:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:44:28 INFO - Running setup.py install for mozprocess 14:44:28 INFO - Running setup.py install for mozprofile 14:44:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:44:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:44:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:44:28 INFO - Running setup.py install for mozrunner 14:44:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:44:28 INFO - Running setup.py install for mozscreenshot 14:44:28 INFO - Running setup.py install for moztest 14:44:28 INFO - Running setup.py install for mozversion 14:44:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:44:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:44:29 INFO - Cleaning up... 14:44:29 INFO - Return code: 0 14:44:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:29 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')]} 14:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:29 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')]} 14:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:29 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:29 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 14:44:29 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 14:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:29 INFO - 'HOME': '/Users/cltbld', 14:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:29 INFO - 'LOGNAME': 'cltbld', 14:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:29 INFO - 'MOZ_NO_REMOTE': '1', 14:44:29 INFO - 'NO_EM_RESTART': '1', 14:44:29 INFO - 'PAGER': '/bin/cat', 14:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:29 INFO - 'PWD': '/builds/slave/test', 14:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:29 INFO - 'SHELL': '/bin/bash', 14:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:29 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:29 INFO - 'USER': 'cltbld', 14:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:29 INFO - 'XPC_FLAGS': '0x0', 14:44:29 INFO - 'XPC_SERVICE_NAME': '0', 14:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-UOJwQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:44:29 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)) 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7gOvp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:44:29 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)) 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-EJCLPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:44:29 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)) 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7C3cAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:44:29 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)) 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-5yDg9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:44:29 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)) 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-tdcjhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:44:29 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)) 14:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:44:29 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-XRTSUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-bCUfBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-97iCRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GhgKr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-vj4BYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qZeA_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-f2TbpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gQ69Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HaIYw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:30 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)) 14:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:44:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-eeUVVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:44:31 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)) 14:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:44:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-2FBsKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:44:31 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 14:44:31 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 14:44:31 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 14:44:31 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 14:44:31 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 14:44:31 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 14:44:33 INFO - Downloading blessings-1.6.tar.gz 14:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:44:33 INFO - Installing collected packages: blessings 14:44:33 INFO - Running setup.py install for blessings 14:44:34 INFO - Successfully installed blessings 14:44:34 INFO - Cleaning up... 14:44:34 INFO - Return code: 0 14:44:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:44:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:44:34 INFO - Reading from file tmpfile_stdout 14:44:34 INFO - Current package versions: 14:44:34 INFO - blessings == 1.6 14:44:34 INFO - blobuploader == 1.2.4 14:44:34 INFO - docopt == 0.6.1 14:44:34 INFO - functools32 == 3.2.3-2 14:44:34 INFO - jsonschema == 2.5.1 14:44:34 INFO - manifestparser == 1.1 14:44:34 INFO - mozInstall == 1.12 14:44:34 INFO - mozcrash == 1.0 14:44:34 INFO - mozdebug == 0.1 14:44:34 INFO - mozdevice == 0.48 14:44:34 INFO - mozfile == 1.2 14:44:34 INFO - mozhttpd == 0.7 14:44:34 INFO - mozinfo == 0.9 14:44:34 INFO - mozleak == 0.1 14:44:34 INFO - mozlog == 3.4 14:44:34 INFO - moznetwork == 0.27 14:44:34 INFO - mozprocess == 0.23 14:44:34 INFO - mozprofile == 0.28 14:44:34 INFO - mozrunner == 6.13 14:44:34 INFO - mozscreenshot == 0.1 14:44:34 INFO - mozsystemmonitor == 0.3 14:44:34 INFO - moztest == 0.8 14:44:34 INFO - mozversion == 1.4 14:44:34 INFO - psutil == 3.1.1 14:44:34 INFO - requests == 1.2.3 14:44:34 INFO - wsgiref == 0.1.2 14:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:34 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')]} 14:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:34 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')]} 14:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:35 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 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44:35 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 14:44:35 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 14:44:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:35 INFO - 'HOME': '/Users/cltbld', 14:44:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:35 INFO - 'LOGNAME': 'cltbld', 14:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:35 INFO - 'MOZ_NO_REMOTE': '1', 14:44:35 INFO - 'NO_EM_RESTART': '1', 14:44:35 INFO - 'PAGER': '/bin/cat', 14:44:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:35 INFO - 'PWD': '/builds/slave/test', 14:44:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:35 INFO - 'SHELL': '/bin/bash', 14:44:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:35 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:35 INFO - 'USER': 'cltbld', 14:44:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:35 INFO - 'XPC_FLAGS': '0x0', 14:44:35 INFO - 'XPC_SERVICE_NAME': '0', 14:44:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 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)) 14:44:35 INFO - Cleaning up... 14:44:35 INFO - Return code: 0 14:44:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:44:35 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')]} 14:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:35 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')]} 14:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0ea490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e060570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf315946c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, '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.kwGT10mSEB/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.m5YHpMZtGb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 14:44: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', 'jsonschema'] in /builds/slave/test/build 14:44: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 jsonschema 14:44:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:36 INFO - 'HOME': '/Users/cltbld', 14:44:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:36 INFO - 'LOGNAME': 'cltbld', 14:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:36 INFO - 'MOZ_NO_REMOTE': '1', 14:44:36 INFO - 'NO_EM_RESTART': '1', 14:44:36 INFO - 'PAGER': '/bin/cat', 14:44:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:36 INFO - 'PWD': '/builds/slave/test', 14:44:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:36 INFO - 'SHELL': '/bin/bash', 14:44:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:36 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:36 INFO - 'USER': 'cltbld', 14:44:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:36 INFO - 'XPC_FLAGS': '0x0', 14:44:36 INFO - 'XPC_SERVICE_NAME': '0', 14:44:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:44:36 INFO - Cleaning up... 14:44:36 INFO - Return code: 0 14:44:36 INFO - Running post-action listener: _resource_record_post_action 14:44:36 INFO - Running post-action listener: _start_resource_monitoring 14:44:36 INFO - Starting resource monitoring. 14:44:36 INFO - [mozharness: 2017-02-10 22:44:36.526490Z] Finished create-virtualenv step (success) 14:44:36 INFO - [mozharness: 2017-02-10 22:44:36.527552Z] Running install step. 14:44:36 INFO - Running pre-action listener: _resource_record_pre_action 14:44:36 INFO - Running main action method: install 14:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:44:36 INFO - Reading from file tmpfile_stdout 14:44:36 INFO - Detecting whether we're running mozinstall >=1.0... 14:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:44:36 INFO - Reading from file tmpfile_stdout 14:44:36 INFO - Output received: 14:44:36 INFO - Usage: mozinstall [options] installer 14:44:36 INFO - Options: 14:44:36 INFO - -h, --help show this help message and exit 14:44:36 INFO - -d DEST, --destination=DEST 14:44:36 INFO - Directory to install application into. [default: 14:44:36 INFO - "/builds/slave/test"] 14:44:36 INFO - --app=APP Application being installed. [default: firefox] 14:44:36 INFO - mkdir: /builds/slave/test/build/application 14:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:44:57 INFO - Reading from file tmpfile_stdout 14:44:57 INFO - Output received: 14:44:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:44:57 INFO - Running post-action listener: _resource_record_post_action 14:44:57 INFO - [mozharness: 2017-02-10 22:44:57.871188Z] Finished install step (success) 14:44:57 INFO - [mozharness: 2017-02-10 22:44:57.871318Z] Running run-tests step. 14:44:57 INFO - Running pre-action listener: _resource_record_pre_action 14:44:57 INFO - Running main action method: run_tests 14:44:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:57 INFO - 2017-02-10 14:44:57.885 screenresolution[1626:7543] starting screenresolution argv=screenresolution get 14:44:57 INFO - 2017-02-10 14:44:57.888 screenresolution[1626:7543] Display 0: 1600x1200x32@60 14:44:57 INFO - 2017-02-10 14:44:57.894 screenresolution[1627:7545] starting screenresolution argv=screenresolution list 14:44:57 INFO - Available Modes on Display 0 14:44:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:58 INFO - Intel Iris: 14:44:58 INFO - Chipset Model: Intel Iris 14:44:58 INFO - Type: GPU 14:44:58 INFO - Bus: Built-In 14:44:58 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:58 INFO - Vendor: Intel (0x8086) 14:44:58 INFO - Device ID: 0x0a2e 14:44:58 INFO - Revision ID: 0x0009 14:44:58 INFO - Displays: 14:44:58 INFO - Display: 14:44:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:58 INFO - Display Serial Number: 1600x1200 60 14:44:58 INFO - Main Display: Yes 14:44:58 INFO - Mirror: Off 14:44:58 INFO - Online: Yes 14:44:58 INFO - Rotation: Supported 14:44:58 INFO - Return code: 0 14:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:44:58 INFO - Python 2.7.3 14:44:58 INFO - Return code: 0 14:44:58 INFO - grabbing minidump binary from tooltool 14:44: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')]} 14:44:58 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 0x10defed30>, '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 0x10dd64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10def6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:44:58 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 14:44:58 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 14:44:58 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 14:44:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:44:58 INFO - Return code: 0 14:44:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:44:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:44:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:44:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:44:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 14:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 14:44:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kwGT10mSEB/Render', 14:44:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:58 INFO - 'HOME': '/Users/cltbld', 14:44:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:58 INFO - 'LOGNAME': 'cltbld', 14:44:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:44:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:58 INFO - 'MOZ_NO_REMOTE': '1', 14:44:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:44:58 INFO - 'NO_EM_RESTART': '1', 14:44:58 INFO - 'PAGER': '/bin/cat', 14:44:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:58 INFO - 'PWD': '/builds/slave/test', 14:44:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:44:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:58 INFO - 'SHELL': '/bin/bash', 14:44:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5YHpMZtGb/Listeners', 14:44:58 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 14:44:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:58 INFO - 'USER': 'cltbld', 14:44:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:58 INFO - 'XPC_FLAGS': '0x0', 14:44:58 INFO - 'XPC_SERVICE_NAME': '0', 14:44:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 14:44:58 INFO - mozversion application_buildid: 20170210124219 14:44:58 INFO - mozversion application_changeset: fe1a313151e8ffec4016ec1da4c8100a9fa2d850 14:44:58 INFO - mozversion application_display_name: Firefox 14:44:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:44:58 INFO - mozversion application_name: Firefox 14:44:58 INFO - mozversion application_remotingname: firefox 14:44:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:44:58 INFO - mozversion application_vendor: Mozilla 14:44:58 INFO - mozversion application_version: 52.0 14:44:58 INFO - mozversion platform_buildid: 20170210124219 14:44:58 INFO - mozversion platform_changeset: fe1a313151e8ffec4016ec1da4c8100a9fa2d850 14:44:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:44:58 INFO - mozversion platform_version: 52.0 14:44:58 INFO - using testdate: 1486766698 14:44:58 INFO - actual date: 1486766698 14:44:58 INFO - starting webserver on 'localhost:49243' 14:44:58 INFO - SUITE-START | Running 2 tests 14:44:58 INFO - TEST-START | dromaeo_css 14:44:58 INFO - operating with platform_type : mac_ 14:44:58 INFO - Initialising browser for dromaeo_css test... 14:44:58 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmp6lNJL2/profile http://localhost:49243/getInfo.html) 14:45:01 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 14:45:01 INFO - PROCESS | 1637 | colorDepth:24 14:45:01 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 14:45:01 INFO - PROCESS | 1637 | __metrics 14:45:01 INFO - PROCESS | 1637 | 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" 14:45:01 INFO - PROCESS | 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:45:01 INFO - TEST-INFO | 1637: exit 0 14:45:01 INFO - Browser initialized. 14:45:01 INFO - Running cycle 1/1 for dromaeo_css test... 14:45:01 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmp6lNJL2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:45:14 INFO - PROCESS | 1640 | RSS: Main: 167673856 14:45:14 INFO - PROCESS | 1640 | 14:48:17 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 14:48:18 INFO - PROCESS | 1640 | RSS: Main: 309891072 14:48:18 INFO - PROCESS | 1640 | 14:51:21 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 14:51:22 INFO - PROCESS | 1640 | RSS: Main: 298983424 14:51:22 INFO - PROCESS | 1640 | 14:54:24 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 14:54:25 INFO - PROCESS | 1640 | RSS: Main: 284368896 14:54:25 INFO - PROCESS | 1640 | 14:57:27 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 14:57:27 INFO - PROCESS | 1640 | RSS: Main: 269946880 14:57:27 INFO - PROCESS | 1640 | 15:00:31 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 15:00:31 INFO - PROCESS | 1640 | RSS: Main: 266264576 15:00:31 INFO - PROCESS | 1640 | 15:03:34 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 15:03:35 INFO - PROCESS | 1640 | RSS: Main: 362360832 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | __start_tp_report 15:03:35 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 15:03:35 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 15:03:35 INFO - PROCESS | 1640 | |i|pagename|runs| 15:03:35 INFO - PROCESS | 1640 | |0;dojo.html;3503.7021853142483;3504.5444092268017;3517.3317069756736;3538.23927855511;3549.5563054618174;5766.19273301737;5779.913301300484;5810.099434587646;5851.180834683148;5853.7365818538165;5767.913481297784;5836.445537673914;5844.561657875655;5851.4148585141465;5886.087656413263;5220.399654039796;5236.581073514129;5272.23552584875;5278.973605131969;5333.786648534054;4731.172044892147;4731.952680473203;5215.86960325993;5221.347331583552;5232.816851410202;5248.921266181011;5322.387925388572;5325.520703136717;5365.382980957201;5381.031414345416;4812.422509298906;5008.447381311768;5309.654872433299;5321.2284218788445;5336.252924590561;5071.670341427795;5189.974050129763;5269.973650131763;5270.077736396153;5285.894282114336;5718.714064296769;5802;5823.621464604787;5826.650400975913;5889.1460738193155;6106.551676171935;6143.32423433422;6187.81436556904;6259.561830671855;6274.435300822902;6258;6293.811185664437;6303.905441418382;6312.873742525169;6317.557770956035;5739.311282646067;5825.417458254183;5878.529717622666;5889.146073819358;5945.524358051432;6340.270868850049;6371.108044873721;6373.267074286517;6378.266499352541;6385.2656944451055;6266.154069200691;6272.372762723782;6273.686315684289;6282.340354262828;6290.308066112724;5252.947470525246;6185.103160041769;6224.657643829632;6224.751009959641;6311.274203466568;6264.812055638338;6281.3404592518045;6287.654179020198;6288.968555157195;6307.905381419282;6236.563440559208;6284.402981716729;6293.716782744787;6307.842303942346;6313.621182729051;4952.579030782424;5032.220005899091;5037.748112594356;5066.746662666852;5095.566876815438;4555.703879247838;4569;4574.839880604163;4590.97704511482;4605.309203619484;5939.910901336483;6013.729382177812;6017.819465416044;6085.330613632497;6088.939110608926;6255.655938923403;6294.748210071637;6298.716557754912;6300.086487459293;6300.527460440485;5989.580729348903;6055.636661800306;6065.60573562717;6070.484008859208;6088.634681919099;5422.240886275846;5473.425290344536;5482.533984611353;5529.198266251371;5582.162675598693;6371.39471750183;6402.231732192166;6415.230172379344;6415.582987105823;6431.356864313531;6217.440430361289;6250.031245157008;6264.029075493306;6266.060090986389;6283.497320214463;5472.50747432733;6230.968845155927;6281.560290779602;6287.2769631492965;6448.871022579428;6161.969190154021;6259.718312675849;6285.340039295808;6285.622862628257;6294.244690637152;6267.96866015667;6273.811785646438;6276.905846412399;6286.4342209201395;6291.150694656163;5375.5162035417;6011.338752737282;6132;6235.501159907106;6243.344448832989;6135.508280839814;6136.1821086261625;6143.327652471189;6245.469135123383;6256.718447669775;5132.204508301219;6128.356522565066;6129.877402451837;6131.724072416841;6134.877302454015;6069.332373439007;6196.008638617799;6222.222222222223;6241.375862413723;6250.4374606285655;6003.279606447254;6067.939320606737;6082.695865206811;6098.288304407531;6160.507159427146 15:03:35 INFO - PROCESS | 1640 | |1;ext.html;475.5007242395484;490.79631952739595;491.44221308814497;491.64847134299015;562.9107676645693;28303;33864.49203261953;34068.14829629257;34086.31827363451;34150.82924585373;34455;35095;35138.47292290618;35139.12152196196;35152;8311.877896483973;9624.759381015461;9684.951575242148;9864.802703945918;9868.161206297473;9554.856677149848;9628.855567166464;9641.566129524188;9644.083812037845;9659.90340096597;9064.728058158233;9626.470544120071;9678.661246856362;9680;9682.12860842524;9001.459912405244;11380.71548211293;11624.011958983412;11650.533978640844;11898.524059037629;11713.824292635618;11778;11785.410729463492;11809.527618895234;11830.408479576074;41444;41775.58224417747;41788.79105604483;41804.1639167218;41958.951026224284;3315.336932613487;3696;3965.722399432041;3991.48323637019;3996.220736956295;26587.601185982225;30775.692243077505;31703;31754.206144846565;32193;3260.9021729348156;3307.7684562080663;3314.784539004957;3337.632860385356;3395.303962687668;536910;538608;541647;541823;544973.2751336257;35059.12352191165;35073.29853402918;35085.82457087749;37232.44151337732;64336.71326573536;36591.63408365935;36893.446598301045;37036.44445333268;37078.44382334267;37160.44259336112;15268;15398.923005385126;15419.92290038565;15428.922855385652;15429.459968901034;12882.549110781078;12992;13028.609141725574;13036.478540858448;13161.144525605805;7067.964660176666;8126.75619731409;8145.06331771842;8221.17788221185;8233.629486673113;3123.46901026826;3149.88975385865;3240.4977228529615;3304.273059926812;3327.8003319800405;938.2634631813993;974.4153507895206;975.7316737897135;1012.6050840172338;1028.7273872423814;29499;30216.244593885327;30468.085957421314;31009.534856977163;31053;931.5514375146712;990.3117333453325;996.4170959988343;1031.1647565471992;1068.188176985481;15182.316795744218;15888.682226355408;15977.281022354022;16159.842894548832;16167.919160404123;692626;697158.5142074258;698297;699237.5038124777;699902;60997.69501152466;61497;61592.69203653953;61755.36834737323;61767;1354.8848347890344;1373.3339330424735;1400.88792896566;1403.9368228429746;1406.4936622815778;29615.407691846474;30187;30536.541951871182;30702.692973069985;30708.454824928802;50641.493585063676;54153.45846541484;54210.186847196535;54255.45744542662;54349.72825135849;626809;632254;633459;634672;635317;27914.02300919458;28234.71765282403;28295.01934864622;28305.57541636836;28324.716752832206;47826.5217347822;47896;48173.27740083831;49234.50765492299;49697.75151124221;39220.01949951274;40471.19057618772;40978.38532421956;41972.3704144432;42174.578254217064;39216.01959951024;39666.60333396745;40531.09644115726;41227;41355;39121;39900.40149397819;40090.599094009856;40097.39853902136;40134;33763.493547596314;34723.65276347305;34895.65104348924;34960.73983598017;35396.29207415786;25955.091571794896;26197.476050479265;26426.471470570865;26431.471370572865;26809.597856032564 15:03:35 INFO - PROCESS | 1640 | |2;jquery.html;365.14920235850474;380.2869619463506;384.18360982911315;395.8634271176444;416.7124683968062;13027.372398876267;15043.774343384845;17099.914500427512;20176.69734953977;20848.583028339424;19805.306814261505;20238.988050597483;20299.49251268719;20423.18307267711;21011.36965891026;5082.644214904958;5178.5339319461245;5354.036273470773;5379.865503362427;5383.569314454854;4734.526547345273;5963.970180149093;6030.608010479326;6049.697515124226;6057.485113765335;5303.23103150043;5913.586048976574;5994.100884867261;6000.399960004008;6013.308469525995;5189.42916279209;5353.357597088336;5356.143017117262;5360.088784906537;5369.275147855029;5011.473795251519;5160;5220.060389129955;5225.555827754645;5225.88351717555;13111.016673749411;13230.801537976939;13231.338433078308;13243.205407675474;16625.7506137408;2352.917647882316;2375.3942744600017;2381.6308472186665;2401.327628264089;2944.2344990302463;10290.897091029143;10381.480925953747;10454.738631534197;10470.057694807429;12776.297303648296;1783.629362812073;1804.539842340208;1826.8903865768095;1848.1036697201846;1909.847212223019;119286;120374.3981280088;125665;127045.36477317646;129348.35325823404;11160.665180044612;11437.542498300141;11529.942350288362;11584.76830463386;11782.351970641526;14717.632059198606;14756.114633122046;14757.77863332051;14774.187419691805;14778.408863645549;8459.746207613658;8581.313494920392;8735.650573977096;8764.298856091498;8774.25418839393;8614.483131012033;8651.697190598425;8682.609282582172;8789.956050219707;8814.898137732784;4218.535961044283;4262.65898728101;4492.865214043519;4556.088782243564;4648.372469716545;1580.8893377463467;1902.6004539046678;1904.3620387170176;1924;1932.3140285198551;859.8022454835423;891.7681402835179;937.3672770879765;939.1688355805162;1005.934614250086;20320.593588128155;21115.472113197295;21128.943552822297;21164.682529762067;21308.467288317916;918.5590916360185;947.3699989507038;987.7925635616601;1003.2776400991421;1008.82345589523;10766.89233107659;11340;11375.829362559569;11396.544138234378;11456.541738330374;581761;587168;588533;590832;592670;79949.60025199837;105013;106123.87752244913;114198.85801142048;129793;927.9118483744033;961.7980224152866;978.574320170728;978.7504186432557;981.9509024548887;19021.809781902004;19234.519137021685;19498.830070195832;19688.704669429684;19734.30929917446;54769.72615136899;55828;56372.436275638356;57218;57318;79534.75188590461;81192;81336;82250.58874705828;83364;6044.486218671462;6192.938070619416;6593.406593406617;7396.96301518489;7658.846823063619;10879.891201088205;12935.094543381872;12975.156614820007;13434.529791457253;13592.11651242666;5585.944140558705;10919.563217471212;11023.746727959326;11541.769164616828;11543.422828858356;11149.888501114885;11175.49710263024;11574.768504630028;11608.24546404481;11697.941510292734;11336.886631133582;11474.770504589695;11733.765324693288;11866.940665296619;11976.640700778991;7286.672099755418;7413.777586672409;7499.700011999459;7590.051243594551;7696.191899850435;10672;11230.719232019264;11234.213605047567;11408.486618102039;11482.483288251882 15:03:35 INFO - PROCESS | 1640 | |3;mootools.html;1339.9732005359892;1496.8278647955485;1647.5963388969703;1813.6735387630238;1869.9906500467505;7987.24121208485;8355.83288334233;8408.789780255496;8412.327013838894;8450.788730281745;7494.887576686354;7712.652930618122;7756.069271687391;7818.569978651172;8267.586620668957;1813.2293775145577;2288.702468679069;2368.0409434179187;2372.3120295114395;2378.583747844129;2368.526294741059;2398.4243781492405;2408.9879550602222;2409.2170044735444;2411.2043025801445;2353.988230058856;2375.762423757628;2378.7621237876247;2380.809535237177;2388.450656349041;2323.2449453927456;2360.8229382796358;2361.2207971369407;2361.9409514762183;2364.066193853418;2018.777934427212;2370.146747171017;2391.414103544643;2393.1384701507445;2398.292503711409;8348.373871959628;8392.076871544125;8412;8415.705450309271;8416.074231834493;5042.672226305279;5220.425753167148;5225.111731005738;5225.294585230983;5250.7112108834;3398.1844357354303;3478;3539.592946811124;3597.4244120940525;3601.963980360189;1045.6653870761359;1077.3668558264703;1110.0952723530297;1113.1984970820995;1118.4072441605963;10989.61536346232;11013.944930275296;11026.503807328689;11028.44857757109;11047.779044419067;4601.907961840744;4761.952380476151;4774.188387974053;4778.1399348117675;4814.350062741485;8704.564771761387;8735.43219690718;8743.91256087431;8748.650053997897;8752.956235218782;5095.235714642759;5100.158473851847;5106.821261255838;5108.131617625013;5111.233315002779;4367.039251364695;4658.883527911761;4750.952490475051;4800.807967681323;4828.227483602606;3483.4600636901323;3650.4341827016856;3688.8524459021337;3747.6508456955476;3752.099496120911;1147.6442302885964;1164.4119719541748;1164.5225457562358;1169.2461308037944;1171.3908767441053;825.4345773145415;860.0968982568278;868.5309932636432;904.6381447421085;906.4425378392241;5437.564994800486;5550.333959924835;5631.239782629293;5735.081947571566;5758.798442054592;906.3429013964823;919.8482250428738;919.94480331179;921.4839689773748;931.8322701913585;3622.311760765499;3704.8518059277326;3712.8514859405323;3831.693464522887;3846.1922996171115;9594.904050959542;9947.502624868728;10132.696019119438;10234.02776736209;10304.433256170983;10164;10165.644202452879;10180.490975451197;10188.745281367877;10189.898101019044;7569.735059272899;7938.841223175619;7973.8405231896195;7979.880301795478;8008.679652813938;5315.096433606219;5328.920066199088;5428.267183930119;5446.019716451076;5627.493525582553;7893.802654933443;9343.672971445967;9419.858702119336;9425.245980321695;9573.138417542455;9536.284778641491;9537.380070295687;9624.903750962401;9627.9037209627;9726.610935562781;6330.493560515056;6706.295838936841;6838.487113466609;6851.212110607344;6881.483888708267;7396.852062958818;7487.737929172453;7641.503302285556;7898.723544675909;7997.280244777998;6872.381485666314;6954.756583519553;7031.929680703332;7036.683349249399;7091.43268538526;6877.931220687729;6905.205901321412;6924.134483189601;6952.617606031717;6955.408790252885;6440.6135631862235;6546.509011824228;6632.137822083098;6637;6702.162229721285;4608.3778689876435;4646.628269738345;4671.486136525047;4722.669413141047;4747;4636.513166117644;4687.921777991013;4709.3642358281195;4724.8660321523275;4891.804327826847 15:03:35 INFO - PROCESS | 1640 | |4;prototype.html;311.34928000479;320.52882263073275;322.0242664725881;325.2616560407873;328.4859195359261;5384.757685904134;5458.253358925141;5481.835544933653;5488.094464413377;5501.0648189807725;4491.730496170232;5075.416327122372;5151.356080489939;5312.548433383167;5368.62419630626;3823.21624067067;3827.9043023924487;4033.7579745215235;4033.8588149414777;4035.2333056719276;4033.1127152026506;4051.7163798534116;4065.959340406602;4082.7754473503946;4117.9176416471655;3370.2643138783546;4001.379786133154;4002.839886404555;4025.838966441339;4059.7564146151326;3799.2211596622624;3966;3990.2618015667194;4033.5159780826193;4079.6940229482757;3017.8682993877296;3447.465642825366;3448.499967504698;3460.3944309745943;3475.2528206435736;5106.693598384071;5135;5135.512126347991;5194.948050519484;5256.92114618281;3898.766074035567;4011.859584914514;4338.891527711832;4586.449626044862;4608.548307283195;4612.58486736192;4618.884527886829;5441.20440254715;5537.667739935617;5609.467100625434;3516.8241587920757;3879.86420475282;3885.941710874311;3901.1807520420743;3943.861964831217;4783.784729687138;5931.288245410536;5934.703264836784;5970.313413957364;6008;3795.69634429245;3816.5038544988975;3816.790076545761;3820.29324574949;3822.3310920589342;3315.8507867146036;3605.7656252343513;3821.6815198756385;3897.629725176104;3935.665468435215;4036.354183330653;4556.681032327705;4581.908361832745;4632.5830675239395;4641.605463535638;4823;5236.869078273074;5574.989505666895;5586.16207568868;5587.832365029056;1258.1318889965894;1275.9664671616022;1290.2452065541763;1296.5219649599464;1306.4643496166525;763.2367632367632;826.3306721555559;872.625614656918;880.4673172730534;884.9380543361902;4114.794260286973;4518.887027824265;4834.59796658972;4876.878078048077;4892.584130348889;5236.978789136158;5360.758765855546;5400.648957817729;5658.34928983164;5794.797976768801;4537.500874903758;5136.5377116059735;5213.374395072616;5293.708846013429;5333.946660533423;2459.643351714027;2885.8124221925927;2916.9270768230963;2922.240217543454;2923.9181502844085;5696.487316141567;5705.115707065412;5716.742746576414;5727.684977326204;5806;4799.880002999953;4852.56326930578;5405.991862902231;5515.834524964257;5523.619095226193;4598.517155698603;5615;5621;5692.0323544997445;5734.340550836624;4585.9312110317705;4743;5133.358330208724;5400.675959442446;5515.4760297771645;4442.068234964908;4897.191963326011;5078.847634570969;5358.812441564683;5367.940274043757;5570.721463926869;5603.551715862803;5617.269754931833;5621.690807005654;5635.88728225425;3163.3550553712403;3345.8791304913125;3358.9328213435106;3611.476335931328;3629.4555816627717;4758.643101767312;5079.771410286472;5525.563353528031;5855.443732845373;5860.38465961068;4693.812247510062;4895.755212239445;4964.950350496449;5431.076716958048;5695.487406133468;5307.377353539611;5644.238027866186;5675.77296908119;5681.659100453986;5694;5420.810271640474;5493.835184944458;5503.284573005483;5513.365962914316;5537.418571049981;5324.733763311897;5340.305760251143;5481.862953426037;5661.867626474804;5695.487406133468;4868.9756551217015;5444.455554444524;5556.472135147154;5578.330600327824;5605.663660180402 15:03:35 INFO - PROCESS | 1640 | |5;yui.html;713.9286071392861;729.7227053719586;763.9923600763992;790.0795573157272;796.5300472721093;14288.214148221843;15265.38938442461;15339;15339.156346400943;15339.539813805575;13814.378352974116;13855.307234638278;13880.37538310776;14013.719725605508;14026.929865350685;707.23265257196;726.6584705188553;856.1866227084264;859.9957000215006;873.8427083125035;858.1247127929508;874.9650013999465;875.6278581602793;875.8029443375253;877.4121338703085;925.4169872980046;926.0276709455045;926.8146370725848;928.0116675740315;929.3540989012639;919.269181001099;920.4707293306376;920.8434566123808;921.387277460488;922.4280945813572;689.7206631314275;690.2131570010192;690.6788343420334;690.9309069093101;692.6121372031628;12091.576794812227;13619.863801361958;13738.10702304347;13743.450261989508;13768.24274664893;14193.574192774233;14371.771088903466;14409.495667651687;14448.927755361261;14487.565373038826;11608.825867611993;11665.941670291595;11787.823182652268;11805.173637845353;11871.881281187163;3688.704903607705;3716.1081340478363;3729.2541491701495;3965.088029753144;3969.3450580654157;86423;93196;93469.0653093474;94272;94341;10691.625793097204;10793.514291856885;10917.39954302521;11103.500342484607;11351.318920864775;21573.67639485409;21759.45601359947;21970.780292196872;21980.230691925706;21985.23051693183;7852.489588176751;7861.489003214772;7933.484323518953;7944.801379965547;7959.880601790977;4080.836766529365;4298.312270036779;4341.869743907688;4393.758343291086;4546.1135078659345;3434.261633748756;3524.735644826597;3525.7355698322726;3528.5412896323314;3536.1866770642896;619.4177473175201;647.0359164844348;661.7253839656489;662.5627086123136;664.6078813500059;553.7509208581142;632.9651869147241;659.947204223661;679.5888487465013;685.540687739216;6746.392824645805;8870.556472176366;8922.598483068148;9067.909320906838;9153.450792952444;473.74417814380536;487.39319547164007;514.0720998597567;554.4372461951123;577.5754820207144;4422.09347083847;4431.977840110843;4446.444194475691;4456.15333086719;4551.635869130461;119481;122088;122780;125134.37432812777;128700;103773.48113259385;104406;107396.92603074026;109340;109402.45298773615;91359;95860;97096.0290397087;97599;99516;8569.400141990001;8642.395032347928;8722.433041852259;8744.91255087441;8875.112488751074;50547.2417913739;51688.483115169875;52993.7350313246;53126.734366327924;58493.4150658488;67759;72502.27497724956;74005.62997184979;74947.62526187334;80898;12279;12733.872661273268;12785.680357991125;13074.542391016268;13212.801807972695;14654.706905862036;14723.852761472677;14753.631159221106;15432.151231682365;15487.457938972082;12890.35548222604;13526.661833454242;13709;13790.448382064606;14408.85591144075;12223.266604003788;12999.285039322549;13495.865041349854;13640.386182622004;13990.440382384591;12870.420831062438;12992;13189.736205276033;13244.337783110614;13669.179849209078;10597.735056623646;10966.096311882196;10966.287191332538;11241.943790280997;11873.52505899789;11184.608538701106;11585.975966158408;11595.304281743123;11638.243514171552;11651.941740291244 15:03:35 INFO - PROCESS | 1640 | __end_tp_report 15:03:35 INFO - PROCESS | 1640 | __start_cc_report 15:03:35 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1506 15:03:35 INFO - PROCESS | 1640 | __end_cc_report 15:03:35 INFO - PROCESS | 1640 | __startTimestamp1486767815060__endTimestamp 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | ------- Summary: start ------- 15:03:35 INFO - PROCESS | 1640 | Number of tests: 6 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5812.55 Median:6088.63 stddev:637.12 (10.5%) stddev-sans-first:612.78 15:03:35 INFO - PROCESS | 1640 | Values: 3503.7 3504.5 3517.3 3538.2 3549.6 5766.2 5779.9 5810.1 5851.2 5853.7 5767.9 5836.4 5844.6 5851.4 5886.1 5220.4 5236.6 5272.2 5279.0 5333.8 4731.2 4732.0 5215.9 5221.3 5232.8 5248.9 5322.4 5325.5 5365.4 5381.0 4812.4 5008.4 5309.7 5321.2 5336.3 5071.7 5190.0 5270.0 5270.1 5285.9 5718.7 5802.0 5823.6 5826.7 5889.1 6106.6 6143.3 6187.8 6259.6 6274.4 6258.0 6293.8 6303.9 6312.9 6317.6 5739.3 5825.4 5878.5 5889.1 5945.5 6340.3 6371.1 6373.3 6378.3 6385.3 6266.2 6272.4 6273.7 6282.3 6290.3 5252.9 6185.1 6224.7 6224.8 6311.3 6264.8 6281.3 6287.7 6289.0 6307.9 6236.6 6284.4 6293.7 6307.8 6313.6 4952.6 5032.2 5037.7 5066.7 5095.6 4555.7 4569.0 4574.8 4591.0 4605.3 5939.9 6013.7 6017.8 6085.3 6088.9 6255.7 6294.7 6298.7 6300.1 6300.5 5989.6 6055.6 6065.6 6070.5 6088.6 5422.2 5473.4 5482.5 5529.2 5582.2 6371.4 6402.2 6415.2 6415.6 6431.4 6217.4 6250.0 6264.0 6266.1 6283.5 5472.5 6231.0 6281.6 6287.3 6448.9 6162.0 6259.7 6285.3 6285.6 6294.2 6268.0 6273.8 6276.9 6286.4 6291.2 5375.5 6011.3 6132.0 6235.5 6243.3 6135.5 6136.2 6143.3 6245.5 6256.7 5132.2 6128.4 6129.9 6131.7 6134.9 6069.3 6196.0 6222.2 6241.4 6250.4 6003.3 6067.9 6082.7 6098.3 6160.5 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:73396.35 Median:37057.44 stddev:168214.35 (453.9%) stddev-sans-first:168597.14 15:03:35 INFO - PROCESS | 1640 | Values: 475.5 490.8 491.4 491.6 562.9 28303.0 33864.5 34068.1 34086.3 34150.8 34455.0 35095.0 35138.5 35139.1 35152.0 8311.9 9624.8 9685.0 9864.8 9868.2 9554.9 9628.9 9641.6 9644.1 9659.9 9064.7 9626.5 9678.7 9680.0 9682.1 9001.5 11380.7 11624.0 11650.5 11898.5 11713.8 11778.0 11785.4 11809.5 11830.4 41444.0 41775.6 41788.8 41804.2 41959.0 3315.3 3696.0 3965.7 3991.5 3996.2 26587.6 30775.7 31703.0 31754.2 32193.0 3260.9 3307.8 3314.8 3337.6 3395.3 536910.0 538608.0 541647.0 541823.0 544973.3 35059.1 35073.3 35085.8 37232.4 64336.7 36591.6 36893.4 37036.4 37078.4 37160.4 15268.0 15398.9 15419.9 15428.9 15429.5 12882.5 12992.0 13028.6 13036.5 13161.1 7068.0 8126.8 8145.1 8221.2 8233.6 3123.5 3149.9 3240.5 3304.3 3327.8 938.3 974.4 975.7 1012.6 1028.7 29499.0 30216.2 30468.1 31009.5 31053.0 931.6 990.3 996.4 1031.2 1068.2 15182.3 15888.7 15977.3 16159.8 16167.9 692626.0 697158.5 698297.0 699237.5 699902.0 60997.7 61497.0 61592.7 61755.4 61767.0 1354.9 1373.3 1400.9 1403.9 1406.5 29615.4 30187.0 30536.5 30702.7 30708.5 50641.5 54153.5 54210.2 54255.5 54349.7 626809.0 632254.0 633459.0 634672.0 635317.0 27914.0 28234.7 28295.0 28305.6 28324.7 47826.5 47896.0 48173.3 49234.5 49697.8 39220.0 40471.2 40978.4 41972.4 42174.6 39216.0 39666.6 40531.1 41227.0 41355.0 39121.0 39900.4 40090.6 40097.4 40134.0 33763.5 34723.7 34895.7 34960.7 35396.3 25955.1 26197.5 26426.5 26431.5 26809.6 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:34106.09 Median:11830.69 stddev:98104.17 (829.2%) stddev-sans-first:98346.67 15:03:35 INFO - PROCESS | 1640 | Values: 365.1 380.3 384.2 395.9 416.7 13027.4 15043.8 17099.9 20176.7 20848.6 19805.3 20239.0 20299.5 20423.2 21011.4 5082.6 5178.5 5354.0 5379.9 5383.6 4734.5 5964.0 6030.6 6049.7 6057.5 5303.2 5913.6 5994.1 6000.4 6013.3 5189.4 5353.4 5356.1 5360.1 5369.3 5011.5 5160.0 5220.1 5225.6 5225.9 13111.0 13230.8 13231.3 13243.2 16625.8 2352.9 2375.4 2381.6 2401.3 2944.2 10290.9 10381.5 10454.7 10470.1 12776.3 1783.6 1804.5 1826.9 1848.1 1909.8 119286.0 120374.4 125665.0 127045.4 129348.4 11160.7 11437.5 11529.9 11584.8 11782.4 14717.6 14756.1 14757.8 14774.2 14778.4 8459.7 8581.3 8735.7 8764.3 8774.3 8614.5 8651.7 8682.6 8790.0 8814.9 4218.5 4262.7 4492.9 4556.1 4648.4 1580.9 1902.6 1904.4 1924.0 1932.3 859.8 891.8 937.4 939.2 1005.9 20320.6 21115.5 21128.9 21164.7 21308.5 918.6 947.4 987.8 1003.3 1008.8 10766.9 11340.0 11375.8 11396.5 11456.5 581761.0 587168.0 588533.0 590832.0 592670.0 79949.6 105013.0 106123.9 114198.9 129793.0 927.9 961.8 978.6 978.8 982.0 19021.8 19234.5 19498.8 19688.7 19734.3 54769.7 55828.0 56372.4 57218.0 57318.0 79534.8 81192.0 81336.0 82250.6 83364.0 6044.5 6192.9 6593.4 7397.0 7658.8 10879.9 12935.1 12975.2 13434.5 13592.1 5585.9 10919.6 11023.7 11541.8 11543.4 11149.9 11175.5 11574.8 11608.2 11697.9 11336.9 11474.8 11733.8 11866.9 11976.6 7286.7 7413.8 7499.7 7590.1 7696.2 10672.0 11230.7 11234.2 11408.5 11482.5 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5404.17 Median:5103.49 stddev:2952.16 (57.8%) stddev-sans-first:2944.64 15:03:35 INFO - PROCESS | 1640 | Values: 1340.0 1496.8 1647.6 1813.7 1870.0 7987.2 8355.8 8408.8 8412.3 8450.8 7494.9 7712.7 7756.1 7818.6 8267.6 1813.2 2288.7 2368.0 2372.3 2378.6 2368.5 2398.4 2409.0 2409.2 2411.2 2354.0 2375.8 2378.8 2380.8 2388.5 2323.2 2360.8 2361.2 2361.9 2364.1 2018.8 2370.1 2391.4 2393.1 2398.3 8348.4 8392.1 8412.0 8415.7 8416.1 5042.7 5220.4 5225.1 5225.3 5250.7 3398.2 3478.0 3539.6 3597.4 3602.0 1045.7 1077.4 1110.1 1113.2 1118.4 10989.6 11013.9 11026.5 11028.4 11047.8 4601.9 4762.0 4774.2 4778.1 4814.4 8704.6 8735.4 8743.9 8748.7 8753.0 5095.2 5100.2 5106.8 5108.1 5111.2 4367.0 4658.9 4751.0 4800.8 4828.2 3483.5 3650.4 3688.9 3747.7 3752.1 1147.6 1164.4 1164.5 1169.2 1171.4 825.4 860.1 868.5 904.6 906.4 5437.6 5550.3 5631.2 5735.1 5758.8 906.3 919.8 919.9 921.5 931.8 3622.3 3704.9 3712.9 3831.7 3846.2 9594.9 9947.5 10132.7 10234.0 10304.4 10164.0 10165.6 10180.5 10188.7 10189.9 7569.7 7938.8 7973.8 7979.9 8008.7 5315.1 5328.9 5428.3 5446.0 5627.5 7893.8 9343.7 9419.9 9425.2 9573.1 9536.3 9537.4 9624.9 9627.9 9726.6 6330.5 6706.3 6838.5 6851.2 6881.5 7396.9 7487.7 7641.5 7898.7 7997.3 6872.4 6954.8 7031.9 7036.7 7091.4 6877.9 6905.2 6924.1 6952.6 6955.4 6440.6 6546.5 6632.1 6637.0 6702.2 4608.4 4646.6 4671.5 4722.7 4747.0 4636.5 4687.9 4709.4 4724.9 4891.8 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4443.40 Median:4896.47 stddev:1368.50 (27.9%) stddev-sans-first:1336.73 15:03:35 INFO - PROCESS | 1640 | Values: 311.3 320.5 322.0 325.3 328.5 5384.8 5458.3 5481.8 5488.1 5501.1 4491.7 5075.4 5151.4 5312.5 5368.6 3823.2 3827.9 4033.8 4033.9 4035.2 4033.1 4051.7 4066.0 4082.8 4117.9 3370.3 4001.4 4002.8 4025.8 4059.8 3799.2 3966.0 3990.3 4033.5 4079.7 3017.9 3447.5 3448.5 3460.4 3475.3 5106.7 5135.0 5135.5 5194.9 5256.9 3898.8 4011.9 4338.9 4586.4 4608.5 4612.6 4618.9 5441.2 5537.7 5609.5 3516.8 3879.9 3885.9 3901.2 3943.9 4783.8 5931.3 5934.7 5970.3 6008.0 3795.7 3816.5 3816.8 3820.3 3822.3 3315.9 3605.8 3821.7 3897.6 3935.7 4036.4 4556.7 4581.9 4632.6 4641.6 4823.0 5236.9 5575.0 5586.2 5587.8 1258.1 1276.0 1290.2 1296.5 1306.5 763.2 826.3 872.6 880.5 884.9 4114.8 4518.9 4834.6 4876.9 4892.6 5237.0 5360.8 5400.6 5658.3 5794.8 4537.5 5136.5 5213.4 5293.7 5333.9 2459.6 2885.8 2916.9 2922.2 2923.9 5696.5 5705.1 5716.7 5727.7 5806.0 4799.9 4852.6 5406.0 5515.8 5523.6 4598.5 5615.0 5621.0 5692.0 5734.3 4585.9 4743.0 5133.4 5400.7 5515.5 4442.1 4897.2 5078.8 5358.8 5367.9 5570.7 5603.6 5617.3 5621.7 5635.9 3163.4 3345.9 3358.9 3611.5 3629.5 4758.6 5079.8 5525.6 5855.4 5860.4 4693.8 4895.8 4965.0 5431.1 5695.5 5307.4 5644.2 5675.8 5681.7 5694.0 5420.8 5493.8 5503.3 5513.4 5537.4 5324.7 5340.3 5481.9 5661.9 5695.5 4869.0 5444.5 5556.5 5578.3 5605.7 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:21849.88 Median:4189.57 stddev:32884.67 (784.9%) stddev-sans-first:32938.62 15:03:35 INFO - PROCESS | 1640 | Values: 713.9 729.7 764.0 790.1 796.5 14288.2 15265.4 15339.0 15339.2 15339.5 13814.4 13855.3 13880.4 14013.7 14026.9 707.2 726.7 856.2 860.0 873.8 858.1 875.0 875.6 875.8 877.4 925.4 926.0 926.8 928.0 929.4 919.3 920.5 920.8 921.4 922.4 689.7 690.2 690.7 690.9 692.6 12091.6 13619.9 13738.1 13743.5 13768.2 14193.6 14371.8 14409.5 14448.9 14487.6 11608.8 11665.9 11787.8 11805.2 11871.9 3688.7 3716.1 3729.3 3965.1 3969.3 86423.0 93196.0 93469.1 94272.0 94341.0 10691.6 10793.5 10917.4 11103.5 11351.3 21573.7 21759.5 21970.8 21980.2 21985.2 7852.5 7861.5 7933.5 7944.8 7959.9 4080.8 4298.3 4341.9 4393.8 4546.1 3434.3 3524.7 3525.7 3528.5 3536.2 619.4 647.0 661.7 662.6 664.6 553.8 633.0 659.9 679.6 685.5 6746.4 8870.6 8922.6 9067.9 9153.5 473.7 487.4 514.1 554.4 577.6 4422.1 4432.0 4446.4 4456.2 4551.6 119481.0 122088.0 122780.0 125134.4 128700.0 103773.5 104406.0 107396.9 109340.0 109402.5 91359.0 95860.0 97096.0 97599.0 99516.0 8569.4 8642.4 8722.4 8744.9 8875.1 50547.2 51688.5 52993.7 53126.7 58493.4 67759.0 72502.3 74005.6 74947.6 80898.0 12279.0 12733.9 12785.7 13074.5 13212.8 14654.7 14723.9 14753.6 15432.2 15487.5 12890.4 13526.7 13709.0 13790.4 14408.9 12223.3 12999.3 13495.9 13640.4 13990.4 12870.4 12992.0 13189.7 13244.3 13669.2 10597.7 10966.1 10966.3 11241.9 11873.5 11184.6 11586.0 11595.3 11638.2 11651.9 15:03:35 INFO - PROCESS | 1640 | -------- Summary: end -------- 15:03:35 INFO - PROCESS | 1640 | 15:03:35 INFO - TEST-INFO | 1640: exit 0 15:03:35 INFO - TEST-OK | dromaeo_css | took 1117195ms 15:03:35 INFO - TEST-START | kraken 15:03:35 INFO - operating with platform_type : mac_ 15:03:35 INFO - Initialising browser for kraken test... 15:03:35 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmp3r2ocr/profile http://localhost:49243/getInfo.html) 15:03:37 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 15:03:37 INFO - PROCESS | 1649 | colorDepth:24 15:03:37 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 15:03:37 INFO - PROCESS | 1649 | __metrics 15:03:38 INFO - PROCESS | 1649 | 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" 15:03:38 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:03:38 INFO - TEST-INFO | 1649: exit 0 15:03:38 INFO - Browser initialized. 15:03:38 INFO - Running cycle 1/1 for kraken test... 15:03:38 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmp3r2ocr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:51 INFO - PROCESS | 1651 | RSS: Main: 167780352 15:03:51 INFO - PROCESS | 1651 | 15:03:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 15:03:54 INFO - PROCESS | 1651 | RSS: Main: 218247168 15:03:54 INFO - PROCESS | 1651 | 15:03:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 15:03:58 INFO - PROCESS | 1651 | RSS: Main: 231616512 15:03:58 INFO - PROCESS | 1651 | 15:04:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 15:04:01 INFO - PROCESS | 1651 | RSS: Main: 327782400 15:04:01 INFO - PROCESS | 1651 | 15:04:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 15:04:04 INFO - PROCESS | 1651 | RSS: Main: 231649280 15:04:04 INFO - PROCESS | 1651 | 15:04:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:04:07 INFO - PROCESS | 1651 | RSS: Main: 232882176 15:04:07 INFO - PROCESS | 1651 | 15:04:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 15:04:10 INFO - PROCESS | 1651 | RSS: Main: 274759680 15:04:10 INFO - PROCESS | 1651 | 15:04:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 15:04:13 INFO - PROCESS | 1651 | RSS: Main: 273797120 15:04:13 INFO - PROCESS | 1651 | 15:04:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 15:04:17 INFO - PROCESS | 1651 | RSS: Main: 271958016 15:04:17 INFO - PROCESS | 1651 | 15:04:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:04:19 INFO - PROCESS | 1651 | RSS: Main: 248565760 15:04:19 INFO - PROCESS | 1651 | 15:04:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:04:21 INFO - PROCESS | 1651 | RSS: Main: 249769984 15:04:21 INFO - PROCESS | 1651 | 15:04:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:04:24 INFO - PROCESS | 1651 | RSS: Main: 251920384 15:04:24 INFO - PROCESS | 1651 | 15:04:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:04:28 INFO - PROCESS | 1651 | RSS: Main: 262574080 15:04:28 INFO - PROCESS | 1651 | 15:04:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:04:31 INFO - PROCESS | 1651 | RSS: Main: 262766592 15:04:31 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 15:04:33 INFO - PROCESS | 1651 | RSS: Main: 306503680 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | __start_tp_report 15:04:33 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 15:04:33 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 15:04:33 INFO - PROCESS | 1651 | |i|pagename|runs| 15:04:33 INFO - PROCESS | 1651 | |0;ai-astar;103;113;112;112;112;111;113;111;112;114 15:04:33 INFO - PROCESS | 1651 | |1;audio-beat-detection;143;108;117;141;135;136;138;132;138;109 15:04:33 INFO - PROCESS | 1651 | |2;audio-dft;183;185;183;185;186;183;181;184;184;185 15:04:33 INFO - PROCESS | 1651 | |3;audio-fft;83;53;73;101;86;81;110;61;81;57 15:04:33 INFO - PROCESS | 1651 | |4;audio-oscillator;87;68;92;69;67;69;88;68;98;121 15:04:33 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;83;86;84;86;83;86;83;85;83 15:04:33 INFO - PROCESS | 1651 | |6;imaging-darkroom;92;92;98;89;132;121;93;93;92;108 15:04:33 INFO - PROCESS | 1651 | |7;imaging-desaturate;84;84;81;81;80;80;82;82;80;85 15:04:33 INFO - PROCESS | 1651 | |8;json-parse-financial;55;51;52;53;58;58;57;57;55;56 15:04:33 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;69;74;72;78;76;72;72;74;73;73 15:04:33 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;84;81;80;82;79;79;79;81;81;82 15:04:33 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;144;144;138;134;136;135;136;143;191;161 15:04:33 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;160;169;162;160;160;157;165;161;160;160 15:04:33 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;63;66;66;65;64 15:04:33 INFO - PROCESS | 1651 | __end_tp_report 15:04:33 INFO - PROCESS | 1651 | __start_cc_report 15:04:33 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1838 15:04:33 INFO - PROCESS | 1651 | __end_cc_report 15:04:33 INFO - PROCESS | 1651 | __startTimestamp1486767873466__endTimestamp 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | ------- Summary: start ------- 15:04:33 INFO - PROCESS | 1651 | Number of tests: 14 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:0.97 15:04:33 INFO - PROCESS | 1651 | Values: 103.0 113.0 112.0 112.0 112.0 111.0 113.0 111.0 112.0 114.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:137.00 stddev:13.23 (9.7%) stddev-sans-first:13.13 15:04:33 INFO - PROCESS | 1651 | Values: 143.0 108.0 117.0 141.0 135.0 136.0 138.0 132.0 138.0 109.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.45 (0.8%) stddev-sans-first:1.50 15:04:33 INFO - PROCESS | 1651 | Values: 183.0 185.0 183.0 185.0 186.0 183.0 181.0 184.0 184.0 185.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:78.60 Median:77.00 stddev:18.37 (23.9%) stddev-sans-first:19.41 15:04:33 INFO - PROCESS | 1651 | Values: 83.0 53.0 73.0 101.0 86.0 81.0 110.0 61.0 81.0 57.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:78.00 stddev:17.91 (23.0%) stddev-sans-first:18.93 15:04:33 INFO - PROCESS | 1651 | Values: 87.0 68.0 92.0 69.0 67.0 69.0 88.0 68.0 98.0 121.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:84.70 Median:85.50 stddev:1.77 (2.1%) stddev-sans-first:1.41 15:04:33 INFO - PROCESS | 1651 | Values: 88.0 83.0 86.0 84.0 86.0 83.0 86.0 83.0 85.0 83.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:101.00 Median:92.00 stddev:14.66 (15.9%) stddev-sans-first:15.18 15:04:33 INFO - PROCESS | 1651 | Values: 92.0 92.0 98.0 89.0 132.0 121.0 93.0 93.0 92.0 108.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:81.90 Median:82.00 stddev:1.85 (2.3%) stddev-sans-first:1.80 15:04:33 INFO - PROCESS | 1651 | Values: 84.0 84.0 81.0 81.0 80.0 80.0 82.0 82.0 80.0 85.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.50 stddev:2.49 (4.4%) stddev-sans-first:2.64 15:04:33 INFO - PROCESS | 1651 | Values: 55.0 51.0 52.0 53.0 58.0 58.0 57.0 57.0 55.0 56.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:73.50 stddev:2.45 (3.3%) stddev-sans-first:2.05 15:04:33 INFO - PROCESS | 1651 | Values: 69.0 74.0 72.0 78.0 76.0 72.0 72.0 74.0 73.0 73.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:1.62 (2.0%) stddev-sans-first:1.24 15:04:33 INFO - PROCESS | 1651 | Values: 84.0 81.0 80.0 82.0 79.0 79.0 79.0 81.0 81.0 82.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:143.50 stddev:17.62 (12.3%) stddev-sans-first:18.68 15:04:33 INFO - PROCESS | 1651 | Values: 144.0 144.0 138.0 134.0 136.0 135.0 136.0 143.0 191.0 161.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:160.50 stddev:3.34 (2.1%) stddev-sans-first:3.50 15:04:33 INFO - PROCESS | 1651 | Values: 160.0 169.0 162.0 160.0 160.0 157.0 165.0 161.0 160.0 160.0 15:04:33 INFO - PROCESS | 1651 | 15:04:33 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 15:04:33 INFO - PROCESS | 1651 | Values: 67.0 67.0 66.0 66.0 66.0 63.0 66.0 66.0 65.0 64.0 15:04:33 INFO - PROCESS | 1651 | -------- Summary: end -------- 15:04:33 INFO - PROCESS | 1651 | 15:04:34 INFO - TEST-INFO | 1651: exit 0 15:04:34 INFO - TEST-OK | kraken | took 58807ms 15:04:34 INFO - SUITE-END | took 1176s 15:04:34 INFO - Completed test suite (00:19:36) 15:04:34 INFO - javascript benchmark 15:04:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3503.7021853142483, 3504.5444092268017, 3517.3317069756736, 3538.23927855511, 3549.5563054618174, 5766.19273301737, 5779.913301300484, 5810.099434587646, 5851.180834683148, 5853.7365818538165, 5767.913481297784, 5836.445537673914, 5844.561657875655, 5851.4148585141465, 5886.087656413263, 5220.399654039796, 5236.581073514129, 5272.23552584875, 5278.973605131969, 5333.786648534054, 4731.172044892147, 4731.952680473203, 5215.86960325993, 5221.347331583552, 5232.816851410202, 5248.921266181011, 5322.387925388572, 5325.520703136717, 5365.382980957201, 5381.031414345416, 4812.422509298906, 5008.447381311768, 5309.654872433299, 5321.2284218788445, 5336.252924590561, 5071.670341427795, 5189.974050129763, 5269.973650131763, 5270.077736396153, 5285.894282114336, 5718.714064296769, 5802.0, 5823.621464604787, 5826.650400975913, 5889.1460738193155, 6106.551676171935, 6143.32423433422, 6187.81436556904, 6259.561830671855, 6274.435300822902, 6258.0, 6293.811185664437, 6303.905441418382, 6312.873742525169, 6317.557770956035, 5739.311282646067, 5825.417458254183, 5878.529717622666, 5889.146073819358, 5945.524358051432, 6340.270868850049, 6371.108044873721, 6373.267074286517, 6378.266499352541, 6385.2656944451055, 6266.154069200691, 6272.372762723782, 6273.686315684289, 6282.340354262828, 6290.308066112724, 5252.947470525246, 6185.103160041769, 6224.657643829632, 6224.751009959641, 6311.274203466568, 6264.812055638338, 6281.3404592518045, 6287.654179020198, 6288.968555157195, 6307.905381419282, 6236.563440559208, 6284.402981716729, 6293.716782744787, 6307.842303942346, 6313.621182729051, 4952.579030782424, 5032.220005899091, 5037.748112594356, 5066.746662666852, 5095.566876815438, 4555.703879247838, 4569.0, 4574.839880604163, 4590.97704511482, 4605.309203619484, 5939.910901336483, 6013.729382177812, 6017.819465416044, 6085.330613632497, 6088.939110608926, 6255.655938923403, 6294.748210071637, 6298.716557754912, 6300.086487459293, 6300.527460440485, 5989.580729348903, 6055.636661800306, 6065.60573562717, 6070.484008859208, 6088.634681919099, 5422.240886275846, 5473.425290344536, 5482.533984611353, 5529.198266251371, 5582.162675598693, 6371.39471750183, 6402.231732192166, 6415.230172379344, 6415.582987105823, 6431.356864313531, 6217.440430361289, 6250.031245157008, 6264.029075493306, 6266.060090986389, 6283.497320214463, 5472.50747432733, 6230.968845155927, 6281.560290779602, 6287.2769631492965, 6448.871022579428, 6161.969190154021, 6259.718312675849, 6285.340039295808, 6285.622862628257, 6294.244690637152, 6267.96866015667, 6273.811785646438, 6276.905846412399, 6286.4342209201395, 6291.150694656163, 5375.5162035417, 6011.338752737282, 6132.0, 6235.501159907106, 6243.344448832989, 6135.508280839814, 6136.1821086261625, 6143.327652471189, 6245.469135123383, 6256.718447669775, 5132.204508301219, 6128.356522565066, 6129.877402451837, 6131.724072416841, 6134.877302454015, 6069.332373439007, 6196.008638617799, 6222.222222222223, 6241.375862413723, 6250.4374606285655, 6003.279606447254, 6067.939320606737, 6082.695865206811, 6098.288304407531, 6160.507159427146], "value": 5773.799611240482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.5007242395484, 490.79631952739595, 491.44221308814497, 491.64847134299015, 562.9107676645693, 28303.0, 33864.49203261953, 34068.14829629257, 34086.31827363451, 34150.82924585373, 34455.0, 35095.0, 35138.47292290618, 35139.12152196196, 35152.0, 8311.877896483973, 9624.759381015461, 9684.951575242148, 9864.802703945918, 9868.161206297473, 9554.856677149848, 9628.855567166464, 9641.566129524188, 9644.083812037845, 9659.90340096597, 9064.728058158233, 9626.470544120071, 9678.661246856362, 9680.0, 9682.12860842524, 9001.459912405244, 11380.71548211293, 11624.011958983412, 11650.533978640844, 11898.524059037629, 11713.824292635618, 11778.0, 11785.410729463492, 11809.527618895234, 11830.408479576074, 41444.0, 41775.58224417747, 41788.79105604483, 41804.1639167218, 41958.951026224284, 3315.336932613487, 3696.0, 3965.722399432041, 3991.48323637019, 3996.220736956295, 26587.601185982225, 30775.692243077505, 31703.0, 31754.206144846565, 32193.0, 3260.9021729348156, 3307.7684562080663, 3314.784539004957, 3337.632860385356, 3395.303962687668, 536910.0, 538608.0, 541647.0, 541823.0, 544973.2751336257, 35059.12352191165, 35073.29853402918, 35085.82457087749, 37232.44151337732, 64336.71326573536, 36591.63408365935, 36893.446598301045, 37036.44445333268, 37078.44382334267, 37160.44259336112, 15268.0, 15398.923005385126, 15419.92290038565, 15428.922855385652, 15429.459968901034, 12882.549110781078, 12992.0, 13028.609141725574, 13036.478540858448, 13161.144525605805, 7067.964660176666, 8126.75619731409, 8145.06331771842, 8221.17788221185, 8233.629486673113, 3123.46901026826, 3149.88975385865, 3240.4977228529615, 3304.273059926812, 3327.8003319800405, 938.2634631813993, 974.4153507895206, 975.7316737897135, 1012.6050840172338, 1028.7273872423814, 29499.0, 30216.244593885327, 30468.085957421314, 31009.534856977163, 31053.0, 931.5514375146712, 990.3117333453325, 996.4170959988343, 1031.1647565471992, 1068.188176985481, 15182.316795744218, 15888.682226355408, 15977.281022354022, 16159.842894548832, 16167.919160404123, 692626.0, 697158.5142074258, 698297.0, 699237.5038124777, 699902.0, 60997.69501152466, 61497.0, 61592.69203653953, 61755.36834737323, 61767.0, 1354.8848347890344, 1373.3339330424735, 1400.88792896566, 1403.9368228429746, 1406.4936622815778, 29615.407691846474, 30187.0, 30536.541951871182, 30702.692973069985, 30708.454824928802, 50641.493585063676, 54153.45846541484, 54210.186847196535, 54255.45744542662, 54349.72825135849, 626809.0, 632254.0, 633459.0, 634672.0, 635317.0, 27914.02300919458, 28234.71765282403, 28295.01934864622, 28305.57541636836, 28324.716752832206, 47826.5217347822, 47896.0, 48173.27740083831, 49234.50765492299, 49697.75151124221, 39220.01949951274, 40471.19057618772, 40978.38532421956, 41972.3704144432, 42174.578254217064, 39216.01959951024, 39666.60333396745, 40531.09644115726, 41227.0, 41355.0, 39121.0, 39900.40149397819, 40090.599094009856, 40097.39853902136, 40134.0, 33763.493547596314, 34723.65276347305, 34895.65104348924, 34960.73983598017, 35396.29207415786, 25955.091571794896, 26197.476050479265, 26426.471470570865, 26431.471370572865, 26809.597856032564], "value": 19007.849864465705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.14920235850474, 380.2869619463506, 384.18360982911315, 395.8634271176444, 416.7124683968062, 13027.372398876267, 15043.774343384845, 17099.914500427512, 20176.69734953977, 20848.583028339424, 19805.306814261505, 20238.988050597483, 20299.49251268719, 20423.18307267711, 21011.36965891026, 5082.644214904958, 5178.5339319461245, 5354.036273470773, 5379.865503362427, 5383.569314454854, 4734.526547345273, 5963.970180149093, 6030.608010479326, 6049.697515124226, 6057.485113765335, 5303.23103150043, 5913.586048976574, 5994.100884867261, 6000.399960004008, 6013.308469525995, 5189.42916279209, 5353.357597088336, 5356.143017117262, 5360.088784906537, 5369.275147855029, 5011.473795251519, 5160.0, 5220.060389129955, 5225.555827754645, 5225.88351717555, 13111.016673749411, 13230.801537976939, 13231.338433078308, 13243.205407675474, 16625.7506137408, 2352.917647882316, 2375.3942744600017, 2381.6308472186665, 2401.327628264089, 2944.2344990302463, 10290.897091029143, 10381.480925953747, 10454.738631534197, 10470.057694807429, 12776.297303648296, 1783.629362812073, 1804.539842340208, 1826.8903865768095, 1848.1036697201846, 1909.847212223019, 119286.0, 120374.3981280088, 125665.0, 127045.36477317646, 129348.35325823404, 11160.665180044612, 11437.542498300141, 11529.942350288362, 11584.76830463386, 11782.351970641526, 14717.632059198606, 14756.114633122046, 14757.77863332051, 14774.187419691805, 14778.408863645549, 8459.746207613658, 8581.313494920392, 8735.650573977096, 8764.298856091498, 8774.25418839393, 8614.483131012033, 8651.697190598425, 8682.609282582172, 8789.956050219707, 8814.898137732784, 4218.535961044283, 4262.65898728101, 4492.865214043519, 4556.088782243564, 4648.372469716545, 1580.8893377463467, 1902.6004539046678, 1904.3620387170176, 1924.0, 1932.3140285198551, 859.8022454835423, 891.7681402835179, 937.3672770879765, 939.1688355805162, 1005.934614250086, 20320.593588128155, 21115.472113197295, 21128.943552822297, 21164.682529762067, 21308.467288317916, 918.5590916360185, 947.3699989507038, 987.7925635616601, 1003.2776400991421, 1008.82345589523, 10766.89233107659, 11340.0, 11375.829362559569, 11396.544138234378, 11456.541738330374, 581761.0, 587168.0, 588533.0, 590832.0, 592670.0, 79949.60025199837, 105013.0, 106123.87752244913, 114198.85801142048, 129793.0, 927.9118483744033, 961.7980224152866, 978.574320170728, 978.7504186432557, 981.9509024548887, 19021.809781902004, 19234.519137021685, 19498.830070195832, 19688.704669429684, 19734.30929917446, 54769.72615136899, 55828.0, 56372.436275638356, 57218.0, 57318.0, 79534.75188590461, 81192.0, 81336.0, 82250.58874705828, 83364.0, 6044.486218671462, 6192.938070619416, 6593.406593406617, 7396.96301518489, 7658.846823063619, 10879.891201088205, 12935.094543381872, 12975.156614820007, 13434.529791457253, 13592.11651242666, 5585.944140558705, 10919.563217471212, 11023.746727959326, 11541.769164616828, 11543.422828858356, 11149.888501114885, 11175.49710263024, 11574.768504630028, 11608.24546404481, 11697.941510292734, 11336.886631133582, 11474.770504589695, 11733.765324693288, 11866.940665296619, 11976.640700778991, 7286.672099755418, 7413.777586672409, 7499.700011999459, 7590.051243594551, 7696.191899850435, 10672.0, 11230.719232019264, 11234.213605047567, 11408.486618102039, 11482.483288251882], "value": 9283.721279079457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.9732005359892, 1496.8278647955485, 1647.5963388969703, 1813.6735387630238, 1869.9906500467505, 7987.24121208485, 8355.83288334233, 8408.789780255496, 8412.327013838894, 8450.788730281745, 7494.887576686354, 7712.652930618122, 7756.069271687391, 7818.569978651172, 8267.586620668957, 1813.2293775145577, 2288.702468679069, 2368.0409434179187, 2372.3120295114395, 2378.583747844129, 2368.526294741059, 2398.4243781492405, 2408.9879550602222, 2409.2170044735444, 2411.2043025801445, 2353.988230058856, 2375.762423757628, 2378.7621237876247, 2380.809535237177, 2388.450656349041, 2323.2449453927456, 2360.8229382796358, 2361.2207971369407, 2361.9409514762183, 2364.066193853418, 2018.777934427212, 2370.146747171017, 2391.414103544643, 2393.1384701507445, 2398.292503711409, 8348.373871959628, 8392.076871544125, 8412.0, 8415.705450309271, 8416.074231834493, 5042.672226305279, 5220.425753167148, 5225.111731005738, 5225.294585230983, 5250.7112108834, 3398.1844357354303, 3478.0, 3539.592946811124, 3597.4244120940525, 3601.963980360189, 1045.6653870761359, 1077.3668558264703, 1110.0952723530297, 1113.1984970820995, 1118.4072441605963, 10989.61536346232, 11013.944930275296, 11026.503807328689, 11028.44857757109, 11047.779044419067, 4601.907961840744, 4761.952380476151, 4774.188387974053, 4778.1399348117675, 4814.350062741485, 8704.564771761387, 8735.43219690718, 8743.91256087431, 8748.650053997897, 8752.956235218782, 5095.235714642759, 5100.158473851847, 5106.821261255838, 5108.131617625013, 5111.233315002779, 4367.039251364695, 4658.883527911761, 4750.952490475051, 4800.807967681323, 4828.227483602606, 3483.4600636901323, 3650.4341827016856, 3688.8524459021337, 3747.6508456955476, 3752.099496120911, 1147.6442302885964, 1164.4119719541748, 1164.5225457562358, 1169.2461308037944, 1171.3908767441053, 825.4345773145415, 860.0968982568278, 868.5309932636432, 904.6381447421085, 906.4425378392241, 5437.564994800486, 5550.333959924835, 5631.239782629293, 5735.081947571566, 5758.798442054592, 906.3429013964823, 919.8482250428738, 919.94480331179, 921.4839689773748, 931.8322701913585, 3622.311760765499, 3704.8518059277326, 3712.8514859405323, 3831.693464522887, 3846.1922996171115, 9594.904050959542, 9947.502624868728, 10132.696019119438, 10234.02776736209, 10304.433256170983, 10164.0, 10165.644202452879, 10180.490975451197, 10188.745281367877, 10189.898101019044, 7569.735059272899, 7938.841223175619, 7973.8405231896195, 7979.880301795478, 8008.679652813938, 5315.096433606219, 5328.920066199088, 5428.267183930119, 5446.019716451076, 5627.493525582553, 7893.802654933443, 9343.672971445967, 9419.858702119336, 9425.245980321695, 9573.138417542455, 9536.284778641491, 9537.380070295687, 9624.903750962401, 9627.9037209627, 9726.610935562781, 6330.493560515056, 6706.295838936841, 6838.487113466609, 6851.212110607344, 6881.483888708267, 7396.852062958818, 7487.737929172453, 7641.503302285556, 7898.723544675909, 7997.280244777998, 6872.381485666314, 6954.756583519553, 7031.929680703332, 7036.683349249399, 7091.43268538526, 6877.931220687729, 6905.205901321412, 6924.134483189601, 6952.617606031717, 6955.408790252885, 6440.6135631862235, 6546.509011824228, 6632.137822083098, 6637.0, 6702.162229721285, 4608.3778689876435, 4646.628269738345, 4671.486136525047, 4722.669413141047, 4747.0, 4636.513166117644, 4687.921777991013, 4709.3642358281195, 4724.8660321523275, 4891.804327826847], "value": 4392.797048665127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.34928000479, 320.52882263073275, 322.0242664725881, 325.2616560407873, 328.4859195359261, 5384.757685904134, 5458.253358925141, 5481.835544933653, 5488.094464413377, 5501.0648189807725, 4491.730496170232, 5075.416327122372, 5151.356080489939, 5312.548433383167, 5368.62419630626, 3823.21624067067, 3827.9043023924487, 4033.7579745215235, 4033.8588149414777, 4035.2333056719276, 4033.1127152026506, 4051.7163798534116, 4065.959340406602, 4082.7754473503946, 4117.9176416471655, 3370.2643138783546, 4001.379786133154, 4002.839886404555, 4025.838966441339, 4059.7564146151326, 3799.2211596622624, 3966.0, 3990.2618015667194, 4033.5159780826193, 4079.6940229482757, 3017.8682993877296, 3447.465642825366, 3448.499967504698, 3460.3944309745943, 3475.2528206435736, 5106.693598384071, 5135.0, 5135.512126347991, 5194.948050519484, 5256.92114618281, 3898.766074035567, 4011.859584914514, 4338.891527711832, 4586.449626044862, 4608.548307283195, 4612.58486736192, 4618.884527886829, 5441.20440254715, 5537.667739935617, 5609.467100625434, 3516.8241587920757, 3879.86420475282, 3885.941710874311, 3901.1807520420743, 3943.861964831217, 4783.784729687138, 5931.288245410536, 5934.703264836784, 5970.313413957364, 6008.0, 3795.69634429245, 3816.5038544988975, 3816.790076545761, 3820.29324574949, 3822.3310920589342, 3315.8507867146036, 3605.7656252343513, 3821.6815198756385, 3897.629725176104, 3935.665468435215, 4036.354183330653, 4556.681032327705, 4581.908361832745, 4632.5830675239395, 4641.605463535638, 4823.0, 5236.869078273074, 5574.989505666895, 5586.16207568868, 5587.832365029056, 1258.1318889965894, 1275.9664671616022, 1290.2452065541763, 1296.5219649599464, 1306.4643496166525, 763.2367632367632, 826.3306721555559, 872.625614656918, 880.4673172730534, 884.9380543361902, 4114.794260286973, 4518.887027824265, 4834.59796658972, 4876.878078048077, 4892.584130348889, 5236.978789136158, 5360.758765855546, 5400.648957817729, 5658.34928983164, 5794.797976768801, 4537.500874903758, 5136.5377116059735, 5213.374395072616, 5293.708846013429, 5333.946660533423, 2459.643351714027, 2885.8124221925927, 2916.9270768230963, 2922.240217543454, 2923.9181502844085, 5696.487316141567, 5705.115707065412, 5716.742746576414, 5727.684977326204, 5806.0, 4799.880002999953, 4852.56326930578, 5405.991862902231, 5515.834524964257, 5523.619095226193, 4598.517155698603, 5615.0, 5621.0, 5692.0323544997445, 5734.340550836624, 4585.9312110317705, 4743.0, 5133.358330208724, 5400.675959442446, 5515.4760297771645, 4442.068234964908, 4897.191963326011, 5078.847634570969, 5358.812441564683, 5367.940274043757, 5570.721463926869, 5603.551715862803, 5617.269754931833, 5621.690807005654, 5635.88728225425, 3163.3550553712403, 3345.8791304913125, 3358.9328213435106, 3611.476335931328, 3629.4555816627717, 4758.643101767312, 5079.771410286472, 5525.563353528031, 5855.443732845373, 5860.38465961068, 4693.812247510062, 4895.755212239445, 4964.950350496449, 5431.076716958048, 5695.487406133468, 5307.377353539611, 5644.238027866186, 5675.77296908119, 5681.659100453986, 5694.0, 5420.810271640474, 5493.835184944458, 5503.284573005483, 5513.365962914316, 5537.418571049981, 5324.733763311897, 5340.305760251143, 5481.862953426037, 5661.867626474804, 5695.487406133468, 4868.9756551217015, 5444.455554444524, 5556.472135147154, 5578.330600327824, 5605.663660180402], "value": 4011.017650495098, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9286071392861, 729.7227053719586, 763.9923600763992, 790.0795573157272, 796.5300472721093, 14288.214148221843, 15265.38938442461, 15339.0, 15339.156346400943, 15339.539813805575, 13814.378352974116, 13855.307234638278, 13880.37538310776, 14013.719725605508, 14026.929865350685, 707.23265257196, 726.6584705188553, 856.1866227084264, 859.9957000215006, 873.8427083125035, 858.1247127929508, 874.9650013999465, 875.6278581602793, 875.8029443375253, 877.4121338703085, 925.4169872980046, 926.0276709455045, 926.8146370725848, 928.0116675740315, 929.3540989012639, 919.269181001099, 920.4707293306376, 920.8434566123808, 921.387277460488, 922.4280945813572, 689.7206631314275, 690.2131570010192, 690.6788343420334, 690.9309069093101, 692.6121372031628, 12091.576794812227, 13619.863801361958, 13738.10702304347, 13743.450261989508, 13768.24274664893, 14193.574192774233, 14371.771088903466, 14409.495667651687, 14448.927755361261, 14487.565373038826, 11608.825867611993, 11665.941670291595, 11787.823182652268, 11805.173637845353, 11871.881281187163, 3688.704903607705, 3716.1081340478363, 3729.2541491701495, 3965.088029753144, 3969.3450580654157, 86423.0, 93196.0, 93469.0653093474, 94272.0, 94341.0, 10691.625793097204, 10793.514291856885, 10917.39954302521, 11103.500342484607, 11351.318920864775, 21573.67639485409, 21759.45601359947, 21970.780292196872, 21980.230691925706, 21985.23051693183, 7852.489588176751, 7861.489003214772, 7933.484323518953, 7944.801379965547, 7959.880601790977, 4080.836766529365, 4298.312270036779, 4341.869743907688, 4393.758343291086, 4546.1135078659345, 3434.261633748756, 3524.735644826597, 3525.7355698322726, 3528.5412896323314, 3536.1866770642896, 619.4177473175201, 647.0359164844348, 661.7253839656489, 662.5627086123136, 664.6078813500059, 553.7509208581142, 632.9651869147241, 659.947204223661, 679.5888487465013, 685.540687739216, 6746.392824645805, 8870.556472176366, 8922.598483068148, 9067.909320906838, 9153.450792952444, 473.74417814380536, 487.39319547164007, 514.0720998597567, 554.4372461951123, 577.5754820207144, 4422.09347083847, 4431.977840110843, 4446.444194475691, 4456.15333086719, 4551.635869130461, 119481.0, 122088.0, 122780.0, 125134.37432812777, 128700.0, 103773.48113259385, 104406.0, 107396.92603074026, 109340.0, 109402.45298773615, 91359.0, 95860.0, 97096.0290397087, 97599.0, 99516.0, 8569.400141990001, 8642.395032347928, 8722.433041852259, 8744.91255087441, 8875.112488751074, 50547.2417913739, 51688.483115169875, 52993.7350313246, 53126.734366327924, 58493.4150658488, 67759.0, 72502.27497724956, 74005.62997184979, 74947.62526187334, 80898.0, 12279.0, 12733.872661273268, 12785.680357991125, 13074.542391016268, 13212.801807972695, 14654.706905862036, 14723.852761472677, 14753.631159221106, 15432.151231682365, 15487.457938972082, 12890.35548222604, 13526.661833454242, 13709.0, 13790.448382064606, 14408.85591144075, 12223.266604003788, 12999.285039322549, 13495.865041349854, 13640.386182622004, 13990.440382384591, 12870.420831062438, 12992.0, 13189.736205276033, 13244.337783110614, 13669.179849209078, 10597.735056623646, 10966.096311882196, 10966.287191332538, 11241.943790280997, 11873.52505899789, 11184.608538701106, 11585.975966158408, 11595.304281743123, 11638.243514171552, 11651.941740291244], "value": 7507.93485588, "unit": "score"}], "name": "dromaeo_css", "value": 7160.551715488878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 112.0, 111.0, 113.0, 111.0, 112.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 117.0, 141.0, 135.0, 136.0, 138.0, 132.0, 138.0, 109.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 183.0, 185.0, 186.0, 183.0, 181.0, 184.0, 184.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 53.0, 73.0, 101.0, 86.0, 81.0, 110.0, 61.0, 81.0, 57.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 68.0, 92.0, 69.0, 67.0, 69.0, 88.0, 68.0, 98.0, 121.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 86.0, 84.0, 86.0, 83.0, 86.0, 83.0, 85.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 98.0, 89.0, 132.0, 121.0, 93.0, 93.0, 92.0, 108.0], "value": 101.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 81.0, 81.0, 80.0, 80.0, 82.0, 82.0, 80.0, 85.0], "value": 81.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 52.0, 53.0, 58.0, 58.0, 57.0, 57.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 72.0, 78.0, 76.0, 72.0, 72.0, 74.0, 73.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 80.0, 82.0, 79.0, 79.0, 79.0, 81.0, 81.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 138.0, 134.0, 136.0, 135.0, 136.0, 143.0, 191.0, 161.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 169.0, 162.0, 160.0, 160.0, 157.0, 165.0, 161.0, 160.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 63.0, 66.0, 66.0, 65.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1436.3000000000002, "alertThreshold": 2.0}]} 15:04:34 INFO - Return code: 0 15:04:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:04:34 INFO - # TBPL SUCCESS # 15:04:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:04:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:04:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:04:34 INFO - 2017-02-10 15:04:34.790 screenresolution[1655:10001] starting screenresolution argv=screenresolution get 15:04:34 INFO - 2017-02-10 15:04:34.793 screenresolution[1655:10001] Display 0: 1600x1200x32@60 15:04:34 INFO - 2017-02-10 15:04:34.799 screenresolution[1656:10004] starting screenresolution argv=screenresolution list 15:04:34 INFO - Available Modes on Display 0 15:04:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:04:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:04:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:04:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:04:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:04:35 INFO - Intel Iris: 15:04:35 INFO - Chipset Model: Intel Iris 15:04:35 INFO - Type: GPU 15:04:35 INFO - Bus: Built-In 15:04:35 INFO - VRAM (Dynamic, Max): 1536 MB 15:04:35 INFO - Vendor: Intel (0x8086) 15:04:35 INFO - Device ID: 0x0a2e 15:04:35 INFO - Revision ID: 0x0009 15:04:35 INFO - Displays: 15:04:35 INFO - Display: 15:04:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:04:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:04:35 INFO - Display Serial Number: 1600x1200 60 15:04:35 INFO - Main Display: Yes 15:04:35 INFO - Mirror: Off 15:04:35 INFO - Online: Yes 15:04:35 INFO - Rotation: Supported 15:04:35 INFO - Return code: 0 15:04:35 INFO - Running post-action listener: _resource_record_post_action 15:04:35 INFO - [mozharness: 2017-02-10 23:04:35.042808Z] Finished run-tests step (success) 15:04:35 INFO - Running post-run listener: _resource_record_post_run 15:04:35 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 39093248; Write bytes: 501147136; Read time: 434; Write time: 1737 15:04:35 INFO - TinderboxPrint: CPU usage
53.5% 15:04:35 INFO - TinderboxPrint: I/O read bytes / time
39,093,248 / 434 15:04:35 INFO - TinderboxPrint: I/O write bytes / time
501,147,136 / 1,737 15:04:35 INFO - TinderboxPrint: CPU idle
2,229.7 (46.5%) 15:04:35 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 15:04:35 INFO - TinderboxPrint: CPU user
1,604.7 (33.5%) 15:04:35 INFO - TinderboxPrint: Swap in / out
230,330,368 / 0 15:04:35 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 188633600; Write bytes: 187880960; Read time: 16816; Write time: 393 15:04:35 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37016576; Write bytes: 306085888; Read time: 413; Write time: 1316 15:04:35 INFO - Running post-run listener: _upload_blobber_files 15:04:35 INFO - Blob upload gear active. 15:04:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:04:35 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 15:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:04:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:36 INFO - (blobuploader) - INFO - Done attempting. 15:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:37 INFO - (blobuploader) - INFO - Done attempting. 15:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:04:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:39 INFO - (blobuploader) - INFO - Done attempting. 15:04:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:04:39 INFO - Return code: 0 15:04:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:04:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:04:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa37cd4721cd4ec41cd0e89e9f5dd30f6148fb91e354792153a725c68abf28337744f1538b8a55daeff3d3d1768f7fd2b19dff5c66a64e5eeafb21e01e58d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18e2096bbec13997c694d4f9a3e4098701a077658c6eaaaacd6502e90c67e939ab3b20adafd863f2013fef8c0d55891df83ec20da348402dfa578bbf6f96384b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71bef3c117c5d7a087333031466d5fa7f77c029418cd16496b015685b7dfd3994c88ad170e1500fa83d50d615c5139abf6e83308e9e8e3ce381348d0ef0a2ff5"} 15:04:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:04:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:04:39 INFO - Contents: 15:04:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa37cd4721cd4ec41cd0e89e9f5dd30f6148fb91e354792153a725c68abf28337744f1538b8a55daeff3d3d1768f7fd2b19dff5c66a64e5eeafb21e01e58d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18e2096bbec13997c694d4f9a3e4098701a077658c6eaaaacd6502e90c67e939ab3b20adafd863f2013fef8c0d55891df83ec20da348402dfa578bbf6f96384b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71bef3c117c5d7a087333031466d5fa7f77c029418cd16496b015685b7dfd3994c88ad170e1500fa83d50d615c5139abf6e83308e9e8e3ce381348d0ef0a2ff5"} 15:04:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:04:39 INFO - Copying logs to upload dir... 15:04:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:04:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.961589 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-10 15:04:39.969660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 15:04:39.973839) ========= 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.kwGT10mSEB/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.m5YHpMZtGb/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa37cd4721cd4ec41cd0e89e9f5dd30f6148fb91e354792153a725c68abf28337744f1538b8a55daeff3d3d1768f7fd2b19dff5c66a64e5eeafb21e01e58d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18e2096bbec13997c694d4f9a3e4098701a077658c6eaaaacd6502e90c67e939ab3b20adafd863f2013fef8c0d55891df83ec20da348402dfa578bbf6f96384b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71bef3c117c5d7a087333031466d5fa7f77c029418cd16496b015685b7dfd3994c88ad170e1500fa83d50d615c5139abf6e83308e9e8e3ce381348d0ef0a2ff5"} build_url:https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010851 build_url: 'https://queue.taskcluster.net/v1/task/NxBHsoiARTevjML0ChPgCg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2fa37cd4721cd4ec41cd0e89e9f5dd30f6148fb91e354792153a725c68abf28337744f1538b8a55daeff3d3d1768f7fd2b19dff5c66a64e5eeafb21e01e58d90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/18e2096bbec13997c694d4f9a3e4098701a077658c6eaaaacd6502e90c67e939ab3b20adafd863f2013fef8c0d55891df83ec20da348402dfa578bbf6f96384b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71bef3c117c5d7a087333031466d5fa7f77c029418cd16496b015685b7dfd3994c88ad170e1500fa83d50d615c5139abf6e83308e9e8e3ce381348d0ef0a2ff5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 15:04:40.008735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 15:04:40.009135) ========= 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.kwGT10mSEB/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.m5YHpMZtGb/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005291 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 15:04:40.058830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 15:04:40.059208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 15:04:40.059621) ========= ========= Total master_lag: 0.20 =========