builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0330 starttime: 1486643268.38 results: success (0) buildid: 20170209030214 builduid: 7cc43ce136944e6cb14b78737e5b7042 revision: b772e0f4138540113e91a46c99bb0d14ecc8acca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.381436) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.381854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.382145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.408183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.408531) ========= 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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-09 04:27:48-- 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% 18.7M=0.001s 2017-02-09 04:27:48 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.560411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.560724) ========= 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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.025720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.611812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:48.612219) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b772e0f4138540113e91a46c99bb0d14ecc8acca --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 b772e0f4138540113e91a46c99bb0d14ecc8acca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-09 04:27:48,723 truncating revision to first 12 chars 2017-02-09 04:27:48,723 Setting DEBUG logging. 2017-02-09 04:27:48,723 attempt 1/10 2017-02-09 04:27:48,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b772e0f41385?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 04:27:49,372 unpacking tar archive at: mozilla-central-b772e0f41385/testing/mozharness/ program finished with exit code 0 elapsedTime=0.909809 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:49.548335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:49.548660) ========= script_repo_revision: b772e0f4138540113e91a46c99bb0d14ecc8acca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:49.549054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:49.549321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 04:27:49.568812) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-02-09 04:27:49.569209) ========= /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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:27:49 INFO - MultiFileLogger online at 20170209 04:27:49 in /builds/slave/test 04:27:49 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 04:27:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:49 INFO - {'append_to_log': False, 04:27:49 INFO - 'base_work_dir': '/builds/slave/test', 04:27:49 INFO - 'blob_upload_branch': 'Firefox', 04:27:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:49 INFO - 'branch': 'Firefox', 04:27:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:49 INFO - 'config_files': ('talos/mac_config.py',), 04:27:49 INFO - 'default_actions': ('clobber', 04:27:49 INFO - 'read-buildbot-config', 04:27:49 INFO - 'download-and-extract', 04:27:49 INFO - 'populate-webroot', 04:27:49 INFO - 'create-virtualenv', 04:27:49 INFO - 'install', 04:27:49 INFO - 'run-tests'), 04:27:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:49 INFO - 'download_minidump_stackwalk': True, 04:27:49 INFO - 'download_symbols': 'ondemand', 04:27:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:49 INFO - 'installer_path': 'installer.exe', 04:27:49 INFO - 'log_level': 'info', 04:27:49 INFO - 'log_name': 'talos', 04:27:49 INFO - 'log_to_console': True, 04:27:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:27:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:27:49 INFO - 'opt_config_files': (), 04:27:49 INFO - 'pip_index': False, 04:27:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:49 INFO - 'cmd': ('bash', 04:27:49 INFO - '-c', 04:27:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:49 INFO - 'enabled': True, 04:27:49 INFO - 'halt_on_failure': False, 04:27:49 INFO - 'name': 'check_screen_resolution'},), 04:27:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:49 INFO - 'cmd': ('bash', 04:27:49 INFO - '-c', 04:27:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:49 INFO - 'enabled': True, 04:27:49 INFO - 'halt_on_failure': False, 04:27:49 INFO - 'name': 'check_screen_resolution'},), 04:27:49 INFO - 'run_cmd_checks_enabled': True, 04:27:49 INFO - 'sps_profile': False, 04:27:49 INFO - 'sps_profile_interval': 0, 04:27:49 INFO - 'suite': 'dromaeojs', 04:27:49 INFO - 'system_bits': '32', 04:27:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:49 INFO - 'title': 't-yosemite-r7-0330', 04:27:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:49 INFO - 'use_talos_json': True, 04:27:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:49 INFO - 'work_dir': 'build'} 04:27:49 INFO - [mozharness: 2017-02-09 12:27:49.784596Z] Running clobber step. 04:27:49 INFO - Running pre-action listener: _resource_record_pre_action 04:27:49 INFO - Running main action method: clobber 04:27:49 INFO - rmtree: /builds/slave/test/build 04:27:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:52 INFO - Running post-action listener: _resource_record_post_action 04:27:52 INFO - [mozharness: 2017-02-09 12:27:52.269013Z] Finished clobber step (success) 04:27:52 INFO - [mozharness: 2017-02-09 12:27:52.269144Z] Running read-buildbot-config step. 04:27:52 INFO - Running pre-action listener: _resource_record_pre_action 04:27:52 INFO - Running main action method: read_buildbot_config 04:27:52 INFO - Using buildbot properties: 04:27:52 INFO - { 04:27:52 INFO - "project": "", 04:27:52 INFO - "product": "firefox", 04:27:52 INFO - "script_repo_revision": "production", 04:27:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:27:52 INFO - "repository": "", 04:27:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:27:52 INFO - "buildid": "20170209030214", 04:27:52 INFO - "stage_platform": "macosx64", 04:27:52 INFO - "basedir": "/builds/slave/test", 04:27:52 INFO - "nightly_build": "True", 04:27:52 INFO - "buildnumber": 84, 04:27:52 INFO - "slavename": "t-yosemite-r7-0330", 04:27:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:27:52 INFO - "platform": "yosemite_r7", 04:27:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:27:52 INFO - "branch": "mozilla-central", 04:27:52 INFO - "repo_path": "mozilla-central", 04:27:52 INFO - "revision": "b772e0f4138540113e91a46c99bb0d14ecc8acca", 04:27:52 INFO - "pgo_build": "False", 04:27:52 INFO - "builduid": "7cc43ce136944e6cb14b78737e5b7042", 04:27:52 INFO - "slavebuilddir": "test" 04:27:52 INFO - } 04:27:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:27:52 INFO - Running post-action listener: _resource_record_post_action 04:27:52 INFO - [mozharness: 2017-02-09 12:27:52.272649Z] Finished read-buildbot-config step (success) 04:27:52 INFO - [mozharness: 2017-02-09 12:27:52.272766Z] Running download-and-extract step. 04:27:52 INFO - Running pre-action listener: _resource_record_pre_action 04:27:52 INFO - Running main action method: download_and_extract 04:27:52 INFO - mkdir: /builds/slave/test/build/tests 04:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:52 INFO - trying https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:27:52 INFO - Downloading https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:27:53 INFO - Downloaded 1199 bytes. 04:27:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:27:53 INFO - Using the following test package requirements: 04:27:53 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:27:53 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:27:53 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:27:53 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'jsshell-mac.zip'], 04:27:53 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:27:53 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:27:53 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:27:53 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:27:53 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:27:53 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:27:53 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:27:53 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:27:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:27:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:27:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:27:54 INFO - Expected file size: 34939821 04:27:54 INFO - Obtained file size: 34939821 04:28:01 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:28:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:28:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:28:01 INFO - Fetch https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:28:02 INFO - Expected file size: 34939821 04:28:02 INFO - Obtained file size: 34939821 04:28:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:28:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:28:09 INFO - Fetch https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:28:10 INFO - Expected file size: 14403454 04:28:10 INFO - Obtained file size: 14403454 04:28: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')]} 04:28:10 INFO - trying https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:28:10 INFO - Downloading https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:28:12 INFO - Downloaded 70372404 bytes. 04:28:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:28:12 INFO - mkdir: /builds/slave/test/properties 04:28:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:28:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:28:12 INFO - Contents: 04:28:12 INFO - build_url:https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:28:13 INFO - Running post-action listener: _resource_record_post_action 04:28:13 INFO - Running post-action listener: set_extra_try_arguments 04:28:13 INFO - [mozharness: 2017-02-09 12:28:13.647893Z] Finished download-and-extract step (success) 04:28:13 INFO - [mozharness: 2017-02-09 12:28:13.648046Z] Running populate-webroot step. 04:28:13 INFO - Running pre-action listener: _resource_record_pre_action 04:28:13 INFO - Running main action method: populate_webroot 04:28:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:28:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:28:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:28:13 INFO - '--tppagecycles', 04:28:13 INFO - '7'], 04:28:13 INFO - 'tests': ['tsvgm']}}, 04:28:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:28:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:28:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:28:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:28:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:28:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:28:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['damp', 'tps']}, 04:28:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'tests': ['damp', 'tps']}, 04:28:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['dromaeo_dom']}, 04:28:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:28:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['basic_compositor_video']}, 04:28:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:28:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['a11yr', 04:28:13 INFO - 'ts_paint', 04:28:13 INFO - 'tpaint', 04:28:13 INFO - 'sessionrestore', 04:28:13 INFO - 'sessionrestore_no_auto_restore', 04:28:13 INFO - 'tabpaint']}, 04:28:13 INFO - 'other-e10s': {'tests': ['a11yr', 04:28:13 INFO - 'ts_paint', 04:28:13 INFO - 'tpaint', 04:28:13 INFO - 'sessionrestore', 04:28:13 INFO - 'sessionrestore_no_auto_restore', 04:28:13 INFO - 'tabpaint']}, 04:28:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:28:13 INFO - 'ts_paint', 04:28:13 INFO - 'tpaint', 04:28:13 INFO - 'sessionrestore', 04:28:13 INFO - 'sessionrestore_no_auto_restore', 04:28:13 INFO - 'tabpaint']}, 04:28:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:28:13 INFO - 'ts_paint', 04:28:13 INFO - 'tpaint', 04:28:13 INFO - 'sessionrestore', 04:28:13 INFO - 'sessionrestore_no_auto_restore', 04:28:13 INFO - 'tabpaint']}, 04:28:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['a11yr', 04:28:13 INFO - 'ts_paint', 04:28:13 INFO - 'tpaint', 04:28:13 INFO - 'sessionrestore', 04:28:13 INFO - 'sessionrestore_no_auto_restore', 04:28:13 INFO - 'tabpaint']}, 04:28:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['a11yr', 04:28:13 INFO - 'ts_paint', 04:28:13 INFO - 'tpaint', 04:28:13 INFO - 'sessionrestore', 04:28:13 INFO - 'sessionrestore_no_auto_restore', 04:28:13 INFO - 'tabpaint']}, 04:28:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['tsvgx', 04:28:13 INFO - 'tsvgr_opacity', 04:28:13 INFO - 'tart', 04:28:13 INFO - 'tscrollx', 04:28:13 INFO - 'cart', 04:28:13 INFO - 'tsvg_static']}, 04:28:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:28:13 INFO - 'tsvgr_opacity', 04:28:13 INFO - 'tart', 04:28:13 INFO - 'tscrollx', 04:28:13 INFO - 'cart', 04:28:13 INFO - 'tsvg_static']}, 04:28:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'talos_options': ['--disable-e10s'], 04:28:13 INFO - 'tests': ['tp5o']}, 04:28:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:28:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'talos_options': ['--disable-e10s', 04:28:13 INFO - '--xperf_path', 04:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:28:13 INFO - 'tests': ['tp5n']}, 04:28:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:28:13 INFO - 'talos_options': ['--xperf_path', 04:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:28:13 INFO - 'tests': ['tp5n']}}, 04:28:13 INFO - 'talos.zip': {'path': '', 04:28:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:28:13 INFO - Running post-action listener: _resource_record_post_action 04:28:13 INFO - [mozharness: 2017-02-09 12:28:13.666436Z] Finished populate-webroot step (success) 04:28:13 INFO - [mozharness: 2017-02-09 12:28:13.666583Z] Running create-virtualenv step. 04:28:13 INFO - Running pre-action listener: _resource_record_pre_action 04:28:13 INFO - Running main action method: create_virtualenv 04:28:13 INFO - Creating virtualenv /builds/slave/test/build/venv 04:28:13 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 04:28:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:28:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:28:13 INFO - Using real prefix '/tools/python27' 04:28:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:28:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:28:17 INFO - Installing pip.................done. 04:28:17 INFO - Return code: 0 04:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:28:17 INFO - Reading from file tmpfile_stdout 04:28:17 INFO - Output received: 04:28:17 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) 04:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:17 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:17 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 04:28:17 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 04:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:17 INFO - 'HOME': '/Users/cltbld', 04:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:17 INFO - 'LOGNAME': 'cltbld', 04:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:17 INFO - 'MOZ_NO_REMOTE': '1', 04:28:17 INFO - 'NO_EM_RESTART': '1', 04:28:17 INFO - 'PAGER': '/bin/cat', 04:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:17 INFO - 'PWD': '/builds/slave/test', 04:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:17 INFO - 'SHELL': '/bin/bash', 04:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:17 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:17 INFO - 'USER': 'cltbld', 04:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:17 INFO - 'XPC_FLAGS': '0x0', 04:28:17 INFO - 'XPC_SERVICE_NAME': '0', 04:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:17 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 04:28:17 INFO - Cleaning up... 04:28:17 INFO - Return code: 0 04:28:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:17 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:17 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 04:28:17 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 04:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:17 INFO - 'HOME': '/Users/cltbld', 04:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:17 INFO - 'LOGNAME': 'cltbld', 04:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:17 INFO - 'MOZ_NO_REMOTE': '1', 04:28:17 INFO - 'NO_EM_RESTART': '1', 04:28:17 INFO - 'PAGER': '/bin/cat', 04:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:17 INFO - 'PWD': '/builds/slave/test', 04:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:17 INFO - 'SHELL': '/bin/bash', 04:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:17 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:17 INFO - 'USER': 'cltbld', 04:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:17 INFO - 'XPC_FLAGS': '0x0', 04:28:17 INFO - 'XPC_SERVICE_NAME': '0', 04:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:18 INFO - Downloading/unpacking psutil>=3.1.1 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:28:21 INFO - Installing collected packages: psutil 04:28:21 INFO - Running setup.py install for psutil 04:28:21 INFO - building 'psutil._psutil_osx' extension 04:28:21 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 04:28:22 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 04:28:22 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 04:28:22 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 04:28:22 INFO - building 'psutil._psutil_posix' extension 04:28:22 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 04:28:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:28:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:28:22 INFO - ^ 04:28:22 INFO - 1 warning generated. 04:28:22 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 04:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:28:22 INFO - Successfully installed psutil 04:28:22 INFO - Cleaning up... 04:28:22 INFO - Return code: 0 04:28:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:22 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:22 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 04:28:22 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 04:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:22 INFO - 'HOME': '/Users/cltbld', 04:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:22 INFO - 'LOGNAME': 'cltbld', 04:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:22 INFO - 'MOZ_NO_REMOTE': '1', 04:28:22 INFO - 'NO_EM_RESTART': '1', 04:28:22 INFO - 'PAGER': '/bin/cat', 04:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:22 INFO - 'PWD': '/builds/slave/test', 04:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:22 INFO - 'SHELL': '/bin/bash', 04:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:22 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:22 INFO - 'USER': 'cltbld', 04:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:22 INFO - 'XPC_FLAGS': '0x0', 04:28:22 INFO - 'XPC_SERVICE_NAME': '0', 04:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:28:25 INFO - Installing collected packages: mozsystemmonitor 04:28:25 INFO - Running setup.py install for mozsystemmonitor 04:28:26 INFO - Successfully installed mozsystemmonitor 04:28:26 INFO - Cleaning up... 04:28:26 INFO - Return code: 0 04:28:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:28:26 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')]} 04:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:26 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')]} 04:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:26 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:26 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 04:28:26 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 04:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:26 INFO - 'HOME': '/Users/cltbld', 04:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:26 INFO - 'LOGNAME': 'cltbld', 04:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:26 INFO - 'MOZ_NO_REMOTE': '1', 04:28:26 INFO - 'NO_EM_RESTART': '1', 04:28:26 INFO - 'PAGER': '/bin/cat', 04:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:26 INFO - 'PWD': '/builds/slave/test', 04:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:26 INFO - 'SHELL': '/bin/bash', 04:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:26 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:26 INFO - 'USER': 'cltbld', 04:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:26 INFO - 'XPC_FLAGS': '0x0', 04:28:26 INFO - 'XPC_SERVICE_NAME': '0', 04:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:28:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:28:29 INFO - warning: no files found matching '*.txt' 04:28:29 INFO - no previously-included directories found matching 'build' 04:28:29 INFO - no previously-included directories found matching 'dist' 04:28:29 INFO - no previously-included directories found matching '.git*' 04:28:29 INFO - Installing collected packages: jsonschema, functools32 04:28:29 INFO - Running setup.py install for functools32 04:28:29 INFO - warning: no files found matching '*.txt' 04:28:29 INFO - no previously-included directories found matching 'build' 04:28:29 INFO - no previously-included directories found matching 'dist' 04:28:29 INFO - no previously-included directories found matching '.git*' 04:28:29 INFO - Successfully installed jsonschema functools32 04:28:29 INFO - Cleaning up... 04:28:29 INFO - Return code: 0 04:28:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:29 INFO - 'HOME': '/Users/cltbld', 04:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:29 INFO - 'LOGNAME': 'cltbld', 04:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:29 INFO - 'MOZ_NO_REMOTE': '1', 04:28:29 INFO - 'NO_EM_RESTART': '1', 04:28:29 INFO - 'PAGER': '/bin/cat', 04:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:29 INFO - 'PWD': '/builds/slave/test', 04:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:29 INFO - 'SHELL': '/bin/bash', 04:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:29 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:29 INFO - 'USER': 'cltbld', 04:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:29 INFO - 'XPC_FLAGS': '0x0', 04:28:29 INFO - 'XPC_SERVICE_NAME': '0', 04:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:28:30 INFO - Cleaning up... 04:28:30 INFO - Return code: 0 04:28:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:30 INFO - 'HOME': '/Users/cltbld', 04:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:30 INFO - 'LOGNAME': 'cltbld', 04:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:30 INFO - 'MOZ_NO_REMOTE': '1', 04:28:30 INFO - 'NO_EM_RESTART': '1', 04:28:30 INFO - 'PAGER': '/bin/cat', 04:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:30 INFO - 'PWD': '/builds/slave/test', 04:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:30 INFO - 'SHELL': '/bin/bash', 04:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:30 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:30 INFO - 'USER': 'cltbld', 04:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:30 INFO - 'XPC_FLAGS': '0x0', 04:28:30 INFO - 'XPC_SERVICE_NAME': '0', 04:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:28:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:28:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:34 INFO - Downloading docopt-0.6.1.tar.gz 04:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:28:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:28:34 INFO - Running setup.py install for blobuploader 04:28:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:28:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:28:34 INFO - Running setup.py install for requests 04:28:34 INFO - Running setup.py install for docopt 04:28:35 INFO - Successfully installed blobuploader requests docopt 04:28:35 INFO - Cleaning up... 04:28:35 INFO - Return code: 0 04:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:35 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:35 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 04:28:35 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 04:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:35 INFO - 'HOME': '/Users/cltbld', 04:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:35 INFO - 'LOGNAME': 'cltbld', 04:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:35 INFO - 'MOZ_NO_REMOTE': '1', 04:28:35 INFO - 'NO_EM_RESTART': '1', 04:28:35 INFO - 'PAGER': '/bin/cat', 04:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:35 INFO - 'PWD': '/builds/slave/test', 04:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:35 INFO - 'SHELL': '/bin/bash', 04:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:35 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:35 INFO - 'USER': 'cltbld', 04:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:35 INFO - 'XPC_FLAGS': '0x0', 04:28:35 INFO - 'XPC_SERVICE_NAME': '0', 04:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:35 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-fnRa7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:35 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-2_EIov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:35 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-4Sw0CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:35 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-tVVvIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:35 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-gtyzfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:35 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-TZgFaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-j72S5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-fw0qBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-iqiv0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-9UBiKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-H5UfTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-wYFY7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-08_QPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-XRryzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:36 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-mur4ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:37 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-vgbcrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:37 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-upjN5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:28:37 INFO - Running setup.py install for manifestparser 04:28:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:28:37 INFO - Running setup.py install for mozcrash 04:28:37 INFO - Running setup.py install for mozdebug 04:28:37 INFO - Running setup.py install for mozdevice 04:28:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:28:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:28:37 INFO - Running setup.py install for mozfile 04:28:37 INFO - Running setup.py install for mozhttpd 04:28:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Running setup.py install for mozinfo 04:28:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Running setup.py install for mozInstall 04:28:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Running setup.py install for mozleak 04:28:38 INFO - Running setup.py install for mozlog 04:28:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Running setup.py install for moznetwork 04:28:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:28:38 INFO - Running setup.py install for mozprocess 04:28:38 INFO - Running setup.py install for mozprofile 04:28:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:28:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:28:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:28:39 INFO - Running setup.py install for mozrunner 04:28:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:28:39 INFO - Running setup.py install for mozscreenshot 04:28:39 INFO - Running setup.py install for moztest 04:28:39 INFO - Running setup.py install for mozversion 04:28:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:28:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:28:39 INFO - Cleaning up... 04:28:39 INFO - Return code: 0 04:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:39 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:39 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 04:28:39 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 04:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:39 INFO - 'HOME': '/Users/cltbld', 04:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:39 INFO - 'LOGNAME': 'cltbld', 04:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:39 INFO - 'MOZ_NO_REMOTE': '1', 04:28:39 INFO - 'NO_EM_RESTART': '1', 04:28:39 INFO - 'PAGER': '/bin/cat', 04:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:39 INFO - 'PWD': '/builds/slave/test', 04:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:39 INFO - 'SHELL': '/bin/bash', 04:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:39 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:39 INFO - 'USER': 'cltbld', 04:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:39 INFO - 'XPC_FLAGS': '0x0', 04:28:39 INFO - 'XPC_SERVICE_NAME': '0', 04:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-SkoKiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:40 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-16ypsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Q2_X2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:40 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-aO5V4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-tIFe_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:40 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-BrMH6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:40 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-X9DNCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:40 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-umDSYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:40 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)) 04:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:40 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-qzcQ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:41 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)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-OWL1IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:41 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)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-VqYAqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:41 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)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-NgxfV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-MDz_iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:41 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)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-jPkNHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-mZmP6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:41 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)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-mD8wZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:41 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-PFaG6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:41 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)) 04:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:41 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)) 04:28:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:41 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 04:28:41 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 04:28:41 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 04:28:41 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 04:28:41 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 04:28:41 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 04:28:44 INFO - Downloading blessings-1.6.tar.gz 04:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:28:45 INFO - Installing collected packages: blessings 04:28:45 INFO - Running setup.py install for blessings 04:28:45 INFO - Successfully installed blessings 04:28:45 INFO - Cleaning up... 04:28:45 INFO - Return code: 0 04:28:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:45 INFO - Reading from file tmpfile_stdout 04:28:45 INFO - Current package versions: 04:28:45 INFO - blessings == 1.6 04:28:45 INFO - blobuploader == 1.2.4 04:28:45 INFO - docopt == 0.6.1 04:28:45 INFO - functools32 == 3.2.3-2 04:28:45 INFO - jsonschema == 2.5.1 04:28:45 INFO - manifestparser == 1.1 04:28:45 INFO - mozInstall == 1.12 04:28:45 INFO - mozcrash == 1.0 04:28:45 INFO - mozdebug == 0.1 04:28:45 INFO - mozdevice == 0.49 04:28:45 INFO - mozfile == 1.2 04:28:45 INFO - mozhttpd == 0.7 04:28:45 INFO - mozinfo == 0.9 04:28:45 INFO - mozleak == 0.1 04:28:45 INFO - mozlog == 3.4 04:28:45 INFO - moznetwork == 0.27 04:28:45 INFO - mozprocess == 0.24 04:28:45 INFO - mozprofile == 0.28 04:28:45 INFO - mozrunner == 6.13 04:28:45 INFO - mozscreenshot == 0.1 04:28:45 INFO - mozsystemmonitor == 0.3 04:28:45 INFO - moztest == 0.8 04:28:45 INFO - mozversion == 1.4 04:28:45 INFO - psutil == 3.1.1 04:28:45 INFO - requests == 1.2.3 04:28:45 INFO - wsgiref == 0.1.2 04:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:45 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')]} 04:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:45 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')]} 04:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:45 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:45 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 04:28:45 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 04:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:45 INFO - 'HOME': '/Users/cltbld', 04:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:45 INFO - 'LOGNAME': 'cltbld', 04:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:45 INFO - 'MOZ_NO_REMOTE': '1', 04:28:45 INFO - 'NO_EM_RESTART': '1', 04:28:45 INFO - 'PAGER': '/bin/cat', 04:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:45 INFO - 'PWD': '/builds/slave/test', 04:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:45 INFO - 'SHELL': '/bin/bash', 04:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:45 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:45 INFO - 'USER': 'cltbld', 04:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:45 INFO - 'XPC_FLAGS': '0x0', 04:28:45 INFO - 'XPC_SERVICE_NAME': '0', 04:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 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)) 04:28:46 INFO - Cleaning up... 04:28:46 INFO - Return code: 0 04:28:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:28:46 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')]} 04:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:46 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')]} 04:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:46 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 0x103366b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103369768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc995688c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, '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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 04:28:46 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 04:28:46 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 04:28:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:28:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:46 INFO - 'HOME': '/Users/cltbld', 04:28:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:46 INFO - 'LOGNAME': 'cltbld', 04:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:46 INFO - 'MOZ_NO_REMOTE': '1', 04:28:46 INFO - 'NO_EM_RESTART': '1', 04:28:46 INFO - 'PAGER': '/bin/cat', 04:28:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:46 INFO - 'PWD': '/builds/slave/test', 04:28:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:46 INFO - 'SHELL': '/bin/bash', 04:28:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:28:46 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:28:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:46 INFO - 'USER': 'cltbld', 04:28:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:46 INFO - 'XPC_FLAGS': '0x0', 04:28:46 INFO - 'XPC_SERVICE_NAME': '0', 04:28:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:28:46 INFO - Cleaning up... 04:28:46 INFO - Return code: 0 04:28:46 INFO - Running post-action listener: _resource_record_post_action 04:28:46 INFO - Running post-action listener: _start_resource_monitoring 04:28:46 INFO - Starting resource monitoring. 04:28:46 INFO - [mozharness: 2017-02-09 12:28:46.539464Z] Finished create-virtualenv step (success) 04:28:46 INFO - [mozharness: 2017-02-09 12:28:46.540424Z] Running install step. 04:28:46 INFO - Running pre-action listener: _resource_record_pre_action 04:28:46 INFO - Running main action method: install 04:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:46 INFO - Reading from file tmpfile_stdout 04:28:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:28:46 INFO - Reading from file tmpfile_stdout 04:28:46 INFO - Output received: 04:28:46 INFO - Usage: mozinstall [options] installer 04:28:46 INFO - Options: 04:28:46 INFO - -h, --help show this help message and exit 04:28:46 INFO - -d DEST, --destination=DEST 04:28:46 INFO - Directory to install application into. [default: 04:28:46 INFO - "/builds/slave/test"] 04:28:46 INFO - --app=APP Application being installed. [default: firefox] 04:28:46 INFO - mkdir: /builds/slave/test/build/application 04:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:29:08 INFO - Reading from file tmpfile_stdout 04:29:08 INFO - Output received: 04:29:08 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:29:08 INFO - Running post-action listener: _resource_record_post_action 04:29:08 INFO - [mozharness: 2017-02-09 12:29:08.799679Z] Finished install step (success) 04:29:08 INFO - [mozharness: 2017-02-09 12:29:08.799824Z] Running run-tests step. 04:29:08 INFO - Running pre-action listener: _resource_record_pre_action 04:29:08 INFO - Running main action method: run_tests 04:29:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:29:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:29:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:29:08 INFO - 2017-02-09 04:29:08.814 screenresolution[1634:7527] starting screenresolution argv=screenresolution get 04:29:08 INFO - 2017-02-09 04:29:08.816 screenresolution[1634:7527] Display 0: 1600x1200x32@60 04:29:08 INFO - 2017-02-09 04:29:08.822 screenresolution[1635:7530] starting screenresolution argv=screenresolution list 04:29:08 INFO - Available Modes on Display 0 04:29:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:29:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:29:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:29:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:29:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:29:09 INFO - Intel Iris: 04:29:09 INFO - Chipset Model: Intel Iris 04:29:09 INFO - Type: GPU 04:29:09 INFO - Bus: Built-In 04:29:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:29:09 INFO - Vendor: Intel (0x8086) 04:29:09 INFO - Device ID: 0x0a2e 04:29:09 INFO - Revision ID: 0x0009 04:29:09 INFO - Displays: 04:29:09 INFO - Display: 04:29:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:29:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:29:09 INFO - Display Serial Number: 1600x1200 60 04:29:09 INFO - Main Display: Yes 04:29:09 INFO - Mirror: Off 04:29:09 INFO - Online: Yes 04:29:09 INFO - Rotation: Supported 04:29:09 INFO - Return code: 0 04:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:29:09 INFO - Python 2.7.3 04:29:09 INFO - Return code: 0 04:29:09 INFO - grabbing minidump binary from tooltool 04:29:09 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')]} 04:29:09 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 0x103144d30>, '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 0x10306bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103139be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:29:09 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 04:29:09 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 04:29:09 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 04:29:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:29:09 INFO - Return code: 0 04:29:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:29:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:29:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:29:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:29:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:29:09 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/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 04:29:09 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/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0330 --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 04:29:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JHBe4Wk7Jd/Render', 04:29:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:09 INFO - 'HOME': '/Users/cltbld', 04:29:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:09 INFO - 'LOGNAME': 'cltbld', 04:29:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:29:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:09 INFO - 'MOZ_NO_REMOTE': '1', 04:29:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:29:09 INFO - 'NO_EM_RESTART': '1', 04:29:09 INFO - 'PAGER': '/bin/cat', 04:29:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:09 INFO - 'PWD': '/builds/slave/test', 04:29:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:29:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:09 INFO - 'SHELL': '/bin/bash', 04:29:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Df1Djgudcd/Listeners', 04:29:09 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 04:29:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:09 INFO - 'USER': 'cltbld', 04:29:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:09 INFO - 'XPC_FLAGS': '0x0', 04:29:09 INFO - 'XPC_SERVICE_NAME': '0', 04:29:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:09 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/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 04:29:09 INFO - mozversion application_buildid: 20170209030214 04:29:09 INFO - mozversion application_changeset: b772e0f4138540113e91a46c99bb0d14ecc8acca 04:29:09 INFO - mozversion application_display_name: Nightly 04:29:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:29:09 INFO - mozversion application_name: Firefox 04:29:09 INFO - mozversion application_remotingname: firefox 04:29:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:29:09 INFO - mozversion application_vendor: Mozilla 04:29:09 INFO - mozversion application_version: 54.0a1 04:29:09 INFO - mozversion platform_buildid: 20170209030214 04:29:09 INFO - mozversion platform_changeset: b772e0f4138540113e91a46c99bb0d14ecc8acca 04:29:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:29:09 INFO - mozversion platform_version: 54.0a1 04:29:09 INFO - using testdate: 1486643349 04:29:09 INFO - actual date: 1486643349 04:29:09 INFO - starting webserver on 'localhost:49241' 04:29:09 INFO - SUITE-START | Running 2 tests 04:29:09 INFO - TEST-START | dromaeo_css 04:29:09 INFO - operating with platform_type : mac_ 04:29:09 INFO - Initialising browser for dromaeo_css test... 04:29:09 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpBiQUrV/profile http://localhost:49241/getInfo.html) 04:29:11 INFO - PROCESS | 1645 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:29:12 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 04:29:12 INFO - PROCESS | 1645 | colorDepth:24 04:29:12 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 04:29:12 INFO - PROCESS | 1645 | __metrics 04:29:12 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:29:12 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:29:13 INFO - TEST-INFO | 1645: exit 0 04:29:13 INFO - Browser initialized. 04:29:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:29:13 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpBiQUrV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:25 INFO - PROCESS | 1648 | RSS: Main: 256270336 04:29:25 INFO - PROCESS | 1648 | 04:32:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:32:30 INFO - PROCESS | 1648 | RSS: Main: 405766144 04:32:30 INFO - PROCESS | 1648 | 04:34:15 INFO - PROCESS | 1648 | ************************* 04:34:15 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 04:34:15 INFO - PROCESS | 1648 | 04:34:15 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:34:15 INFO - PROCESS | 1648 | Full stack: 04:34:15 INFO - PROCESS | 1648 | ************************* 04:35:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:35:34 INFO - PROCESS | 1648 | RSS: Main: 387940352 04:35:34 INFO - PROCESS | 1648 | 04:38:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:38:37 INFO - PROCESS | 1648 | RSS: Main: 361119744 04:38:37 INFO - PROCESS | 1648 | 04:41:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:41:40 INFO - PROCESS | 1648 | RSS: Main: 360910848 04:41:40 INFO - PROCESS | 1648 | 04:44:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:44:44 INFO - PROCESS | 1648 | RSS: Main: 349253632 04:44:44 INFO - PROCESS | 1648 | 04:47:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 04:47:48 INFO - PROCESS | 1648 | RSS: Main: 517353472 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | __start_tp_report 04:47:48 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 04:47:48 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 04:47:48 INFO - PROCESS | 1648 | |i|pagename|runs| 04:47:48 INFO - PROCESS | 1648 | |0;dojo.html;2723.7412445817663;2750.6561679790025;3293.259016721238;3301.339732053589;3347.8326083695824;5320.893582128365;5391.73041347932;5474.042042642536;5507.5593952483805;5514.090175121105;4217.430646862673;5432.103702889019;5451.318585176853;5499.9825032369035;5505.366882808478;4216.430781844442;4908.28829819676;4943.728094954776;4986.850394488171;5136.922946155811;5104.234364845266;5115.9488405116035;5144.0740666679985;5150.8712282193055;5157.458466860982;3817.7136714746366;4963.503649635044;4974.204127339644;5018.7992480300745;5082.618803589727;5059.418166910816;5066.088104141253;5088.363954505687;5110.540051395392;5126.487351264881;4958.925616115761;5006.3992320921725;5043.747812609355;5050.797968081272;5081.74591270435;5307.363116426053;5529.419410961831;5533.363663178746;5535.612507124503;5563.666180029211;5793.73928173229;5837.941620583782;5838;5839.328477225131;5857.502112320458;5888.057910734305;5890.3815099414805;5898.262717160355;5908.97045514774;5926.962781513218;5515.062439385314;5528.198411230389;5537.003339398947;5541.085720856054;5546.7781288748;6060.666663333471;6175.660338681416;6218.533609979269;6248.187735594434;6277.560570760094;5662.122371032497;5698.629589076697;5700.743466544015;5962.195103661037;6007.759689612454;6052.818415447544;6125.938740612537;6129.817282374534;6131.233595800525;6139.3388173831;6019.157317975487;6029.969850150721;6032;6050.30421501533;6071.635701857903;5774.82675519735;5826.6795326256615;5829.591928565044;5908.556858235649;6049.516038716892;4764.690295130806;4802.351682522884;4810.2063159578975;4814.470408255089;4843.685160464629;4298.914021719548;4311.913761724748;4312.611864932109;4362.716423432466;4369.584889435499;4704.364910737075;5372.5433338166695;5413.404525502192;5497.972510137423;5499.780008799683;5973.462388385066;6093.512518998469;6102.51954821894;6115.088229002346;6146.293176284695;5477.507024367826;5548.278723765885;5557.527610153102;5559.27729395176;5593.776248950077;4894.898647804215;5297.947020529822;5341.65279256847;5362.356517217959;5376.166694162411;5647.802326918538;6125.509959203253;6131.84670383244;6147.815565533041;6182.505399568114;6116.670564642638;6125.84685382869;6141.670122563672;6147.84630384244;6163.414475624809;6271.905921411274;6290.087937248982;6293.056041593614;6302.905456418249;6304.810855674337;6015.819525414245;6021.819345419644;6054.757809687563;6084.969575152096;6086.02623580225;5905.734241959036;5946.791862284972;6055.939440605537;6084;6099.420555047263;5689.573282003949;5736.598438109292;5901.763929442946;5910.408959104056;5930.644161350333;5780.5953583248765;5814.30228372598;5816.185733997159;5854.121881717776;5899.115132729953;5697.116946873241;5706.28671416073;5716.714164291852;5717.828465146053;5737.397573254748;5619.381867994435;5646.830595082154;5652.095664693629;5823;5877.500412464818;5636.520895723909;5769.653820770767;5778.27771528559;5785.942140578709;5788.218590490398 04:47:48 INFO - PROCESS | 1648 | |1;ext.html;440.6232671066238;498.53387083077325;499.5504046358275;499.56537812103477;513.0790231534395;29049.419011619753;38289;39609.80195099021;39648.60351396489;39857.40213896794;39928.60071399285;40533.39199912004;40940.181196376056;40977.38533921994;40982;8926.821463570725;9124.041975592567;9125.315601329927;9137.543122843865;9153.67962121326;7869.252421020023;8104.635291411901;10666.78666426671;10935.398553079578;10957.17821163416;10893.618723344685;10932;10942.781144377108;10971;11094.944525277362;10857.131429485622;10897.291676041032;10922.836157457645;10926.508307126198;10934.56261749529;7737.651805668758;7935.96032019842;10507;10720.249582529226;10782.083522900562;38205.80897095497;38586.03534911622;38604.22791544154;38716.80641596774;38737.41893871594;3808.1650570676043;3831.233753249361;3840.558335791392;3858.2090671412575;3959;28240.435191296263;28383.57424638632;28442.146735597966;29013.41973160525;29340;3072.969270307313;3084.21352555097;3086.2284428892776;3098.4577698902604;3165.446046941799;385937;386003;387420;388117.99999999715;388286;46891;49900;58055.77498025198;58158.8368232633;58218;51176;52935;61014.64419456972;62269.688651556455;62509.06236406458;14812.555623331318;14970.625734356729;14980.850191497946;14984.325705343286;14993.100413975197;9956.800863982824;10520.579176832995;11445.942770286096;11477.770444591062;11577.421128943519;16843.494695159166;16855.325786968628;16858.494245172664;16883.32466701318;16896.915515422344;5148.536631703165;5578.832635020955;6345.904811427832;6346.714397852108;6429.357064293533;782.0185666988008;826.6858593734343;827.6344032346676;835.6824406725406;838.5639467477;25645;27043.51260680642;27081;29265.448311263743;29581;946.7491114854569;1017.5065093429681;1035.8705161854768;1046.5918291866178;1046.8796088449774;11875.584354547722;14229.644258893404;14882.553523394316;15095.622609434633;15262;558225;561958;562409;562678;563079;57392;57579.712101439225;57681.71159144177;57707;57784.999999999156;1302.2837439408288;1355.7559639265028;1361.0676686469799;1363.6659018540522;1364.106510235797;26642.866785666723;27275.045373411835;28400;28729.85635071895;28874.27814304659;47819.76090119527;48194.75902620464;48267.275990860864;48328.03343933031;48402.51597484121;489385;492107;492388;492801;493150;30072;38032.61967380291;39154.60845391623;39247.2150556993;40509;44370.00669939721;44603.776981116185;45425.318620221384;45633.54366456293;45851;36208.275834482636;36540.45189322109;36680.63319366772;37479.81260093682;37751;35621.28757424889;35647.82176089103;36344.72793452216;36939;36960;33612;34328.21730770179;34579.82710086534;34652.48021279633;34682.786102486294;23423.76576234216;27741.79426718015;30877.529797616586;31373.686263137075;31422.528662070545;23187.4203144916;23385.649215261445;23607.465514741485;23811.880940595187;24118.87940560286 04:47:48 INFO - PROCESS | 1648 | |2;jquery.html;360.6105406161346;379.3816079789943;382.9061879839438;389.6473691309365;390.2994125544647;13981;14253.287335633217;14779.408823647042;19693.803061969375;20219.39341819744;20011.59976800463;20257.594848103065;20807.68788468174;21077.051532681027;21143.47141321464;5302.814401495948;5572.247746554214;5809.912851307234;5811.389804070575;5812.709364531777;5331.680099194061;5743.167240750089;5784.797532086378;5800.593958422912;5801.158831969362;5425.240466334716;5615.803446879339;5620.409856965021;5626.409227031164;5759.712014399284;5573.693446860421;5716.228309178249;5773.220615216934;5778.017736984722;5787.247657804459;4827.686200396963;5000.949990500085;5081.110805609003;5092.541671249605;5114.616403769732;23979.92090355938;24067;24207.03171873123;24353.512929741308;24531.386715332083;2638.2349118755537;2645.431232285068;2652.2838833515034;2652.681678198609;2655.322892662378;14204.857951420458;14913.552593422215;14938.32777525003;15598;15621.531354059396;1768.6816373052845;1804.2512357371675;1811.9275228990825;1817.1096162880226;1831.2034265094594;120842;121344;122295.38852305681;123251.3837430816;124494.19328390551;10587.84118238227;11061.059809916247;11083.390413527171;11139.944300278446;11224.66326010221;13937.930310348384;13941.302934853216;13946.372413241428;13954.720905581831;14001.859981400055;6714.597124172566;7941.523508589503;8138.267555919877;8145.266925976691;8267.958660206661;7944.880826787603;7954.84090318202;7993.160718124514;8116.75649730509;8126.349892008625;5544.306961629796;6688.163979502562;6803.829904252334;6854.10896583441;6891.724331026703;1560.305663979541;1576.3458164861454;1835.9632807343778;1876.74663920369;1884.6042331110345;872.956816604152;988.8566157907063;1025.0614640336255;1026.8921763214905;1066.4880857188593;21222.893885530473;21721.34835954924;21888.781112188994;21931.890340548194;22023.22918697838;1041.5261056219401;1045.414567842011;1052.8867800367045;1067.3969207397795;1071.844582535528;11141.498632561554;11368.317900925971;11513.769724605461;11537.88462115368;11643.53425862956;431207;519090;520687;589414;677049.3688288964;133045;142072;142236;142587;142686;963.5808423335872;999.9750006249902;1026.1636766035658;1035.321864178964;1040.5369610523396;18183.545316374395;18481.630367392845;19512.902435487733;19587.824730516215;19627.018649067773;46888;53593.46406535885;55102;56246;60384.49038774066;67756;84676;84902.15097848943;85474;87445.6883146766;6481.578697384655;7742.845143097219;7993.72021979228;8073.3541316693345;8664.91335086641;9359.438433694;12734.936325318315;12756.298403587893;13218.405171767101;13344.532941347394;10429.16566674649;10997.505112269808;11214.439278035903;11294.192929131299;11363.37501437429;10175.236857235588;10877.728056798327;11083.503726996752;11331.150163737917;11444.828327574927;11157.88842111601;11308;11587.8261826071;11604.535818567163;11652.359120248468;8162.142974987778;8318.792030199293;8395.328373729964;8407.831843363221;8480.575971201291;9879.604815807288;10886.23796334249;11136.944315278372;11178.608748693756;11251.49368278413 04:47:48 INFO - PROCESS | 1648 | |3;mootools.html;1429.706910083433;1435.951755218691;1453.4999800343412;1459.2339022013446;1460.8027916231308;8134.308583770379;8444.493330400173;8469.449485783434;8476.745697629065;8487.830243395128;8189;8337.374696897727;8431.40980131391;8448.662053517852;8511.744647660564;2230.408941630469;2263.852849564773;2263.8868056597103;2267.0818318581;2273.1702928431087;2243.14760391052;2275.954480910381;2276.4195130241765;2277.39648993017;2278.963071802326;2232.1716963411673;2236.9776302236933;2261.9208327708534;2266.9206577769783;2272.2728726807427;2123.4691327168284;2137.7434707835005;2164.6969424280614;2166.328438184168;2227.855189412683;2236.7651396603446;2255.6278214094655;2258.2660635293432;2259.9322020339414;2263.660450932357;8259.091499935003;8445.324374050062;8447;8458.619362128718;8459.450135741157;5007.474215207387;5160.225966105077;5164.070467315919;5167.1990841419265;5173.948260517422;2641.590553464216;3286.5727455430642;3418.4017796885446;3460.8788692395897;3468.219650578625;1189.0962868220215;1207.3661327802886;1225.9754804903853;1250.0686988193763;1253.078986944595;8965.910340896573;10076.69769906904;10441.2169087318;10454.581816727321;10903.781924361547;4251.936220956688;4397.340398940185;4418.955810441855;4420.226460369422;4433.046894917608;7291.34377905991;8487.236148746642;8489.830203395897;8636.654533818702;8711.346649001223;3775.679067279257;4689.882752931204;4875.68308059975;4940.6788558743565;4980.427250866124;4672.252439609646;4792.472827988919;4799.55222836356;4801.51984801517;4805.303231031481;3387.5257463955068;3545.166885781839;3564.7861128332383;3606.4590311452966;3620.71034317254;1124.7300647844459;1130.0564029035684;1131.6095946898306;1133.9206255562196;1138.510440510572;807.3702512040618;839.5214727605329;872.4024043530202;878.7012415778665;901.6258252825004;5329.360476742816;5337.332833395825;5485.204645326406;5569.860753481114;5683.090705487102;775.8943505504633;922.7508572685338;966.5843687214425;982.3712823792779;988.8331768513224;3597.2086141048926;3628.0748409156026;3657.579378371521;3732.936113207777;3776.0748616589112;9687.951560242154;9979.251556133318;10075.647352342632;10078.798424031478;10104.242181836391;8240.423170378135;10011.349262297927;10025.899741002497;10029.047240512285;10029.849552256575;7495.400367970549;7555.791073428335;7653.885191722128;7752.457327987099;7769.494982826098;4669.953300466952;5125.564327032095;5237.711925844115;5407.810726624707;5423.83387571674;8500.319974402157;8767.079456656958;8987.101289870961;9038.457692538468;9102.544872756469;7481.214472480311;8473.491590504344;8720.651173953225;9295.25637948976;9325.813483730151;6967.303269673195;7070.222275549789;7097.609631470319;7174.820629484305;7197.172325182671;7741.883871742041;7834.412419068479;7848.7645370638975;7850.646720897687;7857.646405911633;6787.796366108827;6938.444924406136;7108.3602475777425;7181.820454488679;7192.280771922766;6924.723011079501;7034.824129396601;7042.683079261343;7209.423246140192;7227.638618069181;6195.380461953769;6351.30135685065;6359.268684101203;6360.395762402564;6361.2048493938255;4791.784369703302;4802.51974802517;4835.854924352275;4858.878528036827;4912.45962944083;4865.829695960624;4892.828750993698;4929.852104436873;4980.775865086152;5011.874703132451 04:47:48 INFO - PROCESS | 1648 | |4;prototype.html;346.8456536841105;349.90377646147306;358.9946150807738;362.4798414275513;363.6781448418151;4581.541845815417;4906.852794416164;5019.168003678658;5188.808882537241;5217.686938783676;3886.3587508061137;4570.268756998881;4780.498047704993;5005.824796132136;5053.9241911371355;4015.337469317559;4049.4330793688905;4078.5717499662555;4113.341865301552;4116.794160291988;3311.8840840570583;4065.715399922007;4094.5086589609286;4111.075008123178;4130.938035929464;3366.3000184906587;3686.7419280650365;3920.353141731611;4074.775887326196;4098.8975275618195;3383.374075795986;3590.5152804371337;4051.149258655686;4063.4717486726536;4084.244414783275;3220.776105080078;3325.584301962255;3337.7329813615097;3667.5696478373457;3711.406175012012;4777.972735861772;4868.732219727914;4936.346323981471;5063.3417655704525;5113.590912726973;3986.5814089520763;4412.646988240933;4659.038124397506;4685.8594242172785;4699;4933.975330123362;5335.1730481775385;5454.836354909359;5456.317960254968;5578.30271216098;3530.3292374448774;3691.963080369189;3877.011362102674;3983.5618082011247;4050.5949405059555;4674.509176536449;5000.574836171673;5696.8860622787315;5700.40145784695;5707.315122185364;4082.4284600156;4094.7133700641266;4116.650084742771;4123.969007748063;4133.875983720493;4003.599640035973;4149.522804877417;4182.937255941163;4185.121124563876;4196.916061678749;4116.341385378325;4556.931646025312;4635.907281854412;4674.672772905932;4706.576408123286;4711.481737008995;5482.205080263339;5483.561315094783;5500.3949565547755;5584.972075139598;1190.547591915084;1210.9152359334762;1233.8771717736815;1329.6808765896114;1332.9800052999212;841.8232171243985;943.4197968249478;945.3713280668278;949.586929685589;973.1922504321396;4170.624643782075;4186.811593478301;4211.852585159505;4789.4971028041555;4863.708177509361;4283.986526332618;4475.709078909926;4857.611391088704;5220.947790522122;5442.346918369742;4139.544650088488;4299.527052024275;4708.749744035445;4754.78603462845;4768.332433459318;2536.4673418581933;2608.2222433108677;2683.745044220796;2693.043969390838;2769.7951391144916;4560.726356418625;4822.662413631082;4964.230544265644;4986.4514903360605;5275.5515781158265;4271.9359209611885;5448.482394172547;5457.563394928476;5497.47773961473;5499.917501237484;4808.567228949411;4918.803247870045;4959.958408734134;5468.398476167618;5479.726013699299;4204.51648060477;4500.617447516997;4872.9269060964825;5317.692668938173;5321.487818040075;4727.220008698526;5026.824061157842;5250.243622098429;5264.473552644705;5272.337469577992;5117;5243.632945693765;5261.631685781958;5482.615062447848;5513.283273174462;3469.8959031229106;3727.310447567209;3879.903002424962;3895.590962948963;3918.6277303656107;4388.545626189357;5090.541851233407;5551;5570.242729848751;5598.86002849932;4333.934990975201;4812.590929771009;5158.200478925773;5438.592105592175;5441.319835020622;4665.370175026328;5187.273781670645;5225.503577160163;5407.675539467645;5412;4974.403071631427;5037.9924015196375;5062.240663900445;5156.587473002226;5345.877365753236;4242.708937173891;4360.716553424018;4933.1613625683;5383;5407.72918364192;4419.917120305546;5249.422563517934;5274.050670879278;5282.841514754564;5316.893662126813 04:47:48 INFO - PROCESS | 1648 | |5;yui.html;690.4890381117974;708.1325376413894;746.9990213114426;812.3420029775882;820.790698371915;14303.213323267217;14880.47918322859;14904.701905961874;14925.776113358308;14929.954903156784;13252.271125088117;13290.800637990415;13360.398782054806;13386.062975591713;13532.59402217935;741.7737590035038;824.4105464592815;858.3690987124443;874.6107981948004;879.1296616349799;841.4993079117914;845.3744229270327;860.0883063952199;860.311750599521;861.8793368928355;897.1297841094129;900.2797761790541;900.6712549919265;900.918917297443;901.4681338010572;860.7030574451804;861.7630151708299;862.3532350736916;874.9212570868652;899.694104004635;661.9669016549153;663.3996233408773;663.449337050252;663.8108139180358;665.2981104934292;14756.262186890719;14866.331015104346;15004.474843380429;15037.323320450607;15041.097534147986;13753.243571603558;13891.930540347335;13989.790153147711;14006.71986560263;14028.43886244549;9452.43285402878;11443.683976342743;11504.76990460186;11550.826737598858;11924.761504769856;3589.6410358964154;3600.5499312585926;3629.8548058077645;3632.600413954463;3763.209725957552;110988.4450577742;112821.99999999919;113805.43097284461;114276;114805;10583.470826458646;10599.364038157735;10658.893411065945;10997;11111.55553777856;21847.907604619704;21859.67210491812;22331.888340558195;22337.77662223357;22404.103835846385;7443.330100291;7460.440466964999;7513.4740568159705;7536.886946695804;7690.077190737147;3985.501812273466;4091.734037287567;4095.7133000689664;4096.938545921814;4125.938110928339;3552.946705799415;3646.9635303647156;3651.908702282464;3659.396199627085;3664.340418724655;600.570592026703;649.4998850884792;660.7092879133166;664.1631544254275;669.464428457242;630.3192552043781;665.5524234789314;666.9833254168587;702.1433850702135;720.2113685514354;7928.603569821601;8695.652173913099;9077.68228112013;9873.407595544146;10164.949175254076;648.4747354642755;672.7645324136611;680.938715515606;689.2418339826152;711.8825393810067;4774.785134668949;4781.842111798199;4873.074115917964;4888.074484944575;4936.3829521309835;89503.55248223717;90932;91462;91653.5417322909;93315;50870.23694644583;62791.6860415695;83217;83503;87261.25477490542;56729.86540269254;62671.4332141691;67048.6647566759;70260.29739702538;76185.8097804626;6393.6163830170335;9050.637974480947;9166.908330916873;10392;10675.51960161779;42937.57062429336;45972.540274596824;47317.867887377;47864.7606761964;49982.50017499924;51683;65280;65335;66246;67489.31276718121;10662.306950048222;10860.565577376816;11289.98390144891;11444.599439019594;11526.308421494738;11936.10479214045;11942.164048516868;11973.461194246454;12006.339651319262;12009.819852702041;11631.825522616999;11730.296182229093;11750;11775;11940.820887686865;11728;11802.76394472123;11969.042476602026;12175.086868484723;12218.722989956257;11266.436678166223;11494.54021839117;11594.01450876685;11982.520699171935;12093.818592721293;8744.825103498022;9629.855552166582;9647.758806029624;9719.187989425795;10140.29017968735;6781.42357899584;8645.221930026328;9213.539323033956;9301.72094837156;9328.113829186217 04:47:48 INFO - PROCESS | 1648 | __end_tp_report 04:47:48 INFO - PROCESS | 1648 | __start_cc_report 04:47:48 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1633 04:47:48 INFO - PROCESS | 1648 | __end_cc_report 04:47:48 INFO - PROCESS | 1648 | __startTimestamp1486644468104__endTimestamp 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | ------- Summary: start ------- 04:47:48 INFO - PROCESS | 1648 | Number of tests: 6 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5519.39 Median:5697.12 stddev:666.68 (11.7%) stddev-sans-first:631.62 04:47:48 INFO - PROCESS | 1648 | Values: 2723.7 2750.7 3293.3 3301.3 3347.8 5320.9 5391.7 5474.0 5507.6 5514.1 4217.4 5432.1 5451.3 5500.0 5505.4 4216.4 4908.3 4943.7 4986.9 5136.9 5104.2 5115.9 5144.1 5150.9 5157.5 3817.7 4963.5 4974.2 5018.8 5082.6 5059.4 5066.1 5088.4 5110.5 5126.5 4958.9 5006.4 5043.7 5050.8 5081.7 5307.4 5529.4 5533.4 5535.6 5563.7 5793.7 5837.9 5838.0 5839.3 5857.5 5888.1 5890.4 5898.3 5909.0 5927.0 5515.1 5528.2 5537.0 5541.1 5546.8 6060.7 6175.7 6218.5 6248.2 6277.6 5662.1 5698.6 5700.7 5962.2 6007.8 6052.8 6125.9 6129.8 6131.2 6139.3 6019.2 6030.0 6032.0 6050.3 6071.6 5774.8 5826.7 5829.6 5908.6 6049.5 4764.7 4802.4 4810.2 4814.5 4843.7 4298.9 4311.9 4312.6 4362.7 4369.6 4704.4 5372.5 5413.4 5498.0 5499.8 5973.5 6093.5 6102.5 6115.1 6146.3 5477.5 5548.3 5557.5 5559.3 5593.8 4894.9 5297.9 5341.7 5362.4 5376.2 5647.8 6125.5 6131.8 6147.8 6182.5 6116.7 6125.8 6141.7 6147.8 6163.4 6271.9 6290.1 6293.1 6302.9 6304.8 6015.8 6021.8 6054.8 6085.0 6086.0 5905.7 5946.8 6055.9 6084.0 6099.4 5689.6 5736.6 5901.8 5910.4 5930.6 5780.6 5814.3 5816.2 5854.1 5899.1 5697.1 5706.3 5716.7 5717.8 5737.4 5619.4 5646.8 5652.1 5823.0 5877.5 5636.5 5769.7 5778.3 5785.9 5788.2 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:61845.82 Median:37891.81 stddev:129325.65 (341.3%) stddev-sans-first:129606.26 04:47:48 INFO - PROCESS | 1648 | Values: 440.6 498.5 499.6 499.6 513.1 29049.4 38289.0 39609.8 39648.6 39857.4 39928.6 40533.4 40940.2 40977.4 40982.0 8926.8 9124.0 9125.3 9137.5 9153.7 7869.3 8104.6 10666.8 10935.4 10957.2 10893.6 10932.0 10942.8 10971.0 11094.9 10857.1 10897.3 10922.8 10926.5 10934.6 7737.7 7936.0 10507.0 10720.2 10782.1 38205.8 38586.0 38604.2 38716.8 38737.4 3808.2 3831.2 3840.6 3858.2 3959.0 28240.4 28383.6 28442.1 29013.4 29340.0 3073.0 3084.2 3086.2 3098.5 3165.4 385937.0 386003.0 387420.0 388118.0 388286.0 46891.0 49900.0 58055.8 58158.8 58218.0 51176.0 52935.0 61014.6 62269.7 62509.1 14812.6 14970.6 14980.9 14984.3 14993.1 9956.8 10520.6 11445.9 11477.8 11577.4 16843.5 16855.3 16858.5 16883.3 16896.9 5148.5 5578.8 6345.9 6346.7 6429.4 782.0 826.7 827.6 835.7 838.6 25645.0 27043.5 27081.0 29265.4 29581.0 946.7 1017.5 1035.9 1046.6 1046.9 11875.6 14229.6 14882.6 15095.6 15262.0 558225.0 561958.0 562409.0 562678.0 563079.0 57392.0 57579.7 57681.7 57707.0 57785.0 1302.3 1355.8 1361.1 1363.7 1364.1 26642.9 27275.0 28400.0 28729.9 28874.3 47819.8 48194.8 48267.3 48328.0 48402.5 489385.0 492107.0 492388.0 492801.0 493150.0 30072.0 38032.6 39154.6 39247.2 40509.0 44370.0 44603.8 45425.3 45633.5 45851.0 36208.3 36540.5 36680.6 37479.8 37751.0 35621.3 35647.8 36344.7 36939.0 36960.0 33612.0 34328.2 34579.8 34652.5 34682.8 23423.8 27741.8 30877.5 31373.7 31422.5 23187.4 23385.6 23607.5 23811.9 24118.9 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34258.83 Median:21805.06 stddev:93453.36 (428.6%) stddev-sans-first:93680.86 04:47:48 INFO - PROCESS | 1648 | Values: 360.6 379.4 382.9 389.6 390.3 13981.0 14253.3 14779.4 19693.8 20219.4 20011.6 20257.6 20807.7 21077.1 21143.5 5302.8 5572.2 5809.9 5811.4 5812.7 5331.7 5743.2 5784.8 5800.6 5801.2 5425.2 5615.8 5620.4 5626.4 5759.7 5573.7 5716.2 5773.2 5778.0 5787.2 4827.7 5000.9 5081.1 5092.5 5114.6 23979.9 24067.0 24207.0 24353.5 24531.4 2638.2 2645.4 2652.3 2652.7 2655.3 14204.9 14913.6 14938.3 15598.0 15621.5 1768.7 1804.3 1811.9 1817.1 1831.2 120842.0 121344.0 122295.4 123251.4 124494.2 10587.8 11061.1 11083.4 11139.9 11224.7 13937.9 13941.3 13946.4 13954.7 14001.9 6714.6 7941.5 8138.3 8145.3 8268.0 7944.9 7954.8 7993.2 8116.8 8126.3 5544.3 6688.2 6803.8 6854.1 6891.7 1560.3 1576.3 1836.0 1876.7 1884.6 873.0 988.9 1025.1 1026.9 1066.5 21222.9 21721.3 21888.8 21931.9 22023.2 1041.5 1045.4 1052.9 1067.4 1071.8 11141.5 11368.3 11513.8 11537.9 11643.5 431207.0 519090.0 520687.0 589414.0 677049.4 133045.0 142072.0 142236.0 142587.0 142686.0 963.6 1000.0 1026.2 1035.3 1040.5 18183.5 18481.6 19512.9 19587.8 19627.0 46888.0 53593.5 55102.0 56246.0 60384.5 67756.0 84676.0 84902.2 85474.0 87445.7 6481.6 7742.8 7993.7 8073.4 8664.9 9359.4 12734.9 12756.3 13218.4 13344.5 10429.2 10997.5 11214.4 11294.2 11363.4 10175.2 10877.7 11083.5 11331.2 11444.8 11157.9 11308.0 11587.8 11604.5 11652.4 8162.1 8318.8 8395.3 8407.8 8480.6 9879.6 10886.2 11136.9 11178.6 11251.5 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5293.35 Median:4994.13 stddev:2884.07 (57.7%) stddev-sans-first:2877.54 04:47:48 INFO - PROCESS | 1648 | Values: 1429.7 1436.0 1453.5 1459.2 1460.8 8134.3 8444.5 8469.4 8476.7 8487.8 8189.0 8337.4 8431.4 8448.7 8511.7 2230.4 2263.9 2263.9 2267.1 2273.2 2243.1 2276.0 2276.4 2277.4 2279.0 2232.2 2237.0 2261.9 2266.9 2272.3 2123.5 2137.7 2164.7 2166.3 2227.9 2236.8 2255.6 2258.3 2259.9 2263.7 8259.1 8445.3 8447.0 8458.6 8459.5 5007.5 5160.2 5164.1 5167.2 5173.9 2641.6 3286.6 3418.4 3460.9 3468.2 1189.1 1207.4 1226.0 1250.1 1253.1 8965.9 10076.7 10441.2 10454.6 10903.8 4251.9 4397.3 4419.0 4420.2 4433.0 7291.3 8487.2 8489.8 8636.7 8711.3 3775.7 4689.9 4875.7 4940.7 4980.4 4672.3 4792.5 4799.6 4801.5 4805.3 3387.5 3545.2 3564.8 3606.5 3620.7 1124.7 1130.1 1131.6 1133.9 1138.5 807.4 839.5 872.4 878.7 901.6 5329.4 5337.3 5485.2 5569.9 5683.1 775.9 922.8 966.6 982.4 988.8 3597.2 3628.1 3657.6 3732.9 3776.1 9688.0 9979.3 10075.6 10078.8 10104.2 8240.4 10011.3 10025.9 10029.0 10029.8 7495.4 7555.8 7653.9 7752.5 7769.5 4670.0 5125.6 5237.7 5407.8 5423.8 8500.3 8767.1 8987.1 9038.5 9102.5 7481.2 8473.5 8720.7 9295.3 9325.8 6967.3 7070.2 7097.6 7174.8 7197.2 7741.9 7834.4 7848.8 7850.6 7857.6 6787.8 6938.4 7108.4 7181.8 7192.3 6924.7 7034.8 7042.7 7209.4 7227.6 6195.4 6351.3 6359.3 6360.4 6361.2 4791.8 4802.5 4835.9 4858.9 4912.5 4865.8 4892.8 4929.9 4980.8 5011.9 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4300.53 Median:4707.66 stddev:1253.73 (26.6%) stddev-sans-first:1221.62 04:47:48 INFO - PROCESS | 1648 | Values: 346.8 349.9 359.0 362.5 363.7 4581.5 4906.9 5019.2 5188.8 5217.7 3886.4 4570.3 4780.5 5005.8 5053.9 4015.3 4049.4 4078.6 4113.3 4116.8 3311.9 4065.7 4094.5 4111.1 4130.9 3366.3 3686.7 3920.4 4074.8 4098.9 3383.4 3590.5 4051.1 4063.5 4084.2 3220.8 3325.6 3337.7 3667.6 3711.4 4778.0 4868.7 4936.3 5063.3 5113.6 3986.6 4412.6 4659.0 4685.9 4699.0 4934.0 5335.2 5454.8 5456.3 5578.3 3530.3 3692.0 3877.0 3983.6 4050.6 4674.5 5000.6 5696.9 5700.4 5707.3 4082.4 4094.7 4116.7 4124.0 4133.9 4003.6 4149.5 4182.9 4185.1 4196.9 4116.3 4556.9 4635.9 4674.7 4706.6 4711.5 5482.2 5483.6 5500.4 5585.0 1190.5 1210.9 1233.9 1329.7 1333.0 841.8 943.4 945.4 949.6 973.2 4170.6 4186.8 4211.9 4789.5 4863.7 4284.0 4475.7 4857.6 5220.9 5442.3 4139.5 4299.5 4708.7 4754.8 4768.3 2536.5 2608.2 2683.7 2693.0 2769.8 4560.7 4822.7 4964.2 4986.5 5275.6 4271.9 5448.5 5457.6 5497.5 5499.9 4808.6 4918.8 4960.0 5468.4 5479.7 4204.5 4500.6 4872.9 5317.7 5321.5 4727.2 5026.8 5250.2 5264.5 5272.3 5117.0 5243.6 5261.6 5482.6 5513.3 3469.9 3727.3 3879.9 3895.6 3918.6 4388.5 5090.5 5551.0 5570.2 5598.9 4333.9 4812.6 5158.2 5438.6 5441.3 4665.4 5187.3 5225.5 5407.7 5412.0 4974.4 5038.0 5062.2 5156.6 5345.9 4242.7 4360.7 4933.2 5383.0 5407.7 4419.9 5249.4 5274.1 5282.8 5316.9 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:18935.88 Median:4912.23 stddev:27615.60 (562.2%) stddev-sans-first:27659.09 04:47:48 INFO - PROCESS | 1648 | Values: 690.5 708.1 747.0 812.3 820.8 14303.2 14880.5 14904.7 14925.8 14930.0 13252.3 13290.8 13360.4 13386.1 13532.6 741.8 824.4 858.4 874.6 879.1 841.5 845.4 860.1 860.3 861.9 897.1 900.3 900.7 900.9 901.5 860.7 861.8 862.4 874.9 899.7 662.0 663.4 663.4 663.8 665.3 14756.3 14866.3 15004.5 15037.3 15041.1 13753.2 13891.9 13989.8 14006.7 14028.4 9452.4 11443.7 11504.8 11550.8 11924.8 3589.6 3600.5 3629.9 3632.6 3763.2 110988.4 112822.0 113805.4 114276.0 114805.0 10583.5 10599.4 10658.9 10997.0 11111.6 21847.9 21859.7 22331.9 22337.8 22404.1 7443.3 7460.4 7513.5 7536.9 7690.1 3985.5 4091.7 4095.7 4096.9 4125.9 3552.9 3647.0 3651.9 3659.4 3664.3 600.6 649.5 660.7 664.2 669.5 630.3 665.6 667.0 702.1 720.2 7928.6 8695.7 9077.7 9873.4 10164.9 648.5 672.8 680.9 689.2 711.9 4774.8 4781.8 4873.1 4888.1 4936.4 89503.6 90932.0 91462.0 91653.5 93315.0 50870.2 62791.7 83217.0 83503.0 87261.3 56729.9 62671.4 67048.7 70260.3 76185.8 6393.6 9050.6 9166.9 10392.0 10675.5 42937.6 45972.5 47317.9 47864.8 49982.5 51683.0 65280.0 65335.0 66246.0 67489.3 10662.3 10860.6 11290.0 11444.6 11526.3 11936.1 11942.2 11973.5 12006.3 12009.8 11631.8 11730.3 11750.0 11775.0 11940.8 11728.0 11802.8 11969.0 12175.1 12218.7 11266.4 11494.5 11594.0 11982.5 12093.8 8744.8 9629.9 9647.8 9719.2 10140.3 6781.4 8645.2 9213.5 9301.7 9328.1 04:47:48 INFO - PROCESS | 1648 | -------- Summary: end -------- 04:47:48 INFO - PROCESS | 1648 | 04:47:48 INFO - TEST-INFO | 1648: exit 0 04:47:48 INFO - TEST-OK | dromaeo_css | took 1119422ms 04:47:48 INFO - TEST-START | kraken 04:47:48 INFO - operating with platform_type : mac_ 04:47:48 INFO - Initialising browser for kraken test... 04:47:48 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpcqIr18/profile http://localhost:49241/getInfo.html) 04:47:50 INFO - PROCESS | 1658 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:47:51 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 04:47:51 INFO - PROCESS | 1658 | colorDepth:24 04:47:51 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 04:47:51 INFO - PROCESS | 1658 | __metrics 04:47:51 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:47:51 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:52 INFO - TEST-INFO | 1658: exit 0 04:47:52 INFO - Browser initialized. 04:47:52 INFO - Running cycle 1/1 for kraken test... 04:47:52 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpcqIr18/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:04 INFO - PROCESS | 1660 | RSS: Main: 252739584 04:48:04 INFO - PROCESS | 1660 | 04:48:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 04:48:07 INFO - PROCESS | 1660 | RSS: Main: 302292992 04:48:07 INFO - PROCESS | 1660 | 04:48:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 04:48:11 INFO - PROCESS | 1660 | RSS: Main: 303759360 04:48:11 INFO - PROCESS | 1660 | 04:48:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 04:48:15 INFO - PROCESS | 1660 | RSS: Main: 392347648 04:48:15 INFO - PROCESS | 1660 | 04:48:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 04:48:17 INFO - PROCESS | 1660 | RSS: Main: 295624704 04:48:17 INFO - PROCESS | 1660 | 04:48:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:48:20 INFO - PROCESS | 1660 | RSS: Main: 298479616 04:48:20 INFO - PROCESS | 1660 | 04:48:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 04:48:23 INFO - PROCESS | 1660 | RSS: Main: 339488768 04:48:23 INFO - PROCESS | 1660 | 04:48:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 04:48:27 INFO - PROCESS | 1660 | RSS: Main: 340918272 04:48:27 INFO - PROCESS | 1660 | 04:48:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 04:48:30 INFO - PROCESS | 1660 | RSS: Main: 339623936 04:48:30 INFO - PROCESS | 1660 | 04:48:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:48:33 INFO - PROCESS | 1660 | RSS: Main: 314646528 04:48:33 INFO - PROCESS | 1660 | 04:48:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:48:35 INFO - PROCESS | 1660 | RSS: Main: 319922176 04:48:35 INFO - PROCESS | 1660 | 04:48:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:48:38 INFO - PROCESS | 1660 | RSS: Main: 319922176 04:48:38 INFO - PROCESS | 1660 | 04:48:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:48:42 INFO - PROCESS | 1660 | RSS: Main: 338792448 04:48:42 INFO - PROCESS | 1660 | 04:48:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:48:46 INFO - PROCESS | 1660 | RSS: Main: 333029376 04:48:46 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 04:48:48 INFO - PROCESS | 1660 | RSS: Main: 377720832 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | __start_tp_report 04:48:48 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 04:48:48 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 04:48:48 INFO - PROCESS | 1660 | |i|pagename|runs| 04:48:48 INFO - PROCESS | 1660 | |0;ai-astar;114;114;115;111;113;113;113;113;114;113 04:48:48 INFO - PROCESS | 1660 | |1;audio-beat-detection;142;111;111;161;145;145;117;113;130;114 04:48:48 INFO - PROCESS | 1660 | |2;audio-dft;186;182;185;183;185;181;181;185;183;183 04:48:48 INFO - PROCESS | 1660 | |3;audio-fft;85;63;62;87;60;60;60;59;77;58 04:48:48 INFO - PROCESS | 1660 | |4;audio-oscillator;91;71;87;69;70;67;85;69;69;84 04:48:48 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;87;106;134;93;89;88;89;89;88;89 04:48:48 INFO - PROCESS | 1660 | |6;imaging-darkroom;96;91;110;153;152;96;96;96;95;95 04:48:48 INFO - PROCESS | 1660 | |7;imaging-desaturate;83;83;85;85;87;87;84;87;85;85 04:48:48 INFO - PROCESS | 1660 | |8;json-parse-financial;62;59;58;58;58;59;60;74;67;91 04:48:48 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;65;72;68;66;75;74;69;69;69;68 04:48:48 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;91;92;89;88;89;90;89;91;96;110 04:48:48 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;155;151;154;141;153;157;134;149;207;189 04:48:48 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;175;173;189;239;191;169;172;173;174;173 04:48:48 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;74;76;89;88;88;71;67;64;66 04:48:48 INFO - PROCESS | 1660 | __end_tp_report 04:48:48 INFO - PROCESS | 1660 | __start_cc_report 04:48:48 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2057 04:48:48 INFO - PROCESS | 1660 | __end_cc_report 04:48:48 INFO - PROCESS | 1660 | __startTimestamp1486644528370__endTimestamp 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | ------- Summary: start ------- 04:48:48 INFO - PROCESS | 1660 | Number of tests: 14 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.06 (0.9%) stddev-sans-first:1.09 04:48:48 INFO - PROCESS | 1660 | Values: 114.0 114.0 115.0 111.0 113.0 113.0 113.0 113.0 114.0 113.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:136.00 stddev:18.19 (13.4%) stddev-sans-first:18.67 04:48:48 INFO - PROCESS | 1660 | Values: 142.0 111.0 111.0 161.0 145.0 145.0 117.0 113.0 130.0 114.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.78 (1.0%) stddev-sans-first:1.62 04:48:48 INFO - PROCESS | 1660 | Values: 186.0 182.0 185.0 183.0 185.0 181.0 181.0 185.0 183.0 183.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:67.10 Median:62.50 stddev:11.34 (18.1%) stddev-sans-first:10.01 04:48:48 INFO - PROCESS | 1660 | Values: 85.0 63.0 62.0 87.0 60.0 60.0 60.0 59.0 77.0 58.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.50 stddev:9.31 (12.0%) stddev-sans-first:8.19 04:48:48 INFO - PROCESS | 1660 | Values: 91.0 71.0 87.0 69.0 70.0 67.0 85.0 69.0 69.0 84.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:89.00 stddev:14.73 (16.5%) stddev-sans-first:15.32 04:48:48 INFO - PROCESS | 1660 | Values: 87.0 106.0 134.0 93.0 89.0 88.0 89.0 89.0 88.0 89.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:95.50 stddev:23.96 (25.1%) stddev-sans-first:25.02 04:48:48 INFO - PROCESS | 1660 | Values: 96.0 91.0 110.0 153.0 152.0 96.0 96.0 96.0 95.0 95.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.52 (1.8%) stddev-sans-first:1.41 04:48:48 INFO - PROCESS | 1660 | Values: 83.0 83.0 85.0 85.0 87.0 87.0 84.0 87.0 85.0 85.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:61.00 stddev:10.61 (17.4%) stddev-sans-first:11.21 04:48:48 INFO - PROCESS | 1660 | Values: 62.0 59.0 58.0 58.0 58.0 59.0 60.0 74.0 67.0 91.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:3.24 (4.7%) stddev-sans-first:3.00 04:48:48 INFO - PROCESS | 1660 | Values: 65.0 72.0 68.0 66.0 75.0 74.0 69.0 69.0 69.0 68.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:90.50 stddev:6.55 (7.2%) stddev-sans-first:6.93 04:48:48 INFO - PROCESS | 1660 | Values: 91.0 92.0 89.0 88.0 89.0 90.0 89.0 91.0 96.0 110.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:154.50 stddev:22.11 (14.3%) stddev-sans-first:23.40 04:48:48 INFO - PROCESS | 1660 | Values: 155.0 151.0 154.0 141.0 153.0 157.0 134.0 149.0 207.0 189.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:174.50 stddev:21.08 (12.1%) stddev-sans-first:22.16 04:48:48 INFO - PROCESS | 1660 | Values: 175.0 173.0 189.0 239.0 191.0 169.0 172.0 173.0 174.0 173.0 04:48:48 INFO - PROCESS | 1660 | 04:48:48 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:75.00 stddev:9.90 (13.2%) stddev-sans-first:10.07 04:48:48 INFO - PROCESS | 1660 | Values: 67.0 74.0 76.0 89.0 88.0 88.0 71.0 67.0 64.0 66.0 04:48:48 INFO - PROCESS | 1660 | -------- Summary: end -------- 04:48:48 INFO - PROCESS | 1660 | 04:48:49 INFO - TEST-INFO | 1660: exit 0 04:48:49 INFO - TEST-OK | kraken | took 60550ms 04:48:49 INFO - SUITE-END | took 1179s 04:48:49 INFO - Completed test suite (00:19:40) 04:48:49 INFO - javascript benchmark 04:48:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7029.640125386309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2723.7412445817663, 2750.6561679790025, 3293.259016721238, 3301.339732053589, 3347.8326083695824, 5320.893582128365, 5391.73041347932, 5474.042042642536, 5507.5593952483805, 5514.090175121105, 4217.430646862673, 5432.103702889019, 5451.318585176853, 5499.9825032369035, 5505.366882808478, 4216.430781844442, 4908.28829819676, 4943.728094954776, 4986.850394488171, 5136.922946155811, 5104.234364845266, 5115.9488405116035, 5144.0740666679985, 5150.8712282193055, 5157.458466860982, 3817.7136714746366, 4963.503649635044, 4974.204127339644, 5018.7992480300745, 5082.618803589727, 5059.418166910816, 5066.088104141253, 5088.363954505687, 5110.540051395392, 5126.487351264881, 4958.925616115761, 5006.3992320921725, 5043.747812609355, 5050.797968081272, 5081.74591270435, 5307.363116426053, 5529.419410961831, 5533.363663178746, 5535.612507124503, 5563.666180029211, 5793.73928173229, 5837.941620583782, 5838.0, 5839.328477225131, 5857.502112320458, 5888.057910734305, 5890.3815099414805, 5898.262717160355, 5908.97045514774, 5926.962781513218, 5515.062439385314, 5528.198411230389, 5537.003339398947, 5541.085720856054, 5546.7781288748, 6060.666663333471, 6175.660338681416, 6218.533609979269, 6248.187735594434, 6277.560570760094, 5662.122371032497, 5698.629589076697, 5700.743466544015, 5962.195103661037, 6007.759689612454, 6052.818415447544, 6125.938740612537, 6129.817282374534, 6131.233595800525, 6139.3388173831, 6019.157317975487, 6029.969850150721, 6032.0, 6050.30421501533, 6071.635701857903, 5774.82675519735, 5826.6795326256615, 5829.591928565044, 5908.556858235649, 6049.516038716892, 4764.690295130806, 4802.351682522884, 4810.2063159578975, 4814.470408255089, 4843.685160464629, 4298.914021719548, 4311.913761724748, 4312.611864932109, 4362.716423432466, 4369.584889435499, 4704.364910737075, 5372.5433338166695, 5413.404525502192, 5497.972510137423, 5499.780008799683, 5973.462388385066, 6093.512518998469, 6102.51954821894, 6115.088229002346, 6146.293176284695, 5477.507024367826, 5548.278723765885, 5557.527610153102, 5559.27729395176, 5593.776248950077, 4894.898647804215, 5297.947020529822, 5341.65279256847, 5362.356517217959, 5376.166694162411, 5647.802326918538, 6125.509959203253, 6131.84670383244, 6147.815565533041, 6182.505399568114, 6116.670564642638, 6125.84685382869, 6141.670122563672, 6147.84630384244, 6163.414475624809, 6271.905921411274, 6290.087937248982, 6293.056041593614, 6302.905456418249, 6304.810855674337, 6015.819525414245, 6021.819345419644, 6054.757809687563, 6084.969575152096, 6086.02623580225, 5905.734241959036, 5946.791862284972, 6055.939440605537, 6084.0, 6099.420555047263, 5689.573282003949, 5736.598438109292, 5901.763929442946, 5910.408959104056, 5930.644161350333, 5780.5953583248765, 5814.30228372598, 5816.185733997159, 5854.121881717776, 5899.115132729953, 5697.116946873241, 5706.28671416073, 5716.714164291852, 5717.828465146053, 5737.397573254748, 5619.381867994435, 5646.830595082154, 5652.095664693629, 5823.0, 5877.500412464818, 5636.520895723909, 5769.653820770767, 5778.27771528559, 5785.942140578709, 5788.218590490398], "value": 5474.338205381898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.6232671066238, 498.53387083077325, 499.5504046358275, 499.56537812103477, 513.0790231534395, 29049.419011619753, 38289.0, 39609.80195099021, 39648.60351396489, 39857.40213896794, 39928.60071399285, 40533.39199912004, 40940.181196376056, 40977.38533921994, 40982.0, 8926.821463570725, 9124.041975592567, 9125.315601329927, 9137.543122843865, 9153.67962121326, 7869.252421020023, 8104.635291411901, 10666.78666426671, 10935.398553079578, 10957.17821163416, 10893.618723344685, 10932.0, 10942.781144377108, 10971.0, 11094.944525277362, 10857.131429485622, 10897.291676041032, 10922.836157457645, 10926.508307126198, 10934.56261749529, 7737.651805668758, 7935.96032019842, 10507.0, 10720.249582529226, 10782.083522900562, 38205.80897095497, 38586.03534911622, 38604.22791544154, 38716.80641596774, 38737.41893871594, 3808.1650570676043, 3831.233753249361, 3840.558335791392, 3858.2090671412575, 3959.0, 28240.435191296263, 28383.57424638632, 28442.146735597966, 29013.41973160525, 29340.0, 3072.969270307313, 3084.21352555097, 3086.2284428892776, 3098.4577698902604, 3165.446046941799, 385937.0, 386003.0, 387420.0, 388117.99999999715, 388286.0, 46891.0, 49900.0, 58055.77498025198, 58158.8368232633, 58218.0, 51176.0, 52935.0, 61014.64419456972, 62269.688651556455, 62509.06236406458, 14812.555623331318, 14970.625734356729, 14980.850191497946, 14984.325705343286, 14993.100413975197, 9956.800863982824, 10520.579176832995, 11445.942770286096, 11477.770444591062, 11577.421128943519, 16843.494695159166, 16855.325786968628, 16858.494245172664, 16883.32466701318, 16896.915515422344, 5148.536631703165, 5578.832635020955, 6345.904811427832, 6346.714397852108, 6429.357064293533, 782.0185666988008, 826.6858593734343, 827.6344032346676, 835.6824406725406, 838.5639467477, 25645.0, 27043.51260680642, 27081.0, 29265.448311263743, 29581.0, 946.7491114854569, 1017.5065093429681, 1035.8705161854768, 1046.5918291866178, 1046.8796088449774, 11875.584354547722, 14229.644258893404, 14882.553523394316, 15095.622609434633, 15262.0, 558225.0, 561958.0, 562409.0, 562678.0, 563079.0, 57392.0, 57579.712101439225, 57681.71159144177, 57707.0, 57784.999999999156, 1302.2837439408288, 1355.7559639265028, 1361.0676686469799, 1363.6659018540522, 1364.106510235797, 26642.866785666723, 27275.045373411835, 28400.0, 28729.85635071895, 28874.27814304659, 47819.76090119527, 48194.75902620464, 48267.275990860864, 48328.03343933031, 48402.51597484121, 489385.0, 492107.0, 492388.0, 492801.0, 493150.0, 30072.0, 38032.61967380291, 39154.60845391623, 39247.2150556993, 40509.0, 44370.00669939721, 44603.776981116185, 45425.318620221384, 45633.54366456293, 45851.0, 36208.275834482636, 36540.45189322109, 36680.63319366772, 37479.81260093682, 37751.0, 35621.28757424889, 35647.82176089103, 36344.72793452216, 36939.0, 36960.0, 33612.0, 34328.21730770179, 34579.82710086534, 34652.48021279633, 34682.786102486294, 23423.76576234216, 27741.79426718015, 30877.529797616586, 31373.686263137075, 31422.528662070545, 23187.4203144916, 23385.649215261445, 23607.465514741485, 23811.880940595187, 24118.87940560286], "value": 18971.772999964687, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.6105406161346, 379.3816079789943, 382.9061879839438, 389.6473691309365, 390.2994125544647, 13981.0, 14253.287335633217, 14779.408823647042, 19693.803061969375, 20219.39341819744, 20011.59976800463, 20257.594848103065, 20807.68788468174, 21077.051532681027, 21143.47141321464, 5302.814401495948, 5572.247746554214, 5809.912851307234, 5811.389804070575, 5812.709364531777, 5331.680099194061, 5743.167240750089, 5784.797532086378, 5800.593958422912, 5801.158831969362, 5425.240466334716, 5615.803446879339, 5620.409856965021, 5626.409227031164, 5759.712014399284, 5573.693446860421, 5716.228309178249, 5773.220615216934, 5778.017736984722, 5787.247657804459, 4827.686200396963, 5000.949990500085, 5081.110805609003, 5092.541671249605, 5114.616403769732, 23979.92090355938, 24067.0, 24207.03171873123, 24353.512929741308, 24531.386715332083, 2638.2349118755537, 2645.431232285068, 2652.2838833515034, 2652.681678198609, 2655.322892662378, 14204.857951420458, 14913.552593422215, 14938.32777525003, 15598.0, 15621.531354059396, 1768.6816373052845, 1804.2512357371675, 1811.9275228990825, 1817.1096162880226, 1831.2034265094594, 120842.0, 121344.0, 122295.38852305681, 123251.3837430816, 124494.19328390551, 10587.84118238227, 11061.059809916247, 11083.390413527171, 11139.944300278446, 11224.66326010221, 13937.930310348384, 13941.302934853216, 13946.372413241428, 13954.720905581831, 14001.859981400055, 6714.597124172566, 7941.523508589503, 8138.267555919877, 8145.266925976691, 8267.958660206661, 7944.880826787603, 7954.84090318202, 7993.160718124514, 8116.75649730509, 8126.349892008625, 5544.306961629796, 6688.163979502562, 6803.829904252334, 6854.10896583441, 6891.724331026703, 1560.305663979541, 1576.3458164861454, 1835.9632807343778, 1876.74663920369, 1884.6042331110345, 872.956816604152, 988.8566157907063, 1025.0614640336255, 1026.8921763214905, 1066.4880857188593, 21222.893885530473, 21721.34835954924, 21888.781112188994, 21931.890340548194, 22023.22918697838, 1041.5261056219401, 1045.414567842011, 1052.8867800367045, 1067.3969207397795, 1071.844582535528, 11141.498632561554, 11368.317900925971, 11513.769724605461, 11537.88462115368, 11643.53425862956, 431207.0, 519090.0, 520687.0, 589414.0, 677049.3688288964, 133045.0, 142072.0, 142236.0, 142587.0, 142686.0, 963.5808423335872, 999.9750006249902, 1026.1636766035658, 1035.321864178964, 1040.5369610523396, 18183.545316374395, 18481.630367392845, 19512.902435487733, 19587.824730516215, 19627.018649067773, 46888.0, 53593.46406535885, 55102.0, 56246.0, 60384.49038774066, 67756.0, 84676.0, 84902.15097848943, 85474.0, 87445.6883146766, 6481.578697384655, 7742.845143097219, 7993.72021979228, 8073.3541316693345, 8664.91335086641, 9359.438433694, 12734.936325318315, 12756.298403587893, 13218.405171767101, 13344.532941347394, 10429.16566674649, 10997.505112269808, 11214.439278035903, 11294.192929131299, 11363.37501437429, 10175.236857235588, 10877.728056798327, 11083.503726996752, 11331.150163737917, 11444.828327574927, 11157.88842111601, 11308.0, 11587.8261826071, 11604.535818567163, 11652.359120248468, 8162.142974987778, 8318.792030199293, 8395.328373729964, 8407.831843363221, 8480.575971201291, 9879.604815807288, 10886.23796334249, 11136.944315278372, 11178.608748693756, 11251.49368278413], "value": 9704.711829907374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.706910083433, 1435.951755218691, 1453.4999800343412, 1459.2339022013446, 1460.8027916231308, 8134.308583770379, 8444.493330400173, 8469.449485783434, 8476.745697629065, 8487.830243395128, 8189.0, 8337.374696897727, 8431.40980131391, 8448.662053517852, 8511.744647660564, 2230.408941630469, 2263.852849564773, 2263.8868056597103, 2267.0818318581, 2273.1702928431087, 2243.14760391052, 2275.954480910381, 2276.4195130241765, 2277.39648993017, 2278.963071802326, 2232.1716963411673, 2236.9776302236933, 2261.9208327708534, 2266.9206577769783, 2272.2728726807427, 2123.4691327168284, 2137.7434707835005, 2164.6969424280614, 2166.328438184168, 2227.855189412683, 2236.7651396603446, 2255.6278214094655, 2258.2660635293432, 2259.9322020339414, 2263.660450932357, 8259.091499935003, 8445.324374050062, 8447.0, 8458.619362128718, 8459.450135741157, 5007.474215207387, 5160.225966105077, 5164.070467315919, 5167.1990841419265, 5173.948260517422, 2641.590553464216, 3286.5727455430642, 3418.4017796885446, 3460.8788692395897, 3468.219650578625, 1189.0962868220215, 1207.3661327802886, 1225.9754804903853, 1250.0686988193763, 1253.078986944595, 8965.910340896573, 10076.69769906904, 10441.2169087318, 10454.581816727321, 10903.781924361547, 4251.936220956688, 4397.340398940185, 4418.955810441855, 4420.226460369422, 4433.046894917608, 7291.34377905991, 8487.236148746642, 8489.830203395897, 8636.654533818702, 8711.346649001223, 3775.679067279257, 4689.882752931204, 4875.68308059975, 4940.6788558743565, 4980.427250866124, 4672.252439609646, 4792.472827988919, 4799.55222836356, 4801.51984801517, 4805.303231031481, 3387.5257463955068, 3545.166885781839, 3564.7861128332383, 3606.4590311452966, 3620.71034317254, 1124.7300647844459, 1130.0564029035684, 1131.6095946898306, 1133.9206255562196, 1138.510440510572, 807.3702512040618, 839.5214727605329, 872.4024043530202, 878.7012415778665, 901.6258252825004, 5329.360476742816, 5337.332833395825, 5485.204645326406, 5569.860753481114, 5683.090705487102, 775.8943505504633, 922.7508572685338, 966.5843687214425, 982.3712823792779, 988.8331768513224, 3597.2086141048926, 3628.0748409156026, 3657.579378371521, 3732.936113207777, 3776.0748616589112, 9687.951560242154, 9979.251556133318, 10075.647352342632, 10078.798424031478, 10104.242181836391, 8240.423170378135, 10011.349262297927, 10025.899741002497, 10029.047240512285, 10029.849552256575, 7495.400367970549, 7555.791073428335, 7653.885191722128, 7752.457327987099, 7769.494982826098, 4669.953300466952, 5125.564327032095, 5237.711925844115, 5407.810726624707, 5423.83387571674, 8500.319974402157, 8767.079456656958, 8987.101289870961, 9038.457692538468, 9102.544872756469, 7481.214472480311, 8473.491590504344, 8720.651173953225, 9295.25637948976, 9325.813483730151, 6967.303269673195, 7070.222275549789, 7097.609631470319, 7174.820629484305, 7197.172325182671, 7741.883871742041, 7834.412419068479, 7848.7645370638975, 7850.646720897687, 7857.646405911633, 6787.796366108827, 6938.444924406136, 7108.3602475777425, 7181.820454488679, 7192.280771922766, 6924.723011079501, 7034.824129396601, 7042.683079261343, 7209.423246140192, 7227.638618069181, 6195.380461953769, 6351.30135685065, 6359.268684101203, 6360.395762402564, 6361.2048493938255, 4791.784369703302, 4802.51974802517, 4835.854924352275, 4858.878528036827, 4912.45962944083, 4865.829695960624, 4892.828750993698, 4929.852104436873, 4980.775865086152, 5011.874703132451], "value": 4302.308046137843, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.8456536841105, 349.90377646147306, 358.9946150807738, 362.4798414275513, 363.6781448418151, 4581.541845815417, 4906.852794416164, 5019.168003678658, 5188.808882537241, 5217.686938783676, 3886.3587508061137, 4570.268756998881, 4780.498047704993, 5005.824796132136, 5053.9241911371355, 4015.337469317559, 4049.4330793688905, 4078.5717499662555, 4113.341865301552, 4116.794160291988, 3311.8840840570583, 4065.715399922007, 4094.5086589609286, 4111.075008123178, 4130.938035929464, 3366.3000184906587, 3686.7419280650365, 3920.353141731611, 4074.775887326196, 4098.8975275618195, 3383.374075795986, 3590.5152804371337, 4051.149258655686, 4063.4717486726536, 4084.244414783275, 3220.776105080078, 3325.584301962255, 3337.7329813615097, 3667.5696478373457, 3711.406175012012, 4777.972735861772, 4868.732219727914, 4936.346323981471, 5063.3417655704525, 5113.590912726973, 3986.5814089520763, 4412.646988240933, 4659.038124397506, 4685.8594242172785, 4699.0, 4933.975330123362, 5335.1730481775385, 5454.836354909359, 5456.317960254968, 5578.30271216098, 3530.3292374448774, 3691.963080369189, 3877.011362102674, 3983.5618082011247, 4050.5949405059555, 4674.509176536449, 5000.574836171673, 5696.8860622787315, 5700.40145784695, 5707.315122185364, 4082.4284600156, 4094.7133700641266, 4116.650084742771, 4123.969007748063, 4133.875983720493, 4003.599640035973, 4149.522804877417, 4182.937255941163, 4185.121124563876, 4196.916061678749, 4116.341385378325, 4556.931646025312, 4635.907281854412, 4674.672772905932, 4706.576408123286, 4711.481737008995, 5482.205080263339, 5483.561315094783, 5500.3949565547755, 5584.972075139598, 1190.547591915084, 1210.9152359334762, 1233.8771717736815, 1329.6808765896114, 1332.9800052999212, 841.8232171243985, 943.4197968249478, 945.3713280668278, 949.586929685589, 973.1922504321396, 4170.624643782075, 4186.811593478301, 4211.852585159505, 4789.4971028041555, 4863.708177509361, 4283.986526332618, 4475.709078909926, 4857.611391088704, 5220.947790522122, 5442.346918369742, 4139.544650088488, 4299.527052024275, 4708.749744035445, 4754.78603462845, 4768.332433459318, 2536.4673418581933, 2608.2222433108677, 2683.745044220796, 2693.043969390838, 2769.7951391144916, 4560.726356418625, 4822.662413631082, 4964.230544265644, 4986.4514903360605, 5275.5515781158265, 4271.9359209611885, 5448.482394172547, 5457.563394928476, 5497.47773961473, 5499.917501237484, 4808.567228949411, 4918.803247870045, 4959.958408734134, 5468.398476167618, 5479.726013699299, 4204.51648060477, 4500.617447516997, 4872.9269060964825, 5317.692668938173, 5321.487818040075, 4727.220008698526, 5026.824061157842, 5250.243622098429, 5264.473552644705, 5272.337469577992, 5117.0, 5243.632945693765, 5261.631685781958, 5482.615062447848, 5513.283273174462, 3469.8959031229106, 3727.310447567209, 3879.903002424962, 3895.590962948963, 3918.6277303656107, 4388.545626189357, 5090.541851233407, 5551.0, 5570.242729848751, 5598.86002849932, 4333.934990975201, 4812.590929771009, 5158.200478925773, 5438.592105592175, 5441.319835020622, 4665.370175026328, 5187.273781670645, 5225.503577160163, 5407.675539467645, 5412.0, 4974.403071631427, 5037.9924015196375, 5062.240663900445, 5156.587473002226, 5345.877365753236, 4242.708937173891, 4360.716553424018, 4933.1613625683, 5383.0, 5407.72918364192, 4419.917120305546, 5249.422563517934, 5274.050670879278, 5282.841514754564, 5316.893662126813], "value": 3924.379181822485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.4890381117974, 708.1325376413894, 746.9990213114426, 812.3420029775882, 820.790698371915, 14303.213323267217, 14880.47918322859, 14904.701905961874, 14925.776113358308, 14929.954903156784, 13252.271125088117, 13290.800637990415, 13360.398782054806, 13386.062975591713, 13532.59402217935, 741.7737590035038, 824.4105464592815, 858.3690987124443, 874.6107981948004, 879.1296616349799, 841.4993079117914, 845.3744229270327, 860.0883063952199, 860.311750599521, 861.8793368928355, 897.1297841094129, 900.2797761790541, 900.6712549919265, 900.918917297443, 901.4681338010572, 860.7030574451804, 861.7630151708299, 862.3532350736916, 874.9212570868652, 899.694104004635, 661.9669016549153, 663.3996233408773, 663.449337050252, 663.8108139180358, 665.2981104934292, 14756.262186890719, 14866.331015104346, 15004.474843380429, 15037.323320450607, 15041.097534147986, 13753.243571603558, 13891.930540347335, 13989.790153147711, 14006.71986560263, 14028.43886244549, 9452.43285402878, 11443.683976342743, 11504.76990460186, 11550.826737598858, 11924.761504769856, 3589.6410358964154, 3600.5499312585926, 3629.8548058077645, 3632.600413954463, 3763.209725957552, 110988.4450577742, 112821.99999999919, 113805.43097284461, 114276.0, 114805.0, 10583.470826458646, 10599.364038157735, 10658.893411065945, 10997.0, 11111.55553777856, 21847.907604619704, 21859.67210491812, 22331.888340558195, 22337.77662223357, 22404.103835846385, 7443.330100291, 7460.440466964999, 7513.4740568159705, 7536.886946695804, 7690.077190737147, 3985.501812273466, 4091.734037287567, 4095.7133000689664, 4096.938545921814, 4125.938110928339, 3552.946705799415, 3646.9635303647156, 3651.908702282464, 3659.396199627085, 3664.340418724655, 600.570592026703, 649.4998850884792, 660.7092879133166, 664.1631544254275, 669.464428457242, 630.3192552043781, 665.5524234789314, 666.9833254168587, 702.1433850702135, 720.2113685514354, 7928.603569821601, 8695.652173913099, 9077.68228112013, 9873.407595544146, 10164.949175254076, 648.4747354642755, 672.7645324136611, 680.938715515606, 689.2418339826152, 711.8825393810067, 4774.785134668949, 4781.842111798199, 4873.074115917964, 4888.074484944575, 4936.3829521309835, 89503.55248223717, 90932.0, 91462.0, 91653.5417322909, 93315.0, 50870.23694644583, 62791.6860415695, 83217.0, 83503.0, 87261.25477490542, 56729.86540269254, 62671.4332141691, 67048.6647566759, 70260.29739702538, 76185.8097804626, 6393.6163830170335, 9050.637974480947, 9166.908330916873, 10392.0, 10675.51960161779, 42937.57062429336, 45972.540274596824, 47317.867887377, 47864.7606761964, 49982.50017499924, 51683.0, 65280.0, 65335.0, 66246.0, 67489.31276718121, 10662.306950048222, 10860.565577376816, 11289.98390144891, 11444.599439019594, 11526.308421494738, 11936.10479214045, 11942.164048516868, 11973.461194246454, 12006.339651319262, 12009.819852702041, 11631.825522616999, 11730.296182229093, 11750.0, 11775.0, 11940.820887686865, 11728.0, 11802.76394472123, 11969.042476602026, 12175.086868484723, 12218.722989956257, 11266.436678166223, 11494.54021839117, 11594.01450876685, 11982.520699171935, 12093.818592721293, 8744.825103498022, 9629.855552166582, 9647.758806029624, 9719.187989425795, 10140.29017968735, 6781.42357899584, 8645.221930026328, 9213.539323033956, 9301.72094837156, 9328.113829186217], "value": 7090.139135683783, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 111.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 111.0, 161.0, 145.0, 145.0, 117.0, 113.0, 130.0, 114.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 185.0, 183.0, 185.0, 181.0, 181.0, 185.0, 183.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 63.0, 62.0, 87.0, 60.0, 60.0, 60.0, 59.0, 77.0, 58.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 87.0, 69.0, 70.0, 67.0, 85.0, 69.0, 69.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 106.0, 134.0, 93.0, 89.0, 88.0, 89.0, 89.0, 88.0, 89.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 91.0, 110.0, 153.0, 152.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 85.0, 85.0, 87.0, 87.0, 84.0, 87.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 58.0, 58.0, 58.0, 59.0, 60.0, 74.0, 67.0, 91.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 68.0, 66.0, 75.0, 74.0, 69.0, 69.0, 69.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 89.0, 88.0, 89.0, 90.0, 89.0, 91.0, 96.0, 110.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 154.0, 141.0, 153.0, 157.0, 134.0, 149.0, 207.0, 189.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 189.0, 239.0, 191.0, 169.0, 172.0, 173.0, 174.0, 173.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 76.0, 89.0, 88.0, 88.0, 71.0, 67.0, 64.0, 66.0], "value": 75.0, "unit": "score"}]}]} 04:48:49 INFO - Return code: 0 04:48:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:48:49 ERROR - # TBPL SUCCESS # 04:48:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:48:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:48:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:48:49 INFO - 2017-02-09 04:48:49.712 screenresolution[1664:9888] starting screenresolution argv=screenresolution get 04:48:49 INFO - 2017-02-09 04:48:49.715 screenresolution[1664:9888] Display 0: 1600x1200x32@60 04:48:49 INFO - 2017-02-09 04:48:49.722 screenresolution[1665:9891] starting screenresolution argv=screenresolution list 04:48:49 INFO - Available Modes on Display 0 04:48:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:48:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:48:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:48:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:48:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:48:49 INFO - Intel Iris: 04:48:49 INFO - Chipset Model: Intel Iris 04:48:49 INFO - Type: GPU 04:48:49 INFO - Bus: Built-In 04:48:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:48:49 INFO - Vendor: Intel (0x8086) 04:48:49 INFO - Device ID: 0x0a2e 04:48:49 INFO - Revision ID: 0x0009 04:48:49 INFO - Displays: 04:48:49 INFO - Display: 04:48:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:48:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:48:49 INFO - Display Serial Number: 1600x1200 60 04:48:49 INFO - Main Display: Yes 04:48:49 INFO - Mirror: Off 04:48:49 INFO - Online: Yes 04:48:49 INFO - Rotation: Supported 04:48:49 INFO - Return code: 0 04:48:49 INFO - Running post-action listener: _resource_record_post_action 04:48:49 INFO - [mozharness: 2017-02-09 12:48:49.963684Z] Finished run-tests step (success) 04:48:49 INFO - Running post-run listener: _resource_record_post_run 04:48:50 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37876736; Write bytes: 551959552; Read time: 243; Write time: 1649 04:48:50 INFO - TinderboxPrint: CPU usage
53.6% 04:48:50 INFO - TinderboxPrint: I/O read bytes / time
37,876,736 / 243 04:48:50 INFO - TinderboxPrint: I/O write bytes / time
551,959,552 / 1,649 04:48:50 INFO - TinderboxPrint: CPU idle
2,229.3 (46.4%) 04:48:50 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 04:48:50 INFO - TinderboxPrint: CPU user
1,620.7 (33.7%) 04:48:50 INFO - TinderboxPrint: Swap in / out
289,366,016 / 0 04:48:50 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250776064; Write bytes: 243064832; Read time: 18131; Write time: 502 04:48:50 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35804160; Write bytes: 297589760; Read time: 224; Write time: 1109 04:48:50 INFO - Running post-run listener: _upload_blobber_files 04:48:50 INFO - Blob upload gear active. 04:48:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:48:50 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 04:48:50 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'] 04:48:50 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 04:48:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:48:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:48:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:52 INFO - (blobuploader) - INFO - Done attempting. 04:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:53 INFO - (blobuploader) - INFO - Done attempting. 04:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:54 INFO - (blobuploader) - INFO - Done attempting. 04:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:57 INFO - (blobuploader) - INFO - Done attempting. 04:48:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:57 INFO - Return code: 0 04:48:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28fbca772522f6519235360794270b8efbf761c3778f02c46b772cafaf4f6f90d7d84e2a0bcf3a25f45d524140c305c13b3d2b878e131cdf180df2deb8c69c38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdb65064bcb57333f738db9211270038a0586a6b306e78bf2f80d828032e365a182e0fe84f76319e46d16fad1747c6dbd360529f28565e1c58feb5e564fbe3ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84c90f962d3f2e7eb72b66c4aaa633b716438fb2805d50d9704bcceedc59597d42e3c7c18642e353dbf15916c3113b1e168d901af51bbad67932ba3422ea1761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1681b1b9103df5b20f7686e83ab9187c20264414ca7fb7f1ca4d0a408131a935502edfce93700222e7d816b3118cd8c306f43f76ba9a8d383579ce04e9d79e4"} 04:48:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:57 INFO - Contents: 04:48:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28fbca772522f6519235360794270b8efbf761c3778f02c46b772cafaf4f6f90d7d84e2a0bcf3a25f45d524140c305c13b3d2b878e131cdf180df2deb8c69c38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdb65064bcb57333f738db9211270038a0586a6b306e78bf2f80d828032e365a182e0fe84f76319e46d16fad1747c6dbd360529f28565e1c58feb5e564fbe3ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84c90f962d3f2e7eb72b66c4aaa633b716438fb2805d50d9704bcceedc59597d42e3c7c18642e353dbf15916c3113b1e168d901af51bbad67932ba3422ea1761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1681b1b9103df5b20f7686e83ab9187c20264414ca7fb7f1ca4d0a408131a935502edfce93700222e7d816b3118cd8c306f43f76ba9a8d383579ce04e9d79e4"} 04:48:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:57 INFO - Copying logs to upload dir... 04:48:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.255196 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-02-09 04:48:57.861530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:48:57.865389) ========= 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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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/28fbca772522f6519235360794270b8efbf761c3778f02c46b772cafaf4f6f90d7d84e2a0bcf3a25f45d524140c305c13b3d2b878e131cdf180df2deb8c69c38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdb65064bcb57333f738db9211270038a0586a6b306e78bf2f80d828032e365a182e0fe84f76319e46d16fad1747c6dbd360529f28565e1c58feb5e564fbe3ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84c90f962d3f2e7eb72b66c4aaa633b716438fb2805d50d9704bcceedc59597d42e3c7c18642e353dbf15916c3113b1e168d901af51bbad67932ba3422ea1761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1681b1b9103df5b20f7686e83ab9187c20264414ca7fb7f1ca4d0a408131a935502edfce93700222e7d816b3118cd8c306f43f76ba9a8d383579ce04e9d79e4"} build_url:https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010899 build_url: 'https://queue.taskcluster.net/v1/task/DaDNVud2SSWuqkyX4aZNPw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28fbca772522f6519235360794270b8efbf761c3778f02c46b772cafaf4f6f90d7d84e2a0bcf3a25f45d524140c305c13b3d2b878e131cdf180df2deb8c69c38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdb65064bcb57333f738db9211270038a0586a6b306e78bf2f80d828032e365a182e0fe84f76319e46d16fad1747c6dbd360529f28565e1c58feb5e564fbe3ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84c90f962d3f2e7eb72b66c4aaa633b716438fb2805d50d9704bcceedc59597d42e3c7c18642e353dbf15916c3113b1e168d901af51bbad67932ba3422ea1761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1681b1b9103df5b20f7686e83ab9187c20264414ca7fb7f1ca4d0a408131a935502edfce93700222e7d816b3118cd8c306f43f76ba9a8d383579ce04e9d79e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:48:57.899050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:48:57.899377) ========= 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.JHBe4Wk7Jd/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.Df1Djgudcd/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.005197 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:48:57.947594) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:48:57.947903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:48:57.948210) ========= ========= Total master_lag: 0.18 =========