builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0172 starttime: 1482940311.96 results: success (0) buildid: 20161228064836 builduid: 882cc1a132f3490abf1609a8b7aca608 revision: 7f4072c726a0f6321320baceb534e288ce8b1e33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:51.958652) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:51.959029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:51.959294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:52.150477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:52.150846) ========= 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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-28 07:51:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.78M=0.001s 2016-12-28 07:51:52 (8.78 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:52.669499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:52.669839) ========= 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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.019547 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:52.717997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-28 07:51:52.718300) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f4072c726a0f6321320baceb534e288ce8b1e33 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f4072c726a0f6321320baceb534e288ce8b1e33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-28 07:51:52,783 truncating revision to first 12 chars 2016-12-28 07:51:52,783 Setting DEBUG logging. 2016-12-28 07:51:52,783 attempt 1/10 2016-12-28 07:51:52,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7f4072c726a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-28 07:51:54,024 unpacking tar archive at: mozilla-aurora-7f4072c726a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.492380 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-28 07:51:54.246606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:54.247337) ========= script_repo_revision: 7f4072c726a0f6321320baceb534e288ce8b1e33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:54.248279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:54.252032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-28 07:51:54.273006) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-12-28 07:51:54.273276) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:51:54 INFO - MultiFileLogger online at 20161228 07:51:54 in /builds/slave/test 07:51:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:51:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:54 INFO - {'append_to_log': False, 07:51:54 INFO - 'base_work_dir': '/builds/slave/test', 07:51:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:51:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:54 INFO - 'branch': 'Mozilla-Aurora', 07:51:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:54 INFO - 'config_files': ('talos/mac_config.py',), 07:51:54 INFO - 'default_actions': ('clobber', 07:51:54 INFO - 'read-buildbot-config', 07:51:54 INFO - 'download-and-extract', 07:51:54 INFO - 'populate-webroot', 07:51:54 INFO - 'create-virtualenv', 07:51:54 INFO - 'install', 07:51:54 INFO - 'run-tests'), 07:51:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:54 INFO - 'download_minidump_stackwalk': True, 07:51:54 INFO - 'download_symbols': 'ondemand', 07:51:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:54 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:54 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:54 INFO - 'installer_path': 'installer.exe', 07:51:54 INFO - 'log_level': 'info', 07:51:54 INFO - 'log_name': 'talos', 07:51:54 INFO - 'log_to_console': True, 07:51:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:51:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:51:54 INFO - 'opt_config_files': (), 07:51:54 INFO - 'pip_index': False, 07:51:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:51:54 INFO - 'cmd': ('bash', 07:51:54 INFO - '-c', 07:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:51:54 INFO - 'enabled': True, 07:51:54 INFO - 'halt_on_failure': False, 07:51:54 INFO - 'name': 'check_screen_resolution'},), 07:51:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:51:54 INFO - 'cmd': ('bash', 07:51:54 INFO - '-c', 07:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:51:54 INFO - 'enabled': True, 07:51:54 INFO - 'halt_on_failure': False, 07:51:54 INFO - 'name': 'check_screen_resolution'},), 07:51:54 INFO - 'run_cmd_checks_enabled': True, 07:51:54 INFO - 'sps_profile': False, 07:51:54 INFO - 'sps_profile_interval': 0, 07:51:54 INFO - 'suite': 'dromaeojs', 07:51:54 INFO - 'system_bits': '32', 07:51:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:54 INFO - 'title': 't-yosemite-r7-0172', 07:51:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:54 INFO - 'use_talos_json': True, 07:51:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:54 INFO - 'work_dir': 'build'} 07:51:54 INFO - [mozharness: 2016-12-28 15:51:54.461444Z] Running clobber step. 07:51:54 INFO - Running pre-action listener: _resource_record_pre_action 07:51:54 INFO - Running main action method: clobber 07:51:54 INFO - rmtree: /builds/slave/test/build 07:51:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:54 INFO - Running post-action listener: _resource_record_post_action 07:51:54 INFO - [mozharness: 2016-12-28 15:51:54.661140Z] Finished clobber step (success) 07:51:54 INFO - [mozharness: 2016-12-28 15:51:54.661310Z] Running read-buildbot-config step. 07:51:54 INFO - Running pre-action listener: _resource_record_pre_action 07:51:54 INFO - Running main action method: read_buildbot_config 07:51:54 INFO - Using buildbot properties: 07:51:54 INFO - { 07:51:54 INFO - "project": "", 07:51:54 INFO - "product": "firefox", 07:51:54 INFO - "script_repo_revision": "production", 07:51:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:51:54 INFO - "repository": "", 07:51:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:51:54 INFO - "buildid": "20161228064836", 07:51:54 INFO - "pgo_build": "False", 07:51:54 INFO - "basedir": "/builds/slave/test", 07:51:54 INFO - "buildnumber": 10, 07:51:54 INFO - "slavename": "t-yosemite-r7-0172", 07:51:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:51:54 INFO - "platform": "yosemite_r7", 07:51:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:51:54 INFO - "branch": "mozilla-aurora", 07:51:54 INFO - "repo_path": "releases/mozilla-aurora", 07:51:54 INFO - "revision": "7f4072c726a0f6321320baceb534e288ce8b1e33", 07:51:54 INFO - "stage_platform": "macosx64", 07:51:54 INFO - "builduid": "882cc1a132f3490abf1609a8b7aca608", 07:51:54 INFO - "slavebuilddir": "test" 07:51:54 INFO - } 07:51:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:51:54 INFO - Running post-action listener: _resource_record_post_action 07:51:54 INFO - [mozharness: 2016-12-28 15:51:54.664565Z] Finished read-buildbot-config step (success) 07:51:54 INFO - [mozharness: 2016-12-28 15:51:54.664673Z] Running download-and-extract step. 07:51:54 INFO - Running pre-action listener: _resource_record_pre_action 07:51:54 INFO - Running main action method: download_and_extract 07:51:54 INFO - mkdir: /builds/slave/test/build/tests 07:51:54 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')]} 07:51:54 INFO - trying https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:51:54 INFO - Downloading https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:51:55 INFO - Downloaded 1199 bytes. 07:51:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:51:55 INFO - Using the following test package requirements: 07:51:55 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:51:55 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:51:55 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:51:55 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'jsshell-mac.zip'], 07:51:55 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:51:55 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:51:55 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:51:55 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:51:55 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:51:55 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:51:55 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:51:55 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:51:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:51:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:51:55 INFO - Fetch https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:51:56 INFO - Http code: 200 07:51:56 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 07:51:56 INFO - x-amz-cf-id: E3dYeRr0bGyqyXe2ai6TBek_lbVxRScsmY44FY_Hb0_ykv2AoxAh6w== 07:51:56 INFO - x-amz-version-id: vXQNrC7zwyaahMzY9F7Rknyaqvfp9FU2 07:51:56 INFO - Expected file size: 16268320 07:51:56 INFO - Obtained file size: 16268320 07:52:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:52:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:52:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:52:03 INFO - Fetch https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:52:03 INFO - Http code: 200 07:52:03 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 07:52:03 INFO - x-amz-cf-id: 4aDF8zIIfKUweYowjUGqtoGsIdWmoVY8NDkBnwdLlsPfztEvGDfHSg== 07:52:03 INFO - x-amz-version-id: vXQNrC7zwyaahMzY9F7Rknyaqvfp9FU2 07:52:04 INFO - Expected file size: 16268320 07:52:04 INFO - Obtained file size: 16268320 07:52:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:52:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:52:10 INFO - Fetch https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:52:11 INFO - Http code: 200 07:52:11 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 07:52:11 INFO - x-amz-cf-id: SziNZnvgz1n-frItgxGOoD67T64OzzZDGZqZ9xlqOphYGjpPCHE3TQ== 07:52:11 INFO - x-amz-version-id: KGDfx3oLl.KcqVrIvhNJyT3AaavGN7H5 07:52:11 INFO - Expected file size: 14409038 07:52:11 INFO - Obtained file size: 14409038 07:52: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')]} 07:52:12 INFO - trying https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:52:12 INFO - Downloading https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:52:16 INFO - Downloaded 109821458 bytes. 07:52:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:52:16 INFO - mkdir: /builds/slave/test/properties 07:52:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:16 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:16 INFO - Contents: 07:52:16 INFO - build_url:https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:52:16 INFO - Running post-action listener: _resource_record_post_action 07:52:16 INFO - Running post-action listener: set_extra_try_arguments 07:52:16 INFO - [mozharness: 2016-12-28 15:52:16.683557Z] Finished download-and-extract step (success) 07:52:16 INFO - [mozharness: 2016-12-28 15:52:16.683697Z] Running populate-webroot step. 07:52:16 INFO - Running pre-action listener: _resource_record_pre_action 07:52:16 INFO - Running main action method: populate_webroot 07:52:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:16 INFO - '--tppagecycles', 07:52:16 INFO - '7'], 07:52:16 INFO - 'tests': ['tsvgm']}}, 07:52:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['damp', 'tps']}, 07:52:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'tests': ['damp', 'tps']}, 07:52:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['dromaeo_dom']}, 07:52:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['basic_compositor_video']}, 07:52:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['a11yr', 07:52:16 INFO - 'ts_paint', 07:52:16 INFO - 'tpaint', 07:52:16 INFO - 'sessionrestore', 07:52:16 INFO - 'sessionrestore_no_auto_restore', 07:52:16 INFO - 'tabpaint']}, 07:52:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tsvgx', 07:52:16 INFO - 'tsvgr_opacity', 07:52:16 INFO - 'tart', 07:52:16 INFO - 'tscrollx', 07:52:16 INFO - 'cart']}, 07:52:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:16 INFO - 'tsvgr_opacity', 07:52:16 INFO - 'tart', 07:52:16 INFO - 'tscrollx', 07:52:16 INFO - 'cart']}, 07:52:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s'], 07:52:16 INFO - 'tests': ['tp5o']}, 07:52:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'tests': ['tp5o']}, 07:52:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--disable-e10s', 07:52:16 INFO - '--xperf_path', 07:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:16 INFO - 'tests': ['tp5n']}, 07:52:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:16 INFO - 'talos_options': ['--xperf_path', 07:52:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:16 INFO - 'tests': ['tp5n']}}, 07:52:16 INFO - 'talos.zip': {'path': '', 07:52:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:16 INFO - Running post-action listener: _resource_record_post_action 07:52:16 INFO - [mozharness: 2016-12-28 15:52:16.702523Z] Finished populate-webroot step (success) 07:52:16 INFO - [mozharness: 2016-12-28 15:52:16.702636Z] Running create-virtualenv step. 07:52:16 INFO - Running pre-action listener: _resource_record_pre_action 07:52:16 INFO - Running main action method: create_virtualenv 07:52:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:16 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 07:52:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:16 INFO - Using real prefix '/tools/python27' 07:52:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:20 INFO - Installing pip.................done. 07:52:20 INFO - Return code: 0 07:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:52:20 INFO - Reading from file tmpfile_stdout 07:52:20 INFO - Output received: 07:52:20 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) 07:52:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:20 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')]} 07:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:20 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')]} 07:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:20 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:20 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 07:52:20 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 07:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:20 INFO - 'HOME': '/Users/cltbld', 07:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:20 INFO - 'LOGNAME': 'cltbld', 07:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:20 INFO - 'MOZ_NO_REMOTE': '1', 07:52:20 INFO - 'NO_EM_RESTART': '1', 07:52:20 INFO - 'PAGER': '/bin/cat', 07:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:20 INFO - 'PWD': '/builds/slave/test', 07:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:20 INFO - 'SHELL': '/bin/bash', 07:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:20 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:20 INFO - 'USER': 'cltbld', 07:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:20 INFO - 'XPC_FLAGS': '0x0', 07:52:20 INFO - 'XPC_SERVICE_NAME': '0', 07:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:20 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 07:52:20 INFO - Cleaning up... 07:52:20 INFO - Return code: 0 07:52:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:20 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')]} 07:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:20 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')]} 07:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:20 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:20 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 07:52:20 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 07:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:20 INFO - 'HOME': '/Users/cltbld', 07:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:20 INFO - 'LOGNAME': 'cltbld', 07:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:20 INFO - 'MOZ_NO_REMOTE': '1', 07:52:20 INFO - 'NO_EM_RESTART': '1', 07:52:20 INFO - 'PAGER': '/bin/cat', 07:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:20 INFO - 'PWD': '/builds/slave/test', 07:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:20 INFO - 'SHELL': '/bin/bash', 07:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:20 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:20 INFO - 'USER': 'cltbld', 07:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:20 INFO - 'XPC_FLAGS': '0x0', 07:52:20 INFO - 'XPC_SERVICE_NAME': '0', 07:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:21 INFO - Downloading/unpacking psutil>=3.1.1 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:21 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 07:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:25 INFO - Installing collected packages: psutil 07:52:25 INFO - Running setup.py install for psutil 07:52:25 INFO - building 'psutil._psutil_osx' extension 07:52:25 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 07:52:25 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 07:52:25 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 07:52:25 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 07:52:25 INFO - building 'psutil._psutil_posix' extension 07:52:25 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 07:52:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:52:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:52:25 INFO - ^ 07:52:25 INFO - 1 warning generated. 07:52:25 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 07:52:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:25 INFO - Successfully installed psutil 07:52:25 INFO - Cleaning up... 07:52:25 INFO - Return code: 0 07:52:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:25 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')]} 07:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:25 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')]} 07:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:25 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:25 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 07:52:25 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 07:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:25 INFO - 'HOME': '/Users/cltbld', 07:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:25 INFO - 'LOGNAME': 'cltbld', 07:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:25 INFO - 'MOZ_NO_REMOTE': '1', 07:52:25 INFO - 'NO_EM_RESTART': '1', 07:52:25 INFO - 'PAGER': '/bin/cat', 07:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:25 INFO - 'PWD': '/builds/slave/test', 07:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:25 INFO - 'SHELL': '/bin/bash', 07:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:25 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:25 INFO - 'USER': 'cltbld', 07:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:25 INFO - 'XPC_FLAGS': '0x0', 07:52:25 INFO - 'XPC_SERVICE_NAME': '0', 07:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:26 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 07:52:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:28 INFO - Installing collected packages: mozsystemmonitor 07:52:29 INFO - Running setup.py install for mozsystemmonitor 07:52:29 INFO - Successfully installed mozsystemmonitor 07:52:29 INFO - Cleaning up... 07:52:29 INFO - Return code: 0 07:52:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:29 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:29 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 07:52:29 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 07:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:29 INFO - 'HOME': '/Users/cltbld', 07:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:29 INFO - 'LOGNAME': 'cltbld', 07:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:29 INFO - 'MOZ_NO_REMOTE': '1', 07:52:29 INFO - 'NO_EM_RESTART': '1', 07:52:29 INFO - 'PAGER': '/bin/cat', 07:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:29 INFO - 'PWD': '/builds/slave/test', 07:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:29 INFO - 'SHELL': '/bin/bash', 07:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:29 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:29 INFO - 'USER': 'cltbld', 07:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:29 INFO - 'XPC_FLAGS': '0x0', 07:52:29 INFO - 'XPC_SERVICE_NAME': '0', 07:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 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 07:52:29 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 07:52:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 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 07:52:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:32 INFO - warning: no files found matching '*.txt' 07:52:32 INFO - no previously-included directories found matching 'build' 07:52:32 INFO - no previously-included directories found matching 'dist' 07:52:32 INFO - no previously-included directories found matching '.git*' 07:52:32 INFO - Installing collected packages: jsonschema, functools32 07:52:32 INFO - Running setup.py install for functools32 07:52:32 INFO - warning: no files found matching '*.txt' 07:52:32 INFO - no previously-included directories found matching 'build' 07:52:32 INFO - no previously-included directories found matching 'dist' 07:52:32 INFO - no previously-included directories found matching '.git*' 07:52:32 INFO - Successfully installed jsonschema functools32 07:52:32 INFO - Cleaning up... 07:52:32 INFO - Return code: 0 07:52:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:52:32 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')]} 07:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:32 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')]} 07:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:32 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:32 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 07:52:32 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 07:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:32 INFO - 'HOME': '/Users/cltbld', 07:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:32 INFO - 'LOGNAME': 'cltbld', 07:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:32 INFO - 'MOZ_NO_REMOTE': '1', 07:52:32 INFO - 'NO_EM_RESTART': '1', 07:52:32 INFO - 'PAGER': '/bin/cat', 07:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:32 INFO - 'PWD': '/builds/slave/test', 07:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:32 INFO - 'SHELL': '/bin/bash', 07:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:32 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:32 INFO - 'USER': 'cltbld', 07:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:32 INFO - 'XPC_FLAGS': '0x0', 07:52:32 INFO - 'XPC_SERVICE_NAME': '0', 07:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:52:33 INFO - Cleaning up... 07:52:33 INFO - Return code: 0 07:52:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:33 INFO - 'HOME': '/Users/cltbld', 07:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:33 INFO - 'LOGNAME': 'cltbld', 07:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:33 INFO - 'MOZ_NO_REMOTE': '1', 07:52:33 INFO - 'NO_EM_RESTART': '1', 07:52:33 INFO - 'PAGER': '/bin/cat', 07:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:33 INFO - 'PWD': '/builds/slave/test', 07:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:33 INFO - 'SHELL': '/bin/bash', 07:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:33 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:33 INFO - 'USER': 'cltbld', 07:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:33 INFO - 'XPC_FLAGS': '0x0', 07:52:33 INFO - 'XPC_SERVICE_NAME': '0', 07:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:37 INFO - Downloading docopt-0.6.1.tar.gz 07:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:37 INFO - Running setup.py install for blobuploader 07:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:37 INFO - Running setup.py install for requests 07:52:37 INFO - Running setup.py install for docopt 07:52:38 INFO - Successfully installed blobuploader requests docopt 07:52:38 INFO - Cleaning up... 07:52:38 INFO - Return code: 0 07:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:38 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:38 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 07:52:38 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 07:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:38 INFO - 'HOME': '/Users/cltbld', 07:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:38 INFO - 'LOGNAME': 'cltbld', 07:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:38 INFO - 'MOZ_NO_REMOTE': '1', 07:52:38 INFO - 'NO_EM_RESTART': '1', 07:52:38 INFO - 'PAGER': '/bin/cat', 07:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:38 INFO - 'PWD': '/builds/slave/test', 07:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:38 INFO - 'SHELL': '/bin/bash', 07:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:38 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:38 INFO - 'USER': 'cltbld', 07:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:38 INFO - 'XPC_FLAGS': '0x0', 07:52:38 INFO - 'XPC_SERVICE_NAME': '0', 07:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:38 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-u02gdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:38 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-w0EKo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:38 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-weiSYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:38 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-iW0jDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:38 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-1QqJrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:38 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-_R8oFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-6wWAQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-SkibfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QHHnwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-_IhH3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ph_uli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-l4Sk2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-p7ZJfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-YPCXQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Ask1KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-VvGRs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-gpCGye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:40 INFO - Running setup.py install for manifestparser 07:52:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:40 INFO - Running setup.py install for mozcrash 07:52:40 INFO - Running setup.py install for mozdebug 07:52:40 INFO - Running setup.py install for mozdevice 07:52:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:40 INFO - Running setup.py install for mozfile 07:52:40 INFO - Running setup.py install for mozhttpd 07:52:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for mozinfo 07:52:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for mozInstall 07:52:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for mozleak 07:52:41 INFO - Running setup.py install for mozlog 07:52:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for moznetwork 07:52:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:41 INFO - Running setup.py install for mozprocess 07:52:41 INFO - Running setup.py install for mozprofile 07:52:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for mozrunner 07:52:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Running setup.py install for mozscreenshot 07:52:42 INFO - Running setup.py install for moztest 07:52:42 INFO - Running setup.py install for mozversion 07:52:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:42 INFO - Cleaning up... 07:52:42 INFO - Return code: 0 07:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:42 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:42 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 07:52:42 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 07:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:42 INFO - 'HOME': '/Users/cltbld', 07:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:42 INFO - 'LOGNAME': 'cltbld', 07:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:42 INFO - 'MOZ_NO_REMOTE': '1', 07:52:42 INFO - 'NO_EM_RESTART': '1', 07:52:42 INFO - 'PAGER': '/bin/cat', 07:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:42 INFO - 'PWD': '/builds/slave/test', 07:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:42 INFO - 'SHELL': '/bin/bash', 07:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:42 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:42 INFO - 'USER': 'cltbld', 07:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:42 INFO - 'XPC_FLAGS': '0x0', 07:52:42 INFO - 'XPC_SERVICE_NAME': '0', 07:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-5MhkYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-n0F7XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-PYXbSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-kOvsDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-01JLhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-kQXxEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-T7WHRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-oZi_S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:43 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-alt8a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:43 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)) 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-oRdZ1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-cDvk9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-s1C1W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-4ab5WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-U_dBmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QRq8je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:44 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)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-CJjK0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:44 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-rcLAnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:44 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)) 07:52:44 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)) 07:52:44 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)) 07:52:44 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)) 07:52:44 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)) 07:52:44 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)) 07:52:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:44 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 07:52:44 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 07:52:44 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 07:52:44 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 07:52:44 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 07:52:44 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 07:52:47 INFO - Downloading blessings-1.6.tar.gz 07:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:47 INFO - Installing collected packages: blessings 07:52:47 INFO - Running setup.py install for blessings 07:52:47 INFO - Successfully installed blessings 07:52:47 INFO - Cleaning up... 07:52:47 INFO - Return code: 0 07:52:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:48 INFO - Reading from file tmpfile_stdout 07:52:48 INFO - Current package versions: 07:52:48 INFO - blessings == 1.6 07:52:48 INFO - blobuploader == 1.2.4 07:52:48 INFO - docopt == 0.6.1 07:52:48 INFO - functools32 == 3.2.3-2 07:52:48 INFO - jsonschema == 2.5.1 07:52:48 INFO - manifestparser == 1.1 07:52:48 INFO - mozInstall == 1.12 07:52:48 INFO - mozcrash == 1.0 07:52:48 INFO - mozdebug == 0.1 07:52:48 INFO - mozdevice == 0.48 07:52:48 INFO - mozfile == 1.2 07:52:48 INFO - mozhttpd == 0.7 07:52:48 INFO - mozinfo == 0.9 07:52:48 INFO - mozleak == 0.1 07:52:48 INFO - mozlog == 3.4 07:52:48 INFO - moznetwork == 0.27 07:52:48 INFO - mozprocess == 0.23 07:52:48 INFO - mozprofile == 0.28 07:52:48 INFO - mozrunner == 6.13 07:52:48 INFO - mozscreenshot == 0.1 07:52:48 INFO - mozsystemmonitor == 0.3 07:52:48 INFO - moztest == 0.7 07:52:48 INFO - mozversion == 1.4 07:52:48 INFO - psutil == 3.1.1 07:52:48 INFO - requests == 1.2.3 07:52:48 INFO - wsgiref == 0.1.2 07:52:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:48 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:48 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 07:52:48 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 07:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:48 INFO - 'HOME': '/Users/cltbld', 07:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:48 INFO - 'LOGNAME': 'cltbld', 07:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:48 INFO - 'MOZ_NO_REMOTE': '1', 07:52:48 INFO - 'NO_EM_RESTART': '1', 07:52:48 INFO - 'PAGER': '/bin/cat', 07:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:48 INFO - 'PWD': '/builds/slave/test', 07:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:48 INFO - 'SHELL': '/bin/bash', 07:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:48 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:48 INFO - 'USER': 'cltbld', 07:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:48 INFO - 'XPC_FLAGS': '0x0', 07:52:48 INFO - 'XPC_SERVICE_NAME': '0', 07:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 INFO - Cleaning up... 07:52:48 INFO - Return code: 0 07:52:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:48 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 0x103463490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac78490470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, '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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 07:52:48 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 07:52:48 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 07:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:48 INFO - 'HOME': '/Users/cltbld', 07:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:48 INFO - 'LOGNAME': 'cltbld', 07:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:48 INFO - 'MOZ_NO_REMOTE': '1', 07:52:48 INFO - 'NO_EM_RESTART': '1', 07:52:48 INFO - 'PAGER': '/bin/cat', 07:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:48 INFO - 'PWD': '/builds/slave/test', 07:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:48 INFO - 'SHELL': '/bin/bash', 07:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:52:48 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:48 INFO - 'USER': 'cltbld', 07:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:48 INFO - 'XPC_FLAGS': '0x0', 07:52:48 INFO - 'XPC_SERVICE_NAME': '0', 07:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:52:48 INFO - Cleaning up... 07:52:48 INFO - Return code: 0 07:52:48 INFO - Running post-action listener: _resource_record_post_action 07:52:48 INFO - Running post-action listener: _start_resource_monitoring 07:52:48 INFO - Starting resource monitoring. 07:52:48 INFO - [mozharness: 2016-12-28 15:52:48.610446Z] Finished create-virtualenv step (success) 07:52:48 INFO - [mozharness: 2016-12-28 15:52:48.611428Z] Running install step. 07:52:48 INFO - Running pre-action listener: _resource_record_pre_action 07:52:48 INFO - Running main action method: install 07:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:48 INFO - Reading from file tmpfile_stdout 07:52:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:49 INFO - Reading from file tmpfile_stdout 07:52:49 INFO - Output received: 07:52:49 INFO - Usage: mozinstall [options] installer 07:52:49 INFO - Options: 07:52:49 INFO - -h, --help show this help message and exit 07:52:49 INFO - -d DEST, --destination=DEST 07:52:49 INFO - Directory to install application into. [default: 07:52:49 INFO - "/builds/slave/test"] 07:52:49 INFO - --app=APP Application being installed. [default: firefox] 07:52:49 INFO - mkdir: /builds/slave/test/build/application 07:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:53:19 INFO - Reading from file tmpfile_stdout 07:53:19 INFO - Output received: 07:53:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:53:19 INFO - Running post-action listener: _resource_record_post_action 07:53:19 INFO - [mozharness: 2016-12-28 15:53:19.898481Z] Finished install step (success) 07:53:19 INFO - [mozharness: 2016-12-28 15:53:19.898604Z] Running run-tests step. 07:53:19 INFO - Running pre-action listener: _resource_record_pre_action 07:53:19 INFO - Running main action method: run_tests 07:53:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:19 INFO - 2016-12-28 07:53:19.912 screenresolution[2182:21225] starting screenresolution argv=screenresolution get 07:53:19 INFO - 2016-12-28 07:53:19.915 screenresolution[2182:21225] Display 0: 1600x1200x32@60 07:53:19 INFO - 2016-12-28 07:53:19.921 screenresolution[2183:21228] starting screenresolution argv=screenresolution list 07:53:19 INFO - Available Modes on Display 0 07:53:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:20 INFO - Intel Iris: 07:53:20 INFO - Chipset Model: Intel Iris 07:53:20 INFO - Type: GPU 07:53:20 INFO - Bus: Built-In 07:53:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:20 INFO - Vendor: Intel (0x8086) 07:53:20 INFO - Device ID: 0x0a2e 07:53:20 INFO - Revision ID: 0x0009 07:53:20 INFO - Displays: 07:53:20 INFO - Display: 07:53:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:20 INFO - Display Serial Number: 1600x1200 60 07:53:20 INFO - Main Display: Yes 07:53:20 INFO - Mirror: Off 07:53:20 INFO - Online: Yes 07:53:20 INFO - Rotation: Supported 07:53:20 INFO - Return code: 0 07:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:20 INFO - Python 2.7.3 07:53:20 INFO - Return code: 0 07:53:20 INFO - grabbing minidump binary from tooltool 07:53:20 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')]} 07:53:20 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 0x103277d30>, '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 0x1030dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10326fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:20 INFO - Return code: 0 07:53:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:53:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:53:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 07:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --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 07:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dhiZRGFQDf/Render', 07:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:20 INFO - 'HOME': '/Users/cltbld', 07:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:20 INFO - 'LOGNAME': 'cltbld', 07:53:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:20 INFO - 'MOZ_NO_REMOTE': '1', 07:53:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:20 INFO - 'NO_EM_RESTART': '1', 07:53:20 INFO - 'PAGER': '/bin/cat', 07:53:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:20 INFO - 'PWD': '/builds/slave/test', 07:53:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:20 INFO - 'SHELL': '/bin/bash', 07:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbi9Ee1rwv/Listeners', 07:53:20 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 07:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:20 INFO - 'USER': 'cltbld', 07:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:20 INFO - 'XPC_FLAGS': '0x0', 07:53:20 INFO - 'XPC_SERVICE_NAME': '0', 07:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 07:53:20 INFO - mozversion application_buildid: 20161228064836 07:53:20 INFO - mozversion application_changeset: 7f4072c726a0f6321320baceb534e288ce8b1e33 07:53:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:53:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:20 INFO - mozversion application_name: Firefox 07:53:20 INFO - mozversion application_remotingname: firefox-dev 07:53:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:20 INFO - mozversion application_vendor: Mozilla 07:53:20 INFO - mozversion application_version: 52.0a2 07:53:20 INFO - mozversion platform_buildid: 20161228064836 07:53:20 INFO - mozversion platform_changeset: 7f4072c726a0f6321320baceb534e288ce8b1e33 07:53:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:20 INFO - mozversion platform_version: 52.0a2 07:53:20 INFO - using testdate: 1482940400 07:53:20 INFO - actual date: 1482940400 07:53:20 INFO - starting webserver on 'localhost:51640' 07:53:20 INFO - SUITE-START | Running 2 tests 07:53:20 INFO - TEST-START | dromaeo_css 07:53:20 INFO - operating with platform_type : mac_ 07:53:20 INFO - Initialising browser for dromaeo_css test... 07:53:20 INFO - TEST-INFO | started process 2193 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpUHIicH/profile http://localhost:51640/getInfo.html) 07:53:22 INFO - PROCESS | 2193 | __metrics Screen width/height:1600/1200 07:53:22 INFO - PROCESS | 2193 | colorDepth:24 07:53:22 INFO - PROCESS | 2193 | Browser inner width/height: 1024/689 07:53:22 INFO - PROCESS | 2193 | __metrics 07:53:23 INFO - PROCESS | 2193 | 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" 07:53:23 INFO - PROCESS | 2193 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:23 INFO - TEST-INFO | 2193: exit 0 07:53:23 INFO - Browser initialized. 07:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:23 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpUHIicH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:36 INFO - PROCESS | 2195 | RSS: Main: 222822400 07:53:36 INFO - PROCESS | 2195 | 07:54:27 INFO - PROCESS | 2195 | 1482940467206 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:56:40 INFO - PROCESS | 2195 | Cycle 1(1): loaded http://localhost:51640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51640/tests/dromaeo/cssquery-ext.html) 07:56:42 INFO - PROCESS | 2195 | RSS: Main: 355721216 07:56:42 INFO - PROCESS | 2195 | 07:59:45 INFO - PROCESS | 2195 | Cycle 1(1): loaded http://localhost:51640/tests/dromaeo/cssquery-ext.html (next: http://localhost:51640/tests/dromaeo/cssquery-jquery.html) 07:59:46 INFO - PROCESS | 2195 | RSS: Main: 346509312 07:59:46 INFO - PROCESS | 2195 | 08:02:48 INFO - PROCESS | 2195 | Cycle 1(1): loaded http://localhost:51640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51640/tests/dromaeo/cssquery-mootools.html) 08:02:49 INFO - PROCESS | 2195 | RSS: Main: 317349888 08:02:49 INFO - PROCESS | 2195 | 08:05:51 INFO - PROCESS | 2195 | Cycle 1(1): loaded http://localhost:51640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51640/tests/dromaeo/cssquery-prototype.html) 08:05:52 INFO - PROCESS | 2195 | RSS: Main: 317722624 08:05:52 INFO - PROCESS | 2195 | 08:08:55 INFO - PROCESS | 2195 | Cycle 1(1): loaded http://localhost:51640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51640/tests/dromaeo/cssquery-yui.html) 08:08:56 INFO - PROCESS | 2195 | RSS: Main: 309956608 08:08:56 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | Cycle 1(1): loaded http://localhost:51640/tests/dromaeo/cssquery-yui.html (next: http://localhost:51640/tests/dromaeo/cssquery-dojo.html) 08:11:59 INFO - PROCESS | 2195 | RSS: Main: 461787136 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | __start_tp_report 08:11:59 INFO - PROCESS | 2195 | _x_x_mozilla_page_load 08:11:59 INFO - PROCESS | 2195 | _x_x_mozilla_page_load_details 08:11:59 INFO - PROCESS | 2195 | |i|pagename|runs| 08:11:59 INFO - PROCESS | 2195 | |0;dojo.html;3247.5615791868104;3256.0557438342867;3261.8369081545916;3282.6553211912765;3303.7852539584924;5531.115021596545;5584.4136365681625;5595.972020139893;5596.6082374233765;5638.238837756901;5479.397266300703;5545.500904918556;5566.192902029204;5581.386047534778;5607.859803504914;5068.72122033288;5092.516210959953;5100.41345245296;5122.6158038147105;5218.504242096995;5056.064628043805;5068.26510156029;5085.567726743231;5133.204353325241;5189.506996835295;5128.487151284879;5155.510226528474;5172;5173.430922598511;5177.974110129444;5159.742012899359;5182.481751824825;5215.3741551013745;5223.477652234784;5267;5057.898842023175;5141.794328226866;5143.819966301162;5152.510511501401;5167.638265321429;5513.255710479074;5533.584981126432;5553.694546799924;5585.553155747531;5586;6013.308469526017;6068.393160683896;6073.939260607382;6078.787242446493;6101.450869421729;6182.412670796267;6187.845303867394;6202.162708034448;6216.471599914013;6219.129321894939;5559.583031272671;5609.691466969356;5611.158326251095;5647.209390685307;5697.487226149667;6224.782132625336;6248.343923888017;6260.906086408708;6274.372562743689;6274.403931626488;5922.437368449991;6029;6054.878902421927;6073.4837538808815;6103.481204097613;5989.191459153046;6027.48766354856;6073.453389194994;6142.140100385949;6179.443850053517;6037.245344331958;6102.633841969496;6106.908396374058;6150.323464418911;6158.076288556752;6109.276643289651;6126.417990290915;6131.9671230687945;6140.54810262565;6149.846253843601;4722.787474563653;4871.196252618278;4879.243717223836;4880.755962201875;4882.584980276645;4312.784360781949;4377.365282034088;4380.912381752347;4382.255016647177;4403.8458653946955;5563.805266815642;5586.52514536269;5590.468905453975;5591.245181900392;5594.720263986785;6093.847653808691;6123.693815309217;6131.478824299985;6138.232720909887;6141.293751218578;4709.505501922317;5513.283273174542;5562.833115006556;5574.804881829116;5576.637518561281;5239.659422137549;5243.816466423733;5260.184671375943;5267.420583735786;5269.341332333458;6202.100695399142;6209.285932117864;6231.345708700612;6235.657038862906;6237.500999919905;6119.696404130895;6121.540884433774;6167.876642467215;6193.102000209854;6193.102000209854;6064.666443345658;6225.190725205694;6251.874962500634;6254.093156492192;6256.092866534418;5887.882242355215;5916.585838991229;5938.109283607493;6036.215292012011;6080.118382834553;5066.797328106982;6082.239720034996;6118.724657390339;6119.472088496418;6171.228596425447;5875.148103525051;5961.926853166472;5998.8500287491415;6006.429389208019;6017.488513476404;5801.332846722681;5851.736671849862;5971.880562388815;5973.611715238496;5982.521398288213;4911.705297682151;5724.79963201286;5759.308882934075;5793.565482588739;5803.47768700819;6018.946684330137;6019.789307374221;6030.4572588467245;6037.909431358621;6040.969795150996;5688.862227554423;5830.9416905832095;5840.386759390203;5851.21008663825;5859.472647461578 08:11:59 INFO - PROCESS | 2195 | |1;ext.html;452.5926666000599;457.6704772563755;505.9291699162117;530.5410819641012;536.9636601359377;29863;38768;39883.002924926855;40018.59981400185;40422.7978860106;40560.79719601405;40722;40908;40919;41093.794531027306;8370.204830541104;9386.38988465751;9391.295652826031;9393.812123757521;9406.764830879214;8438.62026208819;8672.696455624055;10982.341059536453;11265.718357041058;11285.943570282137;11202.943985280062;11272.661820145368;11290.040346570551;11324.433778311093;11325.830112548278;8469.32245420371;11072.501737421795;11141.944290278578;11171.050460710809;11186.272892262059;8482.363822713321;11032.28290161137;11351.97832195098;11361.659150225507;11372.976432121066;38871.61128388708;39268.80365598154;39284.60715392838;39312.60687393118;39345.40981885274;3376.8818091366684;3386.3565922474895;3566.0193446802077;3744.925101497982;3826.196498735269;28103.85948070267;28849.42301153986;29673.813047478074;29759.107226783013;30117.849410752806;3072.7080927312095;3134.5454909038062;3149;3168.8098714077;3182.379436009979;467832.9999999966;468922;470162;472139;472311.2768872336;56374.30877073694;56376.43623563794;56404.717976409855;56462;56477.7176114125;34349.48475772866;35119.29761404757;35318.29363412769;35859.4621080684;58767.706161468916;15681.13753743555;15789.289481973108;15802.920985395;15809.288582013836;15816.892817502665;11001.724956876142;11240.662780116609;12061.638150855488;12158.756824863452;12160.574379896838;13649;16292;16420.507384778477;16442.424515141913;18141.909290453463;7531.623418829036;7681.654325555363;7694;7740.4194685398825;7776;840.6049156896249;888.2716172738293;937.962481500746;954.2509130332655;1073.6295977887617;28303;28979.710202898124;29074.563881541795;29708.702912971024;29733.256668583457;1049.8687664041995;1055.678018204455;1076.6070384309828;1144.9313041217554;1156.8727439981594;14721.631959200891;15145.697086058217;15181.848181518044;15324.540263792103;15336.463223787114;689887;693885.7751401098;694166;696972.211945159;698243;55905.44094559084;56429.71785141048;56447.588810280075;56448;56656.15015774767;1246.8316777234957;1280.6286177008562;1282;1377.5798381493742;1394.776835706282;28098.578521321786;29947.850260748557;30394.84802575973;31512;31542;51817.7409112952;52558.47441525689;52632;52680;52851.20723189078;609376;613718;614378;614435;615316;20677.89661051685;25936.22191334263;26313.73686263113;26425;27376.041838535555;35631.28737425185;37537.624623753414;37691.81154094212;43492;44186;35102.824485877405;36340.27319453649;37353.6264637361;38729.41905871358;38789.41815872821;37066.25867482581;37404.81297593604;37815.43276850794;38508.80745596254;38531.80734096312;35752.82123589365;36438.27123457569;36711.816440917624;36814.8159259202;37106.6289337114;28728.707208175263;32096.679033210305;33827.83086084554;33881.32237355288;34100.97697069092;24484.632730509413;24682.753172468045;24765.87617061975;25137.24588262355;25204 08:11:59 INFO - PROCESS | 2195 | |2;jquery.html;353.79656697399;368.8911771027547;378.78220023486483;382.95213098362706;405.2341075367556;14708.77936830947;15116.924415377922;15641.843581564195;20045.799542004577;20536.075876585553;17480;19268.614627707437;19914.20343186271;19957.501062473446;20063.699044514346;5747.856303592413;5984.162217289583;5995.370486098962;5999.910001349983;6022.488088512459;4601.4248218972625;6595.439387652055;6662;6699.162604674416;6708.161479815023;5586.944130558683;5905.291365036202;6642.800715978528;6646.9335306647035;6666.200055993288;6020.307664618581;6049.122877182828;6052.9697351513405;6065.059915713072;6087.6956152192215;5025.597952163855;5282.154855223146;5334.466553344673;5387.24578559002;5817.331006934214;12599.37003149848;12837.229766214057;12866.035047371484;19144.71282930743;23250.953707083223;1806.656735220304;2044.7118315461164;2110.419634600482;2282.577723121228;2529.418233806235;8490.490570565786;9827.213822894222;9842.409455432626;9872.062154095349;10375.584976600927;1695.7959848507573;1725.577233577769;1787.7407775872555;1791.570023194424;1923.2210954563425;120088;122231;129284;131111.34444327716;131385;11223.66329010131;11477.483513241925;11601;11607;11771.823422648667;14564.781528277084;14575.854241457662;14598.927005364905;14601.78097328541;14615.78076328856;8105;8316.168383161636;8362.289205417486;8460.365472589458;8469.195426434602;7880.290773830383;8129.105798362176;8151.714689985822;8313.750587482386;8316.833663326699;4422;4498.640108791289;4503.774811259424;4550.88622784433;4584.381108550303;1866.8319851213455;1921.5388306806544;1922.5097600112163;1922.8173323534243;1923.5287354598213;385.73577099686804;394.954580223278;846.3313981954187;888.3426264564176;977.4917043137528;11175.385353805455;11417.48621312043;11566.42167891602;11599.88400116005;11952.64142075739;419.74185875686845;433.7722695584843;436.36508879580134;436.4740487712299;445.0475981399807;5891.440313170242;5905.291365036223;6033.215681961317;6078.1186727924205;6093.238345206849;531819.6818031848;540812;547725;550829;553421;121546;123385;123931.38034309771;125000;125209;440.60785900548535;450.76785455489795;451.2734497459088;920.5213289089636;989.080155455419;18059.729104063186;18297.993610351557;18930.43208703741;19006.714899276798;19095.90452047731;43581.34627980519;51078;52591.73704131455;52942;54654.72672636611;69726.65136674284;72522.63738681273;72932.63533682298;73030;73950.63024684842;7798.454108212598;7817.609119543887;7846.607669616382;8128.837423251383;8329.333653307842;9351.953240233755;12169;12219.205751626116;12332.951699105677;12604.054695897661;10284.691459256233;10580.629677961542;10716.624918127829;10989.120870330195;11060.949209825054;10515.73710657209;10544;10556.261061725605;10591.311564748576;10666.520006599567;8992.955035224782;10805.783884322112;10986.154845803905;10989.230753847474;11061.22571420025;6954.130733658293;7125.35871771543;7285.635718214174;7354.6690398931105;7468.954346391618;9907.45508997012;10518.526666299882;10595.311304765166;10759.30064545802;10917.290376125526 08:11:59 INFO - PROCESS | 2195 | |3;mootools.html;1284.710940038491;1441.6179712376222;1475.0780762023735;1605.1332280568492;1803.2426380920022;7448.6648100835455;7857.960710196448;7979.401544884128;8331.458455200407;8346.582670866448;8050.5974701264995;8346.74959751207;8354.91645083549;8365.28895043922;8404.327653787697;2314.085936055257;2357.799587035104;2359.4573248152933;2360.704911886014;2366.8698221597892;2330.743618202005;2371.561261166681;2382.4163080045328;2383.880805959695;2386.8329216954735;2289.267434420986;2322.7909488146065;2353.576356255882;2359.0327965534134;2359.1978727232736;2295.127851416451;2300.1604414388794;2335.74306826249;2336.9298921032228;2343.1447521654645;2340.754220806825;2359.315798418457;2366.1363602285214;2368.7039120109985;2371.537550177716;8123.106458289583;8267.958660206721;8352.540610266433;8360.080391156967;8366.707165249249;5050.797968081272;5216.58267338612;5231.848993221485;5245.632805703603;5252.054630166568;3375.476801095834;3496.0735405117666;3513.8243087845763;3578.177019285579;3588.2464682416726;1069.3049517813483;1076.3703233608348;1100.4002818463957;1104.5305745058317;1111.7165122893691;9136.360454768168;10861.1311095113;10920.18098642597;10966.835497467544;10969.012788849042;3999.5000624921886;4519.909601808011;4593.448786145684;4703.800530864608;4703.811847526061;9467.10062544071;9480.525973701288;9493.19307858826;9499.762505937408;9524.523773811281;5229.372475302912;5233.476652334736;5234.9476505235225;5235.424103348629;5236.842894713165;4035.4753881995152;4241.957580424218;4377.562243775597;4384.96953215994;4703.2004559225015;3802.16352402471;3837.0599203195397;3909.980450097788;3915.6280153385383;3916.236333914916;1244.539520377448;1264.2856785915928;1264.5068423314915;1275.9043071769654;1278.961631151067;679.300320669711;814.7270664327517;878.7407714724171;883.8983516895511;884.3411658314468;5225.563909774421;5226.947730522722;5257.868553286198;5470.890582188334;5479.287692599936;438.2549665568483;448.32527046794365;458.7796461412693;460.2589830373097;460.69594067915017;3618.945715814265;3634.436662317345;3637.7089832813313;3701.407774756026;3731.253749250161;9750.073742994404;9956.103950644332;10053.849192262122;10066.547005384775;10139.645112421178;9307.953460232791;9560.330776845554;10011.599536018623;10033.548490317953;10044.598216071276;7149.714011439484;7834.255745704149;7874.13384527713;7875.684972601031;7891.210878912063;5496.80761173357;5517.337919449692;5532;5685.346185188756;5698.230738850368;9422.858657120012;9438.38650487716;9438.811223775348;9445.149936505748;9471.147596716328;8588.141185881363;8969.730908072768;9272.860907086264;9417.811643767223;9581.712548623553;5941.732622031933;6678.699458524476;7152.141742990874;7186.245444228281;7283.781486555412;7764.456488045783;7833.647485863264;7903.407244456804;7927.563983980936;7935.523868567904;7052.576845389293;7086.610236437045;7163.176234733072;7193.280671932765;7260.237675044255;6977.616231107338;7014.298570142945;7016.438684905093;7031.507794454339;7066;6337.90493142594;6537.5096867734155;6598.383396067994;6644.33556644351;6680.866382672417;4646.7444290564345;4670.719756814602;4737.0052289019695;4748.548887855648;4802.351682522814;4778.04439112172;4781.019890922422;4807.903841923212;4895.412550493964;4928.630352723489 08:11:59 INFO - PROCESS | 2195 | |4;prototype.html;252.57567286957902;290.29168828059545;305.2384301168584;315.05640606383884;319.45851781230795;4744.098621261958;4912.7297998610065;5178.456262092483;5318.787248510055;5320.840374788753;5219.817306394277;5277.287566178565;5287.444818294081;5305.99999999999;5313.256144139824;3474.594897000941;3837.1366442550484;3933.9771659368625;3986.641202291793;4066;3369.679880411357;4067.3085575452246;4098.610631989971;4121.216968775923;4122.237386083569;3213.775035747499;3683.465897444882;3716.2567486502808;3985.6612187964056;4021.7586944783407;3585.8386372613295;3676.4485327201132;3800.4869342638945;4053.5135783705996;4055;3424.6232914379398;3532.876349327761;3541.451075083366;3554.8044857532827;3558.2705545363137;4639.5360463953675;4904.166291730378;5112.616553758483;5183.837858906064;5188.377394712621;3766.4915236443003;4146.66826653867;4159.814452880944;4226;4233.767142807144;5050.873728156789;5105.719185444799;5327.360716713981;5548.611597188158;5580.776768929238;3032.8786848526033;3318.3363327334387;3802.7338086333966;3815.8092095395396;3826.8660596879254;4602.378678878342;5538.556915446755;5691.7438715257495;5853.443922827367;5901.114832775118;3821.6560509554274;3883.475730776309;3887.747296425723;3902.551206611219;3907.765534067965;3935.4687117238805;3937.1338305572726;3937.153511994935;3940.763554186758;3942.42834788954;3845.7309088000893;4234.618884300427;4365.323374876899;4531.844379683225;4595.287730401793;4440.844570440084;5421.566274698014;5522.641028333145;5653.251268934115;5660.462256085665;1144.8265527833871;1189.3339729751367;1272.52916420923;1276.8403949506312;1280.4942047891032;818.8730746734266;821.4044817507379;860.3117505995178;872.3936863879543;887.3078998381272;4767.046590681877;4915.606751459874;5066.442691303953;5167.276581278624;5240.423553409122;5725.2232667156395;5739.339975902742;5758.395368486249;5794.710264486759;5801;4490.50604433512;5015.899682006339;5204.20454943044;5285.682859028394;5290.365156181206;2436.683231179971;2600.596907479344;2771.2794673385065;2842.9857850710614;2881.573621057548;4997.25151166864;5122.820701275437;5719.885602287931;5779.797707080232;5825.825225243249;4717.528247175255;5202.947970520322;5616.522595579339;5635.520980716603;5657.201368597221;4792.448868380181;5233.764480598458;5445.292112025411;5700.717338598782;5801.158831969426;4623.768811559341;4645.419322584677;4964.900701986012;5466.795187462339;5608.383077861514;5090.541851233259;5438.700871452108;5439.918401223906;5449.264349312951;5490.368607610017;5613.933352662981;5671.291088613923;5681.431856814285;5711.657760426214;5736.52939971328;3657.798821064867;3678.7424880258127;3685.815709214582;3688.6495782900583;3735.252949410183;5291.867703307448;5385.892282154413;5552;5786.681732504752;5817.0983497557945;5534.363548191848;5545.417731138173;5551.444855514416;5652.91915905824;5663.66018038919;4440.4227450431235;5251.55582214894;5351.9464805351445;5573.860653483695;5669.858253543694;4354.412154359121;5472.5621950243085;5476.479734425223;5543.861403464784;5572.718274796901;5278.841634750964;5439.755211015435;5564.527015203753;5596.272484576979;5654.575906807088;5514.36584792754;5534.06694451925;5547.2511210986;5550.69471179089;5571.944280557304 08:11:59 INFO - PROCESS | 2195 | |5;yui.html;699.8740226759182;703.3037293079849;724.7861880745183;753.118850944395;763.9656215470303;14220.928895355522;14614.269286535684;14625.853741462583;14632.268386580668;14665.633359166026;12788.424520896559;12817.423215955281;12826.48694052239;12873.742525149491;12927.418266178021;645.8966565349544;666.4401902401981;668.595499722668;795.4312666443492;812.6505602590898;824.5382585751968;828.8673812190051;835.302522393802;837.3343192162246;837.7947402886301;882.386741214856;886.8980067292247;888.6800751729404;889.5863423508067;894.6958034268348;680.3536640191837;702.2380716922095;880.6741505642954;884.3853521802317;889.8531742262519;522.9619205876332;524.863535480774;527.9366476022864;620.2371083567192;642.139533025743;13740.793888091686;14176.29118544079;14209.36057877398;14217.50238741639;14220;12813.295268760214;12935.870641293655;12997.805032924514;13111.278879661615;13208.273544955024;11707.356095414749;11898.881011189864;12002.819957700642;12116.515339386415;12283.93858030713;4200.285951388271;4412.889677758049;4415.558444155591;4420.20436321462;4444.11117776446;84082.15917840866;85427;86872.69690954578;90640;91843.62234566487;10167.644132455476;10202.28583999113;10269.7432564185;10501.789964200672;10634;19693.704594431096;20546.383608491768;20619.278325258543;20619.865907374937;20681.482962926046;7310.232425595236;7387.150477695026;7394.55632662042;7522.962385188039;7740.690372385154;4077.9796101019306;4148.56440073794;4150;4212.389203565466;4309.181255561433;3261.951070733941;3376.57792775903;3381.560397148355;3381.983090084583;3391.3047825195777;637.7162162837585;641.3362170153869;645.3062957320899;654.4339146638218;654.505848084693;571.711285800668;600.7927265093535;608.4037643109777;611.0071134406589;619.442501748421;7965;8096.7177221060865;8368;8468.237858592756;8793.692220772242;605.4067014325985;610.8973303187789;617.1113596421139;618.1486448088006;620.314552419579;3818.9048699477166;4192.895177620584;4201.054762678373;4222.514410842792;4316.935245971313;95810.52094739482;100086;113073.4346328263;114145;114288.42855785834;33765;33882.66117338844;46643.5335646646;99429.00570994198;99597;83950.90122746736;84912.57543712242;85015.14984850195;86677;87957.68063479052;7420.6289685516585;8176.918230817616;8180.386471014816;8356.247937685637;8364.498130112213;39076.413853791644;43587.78206108949;55185;56865.71567142138;58287.70856145692;54360;57439.85120297654;63899.68050159719;66473;67457.66271168613;10058.597656093674;11273.605423810128;11993.860474327801;12324.691882703004;12627.11610187278;13035.543755968496;13276.80084798748;13908.791368129283;14465.27673616336;14552.85447145515;12494.625161245178;12723.421686265454;12977.416016279101;13001.804972925225;13009.544665936646;11772.293662380285;11923.76152476963;11926.821097683714;11943.820842687193;12366.258024518558;12128.393580321124;12170.269783812999;12546.12177147591;13071.542496012595;13132.080754347104;10333.276670632984;10942.343459392461;11095.223334366518;11235.831462528233;11557.24877882935;9663.758406039906;9777.266704997011;9985.400875947467;10108.342957708019;11251.099912006855 08:11:59 INFO - PROCESS | 2195 | __end_tp_report 08:11:59 INFO - PROCESS | 2195 | __start_cc_report 08:11:59 INFO - PROCESS | 2195 | _x_x_mozilla_cycle_collect,1447 08:11:59 INFO - PROCESS | 2195 | __end_cc_report 08:11:59 INFO - PROCESS | 2195 | __startTimestamp1482941519537__endTimestamp 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | ------- Summary: start ------- 08:11:59 INFO - PROCESS | 2195 | Number of tests: 6 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | [#0] dojo.html Cycles:165 Average:5624.03 Median:5803.48 stddev:634.18 (10.9%) stddev-sans-first:608.10 08:11:59 INFO - PROCESS | 2195 | Values: 3247.6 3256.1 3261.8 3282.7 3303.8 5531.1 5584.4 5596.0 5596.6 5638.2 5479.4 5545.5 5566.2 5581.4 5607.9 5068.7 5092.5 5100.4 5122.6 5218.5 5056.1 5068.3 5085.6 5133.2 5189.5 5128.5 5155.5 5172.0 5173.4 5178.0 5159.7 5182.5 5215.4 5223.5 5267.0 5057.9 5141.8 5143.8 5152.5 5167.6 5513.3 5533.6 5553.7 5585.6 5586.0 6013.3 6068.4 6073.9 6078.8 6101.5 6182.4 6187.8 6202.2 6216.5 6219.1 5559.6 5609.7 5611.2 5647.2 5697.5 6224.8 6248.3 6260.9 6274.4 6274.4 5922.4 6029.0 6054.9 6073.5 6103.5 5989.2 6027.5 6073.5 6142.1 6179.4 6037.2 6102.6 6106.9 6150.3 6158.1 6109.3 6126.4 6132.0 6140.5 6149.8 4722.8 4871.2 4879.2 4880.8 4882.6 4312.8 4377.4 4380.9 4382.3 4403.8 5563.8 5586.5 5590.5 5591.2 5594.7 6093.8 6123.7 6131.5 6138.2 6141.3 4709.5 5513.3 5562.8 5574.8 5576.6 5239.7 5243.8 5260.2 5267.4 5269.3 6202.1 6209.3 6231.3 6235.7 6237.5 6119.7 6121.5 6167.9 6193.1 6193.1 6064.7 6225.2 6251.9 6254.1 6256.1 5887.9 5916.6 5938.1 6036.2 6080.1 5066.8 6082.2 6118.7 6119.5 6171.2 5875.1 5961.9 5998.9 6006.4 6017.5 5801.3 5851.7 5971.9 5973.6 5982.5 4911.7 5724.8 5759.3 5793.6 5803.5 6018.9 6019.8 6030.5 6037.9 6041.0 5688.9 5830.9 5840.4 5851.2 5859.5 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | [#1] ext.html Cycles:180 Average:70924.84 Median:19659.42 stddev:160878.89 (818.3%) stddev-sans-first:161243.18 08:11:59 INFO - PROCESS | 2195 | Values: 452.6 457.7 505.9 530.5 537.0 29863.0 38768.0 39883.0 40018.6 40422.8 40560.8 40722.0 40908.0 40919.0 41093.8 8370.2 9386.4 9391.3 9393.8 9406.8 8438.6 8672.7 10982.3 11265.7 11285.9 11202.9 11272.7 11290.0 11324.4 11325.8 8469.3 11072.5 11141.9 11171.1 11186.3 8482.4 11032.3 11352.0 11361.7 11373.0 38871.6 39268.8 39284.6 39312.6 39345.4 3376.9 3386.4 3566.0 3744.9 3826.2 28103.9 28849.4 29673.8 29759.1 30117.8 3072.7 3134.5 3149.0 3168.8 3182.4 467833.0 468922.0 470162.0 472139.0 472311.3 56374.3 56376.4 56404.7 56462.0 56477.7 34349.5 35119.3 35318.3 35859.5 58767.7 15681.1 15789.3 15802.9 15809.3 15816.9 11001.7 11240.7 12061.6 12158.8 12160.6 13649.0 16292.0 16420.5 16442.4 18141.9 7531.6 7681.7 7694.0 7740.4 7776.0 840.6 888.3 938.0 954.3 1073.6 28303.0 28979.7 29074.6 29708.7 29733.3 1049.9 1055.7 1076.6 1144.9 1156.9 14721.6 15145.7 15181.8 15324.5 15336.5 689887.0 693885.8 694166.0 696972.2 698243.0 55905.4 56429.7 56447.6 56448.0 56656.2 1246.8 1280.6 1282.0 1377.6 1394.8 28098.6 29947.9 30394.8 31512.0 31542.0 51817.7 52558.5 52632.0 52680.0 52851.2 609376.0 613718.0 614378.0 614435.0 615316.0 20677.9 25936.2 26313.7 26425.0 27376.0 35631.3 37537.6 37691.8 43492.0 44186.0 35102.8 36340.3 37353.6 38729.4 38789.4 37066.3 37404.8 37815.4 38508.8 38531.8 35752.8 36438.3 36711.8 36814.8 37106.6 28728.7 32096.7 33827.8 33881.3 34101.0 24484.6 24682.8 24765.9 25137.2 25204.0 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | [#2] jquery.html Cycles:180 Average:32555.04 Median:426.76 stddev:91711.81 (21490.4%) stddev-sans-first:91937.21 08:11:59 INFO - PROCESS | 2195 | Values: 353.8 368.9 378.8 383.0 405.2 14708.8 15116.9 15641.8 20045.8 20536.1 17480.0 19268.6 19914.2 19957.5 20063.7 5747.9 5984.2 5995.4 5999.9 6022.5 4601.4 6595.4 6662.0 6699.2 6708.2 5586.9 5905.3 6642.8 6646.9 6666.2 6020.3 6049.1 6053.0 6065.1 6087.7 5025.6 5282.2 5334.5 5387.2 5817.3 12599.4 12837.2 12866.0 19144.7 23251.0 1806.7 2044.7 2110.4 2282.6 2529.4 8490.5 9827.2 9842.4 9872.1 10375.6 1695.8 1725.6 1787.7 1791.6 1923.2 120088.0 122231.0 129284.0 131111.3 131385.0 11223.7 11477.5 11601.0 11607.0 11771.8 14564.8 14575.9 14598.9 14601.8 14615.8 8105.0 8316.2 8362.3 8460.4 8469.2 7880.3 8129.1 8151.7 8313.8 8316.8 4422.0 4498.6 4503.8 4550.9 4584.4 1866.8 1921.5 1922.5 1922.8 1923.5 385.7 395.0 846.3 888.3 977.5 11175.4 11417.5 11566.4 11599.9 11952.6 419.7 433.8 436.4 436.5 445.0 5891.4 5905.3 6033.2 6078.1 6093.2 531819.7 540812.0 547725.0 550829.0 553421.0 121546.0 123385.0 123931.4 125000.0 125209.0 440.6 450.8 451.3 920.5 989.1 18059.7 18298.0 18930.4 19006.7 19095.9 43581.3 51078.0 52591.7 52942.0 54654.7 69726.7 72522.6 72932.6 73030.0 73950.6 7798.5 7817.6 7846.6 8128.8 8329.3 9352.0 12169.0 12219.2 12333.0 12604.1 10284.7 10580.6 10716.6 10989.1 11060.9 10515.7 10544.0 10556.3 10591.3 10666.5 8993.0 10805.8 10986.2 10989.2 11061.2 6954.1 7125.4 7285.6 7354.7 7469.0 9907.5 10518.5 10595.3 10759.3 10917.3 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | [#3] mootools.html Cycles:180 Average:5387.42 Median:5133.69 stddev:2963.20 (57.7%) stddev-sans-first:2955.47 08:11:59 INFO - PROCESS | 2195 | Values: 1284.7 1441.6 1475.1 1605.1 1803.2 7448.7 7858.0 7979.4 8331.5 8346.6 8050.6 8346.7 8354.9 8365.3 8404.3 2314.1 2357.8 2359.5 2360.7 2366.9 2330.7 2371.6 2382.4 2383.9 2386.8 2289.3 2322.8 2353.6 2359.0 2359.2 2295.1 2300.2 2335.7 2336.9 2343.1 2340.8 2359.3 2366.1 2368.7 2371.5 8123.1 8268.0 8352.5 8360.1 8366.7 5050.8 5216.6 5231.8 5245.6 5252.1 3375.5 3496.1 3513.8 3578.2 3588.2 1069.3 1076.4 1100.4 1104.5 1111.7 9136.4 10861.1 10920.2 10966.8 10969.0 3999.5 4519.9 4593.4 4703.8 4703.8 9467.1 9480.5 9493.2 9499.8 9524.5 5229.4 5233.5 5234.9 5235.4 5236.8 4035.5 4242.0 4377.6 4385.0 4703.2 3802.2 3837.1 3910.0 3915.6 3916.2 1244.5 1264.3 1264.5 1275.9 1279.0 679.3 814.7 878.7 883.9 884.3 5225.6 5226.9 5257.9 5470.9 5479.3 438.3 448.3 458.8 460.3 460.7 3618.9 3634.4 3637.7 3701.4 3731.3 9750.1 9956.1 10053.8 10066.5 10139.6 9308.0 9560.3 10011.6 10033.5 10044.6 7149.7 7834.3 7874.1 7875.7 7891.2 5496.8 5517.3 5532.0 5685.3 5698.2 9422.9 9438.4 9438.8 9445.1 9471.1 8588.1 8969.7 9272.9 9417.8 9581.7 5941.7 6678.7 7152.1 7186.2 7283.8 7764.5 7833.6 7903.4 7927.6 7935.5 7052.6 7086.6 7163.2 7193.3 7260.2 6977.6 7014.3 7016.4 7031.5 7066.0 6337.9 6537.5 6598.4 6644.3 6680.9 4646.7 4670.7 4737.0 4748.5 4802.4 4778.0 4781.0 4807.9 4895.4 4928.6 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | [#4] prototype.html Cycles:180 Average:4444.77 Median:5098.13 stddev:1384.33 (27.2%) stddev-sans-first:1351.98 08:11:59 INFO - PROCESS | 2195 | Values: 252.6 290.3 305.2 315.1 319.5 4744.1 4912.7 5178.5 5318.8 5320.8 5219.8 5277.3 5287.4 5306.0 5313.3 3474.6 3837.1 3934.0 3986.6 4066.0 3369.7 4067.3 4098.6 4121.2 4122.2 3213.8 3683.5 3716.3 3985.7 4021.8 3585.8 3676.4 3800.5 4053.5 4055.0 3424.6 3532.9 3541.5 3554.8 3558.3 4639.5 4904.2 5112.6 5183.8 5188.4 3766.5 4146.7 4159.8 4226.0 4233.8 5050.9 5105.7 5327.4 5548.6 5580.8 3032.9 3318.3 3802.7 3815.8 3826.9 4602.4 5538.6 5691.7 5853.4 5901.1 3821.7 3883.5 3887.7 3902.6 3907.8 3935.5 3937.1 3937.2 3940.8 3942.4 3845.7 4234.6 4365.3 4531.8 4595.3 4440.8 5421.6 5522.6 5653.3 5660.5 1144.8 1189.3 1272.5 1276.8 1280.5 818.9 821.4 860.3 872.4 887.3 4767.0 4915.6 5066.4 5167.3 5240.4 5725.2 5739.3 5758.4 5794.7 5801.0 4490.5 5015.9 5204.2 5285.7 5290.4 2436.7 2600.6 2771.3 2843.0 2881.6 4997.3 5122.8 5719.9 5779.8 5825.8 4717.5 5202.9 5616.5 5635.5 5657.2 4792.4 5233.8 5445.3 5700.7 5801.2 4623.8 4645.4 4964.9 5466.8 5608.4 5090.5 5438.7 5439.9 5449.3 5490.4 5613.9 5671.3 5681.4 5711.7 5736.5 3657.8 3678.7 3685.8 3688.6 3735.3 5291.9 5385.9 5552.0 5786.7 5817.1 5534.4 5545.4 5551.4 5652.9 5663.7 4440.4 5251.6 5351.9 5573.9 5669.9 4354.4 5472.6 5476.5 5543.9 5572.7 5278.8 5439.8 5564.5 5596.3 5654.6 5514.4 5534.1 5547.3 5550.7 5571.9 08:11:59 INFO - PROCESS | 2195 | 08:11:59 INFO - PROCESS | 2195 | [#5] yui.html Cycles:180 Average:18999.28 Median:24000.34 stddev:27822.80 (115.9%) stddev-sans-first:27866.92 08:11:59 INFO - PROCESS | 2195 | Values: 699.9 703.3 724.8 753.1 764.0 14220.9 14614.3 14625.9 14632.3 14665.6 12788.4 12817.4 12826.5 12873.7 12927.4 645.9 666.4 668.6 795.4 812.7 824.5 828.9 835.3 837.3 837.8 882.4 886.9 888.7 889.6 894.7 680.4 702.2 880.7 884.4 889.9 523.0 524.9 527.9 620.2 642.1 13740.8 14176.3 14209.4 14217.5 14220.0 12813.3 12935.9 12997.8 13111.3 13208.3 11707.4 11898.9 12002.8 12116.5 12283.9 4200.3 4412.9 4415.6 4420.2 4444.1 84082.2 85427.0 86872.7 90640.0 91843.6 10167.6 10202.3 10269.7 10501.8 10634.0 19693.7 20546.4 20619.3 20619.9 20681.5 7310.2 7387.2 7394.6 7523.0 7740.7 4078.0 4148.6 4150.0 4212.4 4309.2 3262.0 3376.6 3381.6 3382.0 3391.3 637.7 641.3 645.3 654.4 654.5 571.7 600.8 608.4 611.0 619.4 7965.0 8096.7 8368.0 8468.2 8793.7 605.4 610.9 617.1 618.1 620.3 3818.9 4192.9 4201.1 4222.5 4316.9 95810.5 100086.0 113073.4 114145.0 114288.4 33765.0 33882.7 46643.5 99429.0 99597.0 83950.9 84912.6 85015.1 86677.0 87957.7 7420.6 8176.9 8180.4 8356.2 8364.5 39076.4 43587.8 55185.0 56865.7 58287.7 54360.0 57439.9 63899.7 66473.0 67457.7 10058.6 11273.6 11993.9 12324.7 12627.1 13035.5 13276.8 13908.8 14465.3 14552.9 12494.6 12723.4 12977.4 13001.8 13009.5 11772.3 11923.8 11926.8 11943.8 12366.3 12128.4 12170.3 12546.1 13071.5 13132.1 10333.3 10942.3 11095.2 11235.8 11557.2 9663.8 9777.3 9985.4 10108.3 11251.1 08:11:59 INFO - PROCESS | 2195 | -------- Summary: end -------- 08:11:59 INFO - PROCESS | 2195 | 08:12:00 INFO - TEST-INFO | 2195: exit 0 08:12:00 INFO - TEST-OK | dromaeo_css | took 1119725ms 08:12:00 INFO - TEST-START | kraken 08:12:00 INFO - operating with platform_type : mac_ 08:12:00 INFO - Initialising browser for kraken test... 08:12:00 INFO - TEST-INFO | started process 2199 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpv8nzU8/profile http://localhost:51640/getInfo.html) 08:12:02 INFO - PROCESS | 2199 | __metrics Screen width/height:1600/1200 08:12:02 INFO - PROCESS | 2199 | colorDepth:24 08:12:02 INFO - PROCESS | 2199 | Browser inner width/height: 1024/689 08:12:02 INFO - PROCESS | 2199 | __metrics 08:12:02 INFO - PROCESS | 2199 | 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" 08:12:02 INFO - PROCESS | 2199 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:03 INFO - TEST-INFO | 2199: exit 0 08:12:03 INFO - Browser initialized. 08:12:03 INFO - Running cycle 1/1 for kraken test... 08:12:03 INFO - TEST-INFO | started process 2200 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpv8nzU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:15 INFO - PROCESS | 2200 | RSS: Main: 222978048 08:12:15 INFO - PROCESS | 2200 | 08:12:18 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51640/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:19 INFO - PROCESS | 2200 | RSS: Main: 272363520 08:12:19 INFO - PROCESS | 2200 | 08:12:22 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51640/tests/kraken/driver.html?testName=audio-dft) 08:12:22 INFO - PROCESS | 2200 | RSS: Main: 283340800 08:12:22 INFO - PROCESS | 2200 | 08:12:26 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51640/tests/kraken/driver.html?testName=audio-fft) 08:12:26 INFO - PROCESS | 2200 | RSS: Main: 380616704 08:12:26 INFO - PROCESS | 2200 | 08:12:28 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51640/tests/kraken/driver.html?testName=audio-oscillator) 08:12:29 INFO - PROCESS | 2200 | RSS: Main: 282193920 08:12:29 INFO - PROCESS | 2200 | 08:12:31 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:31 INFO - PROCESS | 2200 | RSS: Main: 283643904 08:12:31 INFO - PROCESS | 2200 | 08:12:34 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51640/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:35 INFO - PROCESS | 2200 | RSS: Main: 326320128 08:12:35 INFO - PROCESS | 2200 | 08:12:38 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51640/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:38 INFO - PROCESS | 2200 | RSS: Main: 326967296 08:12:38 INFO - PROCESS | 2200 | 08:12:41 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51640/tests/kraken/driver.html?testName=json-parse-financial) 08:12:42 INFO - PROCESS | 2200 | RSS: Main: 324939776 08:12:42 INFO - PROCESS | 2200 | 08:12:43 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:44 INFO - PROCESS | 2200 | RSS: Main: 300351488 08:12:44 INFO - PROCESS | 2200 | 08:12:46 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:47 INFO - PROCESS | 2200 | RSS: Main: 301006848 08:12:47 INFO - PROCESS | 2200 | 08:12:49 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:49 INFO - PROCESS | 2200 | RSS: Main: 303656960 08:12:49 INFO - PROCESS | 2200 | 08:12:52 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:53 INFO - PROCESS | 2200 | RSS: Main: 315088896 08:12:53 INFO - PROCESS | 2200 | 08:12:56 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:57 INFO - PROCESS | 2200 | RSS: Main: 314847232 08:12:57 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:51640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51640/tests/kraken/driver.html?testName=ai-astar) 08:12:59 INFO - PROCESS | 2200 | RSS: Main: 358756352 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | __start_tp_report 08:12:59 INFO - PROCESS | 2200 | _x_x_mozilla_page_load 08:12:59 INFO - PROCESS | 2200 | _x_x_mozilla_page_load_details 08:12:59 INFO - PROCESS | 2200 | |i|pagename|runs| 08:12:59 INFO - PROCESS | 2200 | |0;ai-astar;156;166;142;114;115;114;113;114;114;114 08:12:59 INFO - PROCESS | 2200 | |1;audio-beat-detection;145;108;111;141;108;110;112;109;144;110 08:12:59 INFO - PROCESS | 2200 | |2;audio-dft;184;183;215;260;191;187;185;186;187;183 08:12:59 INFO - PROCESS | 2200 | |3;audio-fft;82;61;60;92;60;58;60;59;82;59 08:12:59 INFO - PROCESS | 2200 | |4;audio-oscillator;89;70;94;74;68;69;90;68;69;97 08:12:59 INFO - PROCESS | 2200 | |5;imaging-gaussian-blur;86;84;86;83;86;82;85;84;86;83 08:12:59 INFO - PROCESS | 2200 | |6;imaging-darkroom;92;94;93;93;92;111;128;93;93;93 08:12:59 INFO - PROCESS | 2200 | |7;imaging-desaturate;98;124;66;128;125;124;86;84;84;83 08:12:59 INFO - PROCESS | 2200 | |8;json-parse-financial;57;53;55;53;57;59;59;58;57;57 08:12:59 INFO - PROCESS | 2200 | |9;json-stringify-tinderbox;65;77;77;74;73;70;69;86;101;100 08:12:59 INFO - PROCESS | 2200 | |10;stanford-crypto-aes;83;84;85;84;83;86;85;83;84;86 08:12:59 INFO - PROCESS | 2200 | |11;stanford-crypto-ccm;144;143;154;155;140;143;143;161;222;149 08:12:59 INFO - PROCESS | 2200 | |12;stanford-crypto-pbkdf2;162;164;166;175;220;206;166;166;166;164 08:12:59 INFO - PROCESS | 2200 | |13;stanford-crypto-sha256-iterative;69;67;68;67;66;68;63;68;67;66 08:12:59 INFO - PROCESS | 2200 | __end_tp_report 08:12:59 INFO - PROCESS | 2200 | __start_cc_report 08:12:59 INFO - PROCESS | 2200 | _x_x_mozilla_cycle_collect,2002 08:12:59 INFO - PROCESS | 2200 | __end_cc_report 08:12:59 INFO - PROCESS | 2200 | __startTimestamp1482941579283__endTimestamp 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | ------- Summary: start ------- 08:12:59 INFO - PROCESS | 2200 | Number of tests: 14 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#0] ai-astar Cycles:10 Average:126.20 Median:114.50 stddev:20.45 (17.9%) stddev-sans-first:18.64 08:12:59 INFO - PROCESS | 2200 | Values: 156.0 166.0 142.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:111.50 stddev:16.31 (14.6%) stddev-sans-first:14.53 08:12:59 INFO - PROCESS | 2200 | Values: 145.0 108.0 111.0 141.0 108.0 110.0 112.0 109.0 144.0 110.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#2] audio-dft Cycles:10 Average:196.10 Median:187.00 stddev:24.37 (13.0%) stddev-sans-first:25.46 08:12:59 INFO - PROCESS | 2200 | Values: 184.0 183.0 215.0 260.0 191.0 187.0 185.0 186.0 187.0 183.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#3] audio-fft Cycles:10 Average:67.30 Median:60.50 stddev:12.76 (21.1%) stddev-sans-first:12.38 08:12:59 INFO - PROCESS | 2200 | Values: 82.0 61.0 60.0 92.0 60.0 58.0 60.0 59.0 82.0 59.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:81.50 stddev:12.10 (14.8%) stddev-sans-first:12.26 08:12:59 INFO - PROCESS | 2200 | Values: 89.0 70.0 94.0 74.0 68.0 69.0 90.0 68.0 69.0 97.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:85.50 stddev:1.51 (1.8%) stddev-sans-first:1.50 08:12:59 INFO - PROCESS | 2200 | Values: 86.0 84.0 86.0 83.0 86.0 82.0 85.0 84.0 86.0 83.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:93.00 stddev:11.93 (12.8%) stddev-sans-first:12.44 08:12:59 INFO - PROCESS | 2200 | Values: 92.0 94.0 93.0 93.0 92.0 111.0 128.0 93.0 93.0 93.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#7] imaging-desaturate Cycles:10 Average:100.20 Median:83.50 stddev:22.89 (27.4%) stddev-sans-first:24.27 08:12:59 INFO - PROCESS | 2200 | Values: 98.0 124.0 66.0 128.0 125.0 124.0 86.0 84.0 84.0 83.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:2.17 (3.8%) stddev-sans-first:2.30 08:12:59 INFO - PROCESS | 2200 | Values: 57.0 53.0 55.0 53.0 57.0 59.0 59.0 58.0 57.0 57.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#9] json-stringify-tinderbox Cycles:10 Average:79.20 Median:73.50 stddev:12.56 (17.1%) stddev-sans-first:12.22 08:12:59 INFO - PROCESS | 2200 | Values: 65.0 77.0 77.0 74.0 73.0 70.0 69.0 86.0 101.0 100.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:1.16 (1.4%) stddev-sans-first:1.13 08:12:59 INFO - PROCESS | 2200 | Values: 83.0 84.0 85.0 84.0 83.0 86.0 85.0 83.0 84.0 86.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:151.50 stddev:24.35 (16.1%) stddev-sans-first:25.48 08:12:59 INFO - PROCESS | 2200 | Values: 144.0 143.0 154.0 155.0 140.0 143.0 143.0 161.0 222.0 149.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:166.00 stddev:20.33 (12.2%) stddev-sans-first:20.96 08:12:59 INFO - PROCESS | 2200 | Values: 162.0 164.0 166.0 175.0 220.0 206.0 166.0 166.0 166.0 164.0 08:12:59 INFO - PROCESS | 2200 | 08:12:59 INFO - PROCESS | 2200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.58 08:12:59 INFO - PROCESS | 2200 | Values: 69.0 67.0 68.0 67.0 66.0 68.0 63.0 68.0 67.0 66.0 08:12:59 INFO - PROCESS | 2200 | -------- Summary: end -------- 08:12:59 INFO - PROCESS | 2200 | 08:13:00 INFO - TEST-INFO | 2200: exit 0 08:13:00 INFO - TEST-OK | kraken | took 60127ms 08:13:00 INFO - SUITE-END | took 1179s 08:13:00 INFO - Completed test suite (00:19:39) 08:13:00 INFO - javascript benchmark 08:13:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.5615791868104, 3256.0557438342867, 3261.8369081545916, 3282.6553211912765, 3303.7852539584924, 5531.115021596545, 5584.4136365681625, 5595.972020139893, 5596.6082374233765, 5638.238837756901, 5479.397266300703, 5545.500904918556, 5566.192902029204, 5581.386047534778, 5607.859803504914, 5068.72122033288, 5092.516210959953, 5100.41345245296, 5122.6158038147105, 5218.504242096995, 5056.064628043805, 5068.26510156029, 5085.567726743231, 5133.204353325241, 5189.506996835295, 5128.487151284879, 5155.510226528474, 5172.0, 5173.430922598511, 5177.974110129444, 5159.742012899359, 5182.481751824825, 5215.3741551013745, 5223.477652234784, 5267.0, 5057.898842023175, 5141.794328226866, 5143.819966301162, 5152.510511501401, 5167.638265321429, 5513.255710479074, 5533.584981126432, 5553.694546799924, 5585.553155747531, 5586.0, 6013.308469526017, 6068.393160683896, 6073.939260607382, 6078.787242446493, 6101.450869421729, 6182.412670796267, 6187.845303867394, 6202.162708034448, 6216.471599914013, 6219.129321894939, 5559.583031272671, 5609.691466969356, 5611.158326251095, 5647.209390685307, 5697.487226149667, 6224.782132625336, 6248.343923888017, 6260.906086408708, 6274.372562743689, 6274.403931626488, 5922.437368449991, 6029.0, 6054.878902421927, 6073.4837538808815, 6103.481204097613, 5989.191459153046, 6027.48766354856, 6073.453389194994, 6142.140100385949, 6179.443850053517, 6037.245344331958, 6102.633841969496, 6106.908396374058, 6150.323464418911, 6158.076288556752, 6109.276643289651, 6126.417990290915, 6131.9671230687945, 6140.54810262565, 6149.846253843601, 4722.787474563653, 4871.196252618278, 4879.243717223836, 4880.755962201875, 4882.584980276645, 4312.784360781949, 4377.365282034088, 4380.912381752347, 4382.255016647177, 4403.8458653946955, 5563.805266815642, 5586.52514536269, 5590.468905453975, 5591.245181900392, 5594.720263986785, 6093.847653808691, 6123.693815309217, 6131.478824299985, 6138.232720909887, 6141.293751218578, 4709.505501922317, 5513.283273174542, 5562.833115006556, 5574.804881829116, 5576.637518561281, 5239.659422137549, 5243.816466423733, 5260.184671375943, 5267.420583735786, 5269.341332333458, 6202.100695399142, 6209.285932117864, 6231.345708700612, 6235.657038862906, 6237.500999919905, 6119.696404130895, 6121.540884433774, 6167.876642467215, 6193.102000209854, 6193.102000209854, 6064.666443345658, 6225.190725205694, 6251.874962500634, 6254.093156492192, 6256.092866534418, 5887.882242355215, 5916.585838991229, 5938.109283607493, 6036.215292012011, 6080.118382834553, 5066.797328106982, 6082.239720034996, 6118.724657390339, 6119.472088496418, 6171.228596425447, 5875.148103525051, 5961.926853166472, 5998.8500287491415, 6006.429389208019, 6017.488513476404, 5801.332846722681, 5851.736671849862, 5971.880562388815, 5973.611715238496, 5982.521398288213, 4911.705297682151, 5724.79963201286, 5759.308882934075, 5793.565482588739, 5803.47768700819, 6018.946684330137, 6019.789307374221, 6030.4572588467245, 6037.909431358621, 6040.969795150996, 5688.862227554423, 5830.9416905832095, 5840.386759390203, 5851.21008663825, 5859.472647461578], "value": 5583.187415827768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.5926666000599, 457.6704772563755, 505.9291699162117, 530.5410819641012, 536.9636601359377, 29863.0, 38768.0, 39883.002924926855, 40018.59981400185, 40422.7978860106, 40560.79719601405, 40722.0, 40908.0, 40919.0, 41093.794531027306, 8370.204830541104, 9386.38988465751, 9391.295652826031, 9393.812123757521, 9406.764830879214, 8438.62026208819, 8672.696455624055, 10982.341059536453, 11265.718357041058, 11285.943570282137, 11202.943985280062, 11272.661820145368, 11290.040346570551, 11324.433778311093, 11325.830112548278, 8469.32245420371, 11072.501737421795, 11141.944290278578, 11171.050460710809, 11186.272892262059, 8482.363822713321, 11032.28290161137, 11351.97832195098, 11361.659150225507, 11372.976432121066, 38871.61128388708, 39268.80365598154, 39284.60715392838, 39312.60687393118, 39345.40981885274, 3376.8818091366684, 3386.3565922474895, 3566.0193446802077, 3744.925101497982, 3826.196498735269, 28103.85948070267, 28849.42301153986, 29673.813047478074, 29759.107226783013, 30117.849410752806, 3072.7080927312095, 3134.5454909038062, 3149.0, 3168.8098714077, 3182.379436009979, 467832.9999999966, 468922.0, 470162.0, 472139.0, 472311.2768872336, 56374.30877073694, 56376.43623563794, 56404.717976409855, 56462.0, 56477.7176114125, 34349.48475772866, 35119.29761404757, 35318.29363412769, 35859.4621080684, 58767.706161468916, 15681.13753743555, 15789.289481973108, 15802.920985395, 15809.288582013836, 15816.892817502665, 11001.724956876142, 11240.662780116609, 12061.638150855488, 12158.756824863452, 12160.574379896838, 13649.0, 16292.0, 16420.507384778477, 16442.424515141913, 18141.909290453463, 7531.623418829036, 7681.654325555363, 7694.0, 7740.4194685398825, 7776.0, 840.6049156896249, 888.2716172738293, 937.962481500746, 954.2509130332655, 1073.6295977887617, 28303.0, 28979.710202898124, 29074.563881541795, 29708.702912971024, 29733.256668583457, 1049.8687664041995, 1055.678018204455, 1076.6070384309828, 1144.9313041217554, 1156.8727439981594, 14721.631959200891, 15145.697086058217, 15181.848181518044, 15324.540263792103, 15336.463223787114, 689887.0, 693885.7751401098, 694166.0, 696972.211945159, 698243.0, 55905.44094559084, 56429.71785141048, 56447.588810280075, 56448.0, 56656.15015774767, 1246.8316777234957, 1280.6286177008562, 1282.0, 1377.5798381493742, 1394.776835706282, 28098.578521321786, 29947.850260748557, 30394.84802575973, 31512.0, 31542.0, 51817.7409112952, 52558.47441525689, 52632.0, 52680.0, 52851.20723189078, 609376.0, 613718.0, 614378.0, 614435.0, 615316.0, 20677.89661051685, 25936.22191334263, 26313.73686263113, 26425.0, 27376.041838535555, 35631.28737425185, 37537.624623753414, 37691.81154094212, 43492.0, 44186.0, 35102.824485877405, 36340.27319453649, 37353.6264637361, 38729.41905871358, 38789.41815872821, 37066.25867482581, 37404.81297593604, 37815.43276850794, 38508.80745596254, 38531.80734096312, 35752.82123589365, 36438.27123457569, 36711.816440917624, 36814.8159259202, 37106.6289337114, 28728.707208175263, 32096.679033210305, 33827.83086084554, 33881.32237355288, 34100.97697069092, 24484.632730509413, 24682.753172468045, 24765.87617061975, 25137.24588262355, 25204.0], "value": 19503.802139766525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.79656697399, 368.8911771027547, 378.78220023486483, 382.95213098362706, 405.2341075367556, 14708.77936830947, 15116.924415377922, 15641.843581564195, 20045.799542004577, 20536.075876585553, 17480.0, 19268.614627707437, 19914.20343186271, 19957.501062473446, 20063.699044514346, 5747.856303592413, 5984.162217289583, 5995.370486098962, 5999.910001349983, 6022.488088512459, 4601.4248218972625, 6595.439387652055, 6662.0, 6699.162604674416, 6708.161479815023, 5586.944130558683, 5905.291365036202, 6642.800715978528, 6646.9335306647035, 6666.200055993288, 6020.307664618581, 6049.122877182828, 6052.9697351513405, 6065.059915713072, 6087.6956152192215, 5025.597952163855, 5282.154855223146, 5334.466553344673, 5387.24578559002, 5817.331006934214, 12599.37003149848, 12837.229766214057, 12866.035047371484, 19144.71282930743, 23250.953707083223, 1806.656735220304, 2044.7118315461164, 2110.419634600482, 2282.577723121228, 2529.418233806235, 8490.490570565786, 9827.213822894222, 9842.409455432626, 9872.062154095349, 10375.584976600927, 1695.7959848507573, 1725.577233577769, 1787.7407775872555, 1791.570023194424, 1923.2210954563425, 120088.0, 122231.0, 129284.0, 131111.34444327716, 131385.0, 11223.66329010131, 11477.483513241925, 11601.0, 11607.0, 11771.823422648667, 14564.781528277084, 14575.854241457662, 14598.927005364905, 14601.78097328541, 14615.78076328856, 8105.0, 8316.168383161636, 8362.289205417486, 8460.365472589458, 8469.195426434602, 7880.290773830383, 8129.105798362176, 8151.714689985822, 8313.750587482386, 8316.833663326699, 4422.0, 4498.640108791289, 4503.774811259424, 4550.88622784433, 4584.381108550303, 1866.8319851213455, 1921.5388306806544, 1922.5097600112163, 1922.8173323534243, 1923.5287354598213, 385.73577099686804, 394.954580223278, 846.3313981954187, 888.3426264564176, 977.4917043137528, 11175.385353805455, 11417.48621312043, 11566.42167891602, 11599.88400116005, 11952.64142075739, 419.74185875686845, 433.7722695584843, 436.36508879580134, 436.4740487712299, 445.0475981399807, 5891.440313170242, 5905.291365036223, 6033.215681961317, 6078.1186727924205, 6093.238345206849, 531819.6818031848, 540812.0, 547725.0, 550829.0, 553421.0, 121546.0, 123385.0, 123931.38034309771, 125000.0, 125209.0, 440.60785900548535, 450.76785455489795, 451.2734497459088, 920.5213289089636, 989.080155455419, 18059.729104063186, 18297.993610351557, 18930.43208703741, 19006.714899276798, 19095.90452047731, 43581.34627980519, 51078.0, 52591.73704131455, 52942.0, 54654.72672636611, 69726.65136674284, 72522.63738681273, 72932.63533682298, 73030.0, 73950.63024684842, 7798.454108212598, 7817.609119543887, 7846.607669616382, 8128.837423251383, 8329.333653307842, 9351.953240233755, 12169.0, 12219.205751626116, 12332.951699105677, 12604.054695897661, 10284.691459256233, 10580.629677961542, 10716.624918127829, 10989.120870330195, 11060.949209825054, 10515.73710657209, 10544.0, 10556.261061725605, 10591.311564748576, 10666.520006599567, 8992.955035224782, 10805.783884322112, 10986.154845803905, 10989.230753847474, 11061.22571420025, 6954.130733658293, 7125.35871771543, 7285.635718214174, 7354.6690398931105, 7468.954346391618, 9907.45508997012, 10518.526666299882, 10595.311304765166, 10759.30064545802, 10917.290376125526], "value": 8575.500591409964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.710940038491, 1441.6179712376222, 1475.0780762023735, 1605.1332280568492, 1803.2426380920022, 7448.6648100835455, 7857.960710196448, 7979.401544884128, 8331.458455200407, 8346.582670866448, 8050.5974701264995, 8346.74959751207, 8354.91645083549, 8365.28895043922, 8404.327653787697, 2314.085936055257, 2357.799587035104, 2359.4573248152933, 2360.704911886014, 2366.8698221597892, 2330.743618202005, 2371.561261166681, 2382.4163080045328, 2383.880805959695, 2386.8329216954735, 2289.267434420986, 2322.7909488146065, 2353.576356255882, 2359.0327965534134, 2359.1978727232736, 2295.127851416451, 2300.1604414388794, 2335.74306826249, 2336.9298921032228, 2343.1447521654645, 2340.754220806825, 2359.315798418457, 2366.1363602285214, 2368.7039120109985, 2371.537550177716, 8123.106458289583, 8267.958660206721, 8352.540610266433, 8360.080391156967, 8366.707165249249, 5050.797968081272, 5216.58267338612, 5231.848993221485, 5245.632805703603, 5252.054630166568, 3375.476801095834, 3496.0735405117666, 3513.8243087845763, 3578.177019285579, 3588.2464682416726, 1069.3049517813483, 1076.3703233608348, 1100.4002818463957, 1104.5305745058317, 1111.7165122893691, 9136.360454768168, 10861.1311095113, 10920.18098642597, 10966.835497467544, 10969.012788849042, 3999.5000624921886, 4519.909601808011, 4593.448786145684, 4703.800530864608, 4703.811847526061, 9467.10062544071, 9480.525973701288, 9493.19307858826, 9499.762505937408, 9524.523773811281, 5229.372475302912, 5233.476652334736, 5234.9476505235225, 5235.424103348629, 5236.842894713165, 4035.4753881995152, 4241.957580424218, 4377.562243775597, 4384.96953215994, 4703.2004559225015, 3802.16352402471, 3837.0599203195397, 3909.980450097788, 3915.6280153385383, 3916.236333914916, 1244.539520377448, 1264.2856785915928, 1264.5068423314915, 1275.9043071769654, 1278.961631151067, 679.300320669711, 814.7270664327517, 878.7407714724171, 883.8983516895511, 884.3411658314468, 5225.563909774421, 5226.947730522722, 5257.868553286198, 5470.890582188334, 5479.287692599936, 438.2549665568483, 448.32527046794365, 458.7796461412693, 460.2589830373097, 460.69594067915017, 3618.945715814265, 3634.436662317345, 3637.7089832813313, 3701.407774756026, 3731.253749250161, 9750.073742994404, 9956.103950644332, 10053.849192262122, 10066.547005384775, 10139.645112421178, 9307.953460232791, 9560.330776845554, 10011.599536018623, 10033.548490317953, 10044.598216071276, 7149.714011439484, 7834.255745704149, 7874.13384527713, 7875.684972601031, 7891.210878912063, 5496.80761173357, 5517.337919449692, 5532.0, 5685.346185188756, 5698.230738850368, 9422.858657120012, 9438.38650487716, 9438.811223775348, 9445.149936505748, 9471.147596716328, 8588.141185881363, 8969.730908072768, 9272.860907086264, 9417.811643767223, 9581.712548623553, 5941.732622031933, 6678.699458524476, 7152.141742990874, 7186.245444228281, 7283.781486555412, 7764.456488045783, 7833.647485863264, 7903.407244456804, 7927.563983980936, 7935.523868567904, 7052.576845389293, 7086.610236437045, 7163.176234733072, 7193.280671932765, 7260.237675044255, 6977.616231107338, 7014.298570142945, 7016.438684905093, 7031.507794454339, 7066.0, 6337.90493142594, 6537.5096867734155, 6598.383396067994, 6644.33556644351, 6680.866382672417, 4646.7444290564345, 4670.719756814602, 4737.0052289019695, 4748.548887855648, 4802.351682522814, 4778.04439112172, 4781.019890922422, 4807.903841923212, 4895.412550493964, 4928.630352723489], "value": 4303.613024534512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.57567286957902, 290.29168828059545, 305.2384301168584, 315.05640606383884, 319.45851781230795, 4744.098621261958, 4912.7297998610065, 5178.456262092483, 5318.787248510055, 5320.840374788753, 5219.817306394277, 5277.287566178565, 5287.444818294081, 5305.99999999999, 5313.256144139824, 3474.594897000941, 3837.1366442550484, 3933.9771659368625, 3986.641202291793, 4066.0, 3369.679880411357, 4067.3085575452246, 4098.610631989971, 4121.216968775923, 4122.237386083569, 3213.775035747499, 3683.465897444882, 3716.2567486502808, 3985.6612187964056, 4021.7586944783407, 3585.8386372613295, 3676.4485327201132, 3800.4869342638945, 4053.5135783705996, 4055.0, 3424.6232914379398, 3532.876349327761, 3541.451075083366, 3554.8044857532827, 3558.2705545363137, 4639.5360463953675, 4904.166291730378, 5112.616553758483, 5183.837858906064, 5188.377394712621, 3766.4915236443003, 4146.66826653867, 4159.814452880944, 4226.0, 4233.767142807144, 5050.873728156789, 5105.719185444799, 5327.360716713981, 5548.611597188158, 5580.776768929238, 3032.8786848526033, 3318.3363327334387, 3802.7338086333966, 3815.8092095395396, 3826.8660596879254, 4602.378678878342, 5538.556915446755, 5691.7438715257495, 5853.443922827367, 5901.114832775118, 3821.6560509554274, 3883.475730776309, 3887.747296425723, 3902.551206611219, 3907.765534067965, 3935.4687117238805, 3937.1338305572726, 3937.153511994935, 3940.763554186758, 3942.42834788954, 3845.7309088000893, 4234.618884300427, 4365.323374876899, 4531.844379683225, 4595.287730401793, 4440.844570440084, 5421.566274698014, 5522.641028333145, 5653.251268934115, 5660.462256085665, 1144.8265527833871, 1189.3339729751367, 1272.52916420923, 1276.8403949506312, 1280.4942047891032, 818.8730746734266, 821.4044817507379, 860.3117505995178, 872.3936863879543, 887.3078998381272, 4767.046590681877, 4915.606751459874, 5066.442691303953, 5167.276581278624, 5240.423553409122, 5725.2232667156395, 5739.339975902742, 5758.395368486249, 5794.710264486759, 5801.0, 4490.50604433512, 5015.899682006339, 5204.20454943044, 5285.682859028394, 5290.365156181206, 2436.683231179971, 2600.596907479344, 2771.2794673385065, 2842.9857850710614, 2881.573621057548, 4997.25151166864, 5122.820701275437, 5719.885602287931, 5779.797707080232, 5825.825225243249, 4717.528247175255, 5202.947970520322, 5616.522595579339, 5635.520980716603, 5657.201368597221, 4792.448868380181, 5233.764480598458, 5445.292112025411, 5700.717338598782, 5801.158831969426, 4623.768811559341, 4645.419322584677, 4964.900701986012, 5466.795187462339, 5608.383077861514, 5090.541851233259, 5438.700871452108, 5439.918401223906, 5449.264349312951, 5490.368607610017, 5613.933352662981, 5671.291088613923, 5681.431856814285, 5711.657760426214, 5736.52939971328, 3657.798821064867, 3678.7424880258127, 3685.815709214582, 3688.6495782900583, 3735.252949410183, 5291.867703307448, 5385.892282154413, 5552.0, 5786.681732504752, 5817.0983497557945, 5534.363548191848, 5545.417731138173, 5551.444855514416, 5652.91915905824, 5663.66018038919, 4440.4227450431235, 5251.55582214894, 5351.9464805351445, 5573.860653483695, 5669.858253543694, 4354.412154359121, 5472.5621950243085, 5476.479734425223, 5543.861403464784, 5572.718274796901, 5278.841634750964, 5439.755211015435, 5564.527015203753, 5596.272484576979, 5654.575906807088, 5514.36584792754, 5534.06694451925, 5547.2511210986, 5550.69471179089, 5571.944280557304], "value": 3998.1734593110873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.8740226759182, 703.3037293079849, 724.7861880745183, 753.118850944395, 763.9656215470303, 14220.928895355522, 14614.269286535684, 14625.853741462583, 14632.268386580668, 14665.633359166026, 12788.424520896559, 12817.423215955281, 12826.48694052239, 12873.742525149491, 12927.418266178021, 645.8966565349544, 666.4401902401981, 668.595499722668, 795.4312666443492, 812.6505602590898, 824.5382585751968, 828.8673812190051, 835.302522393802, 837.3343192162246, 837.7947402886301, 882.386741214856, 886.8980067292247, 888.6800751729404, 889.5863423508067, 894.6958034268348, 680.3536640191837, 702.2380716922095, 880.6741505642954, 884.3853521802317, 889.8531742262519, 522.9619205876332, 524.863535480774, 527.9366476022864, 620.2371083567192, 642.139533025743, 13740.793888091686, 14176.29118544079, 14209.36057877398, 14217.50238741639, 14220.0, 12813.295268760214, 12935.870641293655, 12997.805032924514, 13111.278879661615, 13208.273544955024, 11707.356095414749, 11898.881011189864, 12002.819957700642, 12116.515339386415, 12283.93858030713, 4200.285951388271, 4412.889677758049, 4415.558444155591, 4420.20436321462, 4444.11117776446, 84082.15917840866, 85427.0, 86872.69690954578, 90640.0, 91843.62234566487, 10167.644132455476, 10202.28583999113, 10269.7432564185, 10501.789964200672, 10634.0, 19693.704594431096, 20546.383608491768, 20619.278325258543, 20619.865907374937, 20681.482962926046, 7310.232425595236, 7387.150477695026, 7394.55632662042, 7522.962385188039, 7740.690372385154, 4077.9796101019306, 4148.56440073794, 4150.0, 4212.389203565466, 4309.181255561433, 3261.951070733941, 3376.57792775903, 3381.560397148355, 3381.983090084583, 3391.3047825195777, 637.7162162837585, 641.3362170153869, 645.3062957320899, 654.4339146638218, 654.505848084693, 571.711285800668, 600.7927265093535, 608.4037643109777, 611.0071134406589, 619.442501748421, 7965.0, 8096.7177221060865, 8368.0, 8468.237858592756, 8793.692220772242, 605.4067014325985, 610.8973303187789, 617.1113596421139, 618.1486448088006, 620.314552419579, 3818.9048699477166, 4192.895177620584, 4201.054762678373, 4222.514410842792, 4316.935245971313, 95810.52094739482, 100086.0, 113073.4346328263, 114145.0, 114288.42855785834, 33765.0, 33882.66117338844, 46643.5335646646, 99429.00570994198, 99597.0, 83950.90122746736, 84912.57543712242, 85015.14984850195, 86677.0, 87957.68063479052, 7420.6289685516585, 8176.918230817616, 8180.386471014816, 8356.247937685637, 8364.498130112213, 39076.413853791644, 43587.78206108949, 55185.0, 56865.71567142138, 58287.70856145692, 54360.0, 57439.85120297654, 63899.68050159719, 66473.0, 67457.66271168613, 10058.597656093674, 11273.605423810128, 11993.860474327801, 12324.691882703004, 12627.11610187278, 13035.543755968496, 13276.80084798748, 13908.791368129283, 14465.27673616336, 14552.85447145515, 12494.625161245178, 12723.421686265454, 12977.416016279101, 13001.804972925225, 13009.544665936646, 11772.293662380285, 11923.76152476963, 11926.821097683714, 11943.820842687193, 12366.258024518558, 12128.393580321124, 12170.269783812999, 12546.12177147591, 13071.542496012595, 13132.080754347104, 10333.276670632984, 10942.343459392461, 11095.223334366518, 11235.831462528233, 11557.24877882935, 9663.758406039906, 9777.266704997011, 9985.400875947467, 10108.342957708019, 11251.099912006855], "value": 7002.321537577288, "unit": "score"}], "name": "dromaeo_css", "value": 6948.229905804223, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 166.0, 142.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 126.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 111.0, 141.0, 108.0, 110.0, 112.0, 109.0, 144.0, 110.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 215.0, 260.0, 191.0, 187.0, 185.0, 186.0, 187.0, 183.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 60.0, 92.0, 60.0, 58.0, 60.0, 59.0, 82.0, 59.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 94.0, 74.0, 68.0, 69.0, 90.0, 68.0, 69.0, 97.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 83.0, 86.0, 82.0, 85.0, 84.0, 86.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 93.0, 92.0, 111.0, 128.0, 93.0, 93.0, 93.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 124.0, 66.0, 128.0, 125.0, 124.0, 86.0, 84.0, 84.0, 83.0], "value": 100.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 55.0, 53.0, 57.0, 59.0, 59.0, 58.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 77.0, 74.0, 73.0, 70.0, 69.0, 86.0, 101.0, 100.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 84.0, 83.0, 86.0, 85.0, 83.0, 84.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 154.0, 155.0, 140.0, 143.0, 143.0, 161.0, 222.0, 149.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 175.0, 220.0, 206.0, 166.0, 166.0, 166.0, 164.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 67.0, 66.0, 68.0, 63.0, 68.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1488.9000000000003, "alertThreshold": 2.0}]} 08:13:00 INFO - Return code: 0 08:13:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:13:00 INFO - # TBPL SUCCESS # 08:13:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:00 INFO - 2016-12-28 08:13:00.598 screenresolution[2204:23369] starting screenresolution argv=screenresolution get 08:13:00 INFO - 2016-12-28 08:13:00.601 screenresolution[2204:23369] Display 0: 1600x1200x32@60 08:13:00 INFO - 2016-12-28 08:13:00.607 screenresolution[2205:23372] starting screenresolution argv=screenresolution list 08:13:00 INFO - Available Modes on Display 0 08:13:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:00 INFO - Intel Iris: 08:13:00 INFO - Chipset Model: Intel Iris 08:13:00 INFO - Type: GPU 08:13:00 INFO - Bus: Built-In 08:13:00 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:00 INFO - Vendor: Intel (0x8086) 08:13:00 INFO - Device ID: 0x0a2e 08:13:00 INFO - Revision ID: 0x0009 08:13:00 INFO - Displays: 08:13:00 INFO - Display: 08:13:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:00 INFO - Display Serial Number: 1600x1200 60 08:13:00 INFO - Main Display: Yes 08:13:00 INFO - Mirror: Off 08:13:00 INFO - Online: Yes 08:13:00 INFO - Rotation: Supported 08:13:00 INFO - Return code: 0 08:13:00 INFO - Running post-action listener: _resource_record_post_action 08:13:00 INFO - [mozharness: 2016-12-28 16:13:00.852715Z] Finished run-tests step (success) 08:13:00 INFO - Running post-run listener: _resource_record_post_run 08:13:00 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 827392; Write bytes: 655977472; Read time: 11; Write time: 1937 08:13:00 INFO - TinderboxPrint: CPU usage
53.6% 08:13:00 INFO - TinderboxPrint: I/O read bytes / time
827,392 / 11 08:13:00 INFO - TinderboxPrint: I/O write bytes / time
655,977,472 / 1,937 08:13:00 INFO - TinderboxPrint: CPU idle
2,249.5 (46.4%) 08:13:00 INFO - TinderboxPrint: CPU system
969.1 (20.0%) 08:13:00 INFO - TinderboxPrint: CPU user
1,627.0 (33.6%) 08:13:00 INFO - TinderboxPrint: Swap in / out
349,605,888 / 0 08:13:00 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 348125696; Write bytes: 346322944; Read time: 27039; Write time: 747 08:13:00 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 712704; Write bytes: 302441472; Read time: 9; Write time: 1159 08:13:01 INFO - Running post-run listener: _upload_blobber_files 08:13:01 INFO - Blob upload gear active. 08:13:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:01 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 08:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:13:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:02 INFO - (blobuploader) - INFO - Done attempting. 08:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:03 INFO - (blobuploader) - INFO - Done attempting. 08:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:13:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:05 INFO - (blobuploader) - INFO - Done attempting. 08:13:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:05 INFO - Return code: 0 08:13:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43467c570f43ebc5aa43f0ef3121df9c026061c13cc924e29348f9d9c108baf5750edd63cdaf213e6796b8981f985cc18fddbf901e75274ce222deab1e126585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b821f863bc10238452df4350c4b4dc6823f0aa270761e945f89a7035914d285c9120c14a40e0c31a17babb72ce52e8e9bc5a6c0f98206688f67b1f58e96bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d361beb6ff71565d08417112e88d6398b5776978fa0fa21d74ddf3a0ea3397a06777b5e961f1ce8906b328441f4f0a8299d916ad9a741cf01abc759533721c16"} 08:13:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:05 INFO - Contents: 08:13:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43467c570f43ebc5aa43f0ef3121df9c026061c13cc924e29348f9d9c108baf5750edd63cdaf213e6796b8981f985cc18fddbf901e75274ce222deab1e126585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b821f863bc10238452df4350c4b4dc6823f0aa270761e945f89a7035914d285c9120c14a40e0c31a17babb72ce52e8e9bc5a6c0f98206688f67b1f58e96bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d361beb6ff71565d08417112e88d6398b5776978fa0fa21d74ddf3a0ea3397a06777b5e961f1ce8906b328441f4f0a8299d916ad9a741cf01abc759533721c16"} 08:13:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:05 INFO - Copying logs to upload dir... 08:13:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.625925 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-12-28 08:13:05.943983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-28 08:13:05.948882) ========= 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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43467c570f43ebc5aa43f0ef3121df9c026061c13cc924e29348f9d9c108baf5750edd63cdaf213e6796b8981f985cc18fddbf901e75274ce222deab1e126585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b821f863bc10238452df4350c4b4dc6823f0aa270761e945f89a7035914d285c9120c14a40e0c31a17babb72ce52e8e9bc5a6c0f98206688f67b1f58e96bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d361beb6ff71565d08417112e88d6398b5776978fa0fa21d74ddf3a0ea3397a06777b5e961f1ce8906b328441f4f0a8299d916ad9a741cf01abc759533721c16"} build_url:https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/EdAhskubQ96W2ZbZJzYY6A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43467c570f43ebc5aa43f0ef3121df9c026061c13cc924e29348f9d9c108baf5750edd63cdaf213e6796b8981f985cc18fddbf901e75274ce222deab1e126585", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b821f863bc10238452df4350c4b4dc6823f0aa270761e945f89a7035914d285c9120c14a40e0c31a17babb72ce52e8e9bc5a6c0f98206688f67b1f58e96bc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d361beb6ff71565d08417112e88d6398b5776978fa0fa21d74ddf3a0ea3397a06777b5e961f1ce8906b328441f4f0a8299d916ad9a741cf01abc759533721c16"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-28 08:13:05.985740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:13:05.986024) ========= 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.dhiZRGFQDf/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.qbi9Ee1rwv/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-28 08:13:06.033945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-28 08:13:06.034227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-28 08:13:06.034497) ========= ========= Total master_lag: 0.20 =========