builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0010 starttime: 1476363818.11 results: success (0) buildid: 20161013030204 builduid: 4727b4ffef234352b4a6b922498909cb revision: f03e2740d604d339ed553dad62a3fc54c317f8fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.107483) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.107932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.108430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.137847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.138132) ========= 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.jWTOoW39kf/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.HcXWkSyzCF/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-10-13 06:03:38-- 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% 164M=0s 2016-10-13 06:03:38 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.277317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.277667) ========= 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.jWTOoW39kf/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.HcXWkSyzCF/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.028205 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:38.335254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 06:03:38.335613) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f03e2740d604d339ed553dad62a3fc54c317f8fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f03e2740d604d339ed553dad62a3fc54c317f8fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jWTOoW39kf/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.HcXWkSyzCF/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-10-13 06:03:38,409 truncating revision to first 12 chars 2016-10-13 06:03:38,409 Setting DEBUG logging. 2016-10-13 06:03:38,410 attempt 1/10 2016-10-13 06:03:38,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f03e2740d604?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 06:03:39,805 unpacking tar archive at: mozilla-central-f03e2740d604/testing/mozharness/ program finished with exit code 0 elapsedTime=1.650843 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 06:03:40.008671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:40.008984) ========= script_repo_revision: f03e2740d604d339ed553dad62a3fc54c317f8fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:40.009465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:40.009736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 06:03:40.027641) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-13 06:03:40.028033) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jWTOoW39kf/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.HcXWkSyzCF/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:03:40 INFO - MultiFileLogger online at 20161013 06:03:40 in /builds/slave/test 06:03:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:03:40 INFO - {'append_to_log': False, 06:03:40 INFO - 'base_work_dir': '/builds/slave/test', 06:03:40 INFO - 'blob_upload_branch': 'Firefox', 06:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:03:40 INFO - 'branch': 'Firefox', 06:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:03:40 INFO - 'config_files': ('talos/mac_config.py',), 06:03:40 INFO - 'default_actions': ('clobber', 06:03:40 INFO - 'read-buildbot-config', 06:03:40 INFO - 'download-and-extract', 06:03:40 INFO - 'populate-webroot', 06:03:40 INFO - 'create-virtualenv', 06:03:40 INFO - 'install', 06:03:40 INFO - 'run-tests'), 06:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:03:40 INFO - 'download_minidump_stackwalk': True, 06:03:40 INFO - 'download_symbols': 'ondemand', 06:03:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:03:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:03:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:03:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:03:40 INFO - 'installer_path': 'installer.exe', 06:03:40 INFO - 'log_level': 'info', 06:03:40 INFO - 'log_name': 'talos', 06:03:40 INFO - 'log_to_console': True, 06:03:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:03:40 INFO - 'opt_config_files': (), 06:03:40 INFO - 'pip_index': False, 06:03:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:03:40 INFO - 'cmd': ('bash', 06:03:40 INFO - '-c', 06:03:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:03:40 INFO - 'enabled': True, 06:03:40 INFO - 'halt_on_failure': False, 06:03:40 INFO - 'name': 'check_screen_resolution'},), 06:03:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:03:40 INFO - 'cmd': ('bash', 06:03:40 INFO - '-c', 06:03:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:03:40 INFO - 'enabled': True, 06:03:40 INFO - 'halt_on_failure': False, 06:03:40 INFO - 'name': 'check_screen_resolution'},), 06:03:40 INFO - 'run_cmd_checks_enabled': True, 06:03:40 INFO - 'sps_profile': False, 06:03:40 INFO - 'sps_profile_interval': 0, 06:03:40 INFO - 'suite': 'dromaeojs', 06:03:40 INFO - 'system_bits': '32', 06:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:03:40 INFO - 'title': 't-yosemite-r7-0010', 06:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:03:40 INFO - 'use_talos_json': True, 06:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:03:40 INFO - 'work_dir': 'build'} 06:03:40 INFO - [mozharness: 2016-10-13 13:03:40.231067Z] Running clobber step. 06:03:40 INFO - Running pre-action listener: _resource_record_pre_action 06:03:40 INFO - Running main action method: clobber 06:03:40 INFO - rmtree: /builds/slave/test/build 06:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:03:42 INFO - Running post-action listener: _resource_record_post_action 06:03:42 INFO - [mozharness: 2016-10-13 13:03:42.529606Z] Finished clobber step (success) 06:03:42 INFO - [mozharness: 2016-10-13 13:03:42.529764Z] Running read-buildbot-config step. 06:03:42 INFO - Running pre-action listener: _resource_record_pre_action 06:03:42 INFO - Running main action method: read_buildbot_config 06:03:42 INFO - Using buildbot properties: 06:03:42 INFO - { 06:03:42 INFO - "project": "", 06:03:42 INFO - "product": "firefox", 06:03:42 INFO - "script_repo_revision": "production", 06:03:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:03:42 INFO - "repository": "", 06:03:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:03:42 INFO - "buildid": "20161013030204", 06:03:42 INFO - "stage_platform": "macosx64", 06:03:42 INFO - "basedir": "/builds/slave/test", 06:03:42 INFO - "nightly_build": "True", 06:03:42 INFO - "buildnumber": 47, 06:03:42 INFO - "slavename": "t-yosemite-r7-0010", 06:03:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:03:42 INFO - "platform": "yosemite_r7", 06:03:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:03:42 INFO - "branch": "mozilla-central", 06:03:42 INFO - "repo_path": "mozilla-central", 06:03:42 INFO - "revision": "f03e2740d604d339ed553dad62a3fc54c317f8fa", 06:03:42 INFO - "pgo_build": "False", 06:03:42 INFO - "builduid": "4727b4ffef234352b4a6b922498909cb", 06:03:42 INFO - "slavebuilddir": "test" 06:03:42 INFO - } 06:03:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:03:42 INFO - Running post-action listener: _resource_record_post_action 06:03:42 INFO - [mozharness: 2016-10-13 13:03:42.533370Z] Finished read-buildbot-config step (success) 06:03:42 INFO - [mozharness: 2016-10-13 13:03:42.533470Z] Running download-and-extract step. 06:03:42 INFO - Running pre-action listener: _resource_record_pre_action 06:03:42 INFO - Running main action method: download_and_extract 06:03:42 INFO - mkdir: /builds/slave/test/build/tests 06:03: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')]} 06:03:42 INFO - trying https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:03:43 INFO - Downloaded 1199 bytes. 06:03:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:03:43 INFO - Using the following test package requirements: 06:03:43 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:03:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:03:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:03:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'jsshell-mac.zip'], 06:03:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:03:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:03:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:03:43 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:03:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:03:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:03:43 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:03:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:03:43 INFO - Fetch https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:03:44 INFO - Http code: 200 06:03:44 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 06:03:44 INFO - x-amz-cf-id: V0eCKlOfY4ElUbnvAiEMqe4-NoVrWmkPSPGfsQ0smFRBnt3fXbwbow== 06:03:44 INFO - x-amz-version-id: V3.gzyJselUiMkDIOTiAEBgQ7CR__hyA 06:03:44 INFO - Expected file size: 16520330 06:03:44 INFO - Obtained file size: 16520330 06:03:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:03:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:03:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:03:51 INFO - Fetch https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:03:52 INFO - Http code: 200 06:03:52 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 06:03:52 INFO - x-amz-cf-id: E9j7MwR7HLHXXpo8TiWJMH42OKhypM1NTAV3BlBZS7-Xejou1I9kcQ== 06:03:52 INFO - x-amz-version-id: V3.gzyJselUiMkDIOTiAEBgQ7CR__hyA 06:03:52 INFO - Expected file size: 16520330 06:03:52 INFO - Obtained file size: 16520330 06:03:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:03:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:03:58 INFO - Fetch https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:03:59 INFO - Http code: 200 06:03:59 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 06:03:59 INFO - x-amz-cf-id: A1hpzGfp42Xxx4XiQ6v24noKx_NMxxDh7hlsvwDd-chJfOEHzgzpqw== 06:03:59 INFO - x-amz-version-id: cSC0omIN.mewcNEAU1G1i2NdxCBoJuxY 06:03:59 INFO - Expected file size: 14409006 06:03:59 INFO - Obtained file size: 14409006 06:03:59 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')]} 06:03:59 INFO - trying https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:03:59 INFO - Downloading https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:04:02 INFO - Downloaded 111805334 bytes. 06:04:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:04:02 INFO - mkdir: /builds/slave/test/properties 06:04:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:04:02 INFO - Writing to file /builds/slave/test/properties/build_url 06:04:02 INFO - Contents: 06:04:02 INFO - build_url:https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:04:03 INFO - Running post-action listener: _resource_record_post_action 06:04:03 INFO - Running post-action listener: set_extra_try_arguments 06:04:03 INFO - [mozharness: 2016-10-13 13:04:03.804686Z] Finished download-and-extract step (success) 06:04:03 INFO - [mozharness: 2016-10-13 13:04:03.804830Z] Running populate-webroot step. 06:04:03 INFO - Running pre-action listener: _resource_record_pre_action 06:04:03 INFO - Running main action method: populate_webroot 06:04:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:04:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:04:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:04:03 INFO - '--tppagecycles', 06:04:03 INFO - '7'], 06:04:03 INFO - 'tests': ['tsvgm']}}, 06:04:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:04:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:04:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:04:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:04:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['damp', 'tps']}, 06:04:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'tests': ['damp', 'tps']}, 06:04:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['dromaeo_dom']}, 06:04:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:04:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['basic_compositor_video']}, 06:04:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:04:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['a11yr', 06:04:03 INFO - 'ts_paint', 06:04:03 INFO - 'tpaint', 06:04:03 INFO - 'sessionrestore', 06:04:03 INFO - 'sessionrestore_no_auto_restore', 06:04:03 INFO - 'tabpaint']}, 06:04:03 INFO - 'other-e10s': {'tests': ['a11yr', 06:04:03 INFO - 'ts_paint', 06:04:03 INFO - 'tpaint', 06:04:03 INFO - 'sessionrestore', 06:04:03 INFO - 'sessionrestore_no_auto_restore', 06:04:03 INFO - 'tabpaint']}, 06:04:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:04:03 INFO - 'ts_paint', 06:04:03 INFO - 'tpaint', 06:04:03 INFO - 'sessionrestore', 06:04:03 INFO - 'sessionrestore_no_auto_restore', 06:04:03 INFO - 'tabpaint']}, 06:04:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:04:03 INFO - 'ts_paint', 06:04:03 INFO - 'tpaint', 06:04:03 INFO - 'sessionrestore', 06:04:03 INFO - 'sessionrestore_no_auto_restore', 06:04:03 INFO - 'tabpaint']}, 06:04:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['a11yr', 06:04:03 INFO - 'ts_paint', 06:04:03 INFO - 'tpaint', 06:04:03 INFO - 'sessionrestore', 06:04:03 INFO - 'sessionrestore_no_auto_restore', 06:04:03 INFO - 'tabpaint']}, 06:04:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['a11yr', 06:04:03 INFO - 'ts_paint', 06:04:03 INFO - 'tpaint', 06:04:03 INFO - 'sessionrestore', 06:04:03 INFO - 'sessionrestore_no_auto_restore', 06:04:03 INFO - 'tabpaint']}, 06:04:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['tsvgx', 06:04:03 INFO - 'tsvgr_opacity', 06:04:03 INFO - 'tart', 06:04:03 INFO - 'tscrollx', 06:04:03 INFO - 'cart']}, 06:04:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:04:03 INFO - 'tsvgr_opacity', 06:04:03 INFO - 'tart', 06:04:03 INFO - 'tscrollx', 06:04:03 INFO - 'cart']}, 06:04:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'talos_options': ['--disable-e10s'], 06:04:03 INFO - 'tests': ['tp5o']}, 06:04:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'tests': ['tp5o']}, 06:04:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'talos_options': ['--disable-e10s', 06:04:03 INFO - '--xperf_path', 06:04:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:03 INFO - 'tests': ['tp5n']}, 06:04:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:03 INFO - 'talos_options': ['--xperf_path', 06:04:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:03 INFO - 'tests': ['tp5n']}}, 06:04:03 INFO - 'talos.zip': {'path': '', 06:04:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:04:03 INFO - Running post-action listener: _resource_record_post_action 06:04:03 INFO - [mozharness: 2016-10-13 13:04:03.824351Z] Finished populate-webroot step (success) 06:04:03 INFO - [mozharness: 2016-10-13 13:04:03.824447Z] Running create-virtualenv step. 06:04:03 INFO - Running pre-action listener: _resource_record_pre_action 06:04:03 INFO - Running main action method: create_virtualenv 06:04:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:04:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:04:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:04:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:04:03 INFO - Using real prefix '/tools/python27' 06:04:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:04:04 INFO - Installing distribute.............................................................................................................................................................................................done. 06:04:07 INFO - Installing pip.................done. 06:04:07 INFO - Return code: 0 06:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:04:07 INFO - Reading from file tmpfile_stdout 06:04:07 INFO - Output received: 06:04:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:04:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:07 INFO - 'HOME': '/Users/cltbld', 06:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:07 INFO - 'LOGNAME': 'cltbld', 06:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:07 INFO - 'MOZ_NO_REMOTE': '1', 06:04:07 INFO - 'NO_EM_RESTART': '1', 06:04:07 INFO - 'PAGER': '/bin/cat', 06:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:07 INFO - 'PWD': '/builds/slave/test', 06:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:07 INFO - 'SHELL': '/bin/bash', 06:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:07 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:07 INFO - 'USER': 'cltbld', 06:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:07 INFO - 'XPC_FLAGS': '0x0', 06:04:07 INFO - 'XPC_SERVICE_NAME': '0', 06:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:08 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 06:04:08 INFO - Cleaning up... 06:04:08 INFO - Return code: 0 06:04:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:04:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:08 INFO - 'HOME': '/Users/cltbld', 06:04:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:08 INFO - 'LOGNAME': 'cltbld', 06:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:08 INFO - 'MOZ_NO_REMOTE': '1', 06:04:08 INFO - 'NO_EM_RESTART': '1', 06:04:08 INFO - 'PAGER': '/bin/cat', 06:04:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:08 INFO - 'PWD': '/builds/slave/test', 06:04:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:08 INFO - 'SHELL': '/bin/bash', 06:04:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:08 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:08 INFO - 'USER': 'cltbld', 06:04:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:08 INFO - 'XPC_FLAGS': '0x0', 06:04:08 INFO - 'XPC_SERVICE_NAME': '0', 06:04:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:08 INFO - Downloading/unpacking psutil>=3.1.1 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:08 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 06:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:04:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:11 INFO - Installing collected packages: psutil 06:04:11 INFO - Running setup.py install for psutil 06:04:11 INFO - building 'psutil._psutil_osx' extension 06:04:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:04:12 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 06:04:12 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 06:04:12 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 06:04:12 INFO - building 'psutil._psutil_posix' extension 06:04:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:04:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:04:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:04:12 INFO - ^ 06:04:12 INFO - 1 warning generated. 06:04:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:04:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:12 INFO - Successfully installed psutil 06:04:12 INFO - Cleaning up... 06:04:13 INFO - Return code: 0 06:04:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:04:13 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')]} 06:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:13 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')]} 06:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:13 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 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:13 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 06:04:13 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 06:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:13 INFO - 'HOME': '/Users/cltbld', 06:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:13 INFO - 'LOGNAME': 'cltbld', 06:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:13 INFO - 'MOZ_NO_REMOTE': '1', 06:04:13 INFO - 'NO_EM_RESTART': '1', 06:04:13 INFO - 'PAGER': '/bin/cat', 06:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:13 INFO - 'PWD': '/builds/slave/test', 06:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:13 INFO - 'SHELL': '/bin/bash', 06:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:13 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:13 INFO - 'USER': 'cltbld', 06:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:13 INFO - 'XPC_FLAGS': '0x0', 06:04:13 INFO - 'XPC_SERVICE_NAME': '0', 06:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:04:13 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 06:04:13 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 06:04:13 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 06:04:13 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 06:04:13 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 06:04:13 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 06:04:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:04:15 INFO - Installing collected packages: mozsystemmonitor 06:04:15 INFO - Running setup.py install for mozsystemmonitor 06:04:16 INFO - Successfully installed mozsystemmonitor 06:04:16 INFO - Cleaning up... 06:04:16 INFO - Return code: 0 06:04:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:04:16 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')]} 06:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:16 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')]} 06:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:16 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 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:16 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 06:04:16 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 06:04:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:16 INFO - 'HOME': '/Users/cltbld', 06:04:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:16 INFO - 'LOGNAME': 'cltbld', 06:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:16 INFO - 'MOZ_NO_REMOTE': '1', 06:04:16 INFO - 'NO_EM_RESTART': '1', 06:04:16 INFO - 'PAGER': '/bin/cat', 06:04:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:16 INFO - 'PWD': '/builds/slave/test', 06:04:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:16 INFO - 'SHELL': '/bin/bash', 06:04:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:16 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:16 INFO - 'USER': 'cltbld', 06:04:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:16 INFO - 'XPC_FLAGS': '0x0', 06:04:16 INFO - 'XPC_SERVICE_NAME': '0', 06:04:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:16 INFO - Downloading/unpacking jsonschema==2.5.1 06:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:04:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:19 INFO - Downloading functools32-3.2.3-2.tar.gz 06:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:04:19 INFO - warning: no files found matching '*.txt' 06:04:19 INFO - no previously-included directories found matching 'build' 06:04:19 INFO - no previously-included directories found matching 'dist' 06:04:19 INFO - no previously-included directories found matching '.git*' 06:04:19 INFO - Installing collected packages: jsonschema, functools32 06:04:19 INFO - Running setup.py install for functools32 06:04:19 INFO - warning: no files found matching '*.txt' 06:04:19 INFO - no previously-included directories found matching 'build' 06:04:19 INFO - no previously-included directories found matching 'dist' 06:04:19 INFO - no previously-included directories found matching '.git*' 06:04:19 INFO - Successfully installed jsonschema functools32 06:04:19 INFO - Cleaning up... 06:04:19 INFO - Return code: 0 06:04:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:19 INFO - 'HOME': '/Users/cltbld', 06:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:19 INFO - 'LOGNAME': 'cltbld', 06:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:19 INFO - 'MOZ_NO_REMOTE': '1', 06:04:19 INFO - 'NO_EM_RESTART': '1', 06:04:19 INFO - 'PAGER': '/bin/cat', 06:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:19 INFO - 'PWD': '/builds/slave/test', 06:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:19 INFO - 'SHELL': '/bin/bash', 06:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:19 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:19 INFO - 'USER': 'cltbld', 06:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:19 INFO - 'XPC_FLAGS': '0x0', 06:04:19 INFO - 'XPC_SERVICE_NAME': '0', 06:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:04:19 INFO - Cleaning up... 06:04:19 INFO - Return code: 0 06:04:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:19 INFO - 'HOME': '/Users/cltbld', 06:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:19 INFO - 'LOGNAME': 'cltbld', 06:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:19 INFO - 'MOZ_NO_REMOTE': '1', 06:04:19 INFO - 'NO_EM_RESTART': '1', 06:04:19 INFO - 'PAGER': '/bin/cat', 06:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:19 INFO - 'PWD': '/builds/slave/test', 06:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:19 INFO - 'SHELL': '/bin/bash', 06:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:19 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:19 INFO - 'USER': 'cltbld', 06:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:19 INFO - 'XPC_FLAGS': '0x0', 06:04:19 INFO - 'XPC_SERVICE_NAME': '0', 06:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:04:20 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 06:04:20 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 06:04:20 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 06:04:20 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 06:04:20 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 06:04:20 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 06:04:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:04:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:04:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:23 INFO - Downloading docopt-0.6.1.tar.gz 06:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:04:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:04:23 INFO - Running setup.py install for blobuploader 06:04:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:04:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:04:24 INFO - Running setup.py install for requests 06:04:24 INFO - Running setup.py install for docopt 06:04:24 INFO - Successfully installed blobuploader requests docopt 06:04:24 INFO - Cleaning up... 06:04:24 INFO - Return code: 0 06:04:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:04:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:24 INFO - 'HOME': '/Users/cltbld', 06:04:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:24 INFO - 'LOGNAME': 'cltbld', 06:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:24 INFO - 'MOZ_NO_REMOTE': '1', 06:04:24 INFO - 'NO_EM_RESTART': '1', 06:04:24 INFO - 'PAGER': '/bin/cat', 06:04:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:24 INFO - 'PWD': '/builds/slave/test', 06:04:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:24 INFO - 'SHELL': '/bin/bash', 06:04:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:24 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:24 INFO - 'USER': 'cltbld', 06:04:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:24 INFO - 'XPC_FLAGS': '0x0', 06:04:24 INFO - 'XPC_SERVICE_NAME': '0', 06:04:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-hxV_wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-20sLE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-fXbpVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-YfkU11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1vGs7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-25JR2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-TyATj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-X3Ix9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-QitoR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:25 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-KfF9z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-0t_1D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-phPVR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-wFmNct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-p8FUr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Kl1wNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-z3YPeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:26 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ukM14O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:04:26 INFO - Running setup.py install for manifestparser 06:04:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:04:26 INFO - Running setup.py install for mozcrash 06:04:27 INFO - Running setup.py install for mozdebug 06:04:27 INFO - Running setup.py install for mozdevice 06:04:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Running setup.py install for mozfile 06:04:27 INFO - Running setup.py install for mozhttpd 06:04:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Running setup.py install for mozinfo 06:04:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Running setup.py install for mozInstall 06:04:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:04:27 INFO - Running setup.py install for mozleak 06:04:28 INFO - Running setup.py install for mozlog 06:04:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:04:28 INFO - Running setup.py install for moznetwork 06:04:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:04:28 INFO - Running setup.py install for mozprocess 06:04:28 INFO - Running setup.py install for mozprofile 06:04:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:04:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:04:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:04:28 INFO - Running setup.py install for mozrunner 06:04:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:04:28 INFO - Running setup.py install for mozscreenshot 06:04:29 INFO - Running setup.py install for moztest 06:04:29 INFO - Running setup.py install for mozversion 06:04:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:04:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:04:29 INFO - Cleaning up... 06:04:29 INFO - Return code: 0 06:04:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:04:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:29 INFO - 'HOME': '/Users/cltbld', 06:04:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:29 INFO - 'LOGNAME': 'cltbld', 06:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:29 INFO - 'MOZ_NO_REMOTE': '1', 06:04:29 INFO - 'NO_EM_RESTART': '1', 06:04:29 INFO - 'PAGER': '/bin/cat', 06:04:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:29 INFO - 'PWD': '/builds/slave/test', 06:04:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:29 INFO - 'SHELL': '/bin/bash', 06:04:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:29 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:29 INFO - 'USER': 'cltbld', 06:04:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:29 INFO - 'XPC_FLAGS': '0x0', 06:04:29 INFO - 'XPC_SERVICE_NAME': '0', 06:04:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:04:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Aqzttb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:04:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-lLFVDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:04:29 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-KQkNch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Huxczj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:04:30 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)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-q9340h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:04:30 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)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-bQccs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:04:30 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)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8ZJMgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-WFn4wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-6l1gDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-m6NcP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-kRQNBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-rFCSu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:30 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-rlo_i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:31 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)) 06:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:31 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Gw69of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:31 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-k_MTdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:31 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)) 06:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:31 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-JA6drK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:31 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)) 06:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:31 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-jKP9ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:04:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:33 INFO - Downloading blessings-1.6.tar.gz 06:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:04:34 INFO - Installing collected packages: blessings 06:04:34 INFO - Running setup.py install for blessings 06:04:34 INFO - Successfully installed blessings 06:04:34 INFO - Cleaning up... 06:04:34 INFO - Return code: 0 06:04:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:34 INFO - Reading from file tmpfile_stdout 06:04:34 INFO - Current package versions: 06:04:34 INFO - blessings == 1.6 06:04:34 INFO - blobuploader == 1.2.4 06:04:34 INFO - docopt == 0.6.1 06:04:34 INFO - functools32 == 3.2.3-2 06:04:34 INFO - jsonschema == 2.5.1 06:04:34 INFO - manifestparser == 1.1 06:04:34 INFO - mozInstall == 1.12 06:04:34 INFO - mozcrash == 0.17 06:04:34 INFO - mozdebug == 0.1 06:04:34 INFO - mozdevice == 0.48 06:04:34 INFO - mozfile == 1.2 06:04:34 INFO - mozhttpd == 0.7 06:04:34 INFO - mozinfo == 0.9 06:04:34 INFO - mozleak == 0.1 06:04:34 INFO - mozlog == 3.4 06:04:34 INFO - moznetwork == 0.27 06:04:34 INFO - mozprocess == 0.23 06:04:34 INFO - mozprofile == 0.28 06:04:34 INFO - mozrunner == 6.12 06:04:34 INFO - mozscreenshot == 0.1 06:04:34 INFO - mozsystemmonitor == 0.3 06:04:34 INFO - moztest == 0.7 06:04:34 INFO - mozversion == 1.4 06:04:34 INFO - psutil == 3.1.1 06:04:34 INFO - requests == 1.2.3 06:04:34 INFO - wsgiref == 0.1.2 06:04:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:04:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:35 INFO - 'HOME': '/Users/cltbld', 06:04:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:35 INFO - 'LOGNAME': 'cltbld', 06:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:35 INFO - 'MOZ_NO_REMOTE': '1', 06:04:35 INFO - 'NO_EM_RESTART': '1', 06:04:35 INFO - 'PAGER': '/bin/cat', 06:04:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:35 INFO - 'PWD': '/builds/slave/test', 06:04:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:35 INFO - 'SHELL': '/bin/bash', 06:04:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:35 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:35 INFO - 'USER': 'cltbld', 06:04:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:35 INFO - 'XPC_FLAGS': '0x0', 06:04:35 INFO - 'XPC_SERVICE_NAME': '0', 06:04:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:04:35 INFO - Cleaning up... 06:04:35 INFO - Return code: 0 06:04:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:35 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 0x103e2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b3da1510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, '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.jWTOoW39kf/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.HcXWkSyzCF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:04:35 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 06:04:35 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 06:04:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:04:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:35 INFO - 'HOME': '/Users/cltbld', 06:04:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:35 INFO - 'LOGNAME': 'cltbld', 06:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:35 INFO - 'MOZ_NO_REMOTE': '1', 06:04:35 INFO - 'NO_EM_RESTART': '1', 06:04:35 INFO - 'PAGER': '/bin/cat', 06:04:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:35 INFO - 'PWD': '/builds/slave/test', 06:04:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:35 INFO - 'SHELL': '/bin/bash', 06:04:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:04:35 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:04:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:35 INFO - 'USER': 'cltbld', 06:04:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:35 INFO - 'XPC_FLAGS': '0x0', 06:04:35 INFO - 'XPC_SERVICE_NAME': '0', 06:04:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:04:36 INFO - Cleaning up... 06:04:36 INFO - Return code: 0 06:04:36 INFO - Running post-action listener: _resource_record_post_action 06:04:36 INFO - Running post-action listener: _start_resource_monitoring 06:04:36 INFO - Starting resource monitoring. 06:04:36 INFO - [mozharness: 2016-10-13 13:04:36.248962Z] Finished create-virtualenv step (success) 06:04:36 INFO - [mozharness: 2016-10-13 13:04:36.249945Z] Running install step. 06:04:36 INFO - Running pre-action listener: _resource_record_pre_action 06:04:36 INFO - Running main action method: install 06:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:36 INFO - Reading from file tmpfile_stdout 06:04:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:04:36 INFO - Reading from file tmpfile_stdout 06:04:36 INFO - Output received: 06:04:36 INFO - Usage: mozinstall [options] installer 06:04:36 INFO - Options: 06:04:36 INFO - -h, --help show this help message and exit 06:04:36 INFO - -d DEST, --destination=DEST 06:04:36 INFO - Directory to install application into. [default: 06:04:36 INFO - "/builds/slave/test"] 06:04:36 INFO - --app=APP Application being installed. [default: firefox] 06:04:36 INFO - mkdir: /builds/slave/test/build/application 06:04:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:04:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:05:10 INFO - Reading from file tmpfile_stdout 06:05:10 INFO - Output received: 06:05:10 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:05:10 INFO - Running post-action listener: _resource_record_post_action 06:05:10 INFO - [mozharness: 2016-10-13 13:05:10.685464Z] Finished install step (success) 06:05:10 INFO - [mozharness: 2016-10-13 13:05:10.685593Z] Running run-tests step. 06:05:10 INFO - Running pre-action listener: _resource_record_pre_action 06:05:10 INFO - Running main action method: run_tests 06:05:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:05:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:05:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:05:10 INFO - 2016-10-13 06:05:10.697 screenresolution[1641:7477] starting screenresolution argv=screenresolution get 06:05:10 INFO - 2016-10-13 06:05:10.700 screenresolution[1641:7477] Display 0: 1600x1200x32@60 06:05:10 INFO - 2016-10-13 06:05:10.704 screenresolution[1642:7479] starting screenresolution argv=screenresolution list 06:05:10 INFO - Available Modes on Display 0 06:05:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:05:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:05:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:05:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:05:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:05:10 INFO - Intel Iris: 06:05:10 INFO - Chipset Model: Intel Iris 06:05:10 INFO - Type: GPU 06:05:10 INFO - Bus: Built-In 06:05:10 INFO - VRAM (Dynamic, Max): 1536 MB 06:05:10 INFO - Vendor: Intel (0x8086) 06:05:10 INFO - Device ID: 0x0a2e 06:05:10 INFO - Revision ID: 0x0009 06:05:10 INFO - Displays: 06:05:10 INFO - Display: 06:05:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:05:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:05:10 INFO - Display Serial Number: 1600x1200 60 06:05:10 INFO - Main Display: Yes 06:05:10 INFO - Mirror: Off 06:05:10 INFO - Online: Yes 06:05:10 INFO - Rotation: Supported 06:05:10 INFO - Return code: 0 06:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:10 INFO - Python 2.7.3 06:05:10 INFO - Return code: 0 06:05:10 INFO - grabbing minidump binary from tooltool 06:05:10 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')]} 06:05:10 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 0x103c42d30>, '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 0x103a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c3ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:10 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 06:05:10 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 06:05:10 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 06:05:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:11 INFO - Return code: 0 06:05:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:05:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:05:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 06:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 06:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWTOoW39kf/Render', 06:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:11 INFO - 'HOME': '/Users/cltbld', 06:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:11 INFO - 'LOGNAME': 'cltbld', 06:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:11 INFO - 'MOZ_NO_REMOTE': '1', 06:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:11 INFO - 'NO_EM_RESTART': '1', 06:05:11 INFO - 'PAGER': '/bin/cat', 06:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:11 INFO - 'PWD': '/builds/slave/test', 06:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:11 INFO - 'SHELL': '/bin/bash', 06:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcXWkSyzCF/Listeners', 06:05:11 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:11 INFO - 'USER': 'cltbld', 06:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:11 INFO - 'XPC_FLAGS': '0x0', 06:05:11 INFO - 'XPC_SERVICE_NAME': '0', 06:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 06:05:11 INFO - mozversion application_buildid: 20161013030204 06:05:11 INFO - mozversion application_changeset: f03e2740d604d339ed553dad62a3fc54c317f8fa 06:05:11 INFO - mozversion application_display_name: Nightly 06:05:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:11 INFO - mozversion application_name: Firefox 06:05:11 INFO - mozversion application_remotingname: firefox 06:05:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:05:11 INFO - mozversion application_vendor: Mozilla 06:05:11 INFO - mozversion application_version: 52.0a1 06:05:11 INFO - mozversion platform_buildid: 20161013030204 06:05:11 INFO - mozversion platform_changeset: f03e2740d604d339ed553dad62a3fc54c317f8fa 06:05:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:05:11 INFO - mozversion platform_version: 52.0a1 06:05:11 INFO - using testdate: 1476363911 06:05:11 INFO - actual date: 1476363911 06:05:11 INFO - starting webserver on 'localhost:49274' 06:05:11 INFO - SUITE-START | Running 2 tests 06:05:11 INFO - TEST-START | dromaeo_css 06:05:11 INFO - operating with platform_type : mac_ 06:05:11 INFO - Initialising browser for dromaeo_css test... 06:05:11 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpCVetSD/profile http://localhost:49274/getInfo.html) 06:05:13 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 06:05:13 INFO - PROCESS | 1652 | colorDepth:24 06:05:13 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 06:05:13 INFO - PROCESS | 1652 | __metrics 06:05:14 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:05:14 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:14 INFO - TEST-INFO | 1652: exit 0 06:05:14 INFO - Browser initialized. 06:05:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:14 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpCVetSD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:26 INFO - PROCESS | 1655 | RSS: Main: 237051904 06:05:26 INFO - PROCESS | 1655 | 06:06:18 INFO - PROCESS | 1655 | 1476363978169 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] 06:08:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 06:08:32 INFO - PROCESS | 1655 | RSS: Main: 495939584 06:08:32 INFO - PROCESS | 1655 | 06:11:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 06:11:36 INFO - PROCESS | 1655 | RSS: Main: 374394880 06:11:36 INFO - PROCESS | 1655 | 06:14:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 06:14:39 INFO - PROCESS | 1655 | RSS: Main: 338587648 06:14:39 INFO - PROCESS | 1655 | 06:17:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 06:17:42 INFO - PROCESS | 1655 | RSS: Main: 350064640 06:17:42 INFO - PROCESS | 1655 | 06:20:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 06:20:46 INFO - PROCESS | 1655 | RSS: Main: 333103104 06:20:46 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 06:23:49 INFO - PROCESS | 1655 | RSS: Main: 499802112 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | __start_tp_report 06:23:49 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 06:23:49 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 06:23:49 INFO - PROCESS | 1655 | |i|pagename|runs| 06:23:49 INFO - PROCESS | 1655 | |0;dojo.html;3282.7373810095196;3288;3294.061192560121;3309.3381323735257;3344.799312041276;5388.326459192601;5472.616916815825;5510.8071217507395;5555;5563.44365563444;5453.23654688344;5503.20203570482;5511.5039646431815;5521.779128834852;5536.723163841812;5041.621878359119;5053.747312634372;5060.51925067118;5083.517065878754;5143.408508021569;5083.6441449098575;5135.43510213878;5149.948500515003;5150.768215430315;5158.097332966735;5059.367579052619;5093.134167191586;5129.1536896412235;5133.332666753336;5145.073886700392;5170.224466330043;5178.14560597501;5187.844364669066;5199.376074871002;5219.556337711299;4965.602751779885;4991;5040.571551418134;5113.411957624847;5131.384233891957;4434.667399944985;5382.569394448435;5473.28847249855;5489.725513724298;5503.697296648683;5968;5985.371535988746;5985.431384018555;5985.730642121115;6006.099085137221;5950.523958083386;6005.129256257862;6052.031674932034;6071.028635418356;6090.725917333731;5596.384397716248;5640.85897852557;5646.068398714248;5654.971725141348;5705.5720820938595;6267.7806276781;6269.592476489013;6279.434850863444;6280.528960327993;6283.183186185766;5706.80026199081;5993.0710739835395;5994.730237139339;6005.849853753691;6010.549208809357;6008.489278411384;6044.184035155197;6119.958356786701;6120.355709576858;6133.325334213233;6004.609700369462;6055.091736239599;6063.818085457443;6066.181065556093;6125.418085281891;6105.023196288573;6109.205803245639;6110.358412366638;6111.35830737775;6115.6330620162935;4691.179043667345;4795.760211989386;4798.568128868418;4801.567858892717;4872.317875497433;4351.891202719958;4410.316400957857;4422.778861056934;4429.468463784302;4454.821807127743;5618.353889302701;5640.984622767941;5643.322801263875;5648.039833228361;5674.943250567524;5640.464155905264;6198.008318668992;6202.4417802398;6206.441420272107;6208.627482351073;5358.91961620576;5414.729263536808;5533.391326954032;5582.553395728332;5585.748641311151;5270.60470464709;5283;5284.630075894651;5304.230886521433;5320.52115309624;6236.688165591702;6283;6284.151639528788;6298.811035668938;6310.905336419865;5887.61730487517;6008.789692360747;6035.426634469718;6083.847903802263;6123.877522449437;6235.781747638811;6236.719347629277;6281.277653069956;6282.748690052529;6299.968500157654;5954.07711804671;5985.042393217239;6013.067974463965;6015.165374560801;6101.969490152521;5893.145493903275;6082.574219804571;6119.418655227746;6131.938680613137;6152.292486364126;5676.20533125371;5772.249607550992;5864.44287792659;5868.354481007171;5869.559783016205;5779.306483222041;5840.620359676607;5845.3570107289015;5846.152307915243;5860.970695146668;5737.397573254748;5738.741756620879;5740.569457290637;5740.942590574041;5748.137779333133;5809.796657116981;5820.534357251495;5834.241548598655;5850.385709500441;5851.297844258716;5715.628484148517;5745.8563535911935;5745.971270143623;5749.223854779551;5758.021136406905 06:23:49 INFO - PROCESS | 1655 | |1;ext.html;510.53031211285617;532.5845840244608;537.8063896997078;550.7163810637521;554.603458527153;38443.42334864979;39356.2128757425;39531.40702889455;41451.37822932658;41775.79112104435;40071.799641001824;40329.798351008205;40377;40516;40524.59475405245;8475.406721529496;9416.67041653544;9547.331686781929;9565.904340956606;9567.569459374345;8501.74494765155;8592.398532102756;8592.742217733477;8599.527026013568;9177.678781242625;11261.042811361043;11476.426178691074;11479.827802582968;11490;11506.769864602746;11309.038731707815;11402.201845870792;11409.25839820409;11419.257748246337;11422.828657570102;8330.62512186953;8548.358873084482;11058.336499809957;11363.772724545546;11395.487203075882;38555.03612409684;38890.416643750366;38891.416628750594;38946.41580376297;38985.22029559421;3160.4918540420117;3222.871085156591;3235.320582677617;3264.8041117533025;3337.8831740889195;29435.852820735974;29751.851240743657;30327.696723032706;30603.69396306031;30610.69389306101;3168.318811455525;3198.296374797541;3244.5155075327966;3331.1172539277113;3338.532605435241;420898.7460752365;422739;427049.86475067737;429298;429790;54901;55203.44796552063;55306.17040744392;55371.16943245855;55392.16911746327;58073;58144;58212.4178758207;58318.833623328144;58355.70822145947;15415.845841541666;15616.063036217864;15641.921790390976;15649.374025038871;15691.686166276611;12118.39408029595;12153.149279550347;12153.906148446506;12159.209651372632;12165.93917030427;13088.541901033419;13364;13400.994925380635;14729.410823566937;15080.698386032218;5627.380988091307;6330.4619107375465;6396.456301214356;6449.935760599542;6578.144841170617;745.5340412242349;937.3532262738688;937.4469063252714;1006.4414250091123;1011.3969358566607;23014.769852301597;27729.86135069352;28540.857295713802;28894.855525722236;29635.55546666802;979.3389462113046;1036.4972988100765;1094.6278265389806;1124.145649306533;1127.8251870960014;14983.550493485212;15035.323410446555;15124.54626361211;15221.771673424908;15330.310136043905;179845.20154798546;180051;180488;180734;181664;54892.72553637206;55073.724631376586;55107.07125250597;55112.72443637756;55303;1296.2546535741985;1349.6705744841324;1350.2033800057816;1359.1301566997129;1360.5170164591427;26506.602400963617;27419.725802741716;28801.42397152087;28934.985354364366;29607.703922960496;47090.82272943067;47203.05593888172;47414.81462963454;47577.286340704224;47604.2859357103;573330;573531;575166;576439;581105;24532.386690332172;25425.745742542338;38218.235635287696;38514.614853851104;38515.61484385232;37609.059773504785;38601.03497412587;38783.806080969414;40542.98642533842;44863;35986.28027439489;36591.08522286964;36782.63217367792;37713.62286377211;37897.62102378941;34388.65611343855;36431.817840910626;36947.630523695494;37493.250134997696;37604.435933460474;35810.462843056855;36095;36559;36771.63228367789;37133.81433092817;25360.112396066048;31803.20491987719;32774.34451311008;32853.68585256563;33107.33785324328;23702.762972370056;24088.277351679477;24113.397165071012;24496.14263500769;24508.509829802948 06:23:49 INFO - PROCESS | 1655 | |2;jquery.html;353.6587193358409;367.77749461575746;375.7144570126704;383.7524796506253;401.14956292659565;14469.710605787892;14906.627334316634;15290.313955963982;16825.887210866;20248.493787655316;18558.536036599056;19174.8636055912;19384.03079846009;19668.409947701555;20203.39389818308;5420.376656684472;5777.277840269966;5777.971110144465;5778.4799368056865;5783.277090363705;4693.577578017977;5313.043652142613;5467.753951072212;5766.394528574502;5785.855353616173;5675.091985282335;5713.657180569158;5724.484796368326;5725.742341594618;5727.026405511052;5388.380336261322;5598.2442370280105;5642.379338272786;5658.377578466366;5660.405657405975;4778.354922085544;4965.553100220961;4966.106100901836;4973.626977976666;4983.227599722049;23969.16107936231;23997.40006499834;24730.25809225726;25057.997680092776;25442;2163.5348400094053;2230.2528652901296;2356.552255071531;2378.857268563892;2417.8791060446906;7561.546307221584;14437.87218736256;15642.687146257125;15666.216689165496;15668.059916404938;1660.3939562059882;1754.894706317625;1803.3147403986402;1840.723891416285;1847.214933653192;98745;108567;108848.36727449094;109180;109443;10297.9485102574;10328.328658637165;10522.31604945676;10737.570497180026;10979.505922233519;13293.468261269634;13297.800532992012;13305.600831974863;13313.66715832112;13318.334083295797;7886.290233878978;8139.48852877271;8179.509229446252;8303.211194936472;8346.624401901929;7497.625118744041;7511.948327234191;8187.918120818716;8199.385046121564;8328.292095171857;6330.208723909512;6478.352164783484;6482.837929051717;6492.772752953624;6597.241317248482;1630.4619475573033;1826.926922923068;1833.9913047823643;1873.3162395725462;1873.9063046847602;909.4588719711761;909.6406919266852;921.2445794448622;942.7595963029521;1010.4897027001317;16554.917225414036;20155.39533813988;21721.131154753948;21735.89132054361;21779.23772667949;937.3438592984802;946.7301818981557;973.1436336024253;990.5691024404407;1023.5701005577675;10882.891171088188;10981.39602321864;11478.368689721978;11724;11801.52793888252;535617;616207.9189604024;629713;635102;635426;96801.515992421;99843;106850.46574767077;127537.44925101446;135664.32167839294;864.3992425264381;930.3998920696113;939.7462685074992;1019.0319196763105;1022.3048327137618;18684.906575467037;18980.810191897905;18983.335583255073;19032.048397580344;19049.523761906064;36938.8153059233;44795.295407540565;54567;54734.905301894534;55446;77548;77794.6110269445;80302.59848700953;80971;81076.7838482435;6900.827479313058;7920.603969801372;7970.880436793569;7980.401469889665;8001.519908805491;10524.579016839241;10799.946000269949;12631.368431578569;13005.154664947127;13039.087263891437;10729.034386905216;10776.784464310827;11123.27698699582;11268.7746245073;11373.943130284295;8936.687215947411;9250.167484926389;10429.426381549089;10975.780484390427;11074.557017719524;10796.784064318826;11019.008289254005;11092.389918554234;11492.482838272465;11620;6732;7237.927620723936;7305.780826575211;7420;7495.850082998419;10394.324368915995;10916.56333746673;11259.662210133709;11283.492242849255;11385.259958102697 06:23:49 INFO - PROCESS | 1655 | |3;mootools.html;1488.32281312003;1505.6010157308315;1710.9486715398534;1876.0619690154922;1899.192843041707;8356.83286334273;8880.555972201397;8881.289496840238;8888.733337999854;8915.554222288893;7756.650950707218;8043.436959412844;8353.37349698772;8636.13638636136;8653.87019194711;2329.0450915124843;2362.7282862470865;2365.5860224460735;2366.183666635008;2368.988155059231;2343.2852979841227;2354.482013956927;2382.845115067515;2387.4747555537842;2396.3050715292543;2353.2587235020915;2365.9053637854463;2370.502194539149;2379;2383.5113801670705;2327.94180145496;2344;2351.6237402015595;2356.0222507659387;2357.5638506876285;2324.7210334759766;2342.6837376954063;2348.1077190667606;2352.1061996441413;2352.8941197646145;8640.697575584825;8805.691800787006;8813.735587932373;8815.382923195379;8830.955845220733;5020.0963826511215;5178.40448348441;5181.533661970403;5187.247849061865;5187.688738675692;3025.5764193012997;3353.9161520961925;3396.762226644136;3593.5508061492314;3643.7813731176216;1073.5169173871789;1087.9728006799814;1093.1364222264401;1099.7085772270354;1117.754094099297;11478.311301321948;11586.957173854309;11658.825117623242;11662.241954272946;11665.533378664843;4417.757023363682;4603.792829322689;4674.22875225584;4715.575598196178;4720.763961801897;8333.95833020831;9755.170810481046;9758.707238782848;9764;9764.902350976541;5124.615653825978;5127.897442051213;5142.1772516397195;5146.794128234904;5151.2530683050745;4179.1432756284885;4211.326187809936;4337.392765012901;4698.788554515055;4715.198416269242;3736.831842567091;3768.1333293342686;3861.2084522672785;3892.1242720387686;3966.5636779954184;1241.075398827879;1241.714405686697;1244.2285782814713;1257.352463481308;1267.4043199696127;825.9297959673495;842.9084335785172;903.6520939438363;914.3005600715458;949.4777872170279;5560.77756889728;5665.858353541194;5671.688057156814;5795.246617939641;5948.672822994777;886.3485338276362;916.8899732032199;929.1916033051289;947.2327414794039;956.0200794186015;3214.276787722744;3595.334863050292;3778.2459495669455;4011.6991225658194;4081.653059489977;7962.6416811243635;10642.574297028032;10699.625513107005;10737.946310268555;10753.83869241962;10274.383536987805;10680.98530639588;10690.572377104829;10691.465426728633;10701.304415213142;7849.725259615886;8102.635381407733;8102.756917292609;8126.024877014796;8129.268365847102;5666.829995100154;5725.484706376446;5758.424157584208;5842.474177324061;5847.035239185487;9841.311108222642;9870.111689947938;9885.011498850057;9947.204223661945;9958.950205248928;9208.585613647268;9624.422534647943;9655.710328690151;9771.560279787285;10033.996600339908;6534.150560427114;6735.663216839236;6751.223609284995;7308.232635573401;7460.813479663052;6451.387118223761;6947.652617369213;7905.644246009058;8187.263146316622;8207.876881846658;7194.892076618959;7340.743073992385;7356.77929662111;7382.52013619113;7504.874268859715;7159;7176.533525321046;7192.532485388433;7222.313880181375;7245.45659075582;6547.672616369067;6742.494312926452;6818.829529261808;6898.06876071744;6911.481638877205;4950.975245123751;4955.306257124078;4970.975145124251;5011.4236862761245;5085.669431486942;4922.729249891147;4938.481459446706;5023.271625614192;5061.9493805061475;5071.290019397361 06:23:49 INFO - PROCESS | 1655 | |4;prototype.html;298.9894157746814;300.3047944009618;309.26240915416724;313.98116113033205;317.84902171468553;5080.415752188499;5190.662606930547;5236.2931004314405;5259.92171604821;5291.708956007418;4281.379200015996;5001.624878134146;5142.740028692966;5169.689818610886;5190.8702282442955;3921.6273705024155;4019.899502512446;4034.354503279476;4042.6967977401664;4064.3293856513787;3647.963520364789;3824.2542704172697;3938.6849052075763;3958.366661334187;4037.899052523696;3941.724079314449;4011.696198735408;4023.396490526415;4032.387045181936;4059.1069964607887;3963.3064213762477;3995.9800200998952;4006.1771893788255;4032.7177097602885;4032.7983600820135;2930.120963710878;3062.6631070582216;3505.8772942946875;3525.5769307682986;3533.5406397168204;4462.419885414908;4469.7541635210055;4568.497465278817;4673.345731597579;5175.835437026676;4011.859584914543;4542.04617030424;4601.907961840778;4607.631389488833;4612.907741845144;4787.904241915142;5526.640768350045;5554.139363313295;5606.159076138571;5650.3502097258515;3659.2864391443677;3785.9810700946596;3790.6777923876502;3794.620537946211;3813.1229817141934;4445.466544014739;5239.764210610493;5790.13148027795;5790.594658373958;5893.381194974509;3797.2785170817456;3797.7531460454984;3802.144517483544;3821.4332123829095;3831.1188426662025;3710.7959062251834;3852.6917846572205;3871.7676939383728;3898.317794385971;3904.668103211202;3731.7014638828828;4469.240229161051;4514.25514790056;4517.209488339593;4529.097778932856;4570.634349252118;5201.687898726089;5508.173773933861;5514.751836167382;5550.333959924754;1221.096388672376;1247.2267194339386;1247.5758242197514;1305.8563558008611;1324.8542660307357;877.1316396767155;883.6200433813522;897.371839712191;905.515549181185;907.5099446299057;4435.356873253425;4607.755905905454;4679.415073115861;5234.607404444682;5309.734513274321;5375.946240537544;5605.215269862222;5642.210090587321;5674.687892165888;5702.287214098238;4386.8903277417685;4588.3805686231935;4628.74541900192;5188.391598604445;5213.113770658997;2458.6434966929696;2496.488219914913;2499.7502247976604;2502.3493891587955;2518.4837108392735;4002.939221106409;4030.6170913763144;4049.6152865477734;4283.121959998193;4952.232403977389;4582.510684027638;4789.042191561632;4822.662413631082;4849.9687695190505;4861.51384861511;4100.528439229527;4850.308079016109;4851.059576169489;4855.155041084366;4913.361263035782;4135.464178127658;4427;4614.976925115488;4708.623310135113;4736.573708366263;4000.6799456042863;4005.1388951375593;4502.864914052584;4534.977325113353;4710.929336059893;4047.8988025299604;4657.13714514197;4854.393200849894;4892.877678058077;4947.752612369439;2881.9423611528073;3226.4998925166637;3282.9330467597647;3298.274379636476;3311.569495965509;3917.8628747993685;4354.608085272341;4410.625096866802;4457.910841783211;4695.906081878275;4068.5931406859077;4109.938350924798;4313.25313248135;4562.292844609091;4612.492625811091;3802.5436947565363;3990.960090399059;4527.343535187445;4582.610478109398;4591.586757191869;4593.28804035375;4872.317875497504;4873.610111191168;5166.870828229325;5534.723263836872;4458.8439404620685;5036.395632523974;5193.37679478465;5224.843254702365;5564.527015203753;5052.393712754493;5277.27951793992;5300.496452836975;5476.808311709071;5502.422245664147 06:23:49 INFO - PROCESS | 1655 | |5;yui.html;703.1948419060176;706.487796347648;748.8652042632324;771.0978155557997;834.8747687846823;13561.66095847603;14078.79865166973;14182.432702691905;14239.92880035601;14287.71424571508;12543.498260069586;12690.30203338816;12746.362681865916;12751.362431878415;12761.23432594045;672.9259781424039;841.1168273313027;871.0244526130742;879.4986857491201;882.1575395497284;697.4943166204487;815.592203898051;870.3907264914553;875.5272153037353;884.1600479544427;916.3173435790345;917.857732051533;918.5085979001236;920.0569416348229;923.3813345058793;910.8223896340216;910.9043550427209;913.2146354135439;913.3469569257946;915.5376534849925;530.6126527634809;552.4530714592564;647.760328678392;678.6369292428527;683.7641013850264;11602.4198790061;13872.028957972945;13879.028468007244;13881.958853086058;13891.513797017056;13163.473461061547;13385.397657105355;13635.250061246628;13697.657558561015;14023.158610483404;12052.879471205264;12119.212251203731;12121.333326667118;12448.315342656151;12572.811407828889;4280.614744672995;4321.978390108061;4346.6522678185665;4350.427265203532;4381.890452738675;105541.94458055397;106882.46558767234;107167;110582;111185;10709.036186743231;10726.892731072745;10844.45777711127;11006.559737610565;11247.268927519684;20527.66570172964;20529.79470205309;20535.4866128345;20601.484962875747;20602.690959635616;7477.70089196426;7598.126215485179;7738.7291444800285;7753.612319384121;7850.371970242367;4188.81150348235;4299.333603291495;4300.61294483498;4339.956600434019;4480.507144214133;3274.459714147139;3740.457633643161;3920.784356860343;3921.11774850662;3924.4113382992778;668.6924014953177;675.3179288918129;680.0207700910673;682.1575354437266;712.8859382498879;576.6136688418769;622.651315263454;638.355261186196;644.9613023218621;671.6473851228144;9261.30540209487;9364.578593963288;9371.203447706885;9428.575714092882;9444.811103777885;503.5216544282946;525.1833399064415;601.197401469035;603.7132362127954;618.9164462797555;4284.764337961442;4422.226110430662;4440.933385999213;4480.260756975128;4538.678977201923;128282;153081;155127;158058;159899;128982;134798;135480.32259838638;136464.31767841097;138070.3096484531;108907.99999999841;112866.43566782113;112879;113605;116307.41846290714;6849.8972515411315;7108.289171082851;8498.957505212435;8525.616347264264;8661.04728479854;48587.27119093287;58436.4156358431;60726.78546428958;63916;64393;88568.22863542564;93760.53119734357;97864;99750;101713.49143254236;11244.943775281072;11252.60615878473;11428.542858285575;11716.94141529321;12097.939510302393;12012.519499220283;13303.800442993557;14047.789283160557;14202.928985355007;14820.03669761462;13517.932410337886;13549.86450135486;13657.453701851815;14023.859761402664;14025.789613155606;13610.251436171106;13612.727745444838;13920.721585568435;14341.721643432125;14433.494827680981;13225.603231903058;13334.19994800315;13534.729305414034;13751.862481375458;13838.861611383758;10416.791664166825;10853.214156106884;11199.832002519806;11247.606333778278;11337.376444295644;9027.322950778587;11155.398360762232;11306.773864522498;11309.71725706831;11448.141389395994 06:23:49 INFO - PROCESS | 1655 | __end_tp_report 06:23:49 INFO - PROCESS | 1655 | __start_cc_report 06:23:49 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,3125 06:23:49 INFO - PROCESS | 1655 | __end_cc_report 06:23:49 INFO - PROCESS | 1655 | __startTimestamp1476365029406__endTimestamp 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | ------- Summary: start ------- 06:23:49 INFO - PROCESS | 1655 | Number of tests: 6 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5594.93 Median:5740.94 stddev:620.38 (10.8%) stddev-sans-first:595.17 06:23:49 INFO - PROCESS | 1655 | Values: 3282.7 3288.0 3294.1 3309.3 3344.8 5388.3 5472.6 5510.8 5555.0 5563.4 5453.2 5503.2 5511.5 5521.8 5536.7 5041.6 5053.7 5060.5 5083.5 5143.4 5083.6 5135.4 5149.9 5150.8 5158.1 5059.4 5093.1 5129.2 5133.3 5145.1 5170.2 5178.1 5187.8 5199.4 5219.6 4965.6 4991.0 5040.6 5113.4 5131.4 4434.7 5382.6 5473.3 5489.7 5503.7 5968.0 5985.4 5985.4 5985.7 6006.1 5950.5 6005.1 6052.0 6071.0 6090.7 5596.4 5640.9 5646.1 5655.0 5705.6 6267.8 6269.6 6279.4 6280.5 6283.2 5706.8 5993.1 5994.7 6005.8 6010.5 6008.5 6044.2 6120.0 6120.4 6133.3 6004.6 6055.1 6063.8 6066.2 6125.4 6105.0 6109.2 6110.4 6111.4 6115.6 4691.2 4795.8 4798.6 4801.6 4872.3 4351.9 4410.3 4422.8 4429.5 4454.8 5618.4 5641.0 5643.3 5648.0 5674.9 5640.5 6198.0 6202.4 6206.4 6208.6 5358.9 5414.7 5533.4 5582.6 5585.7 5270.6 5283.0 5284.6 5304.2 5320.5 6236.7 6283.0 6284.2 6298.8 6310.9 5887.6 6008.8 6035.4 6083.8 6123.9 6235.8 6236.7 6281.3 6282.7 6300.0 5954.1 5985.0 6013.1 6015.2 6102.0 5893.1 6082.6 6119.4 6131.9 6152.3 5676.2 5772.2 5864.4 5868.4 5869.6 5779.3 5840.6 5845.4 5846.2 5861.0 5737.4 5738.7 5740.6 5740.9 5748.1 5809.8 5820.5 5834.2 5850.4 5851.3 5715.6 5745.9 5746.0 5749.2 5758.0 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:54628.84 Median:36495.41 stddev:114214.13 (313.0%) stddev-sans-first:114462.25 06:23:49 INFO - PROCESS | 1655 | Values: 510.5 532.6 537.8 550.7 554.6 38443.4 39356.2 39531.4 41451.4 41775.8 40071.8 40329.8 40377.0 40516.0 40524.6 8475.4 9416.7 9547.3 9565.9 9567.6 8501.7 8592.4 8592.7 8599.5 9177.7 11261.0 11476.4 11479.8 11490.0 11506.8 11309.0 11402.2 11409.3 11419.3 11422.8 8330.6 8548.4 11058.3 11363.8 11395.5 38555.0 38890.4 38891.4 38946.4 38985.2 3160.5 3222.9 3235.3 3264.8 3337.9 29435.9 29751.9 30327.7 30603.7 30610.7 3168.3 3198.3 3244.5 3331.1 3338.5 420898.7 422739.0 427049.9 429298.0 429790.0 54901.0 55203.4 55306.2 55371.2 55392.2 58073.0 58144.0 58212.4 58318.8 58355.7 15415.8 15616.1 15641.9 15649.4 15691.7 12118.4 12153.1 12153.9 12159.2 12165.9 13088.5 13364.0 13401.0 14729.4 15080.7 5627.4 6330.5 6396.5 6449.9 6578.1 745.5 937.4 937.4 1006.4 1011.4 23014.8 27729.9 28540.9 28894.9 29635.6 979.3 1036.5 1094.6 1124.1 1127.8 14983.6 15035.3 15124.5 15221.8 15330.3 179845.2 180051.0 180488.0 180734.0 181664.0 54892.7 55073.7 55107.1 55112.7 55303.0 1296.3 1349.7 1350.2 1359.1 1360.5 26506.6 27419.7 28801.4 28935.0 29607.7 47090.8 47203.1 47414.8 47577.3 47604.3 573330.0 573531.0 575166.0 576439.0 581105.0 24532.4 25425.7 38218.2 38514.6 38515.6 37609.1 38601.0 38783.8 40543.0 44863.0 35986.3 36591.1 36782.6 37713.6 37897.6 34388.7 36431.8 36947.6 37493.3 37604.4 35810.5 36095.0 36559.0 36771.6 37133.8 25360.1 31803.2 32774.3 32853.7 33107.3 23702.8 24088.3 24113.4 24496.1 24508.5 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34384.17 Median:24894.13 stddev:101464.94 (407.6%) stddev-sans-first:101717.40 06:23:49 INFO - PROCESS | 1655 | Values: 353.7 367.8 375.7 383.8 401.1 14469.7 14906.6 15290.3 16825.9 20248.5 18558.5 19174.9 19384.0 19668.4 20203.4 5420.4 5777.3 5778.0 5778.5 5783.3 4693.6 5313.0 5467.8 5766.4 5785.9 5675.1 5713.7 5724.5 5725.7 5727.0 5388.4 5598.2 5642.4 5658.4 5660.4 4778.4 4965.6 4966.1 4973.6 4983.2 23969.2 23997.4 24730.3 25058.0 25442.0 2163.5 2230.3 2356.6 2378.9 2417.9 7561.5 14437.9 15642.7 15666.2 15668.1 1660.4 1754.9 1803.3 1840.7 1847.2 98745.0 108567.0 108848.4 109180.0 109443.0 10297.9 10328.3 10522.3 10737.6 10979.5 13293.5 13297.8 13305.6 13313.7 13318.3 7886.3 8139.5 8179.5 8303.2 8346.6 7497.6 7511.9 8187.9 8199.4 8328.3 6330.2 6478.4 6482.8 6492.8 6597.2 1630.5 1826.9 1834.0 1873.3 1873.9 909.5 909.6 921.2 942.8 1010.5 16554.9 20155.4 21721.1 21735.9 21779.2 937.3 946.7 973.1 990.6 1023.6 10882.9 10981.4 11478.4 11724.0 11801.5 535617.0 616207.9 629713.0 635102.0 635426.0 96801.5 99843.0 106850.5 127537.4 135664.3 864.4 930.4 939.7 1019.0 1022.3 18684.9 18980.8 18983.3 19032.0 19049.5 36938.8 44795.3 54567.0 54734.9 55446.0 77548.0 77794.6 80302.6 80971.0 81076.8 6900.8 7920.6 7970.9 7980.4 8001.5 10524.6 10799.9 12631.4 13005.2 13039.1 10729.0 10776.8 11123.3 11268.8 11373.9 8936.7 9250.2 10429.4 10975.8 11074.6 10796.8 11019.0 11092.4 11492.5 11620.0 6732.0 7237.9 7305.8 7420.0 7495.9 10394.3 10916.6 11259.7 11283.5 11385.3 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5573.26 Median:5105.14 stddev:3112.65 (61.0%) stddev-sans-first:3106.24 06:23:49 INFO - PROCESS | 1655 | Values: 1488.3 1505.6 1710.9 1876.1 1899.2 8356.8 8880.6 8881.3 8888.7 8915.6 7756.7 8043.4 8353.4 8636.1 8653.9 2329.0 2362.7 2365.6 2366.2 2369.0 2343.3 2354.5 2382.8 2387.5 2396.3 2353.3 2365.9 2370.5 2379.0 2383.5 2327.9 2344.0 2351.6 2356.0 2357.6 2324.7 2342.7 2348.1 2352.1 2352.9 8640.7 8805.7 8813.7 8815.4 8831.0 5020.1 5178.4 5181.5 5187.2 5187.7 3025.6 3353.9 3396.8 3593.6 3643.8 1073.5 1088.0 1093.1 1099.7 1117.8 11478.3 11587.0 11658.8 11662.2 11665.5 4417.8 4603.8 4674.2 4715.6 4720.8 8334.0 9755.2 9758.7 9764.0 9764.9 5124.6 5127.9 5142.2 5146.8 5151.3 4179.1 4211.3 4337.4 4698.8 4715.2 3736.8 3768.1 3861.2 3892.1 3966.6 1241.1 1241.7 1244.2 1257.4 1267.4 825.9 842.9 903.7 914.3 949.5 5560.8 5665.9 5671.7 5795.2 5948.7 886.3 916.9 929.2 947.2 956.0 3214.3 3595.3 3778.2 4011.7 4081.7 7962.6 10642.6 10699.6 10737.9 10753.8 10274.4 10681.0 10690.6 10691.5 10701.3 7849.7 8102.6 8102.8 8126.0 8129.3 5666.8 5725.5 5758.4 5842.5 5847.0 9841.3 9870.1 9885.0 9947.2 9959.0 9208.6 9624.4 9655.7 9771.6 10034.0 6534.2 6735.7 6751.2 7308.2 7460.8 6451.4 6947.7 7905.6 8187.3 8207.9 7194.9 7340.7 7356.8 7382.5 7504.9 7159.0 7176.5 7192.5 7222.3 7245.5 6547.7 6742.5 6818.8 6898.1 6911.5 4951.0 4955.3 4971.0 5011.4 5085.7 4922.7 4938.5 5023.3 5061.9 5071.3 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4155.82 Median:4515.73 stddev:1236.59 (27.4%) stddev-sans-first:1205.70 06:23:49 INFO - PROCESS | 1655 | Values: 299.0 300.3 309.3 314.0 317.8 5080.4 5190.7 5236.3 5259.9 5291.7 4281.4 5001.6 5142.7 5169.7 5190.9 3921.6 4019.9 4034.4 4042.7 4064.3 3648.0 3824.3 3938.7 3958.4 4037.9 3941.7 4011.7 4023.4 4032.4 4059.1 3963.3 3996.0 4006.2 4032.7 4032.8 2930.1 3062.7 3505.9 3525.6 3533.5 4462.4 4469.8 4568.5 4673.3 5175.8 4011.9 4542.0 4601.9 4607.6 4612.9 4787.9 5526.6 5554.1 5606.2 5650.4 3659.3 3786.0 3790.7 3794.6 3813.1 4445.5 5239.8 5790.1 5790.6 5893.4 3797.3 3797.8 3802.1 3821.4 3831.1 3710.8 3852.7 3871.8 3898.3 3904.7 3731.7 4469.2 4514.3 4517.2 4529.1 4570.6 5201.7 5508.2 5514.8 5550.3 1221.1 1247.2 1247.6 1305.9 1324.9 877.1 883.6 897.4 905.5 907.5 4435.4 4607.8 4679.4 5234.6 5309.7 5375.9 5605.2 5642.2 5674.7 5702.3 4386.9 4588.4 4628.7 5188.4 5213.1 2458.6 2496.5 2499.8 2502.3 2518.5 4002.9 4030.6 4049.6 4283.1 4952.2 4582.5 4789.0 4822.7 4850.0 4861.5 4100.5 4850.3 4851.1 4855.2 4913.4 4135.5 4427.0 4615.0 4708.6 4736.6 4000.7 4005.1 4502.9 4535.0 4710.9 4047.9 4657.1 4854.4 4892.9 4947.8 2881.9 3226.5 3282.9 3298.3 3311.6 3917.9 4354.6 4410.6 4457.9 4695.9 4068.6 4109.9 4313.3 4562.3 4612.5 3802.5 3991.0 4527.3 4582.6 4591.6 4593.3 4872.3 4873.6 5166.9 5534.7 4458.8 5036.4 5193.4 5224.8 5564.5 5052.4 5277.3 5300.5 5476.8 5502.4 06:23:49 INFO - PROCESS | 1655 | 06:23:49 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24911.76 Median:3507.46 stddev:40556.83 (1156.3%) stddev-sans-first:40629.87 06:23:49 INFO - PROCESS | 1655 | Values: 703.2 706.5 748.9 771.1 834.9 13561.7 14078.8 14182.4 14239.9 14287.7 12543.5 12690.3 12746.4 12751.4 12761.2 672.9 841.1 871.0 879.5 882.2 697.5 815.6 870.4 875.5 884.2 916.3 917.9 918.5 920.1 923.4 910.8 910.9 913.2 913.3 915.5 530.6 552.5 647.8 678.6 683.8 11602.4 13872.0 13879.0 13882.0 13891.5 13163.5 13385.4 13635.3 13697.7 14023.2 12052.9 12119.2 12121.3 12448.3 12572.8 4280.6 4322.0 4346.7 4350.4 4381.9 105541.9 106882.5 107167.0 110582.0 111185.0 10709.0 10726.9 10844.5 11006.6 11247.3 20527.7 20529.8 20535.5 20601.5 20602.7 7477.7 7598.1 7738.7 7753.6 7850.4 4188.8 4299.3 4300.6 4340.0 4480.5 3274.5 3740.5 3920.8 3921.1 3924.4 668.7 675.3 680.0 682.2 712.9 576.6 622.7 638.4 645.0 671.6 9261.3 9364.6 9371.2 9428.6 9444.8 503.5 525.2 601.2 603.7 618.9 4284.8 4422.2 4440.9 4480.3 4538.7 128282.0 153081.0 155127.0 158058.0 159899.0 128982.0 134798.0 135480.3 136464.3 138070.3 108908.0 112866.4 112879.0 113605.0 116307.4 6849.9 7108.3 8499.0 8525.6 8661.0 48587.3 58436.4 60726.8 63916.0 64393.0 88568.2 93760.5 97864.0 99750.0 101713.5 11244.9 11252.6 11428.5 11716.9 12097.9 12012.5 13303.8 14047.8 14202.9 14820.0 13517.9 13549.9 13657.5 14023.9 14025.8 13610.3 13612.7 13920.7 14341.7 14433.5 13225.6 13334.2 13534.7 13751.9 13838.9 10416.8 10853.2 11199.8 11247.6 11337.4 9027.3 11155.4 11306.8 11309.7 11448.1 06:23:49 INFO - PROCESS | 1655 | -------- Summary: end -------- 06:23:49 INFO - PROCESS | 1655 | 06:23:50 INFO - TEST-INFO | 1655: exit 0 06:23:50 INFO - TEST-OK | dromaeo_css | took 1118753ms 06:23:50 INFO - TEST-START | kraken 06:23:50 INFO - operating with platform_type : mac_ 06:23:50 INFO - Initialising browser for kraken test... 06:23:50 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpZK9qFq/profile http://localhost:49274/getInfo.html) 06:23:52 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 06:23:52 INFO - PROCESS | 1665 | colorDepth:24 06:23:52 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 06:23:52 INFO - PROCESS | 1665 | __metrics 06:23:52 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:23:52 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:23:53 INFO - TEST-INFO | 1665: exit 0 06:23:53 INFO - Browser initialized. 06:23:53 INFO - Running cycle 1/1 for kraken test... 06:23:53 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpZK9qFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:05 INFO - PROCESS | 1667 | RSS: Main: 236703744 06:24:05 INFO - PROCESS | 1667 | 06:24:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:09 INFO - PROCESS | 1667 | RSS: Main: 295280640 06:24:09 INFO - PROCESS | 1667 | 06:24:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 06:24:12 INFO - PROCESS | 1667 | RSS: Main: 297897984 06:24:12 INFO - PROCESS | 1667 | 06:24:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 06:24:16 INFO - PROCESS | 1667 | RSS: Main: 387969024 06:24:16 INFO - PROCESS | 1667 | 06:24:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 06:24:19 INFO - PROCESS | 1667 | RSS: Main: 287555584 06:24:19 INFO - PROCESS | 1667 | 06:24:21 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:21 INFO - PROCESS | 1667 | RSS: Main: 291614720 06:24:21 INFO - PROCESS | 1667 | 06:24:24 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:25 INFO - PROCESS | 1667 | RSS: Main: 331112448 06:24:25 INFO - PROCESS | 1667 | 06:24:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:28 INFO - PROCESS | 1667 | RSS: Main: 331210752 06:24:28 INFO - PROCESS | 1667 | 06:24:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 06:24:32 INFO - PROCESS | 1667 | RSS: Main: 330153984 06:24:32 INFO - PROCESS | 1667 | 06:24:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:24:34 INFO - PROCESS | 1667 | RSS: Main: 301371392 06:24:34 INFO - PROCESS | 1667 | 06:24:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:24:36 INFO - PROCESS | 1667 | RSS: Main: 307429376 06:24:36 INFO - PROCESS | 1667 | 06:24:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:24:39 INFO - PROCESS | 1667 | RSS: Main: 314654720 06:24:39 INFO - PROCESS | 1667 | 06:24:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:24:43 INFO - PROCESS | 1667 | RSS: Main: 325869568 06:24:43 INFO - PROCESS | 1667 | 06:24:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:24:47 INFO - PROCESS | 1667 | RSS: Main: 319922176 06:24:47 INFO - PROCESS | 1667 | 06:24:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 06:24:49 INFO - PROCESS | 1667 | RSS: Main: 363638784 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | __start_tp_report 06:24:49 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:24:49 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:24:49 INFO - PROCESS | 1667 | |i|pagename|runs| 06:24:49 INFO - PROCESS | 1667 | |0;ai-astar;112;113;112;113;113;113;112;113;113;113 06:24:49 INFO - PROCESS | 1667 | |1;audio-beat-detection;148;112;111;149;118;138;139;114;172;143 06:24:49 INFO - PROCESS | 1667 | |2;audio-dft;186;182;188;185;181;183;184;180;183;181 06:24:49 INFO - PROCESS | 1667 | |3;audio-fft;81;68;83;88;59;59;58;60;81;60 06:24:49 INFO - PROCESS | 1667 | |4;audio-oscillator;85;71;90;69;68;69;92;66;68;90 06:24:49 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;87;84;87;85;86;82;88;127;88;83 06:24:49 INFO - PROCESS | 1667 | |6;imaging-darkroom;95;106;95;96;95;95;97;95;102;95 06:24:49 INFO - PROCESS | 1667 | |7;imaging-desaturate;87;87;84;85;83;84;86;84;85;85 06:24:49 INFO - PROCESS | 1667 | |8;json-parse-financial;55;53;53;55;52;54;54;55;53;54 06:24:49 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;74;63;75;71;70;68;69;70;69;72 06:24:49 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;88;86;89;86;84;86;88;85;86;86 06:24:49 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;144;148;171;150;157;165;156;158;196;145 06:24:49 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;222;237;170;172;171;170;172;170;170;165 06:24:49 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;68;68;68;68;67;66;68;78;74 06:24:49 INFO - PROCESS | 1667 | __end_tp_report 06:24:49 INFO - PROCESS | 1667 | __start_cc_report 06:24:49 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2001 06:24:49 INFO - PROCESS | 1667 | __end_cc_report 06:24:49 INFO - PROCESS | 1667 | __startTimestamp1476365089060__endTimestamp 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:24:49 INFO - PROCESS | 1667 | Number of tests: 14 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:24:49 INFO - PROCESS | 1667 | Values: 112.0 113.0 112.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:141.00 stddev:20.15 (14.3%) stddev-sans-first:20.76 06:24:49 INFO - PROCESS | 1667 | Values: 148.0 112.0 111.0 149.0 118.0 138.0 139.0 114.0 172.0 143.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:2.50 (1.4%) stddev-sans-first:2.45 06:24:49 INFO - PROCESS | 1667 | Values: 186.0 182.0 188.0 185.0 181.0 183.0 184.0 180.0 183.0 181.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:69.70 Median:74.50 stddev:12.13 (16.3%) stddev-sans-first:12.16 06:24:49 INFO - PROCESS | 1667 | Values: 81.0 68.0 83.0 88.0 59.0 59.0 58.0 60.0 81.0 60.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.00 stddev:10.92 (14.0%) stddev-sans-first:11.17 06:24:49 INFO - PROCESS | 1667 | Values: 85.0 71.0 90.0 69.0 68.0 69.0 92.0 66.0 68.0 90.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:86.50 stddev:13.27 (15.3%) stddev-sans-first:14.04 06:24:49 INFO - PROCESS | 1667 | Values: 87.0 84.0 87.0 85.0 86.0 82.0 88.0 127.0 88.0 83.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:95.00 stddev:3.81 (4.0%) stddev-sans-first:3.97 06:24:49 INFO - PROCESS | 1667 | Values: 95.0 106.0 95.0 96.0 95.0 95.0 97.0 95.0 102.0 95.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.33 (1.6%) stddev-sans-first:1.20 06:24:49 INFO - PROCESS | 1667 | Values: 87.0 87.0 84.0 85.0 83.0 84.0 86.0 84.0 85.0 85.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 06:24:49 INFO - PROCESS | 1667 | Values: 55.0 53.0 53.0 55.0 52.0 54.0 54.0 55.0 53.0 54.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:3.35 (4.7%) stddev-sans-first:3.24 06:24:49 INFO - PROCESS | 1667 | Values: 74.0 63.0 75.0 71.0 70.0 68.0 69.0 70.0 69.0 72.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.48 06:24:49 INFO - PROCESS | 1667 | Values: 88.0 86.0 89.0 86.0 84.0 86.0 88.0 85.0 86.0 86.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:157.50 stddev:15.58 (9.9%) stddev-sans-first:15.56 06:24:49 INFO - PROCESS | 1667 | Values: 144.0 148.0 171.0 150.0 157.0 165.0 156.0 158.0 196.0 145.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:171.50 stddev:25.41 (14.8%) stddev-sans-first:22.43 06:24:49 INFO - PROCESS | 1667 | Values: 222.0 237.0 170.0 172.0 171.0 170.0 172.0 170.0 170.0 165.0 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.00 stddev:3.71 (5.5%) stddev-sans-first:3.91 06:24:49 INFO - PROCESS | 1667 | Values: 68.0 68.0 68.0 68.0 68.0 67.0 66.0 68.0 78.0 74.0 06:24:49 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:24:49 INFO - PROCESS | 1667 | 06:24:49 INFO - TEST-INFO | 1667: exit 0 06:24:49 INFO - TEST-OK | kraken | took 59957ms 06:24:49 INFO - SUITE-END | took 1178s 06:24:50 INFO - Completed test suite (00:19:38) 06:24:50 INFO - javascript benchmark 06:24:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.7373810095196, 3288.0, 3294.061192560121, 3309.3381323735257, 3344.799312041276, 5388.326459192601, 5472.616916815825, 5510.8071217507395, 5555.0, 5563.44365563444, 5453.23654688344, 5503.20203570482, 5511.5039646431815, 5521.779128834852, 5536.723163841812, 5041.621878359119, 5053.747312634372, 5060.51925067118, 5083.517065878754, 5143.408508021569, 5083.6441449098575, 5135.43510213878, 5149.948500515003, 5150.768215430315, 5158.097332966735, 5059.367579052619, 5093.134167191586, 5129.1536896412235, 5133.332666753336, 5145.073886700392, 5170.224466330043, 5178.14560597501, 5187.844364669066, 5199.376074871002, 5219.556337711299, 4965.602751779885, 4991.0, 5040.571551418134, 5113.411957624847, 5131.384233891957, 4434.667399944985, 5382.569394448435, 5473.28847249855, 5489.725513724298, 5503.697296648683, 5968.0, 5985.371535988746, 5985.431384018555, 5985.730642121115, 6006.099085137221, 5950.523958083386, 6005.129256257862, 6052.031674932034, 6071.028635418356, 6090.725917333731, 5596.384397716248, 5640.85897852557, 5646.068398714248, 5654.971725141348, 5705.5720820938595, 6267.7806276781, 6269.592476489013, 6279.434850863444, 6280.528960327993, 6283.183186185766, 5706.80026199081, 5993.0710739835395, 5994.730237139339, 6005.849853753691, 6010.549208809357, 6008.489278411384, 6044.184035155197, 6119.958356786701, 6120.355709576858, 6133.325334213233, 6004.609700369462, 6055.091736239599, 6063.818085457443, 6066.181065556093, 6125.418085281891, 6105.023196288573, 6109.205803245639, 6110.358412366638, 6111.35830737775, 6115.6330620162935, 4691.179043667345, 4795.760211989386, 4798.568128868418, 4801.567858892717, 4872.317875497433, 4351.891202719958, 4410.316400957857, 4422.778861056934, 4429.468463784302, 4454.821807127743, 5618.353889302701, 5640.984622767941, 5643.322801263875, 5648.039833228361, 5674.943250567524, 5640.464155905264, 6198.008318668992, 6202.4417802398, 6206.441420272107, 6208.627482351073, 5358.91961620576, 5414.729263536808, 5533.391326954032, 5582.553395728332, 5585.748641311151, 5270.60470464709, 5283.0, 5284.630075894651, 5304.230886521433, 5320.52115309624, 6236.688165591702, 6283.0, 6284.151639528788, 6298.811035668938, 6310.905336419865, 5887.61730487517, 6008.789692360747, 6035.426634469718, 6083.847903802263, 6123.877522449437, 6235.781747638811, 6236.719347629277, 6281.277653069956, 6282.748690052529, 6299.968500157654, 5954.07711804671, 5985.042393217239, 6013.067974463965, 6015.165374560801, 6101.969490152521, 5893.145493903275, 6082.574219804571, 6119.418655227746, 6131.938680613137, 6152.292486364126, 5676.20533125371, 5772.249607550992, 5864.44287792659, 5868.354481007171, 5869.559783016205, 5779.306483222041, 5840.620359676607, 5845.3570107289015, 5846.152307915243, 5860.970695146668, 5737.397573254748, 5738.741756620879, 5740.569457290637, 5740.942590574041, 5748.137779333133, 5809.796657116981, 5820.534357251495, 5834.241548598655, 5850.385709500441, 5851.297844258716, 5715.628484148517, 5745.8563535911935, 5745.971270143623, 5749.223854779551, 5758.021136406905], "value": 5555.553270976553, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.53031211285617, 532.5845840244608, 537.8063896997078, 550.7163810637521, 554.603458527153, 38443.42334864979, 39356.2128757425, 39531.40702889455, 41451.37822932658, 41775.79112104435, 40071.799641001824, 40329.798351008205, 40377.0, 40516.0, 40524.59475405245, 8475.406721529496, 9416.67041653544, 9547.331686781929, 9565.904340956606, 9567.569459374345, 8501.74494765155, 8592.398532102756, 8592.742217733477, 8599.527026013568, 9177.678781242625, 11261.042811361043, 11476.426178691074, 11479.827802582968, 11490.0, 11506.769864602746, 11309.038731707815, 11402.201845870792, 11409.25839820409, 11419.257748246337, 11422.828657570102, 8330.62512186953, 8548.358873084482, 11058.336499809957, 11363.772724545546, 11395.487203075882, 38555.03612409684, 38890.416643750366, 38891.416628750594, 38946.41580376297, 38985.22029559421, 3160.4918540420117, 3222.871085156591, 3235.320582677617, 3264.8041117533025, 3337.8831740889195, 29435.852820735974, 29751.851240743657, 30327.696723032706, 30603.69396306031, 30610.69389306101, 3168.318811455525, 3198.296374797541, 3244.5155075327966, 3331.1172539277113, 3338.532605435241, 420898.7460752365, 422739.0, 427049.86475067737, 429298.0, 429790.0, 54901.0, 55203.44796552063, 55306.17040744392, 55371.16943245855, 55392.16911746327, 58073.0, 58144.0, 58212.4178758207, 58318.833623328144, 58355.70822145947, 15415.845841541666, 15616.063036217864, 15641.921790390976, 15649.374025038871, 15691.686166276611, 12118.39408029595, 12153.149279550347, 12153.906148446506, 12159.209651372632, 12165.93917030427, 13088.541901033419, 13364.0, 13400.994925380635, 14729.410823566937, 15080.698386032218, 5627.380988091307, 6330.4619107375465, 6396.456301214356, 6449.935760599542, 6578.144841170617, 745.5340412242349, 937.3532262738688, 937.4469063252714, 1006.4414250091123, 1011.3969358566607, 23014.769852301597, 27729.86135069352, 28540.857295713802, 28894.855525722236, 29635.55546666802, 979.3389462113046, 1036.4972988100765, 1094.6278265389806, 1124.145649306533, 1127.8251870960014, 14983.550493485212, 15035.323410446555, 15124.54626361211, 15221.771673424908, 15330.310136043905, 179845.20154798546, 180051.0, 180488.0, 180734.0, 181664.0, 54892.72553637206, 55073.724631376586, 55107.07125250597, 55112.72443637756, 55303.0, 1296.2546535741985, 1349.6705744841324, 1350.2033800057816, 1359.1301566997129, 1360.5170164591427, 26506.602400963617, 27419.725802741716, 28801.42397152087, 28934.985354364366, 29607.703922960496, 47090.82272943067, 47203.05593888172, 47414.81462963454, 47577.286340704224, 47604.2859357103, 573330.0, 573531.0, 575166.0, 576439.0, 581105.0, 24532.386690332172, 25425.745742542338, 38218.235635287696, 38514.614853851104, 38515.61484385232, 37609.059773504785, 38601.03497412587, 38783.806080969414, 40542.98642533842, 44863.0, 35986.28027439489, 36591.08522286964, 36782.63217367792, 37713.62286377211, 37897.62102378941, 34388.65611343855, 36431.817840910626, 36947.630523695494, 37493.250134997696, 37604.435933460474, 35810.462843056855, 36095.0, 36559.0, 36771.63228367789, 37133.81433092817, 25360.112396066048, 31803.20491987719, 32774.34451311008, 32853.68585256563, 33107.33785324328, 23702.762972370056, 24088.277351679477, 24113.397165071012, 24496.14263500769, 24508.509829802948], "value": 18648.717629643103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.6587193358409, 367.77749461575746, 375.7144570126704, 383.7524796506253, 401.14956292659565, 14469.710605787892, 14906.627334316634, 15290.313955963982, 16825.887210866, 20248.493787655316, 18558.536036599056, 19174.8636055912, 19384.03079846009, 19668.409947701555, 20203.39389818308, 5420.376656684472, 5777.277840269966, 5777.971110144465, 5778.4799368056865, 5783.277090363705, 4693.577578017977, 5313.043652142613, 5467.753951072212, 5766.394528574502, 5785.855353616173, 5675.091985282335, 5713.657180569158, 5724.484796368326, 5725.742341594618, 5727.026405511052, 5388.380336261322, 5598.2442370280105, 5642.379338272786, 5658.377578466366, 5660.405657405975, 4778.354922085544, 4965.553100220961, 4966.106100901836, 4973.626977976666, 4983.227599722049, 23969.16107936231, 23997.40006499834, 24730.25809225726, 25057.997680092776, 25442.0, 2163.5348400094053, 2230.2528652901296, 2356.552255071531, 2378.857268563892, 2417.8791060446906, 7561.546307221584, 14437.87218736256, 15642.687146257125, 15666.216689165496, 15668.059916404938, 1660.3939562059882, 1754.894706317625, 1803.3147403986402, 1840.723891416285, 1847.214933653192, 98745.0, 108567.0, 108848.36727449094, 109180.0, 109443.0, 10297.9485102574, 10328.328658637165, 10522.31604945676, 10737.570497180026, 10979.505922233519, 13293.468261269634, 13297.800532992012, 13305.600831974863, 13313.66715832112, 13318.334083295797, 7886.290233878978, 8139.48852877271, 8179.509229446252, 8303.211194936472, 8346.624401901929, 7497.625118744041, 7511.948327234191, 8187.918120818716, 8199.385046121564, 8328.292095171857, 6330.208723909512, 6478.352164783484, 6482.837929051717, 6492.772752953624, 6597.241317248482, 1630.4619475573033, 1826.926922923068, 1833.9913047823643, 1873.3162395725462, 1873.9063046847602, 909.4588719711761, 909.6406919266852, 921.2445794448622, 942.7595963029521, 1010.4897027001317, 16554.917225414036, 20155.39533813988, 21721.131154753948, 21735.89132054361, 21779.23772667949, 937.3438592984802, 946.7301818981557, 973.1436336024253, 990.5691024404407, 1023.5701005577675, 10882.891171088188, 10981.39602321864, 11478.368689721978, 11724.0, 11801.52793888252, 535617.0, 616207.9189604024, 629713.0, 635102.0, 635426.0, 96801.515992421, 99843.0, 106850.46574767077, 127537.44925101446, 135664.32167839294, 864.3992425264381, 930.3998920696113, 939.7462685074992, 1019.0319196763105, 1022.3048327137618, 18684.906575467037, 18980.810191897905, 18983.335583255073, 19032.048397580344, 19049.523761906064, 36938.8153059233, 44795.295407540565, 54567.0, 54734.905301894534, 55446.0, 77548.0, 77794.6110269445, 80302.59848700953, 80971.0, 81076.7838482435, 6900.827479313058, 7920.603969801372, 7970.880436793569, 7980.401469889665, 8001.519908805491, 10524.579016839241, 10799.946000269949, 12631.368431578569, 13005.154664947127, 13039.087263891437, 10729.034386905216, 10776.784464310827, 11123.27698699582, 11268.7746245073, 11373.943130284295, 8936.687215947411, 9250.167484926389, 10429.426381549089, 10975.780484390427, 11074.557017719524, 10796.784064318826, 11019.008289254005, 11092.389918554234, 11492.482838272465, 11620.0, 6732.0, 7237.927620723936, 7305.780826575211, 7420.0, 7495.850082998419, 10394.324368915995, 10916.56333746673, 11259.662210133709, 11283.492242849255, 11385.259958102697], "value": 9355.233226256843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.32281312003, 1505.6010157308315, 1710.9486715398534, 1876.0619690154922, 1899.192843041707, 8356.83286334273, 8880.555972201397, 8881.289496840238, 8888.733337999854, 8915.554222288893, 7756.650950707218, 8043.436959412844, 8353.37349698772, 8636.13638636136, 8653.87019194711, 2329.0450915124843, 2362.7282862470865, 2365.5860224460735, 2366.183666635008, 2368.988155059231, 2343.2852979841227, 2354.482013956927, 2382.845115067515, 2387.4747555537842, 2396.3050715292543, 2353.2587235020915, 2365.9053637854463, 2370.502194539149, 2379.0, 2383.5113801670705, 2327.94180145496, 2344.0, 2351.6237402015595, 2356.0222507659387, 2357.5638506876285, 2324.7210334759766, 2342.6837376954063, 2348.1077190667606, 2352.1061996441413, 2352.8941197646145, 8640.697575584825, 8805.691800787006, 8813.735587932373, 8815.382923195379, 8830.955845220733, 5020.0963826511215, 5178.40448348441, 5181.533661970403, 5187.247849061865, 5187.688738675692, 3025.5764193012997, 3353.9161520961925, 3396.762226644136, 3593.5508061492314, 3643.7813731176216, 1073.5169173871789, 1087.9728006799814, 1093.1364222264401, 1099.7085772270354, 1117.754094099297, 11478.311301321948, 11586.957173854309, 11658.825117623242, 11662.241954272946, 11665.533378664843, 4417.757023363682, 4603.792829322689, 4674.22875225584, 4715.575598196178, 4720.763961801897, 8333.95833020831, 9755.170810481046, 9758.707238782848, 9764.0, 9764.902350976541, 5124.615653825978, 5127.897442051213, 5142.1772516397195, 5146.794128234904, 5151.2530683050745, 4179.1432756284885, 4211.326187809936, 4337.392765012901, 4698.788554515055, 4715.198416269242, 3736.831842567091, 3768.1333293342686, 3861.2084522672785, 3892.1242720387686, 3966.5636779954184, 1241.075398827879, 1241.714405686697, 1244.2285782814713, 1257.352463481308, 1267.4043199696127, 825.9297959673495, 842.9084335785172, 903.6520939438363, 914.3005600715458, 949.4777872170279, 5560.77756889728, 5665.858353541194, 5671.688057156814, 5795.246617939641, 5948.672822994777, 886.3485338276362, 916.8899732032199, 929.1916033051289, 947.2327414794039, 956.0200794186015, 3214.276787722744, 3595.334863050292, 3778.2459495669455, 4011.6991225658194, 4081.653059489977, 7962.6416811243635, 10642.574297028032, 10699.625513107005, 10737.946310268555, 10753.83869241962, 10274.383536987805, 10680.98530639588, 10690.572377104829, 10691.465426728633, 10701.304415213142, 7849.725259615886, 8102.635381407733, 8102.756917292609, 8126.024877014796, 8129.268365847102, 5666.829995100154, 5725.484706376446, 5758.424157584208, 5842.474177324061, 5847.035239185487, 9841.311108222642, 9870.111689947938, 9885.011498850057, 9947.204223661945, 9958.950205248928, 9208.585613647268, 9624.422534647943, 9655.710328690151, 9771.560279787285, 10033.996600339908, 6534.150560427114, 6735.663216839236, 6751.223609284995, 7308.232635573401, 7460.813479663052, 6451.387118223761, 6947.652617369213, 7905.644246009058, 8187.263146316622, 8207.876881846658, 7194.892076618959, 7340.743073992385, 7356.77929662111, 7382.52013619113, 7504.874268859715, 7159.0, 7176.533525321046, 7192.532485388433, 7222.313880181375, 7245.45659075582, 6547.672616369067, 6742.494312926452, 6818.829529261808, 6898.06876071744, 6911.481638877205, 4950.975245123751, 4955.306257124078, 4970.975145124251, 5011.4236862761245, 5085.669431486942, 4922.729249891147, 4938.481459446706, 5023.271625614192, 5061.9493805061475, 5071.290019397361], "value": 4503.4337519303135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.9894157746814, 300.3047944009618, 309.26240915416724, 313.98116113033205, 317.84902171468553, 5080.415752188499, 5190.662606930547, 5236.2931004314405, 5259.92171604821, 5291.708956007418, 4281.379200015996, 5001.624878134146, 5142.740028692966, 5169.689818610886, 5190.8702282442955, 3921.6273705024155, 4019.899502512446, 4034.354503279476, 4042.6967977401664, 4064.3293856513787, 3647.963520364789, 3824.2542704172697, 3938.6849052075763, 3958.366661334187, 4037.899052523696, 3941.724079314449, 4011.696198735408, 4023.396490526415, 4032.387045181936, 4059.1069964607887, 3963.3064213762477, 3995.9800200998952, 4006.1771893788255, 4032.7177097602885, 4032.7983600820135, 2930.120963710878, 3062.6631070582216, 3505.8772942946875, 3525.5769307682986, 3533.5406397168204, 4462.419885414908, 4469.7541635210055, 4568.497465278817, 4673.345731597579, 5175.835437026676, 4011.859584914543, 4542.04617030424, 4601.907961840778, 4607.631389488833, 4612.907741845144, 4787.904241915142, 5526.640768350045, 5554.139363313295, 5606.159076138571, 5650.3502097258515, 3659.2864391443677, 3785.9810700946596, 3790.6777923876502, 3794.620537946211, 3813.1229817141934, 4445.466544014739, 5239.764210610493, 5790.13148027795, 5790.594658373958, 5893.381194974509, 3797.2785170817456, 3797.7531460454984, 3802.144517483544, 3821.4332123829095, 3831.1188426662025, 3710.7959062251834, 3852.6917846572205, 3871.7676939383728, 3898.317794385971, 3904.668103211202, 3731.7014638828828, 4469.240229161051, 4514.25514790056, 4517.209488339593, 4529.097778932856, 4570.634349252118, 5201.687898726089, 5508.173773933861, 5514.751836167382, 5550.333959924754, 1221.096388672376, 1247.2267194339386, 1247.5758242197514, 1305.8563558008611, 1324.8542660307357, 877.1316396767155, 883.6200433813522, 897.371839712191, 905.515549181185, 907.5099446299057, 4435.356873253425, 4607.755905905454, 4679.415073115861, 5234.607404444682, 5309.734513274321, 5375.946240537544, 5605.215269862222, 5642.210090587321, 5674.687892165888, 5702.287214098238, 4386.8903277417685, 4588.3805686231935, 4628.74541900192, 5188.391598604445, 5213.113770658997, 2458.6434966929696, 2496.488219914913, 2499.7502247976604, 2502.3493891587955, 2518.4837108392735, 4002.939221106409, 4030.6170913763144, 4049.6152865477734, 4283.121959998193, 4952.232403977389, 4582.510684027638, 4789.042191561632, 4822.662413631082, 4849.9687695190505, 4861.51384861511, 4100.528439229527, 4850.308079016109, 4851.059576169489, 4855.155041084366, 4913.361263035782, 4135.464178127658, 4427.0, 4614.976925115488, 4708.623310135113, 4736.573708366263, 4000.6799456042863, 4005.1388951375593, 4502.864914052584, 4534.977325113353, 4710.929336059893, 4047.8988025299604, 4657.13714514197, 4854.393200849894, 4892.877678058077, 4947.752612369439, 2881.9423611528073, 3226.4998925166637, 3282.9330467597647, 3298.274379636476, 3311.569495965509, 3917.8628747993685, 4354.608085272341, 4410.625096866802, 4457.910841783211, 4695.906081878275, 4068.5931406859077, 4109.938350924798, 4313.25313248135, 4562.292844609091, 4612.492625811091, 3802.5436947565363, 3990.960090399059, 4527.343535187445, 4582.610478109398, 4591.586757191869, 4593.28804035375, 4872.317875497504, 4873.610111191168, 5166.870828229325, 5534.723263836872, 4458.8439404620685, 5036.395632523974, 5193.37679478465, 5224.843254702365, 5564.527015203753, 5052.393712754493, 5277.27951793992, 5300.496452836975, 5476.808311709071, 5502.422245664147], "value": 3776.9396740812176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1948419060176, 706.487796347648, 748.8652042632324, 771.0978155557997, 834.8747687846823, 13561.66095847603, 14078.79865166973, 14182.432702691905, 14239.92880035601, 14287.71424571508, 12543.498260069586, 12690.30203338816, 12746.362681865916, 12751.362431878415, 12761.23432594045, 672.9259781424039, 841.1168273313027, 871.0244526130742, 879.4986857491201, 882.1575395497284, 697.4943166204487, 815.592203898051, 870.3907264914553, 875.5272153037353, 884.1600479544427, 916.3173435790345, 917.857732051533, 918.5085979001236, 920.0569416348229, 923.3813345058793, 910.8223896340216, 910.9043550427209, 913.2146354135439, 913.3469569257946, 915.5376534849925, 530.6126527634809, 552.4530714592564, 647.760328678392, 678.6369292428527, 683.7641013850264, 11602.4198790061, 13872.028957972945, 13879.028468007244, 13881.958853086058, 13891.513797017056, 13163.473461061547, 13385.397657105355, 13635.250061246628, 13697.657558561015, 14023.158610483404, 12052.879471205264, 12119.212251203731, 12121.333326667118, 12448.315342656151, 12572.811407828889, 4280.614744672995, 4321.978390108061, 4346.6522678185665, 4350.427265203532, 4381.890452738675, 105541.94458055397, 106882.46558767234, 107167.0, 110582.0, 111185.0, 10709.036186743231, 10726.892731072745, 10844.45777711127, 11006.559737610565, 11247.268927519684, 20527.66570172964, 20529.79470205309, 20535.4866128345, 20601.484962875747, 20602.690959635616, 7477.70089196426, 7598.126215485179, 7738.7291444800285, 7753.612319384121, 7850.371970242367, 4188.81150348235, 4299.333603291495, 4300.61294483498, 4339.956600434019, 4480.507144214133, 3274.459714147139, 3740.457633643161, 3920.784356860343, 3921.11774850662, 3924.4113382992778, 668.6924014953177, 675.3179288918129, 680.0207700910673, 682.1575354437266, 712.8859382498879, 576.6136688418769, 622.651315263454, 638.355261186196, 644.9613023218621, 671.6473851228144, 9261.30540209487, 9364.578593963288, 9371.203447706885, 9428.575714092882, 9444.811103777885, 503.5216544282946, 525.1833399064415, 601.197401469035, 603.7132362127954, 618.9164462797555, 4284.764337961442, 4422.226110430662, 4440.933385999213, 4480.260756975128, 4538.678977201923, 128282.0, 153081.0, 155127.0, 158058.0, 159899.0, 128982.0, 134798.0, 135480.32259838638, 136464.31767841097, 138070.3096484531, 108907.99999999841, 112866.43566782113, 112879.0, 113605.0, 116307.41846290714, 6849.8972515411315, 7108.289171082851, 8498.957505212435, 8525.616347264264, 8661.04728479854, 48587.27119093287, 58436.4156358431, 60726.78546428958, 63916.0, 64393.0, 88568.22863542564, 93760.53119734357, 97864.0, 99750.0, 101713.49143254236, 11244.943775281072, 11252.60615878473, 11428.542858285575, 11716.94141529321, 12097.939510302393, 12012.519499220283, 13303.800442993557, 14047.789283160557, 14202.928985355007, 14820.03669761462, 13517.932410337886, 13549.86450135486, 13657.453701851815, 14023.859761402664, 14025.789613155606, 13610.251436171106, 13612.727745444838, 13920.721585568435, 14341.721643432125, 14433.494827680981, 13225.603231903058, 13334.19994800315, 13534.729305414034, 13751.862481375458, 13838.861611383758, 10416.791664166825, 10853.214156106884, 11199.832002519806, 11247.606333778278, 11337.376444295644, 9027.322950778587, 11155.398360762232, 11306.773864522498, 11309.71725706831, 11448.141389395994], "value": 7678.906812994038, "unit": "score"}], "name": "dromaeo_css", "value": 7086.150562775839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 111.0, 149.0, 118.0, 138.0, 139.0, 114.0, 172.0, 143.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 188.0, 185.0, 181.0, 183.0, 184.0, 180.0, 183.0, 181.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 83.0, 88.0, 59.0, 59.0, 58.0, 60.0, 81.0, 60.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 90.0, 69.0, 68.0, 69.0, 92.0, 66.0, 68.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 86.0, 82.0, 88.0, 127.0, 88.0, 83.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 102.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 84.0, 85.0, 83.0, 84.0, 86.0, 84.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 55.0, 52.0, 54.0, 54.0, 55.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 63.0, 75.0, 71.0, 70.0, 68.0, 69.0, 70.0, 69.0, 72.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 84.0, 86.0, 88.0, 85.0, 86.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 148.0, 171.0, 150.0, 157.0, 165.0, 156.0, 158.0, 196.0, 145.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 237.0, 170.0, 172.0, 171.0, 170.0, 172.0, 170.0, 170.0, 165.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0, 68.0, 78.0, 74.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1469.2, "alertThreshold": 2.0}]} 06:24:50 INFO - Return code: 0 06:24:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:24:50 INFO - # TBPL SUCCESS # 06:24:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:24:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:24:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:24:50 INFO - 2016-10-13 06:24:50.347 screenresolution[1671:9774] starting screenresolution argv=screenresolution get 06:24:50 INFO - 2016-10-13 06:24:50.350 screenresolution[1671:9774] Display 0: 1600x1200x32@60 06:24:50 INFO - 2016-10-13 06:24:50.356 screenresolution[1672:9777] starting screenresolution argv=screenresolution list 06:24:50 INFO - Available Modes on Display 0 06:24:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:24:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:24:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:24:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:24:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:24:50 INFO - Intel Iris: 06:24:50 INFO - Chipset Model: Intel Iris 06:24:50 INFO - Type: GPU 06:24:50 INFO - Bus: Built-In 06:24:50 INFO - VRAM (Dynamic, Max): 1536 MB 06:24:50 INFO - Vendor: Intel (0x8086) 06:24:50 INFO - Device ID: 0x0a2e 06:24:50 INFO - Revision ID: 0x0009 06:24:50 INFO - Displays: 06:24:50 INFO - Display: 06:24:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:24:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:24:50 INFO - Display Serial Number: 1600x1200 60 06:24:50 INFO - Main Display: Yes 06:24:50 INFO - Mirror: Off 06:24:50 INFO - Online: Yes 06:24:50 INFO - Rotation: Supported 06:24:50 INFO - Return code: 0 06:24:50 INFO - Running post-action listener: _resource_record_post_action 06:24:50 INFO - [mozharness: 2016-10-13 13:24:50.597473Z] Finished run-tests step (success) 06:24:50 INFO - Running post-run listener: _resource_record_post_run 06:24:50 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38720512; Write bytes: 705589248; Read time: 380; Write time: 2308 06:24:50 INFO - TinderboxPrint: CPU usage
53.9% 06:24:50 INFO - TinderboxPrint: I/O read bytes / time
38,720,512 / 380 06:24:50 INFO - TinderboxPrint: I/O write bytes / time
705,589,248 / 2,308 06:24:50 INFO - TinderboxPrint: CPU idle
2,239.6 (46.1%) 06:24:50 INFO - TinderboxPrint: CPU system
976.5 (20.1%) 06:24:50 INFO - TinderboxPrint: CPU user
1,637.5 (33.7%) 06:24:50 INFO - TinderboxPrint: Swap in / out
446,087,168 / 0 06:24:50 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401783296; Write bytes: 395057152; Read time: 29568; Write time: 691 06:24:50 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36598784; Write bytes: 295540736; Read time: 356; Write time: 1578 06:24:51 INFO - Running post-run listener: _upload_blobber_files 06:24:51 INFO - Blob upload gear active. 06:24:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:24:51 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 06:24:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:24:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:24:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:24:53 INFO - (blobuploader) - INFO - Done attempting. 06:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:24:54 INFO - (blobuploader) - INFO - Done attempting. 06:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:24:56 INFO - (blobuploader) - INFO - Done attempting. 06:24:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:24:56 INFO - Return code: 0 06:24:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:24:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:24:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7b2f59b46da54e3abd6efbd86741e0644b4bf734c030ae335c85137f4981d7c3f05581b9b978771343208410848cad89df5caf19911f404174c768161399c48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e25f94851bc5f44130140c998eab3bbfdbcd2cafcb848e24d12c7d9dcc5d6862ade934c4574d518d9467c1889fab110c172336afe478bc4c5149144a58c2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5709a2087644e874f365920b14285c408431fd37831307ec3eef142d9941eca0b43e5b5e7c24654567771ea1b05116041bffbe29646c282d98d7f393207bdc"} 06:24:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:24:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:24:56 INFO - Contents: 06:24:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7b2f59b46da54e3abd6efbd86741e0644b4bf734c030ae335c85137f4981d7c3f05581b9b978771343208410848cad89df5caf19911f404174c768161399c48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e25f94851bc5f44130140c998eab3bbfdbcd2cafcb848e24d12c7d9dcc5d6862ade934c4574d518d9467c1889fab110c172336afe478bc4c5149144a58c2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5709a2087644e874f365920b14285c408431fd37831307ec3eef142d9941eca0b43e5b5e7c24654567771ea1b05116041bffbe29646c282d98d7f393207bdc"} 06:24:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:24:56 INFO - Copying logs to upload dir... 06:24:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:24:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.423795 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-13 06:24:56.490187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 06:24:56.495924) ========= 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.jWTOoW39kf/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.HcXWkSyzCF/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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/Firefox/sha512/a7b2f59b46da54e3abd6efbd86741e0644b4bf734c030ae335c85137f4981d7c3f05581b9b978771343208410848cad89df5caf19911f404174c768161399c48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e25f94851bc5f44130140c998eab3bbfdbcd2cafcb848e24d12c7d9dcc5d6862ade934c4574d518d9467c1889fab110c172336afe478bc4c5149144a58c2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5709a2087644e874f365920b14285c408431fd37831307ec3eef142d9941eca0b43e5b5e7c24654567771ea1b05116041bffbe29646c282d98d7f393207bdc"} build_url:https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/X-84JmoOS2ORoInz3QkcJg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7b2f59b46da54e3abd6efbd86741e0644b4bf734c030ae335c85137f4981d7c3f05581b9b978771343208410848cad89df5caf19911f404174c768161399c48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e25f94851bc5f44130140c998eab3bbfdbcd2cafcb848e24d12c7d9dcc5d6862ade934c4574d518d9467c1889fab110c172336afe478bc4c5149144a58c2fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c5709a2087644e874f365920b14285c408431fd37831307ec3eef142d9941eca0b43e5b5e7c24654567771ea1b05116041bffbe29646c282d98d7f393207bdc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 06:24:56.532758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:24:56.533073) ========= 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.jWTOoW39kf/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.HcXWkSyzCF/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005011 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 06:24:56.581152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 06:24:56.581478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 06:24:56.581794) ========= ========= Total master_lag: 0.18 =========