builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0064 starttime: 1487100903.17 results: success (0) buildid: 20170214100844 builduid: e3549893b78a49399bcd013eb063cb9e revision: 273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.166068) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.166562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.166869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.192278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.192744) ========= 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.wvf3MaufSl/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.AS00e8ZIOm/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-14 11:35:03-- 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% 145M=0s 2017-02-14 11:35:03 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.355340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.355674) ========= 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.wvf3MaufSl/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.AS00e8ZIOm/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.019999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:03.404938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-14 11:35:03.405280) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wvf3MaufSl/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.AS00e8ZIOm/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-14 11:35:03,408 truncating revision to first 12 chars 2017-02-14 11:35:03,408 Setting DEBUG logging. 2017-02-14 11:35:03,409 attempt 1/10 2017-02-14 11:35:03,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/273f9d9d0feb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 11:35:04,863 unpacking tar archive at: mozilla-aurora-273f9d9d0feb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.693707 ========= master_lag: 1.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-14 11:35:06.175856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:06.176179) ========= script_repo_revision: 273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 11:35:06.176567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-02-14 11:35:06.176890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-02-14 11:35:08.920066) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-02-14 11:35:08.920385) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wvf3MaufSl/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.AS00e8ZIOm/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:09 INFO - MultiFileLogger online at 20170214 11:35:09 in /builds/slave/test 11:35:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:35:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:09 INFO - {'append_to_log': False, 11:35:09 INFO - 'base_work_dir': '/builds/slave/test', 11:35:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:35:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:09 INFO - 'branch': 'Mozilla-Aurora', 11:35:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:09 INFO - 'config_files': ('talos/mac_config.py',), 11:35:09 INFO - 'default_actions': ('clobber', 11:35:09 INFO - 'read-buildbot-config', 11:35:09 INFO - 'download-and-extract', 11:35:09 INFO - 'populate-webroot', 11:35:09 INFO - 'create-virtualenv', 11:35:09 INFO - 'install', 11:35:09 INFO - 'run-tests'), 11:35:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:09 INFO - 'download_minidump_stackwalk': True, 11:35:09 INFO - 'download_symbols': 'ondemand', 11:35:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:35:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:35:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:35:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:35:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:09 INFO - 'installer_path': 'installer.exe', 11:35:09 INFO - 'log_level': 'info', 11:35:09 INFO - 'log_name': 'talos', 11:35:09 INFO - 'log_to_console': True, 11:35:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:35:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:35:09 INFO - 'opt_config_files': (), 11:35:09 INFO - 'pip_index': False, 11:35:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:35:09 INFO - 'cmd': ('bash', 11:35:09 INFO - '-c', 11:35:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:35:09 INFO - 'enabled': True, 11:35:09 INFO - 'halt_on_failure': False, 11:35:09 INFO - 'name': 'check_screen_resolution'},), 11:35:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:35:09 INFO - 'cmd': ('bash', 11:35:09 INFO - '-c', 11:35:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:35:09 INFO - 'enabled': True, 11:35:09 INFO - 'halt_on_failure': False, 11:35:09 INFO - 'name': 'check_screen_resolution'},), 11:35:09 INFO - 'run_cmd_checks_enabled': True, 11:35:09 INFO - 'sps_profile': False, 11:35:09 INFO - 'sps_profile_interval': 0, 11:35:09 INFO - 'suite': 'dromaeojs', 11:35:09 INFO - 'system_bits': '32', 11:35:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:09 INFO - 'title': 't-yosemite-r7-0064', 11:35:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:09 INFO - 'use_talos_json': True, 11:35:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:09 INFO - 'work_dir': 'build'} 11:35:09 INFO - [mozharness: 2017-02-14 19:35:09.036441Z] Running clobber step. 11:35:09 INFO - Running pre-action listener: _resource_record_pre_action 11:35:09 INFO - Running main action method: clobber 11:35:09 INFO - rmtree: /builds/slave/test/build 11:35:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:10 INFO - Running post-action listener: _resource_record_post_action 11:35:10 INFO - [mozharness: 2017-02-14 19:35:10.670734Z] Finished clobber step (success) 11:35:10 INFO - [mozharness: 2017-02-14 19:35:10.670931Z] Running read-buildbot-config step. 11:35:10 INFO - Running pre-action listener: _resource_record_pre_action 11:35:10 INFO - Running main action method: read_buildbot_config 11:35:10 INFO - Using buildbot properties: 11:35:10 INFO - { 11:35:10 INFO - "project": "", 11:35:10 INFO - "product": "firefox", 11:35:10 INFO - "script_repo_revision": "production", 11:35:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:35:10 INFO - "repository": "", 11:35:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:35:10 INFO - "buildid": "20170214100844", 11:35:10 INFO - "pgo_build": "False", 11:35:10 INFO - "basedir": "/builds/slave/test", 11:35:10 INFO - "buildnumber": 2, 11:35:10 INFO - "slavename": "t-yosemite-r7-0064", 11:35:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:35:10 INFO - "platform": "yosemite_r7", 11:35:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:35:10 INFO - "branch": "mozilla-aurora", 11:35:10 INFO - "repo_path": "releases/mozilla-aurora", 11:35:10 INFO - "revision": "273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad", 11:35:10 INFO - "stage_platform": "macosx64", 11:35:10 INFO - "builduid": "e3549893b78a49399bcd013eb063cb9e", 11:35:10 INFO - "slavebuilddir": "test" 11:35:10 INFO - } 11:35:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:35:10 INFO - Running post-action listener: _resource_record_post_action 11:35:10 INFO - [mozharness: 2017-02-14 19:35:10.674277Z] Finished read-buildbot-config step (success) 11:35:10 INFO - [mozharness: 2017-02-14 19:35:10.674400Z] Running download-and-extract step. 11:35:10 INFO - Running pre-action listener: _resource_record_pre_action 11:35:10 INFO - Running main action method: download_and_extract 11:35:10 INFO - mkdir: /builds/slave/test/build/tests 11:35: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')]} 11:35:10 INFO - trying https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:35:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:35:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 11:35:12 INFO - Downloaded 1199 bytes. 11:35:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:35:12 INFO - Using the following test package requirements: 11:35:12 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:35:12 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:35:12 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:35:12 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'jsshell-mac.zip'], 11:35:12 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:35:12 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:35:12 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:35:12 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:35:12 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:35:12 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:35:12 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:35:12 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:35:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:35:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:35:12 INFO - Fetch https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:35:14 INFO - Expected file size: 16358342 11:35:14 INFO - Obtained file size: 16358342 11:35:21 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:35:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:35:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:35:21 INFO - Fetch https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:35:23 INFO - Expected file size: 16358342 11:35:23 INFO - Obtained file size: 16358342 11:35:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:35:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:35:30 INFO - Fetch https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:35:32 INFO - Expected file size: 14403485 11:35:32 INFO - Obtained file size: 14403485 11:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:33 INFO - trying https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 11:35:38 INFO - Downloaded 73950751 bytes. 11:35:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:35:38 INFO - mkdir: /builds/slave/test/properties 11:35:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:35:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:35:38 INFO - Contents: 11:35:38 INFO - build_url:https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:35:39 INFO - Running post-action listener: _resource_record_post_action 11:35:39 INFO - Running post-action listener: set_extra_try_arguments 11:35:39 INFO - [mozharness: 2017-02-14 19:35:39.912760Z] Finished download-and-extract step (success) 11:35:39 INFO - [mozharness: 2017-02-14 19:35:39.912864Z] Running populate-webroot step. 11:35:39 INFO - Running pre-action listener: _resource_record_pre_action 11:35:39 INFO - Running main action method: populate_webroot 11:35:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:35:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:35:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:35:39 INFO - '--tppagecycles', 11:35:39 INFO - '7'], 11:35:39 INFO - 'tests': ['tsvgm']}}, 11:35:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:35:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:35:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:35:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:35:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['damp', 'tps']}, 11:35:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'tests': ['damp', 'tps']}, 11:35:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['dromaeo_dom']}, 11:35:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:35:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['basic_compositor_video']}, 11:35:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:35:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['a11yr', 11:35:39 INFO - 'ts_paint', 11:35:39 INFO - 'tpaint', 11:35:39 INFO - 'sessionrestore', 11:35:39 INFO - 'sessionrestore_no_auto_restore', 11:35:39 INFO - 'tabpaint']}, 11:35:39 INFO - 'other-e10s': {'tests': ['a11yr', 11:35:39 INFO - 'ts_paint', 11:35:39 INFO - 'tpaint', 11:35:39 INFO - 'sessionrestore', 11:35:39 INFO - 'sessionrestore_no_auto_restore', 11:35:39 INFO - 'tabpaint']}, 11:35:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:35:39 INFO - 'ts_paint', 11:35:39 INFO - 'tpaint', 11:35:39 INFO - 'sessionrestore', 11:35:39 INFO - 'sessionrestore_no_auto_restore', 11:35:39 INFO - 'tabpaint']}, 11:35:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:35:39 INFO - 'ts_paint', 11:35:39 INFO - 'tpaint', 11:35:39 INFO - 'sessionrestore', 11:35:39 INFO - 'sessionrestore_no_auto_restore', 11:35:39 INFO - 'tabpaint']}, 11:35:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['a11yr', 11:35:39 INFO - 'ts_paint', 11:35:39 INFO - 'tpaint', 11:35:39 INFO - 'sessionrestore', 11:35:39 INFO - 'sessionrestore_no_auto_restore', 11:35:39 INFO - 'tabpaint']}, 11:35:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['a11yr', 11:35:39 INFO - 'ts_paint', 11:35:39 INFO - 'tpaint', 11:35:39 INFO - 'sessionrestore', 11:35:39 INFO - 'sessionrestore_no_auto_restore', 11:35:39 INFO - 'tabpaint']}, 11:35:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['tsvgx', 11:35:39 INFO - 'tsvgr_opacity', 11:35:39 INFO - 'tart', 11:35:39 INFO - 'tscrollx', 11:35:39 INFO - 'cart', 11:35:39 INFO - 'tsvg_static']}, 11:35:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:35:39 INFO - 'tsvgr_opacity', 11:35:39 INFO - 'tart', 11:35:39 INFO - 'tscrollx', 11:35:39 INFO - 'cart', 11:35:39 INFO - 'tsvg_static']}, 11:35:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'talos_options': ['--disable-e10s'], 11:35:39 INFO - 'tests': ['tp5o']}, 11:35:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:35:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'talos_options': ['--disable-e10s', 11:35:39 INFO - '--xperf_path', 11:35:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:39 INFO - 'tests': ['tp5n']}, 11:35:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:35:39 INFO - 'talos_options': ['--xperf_path', 11:35:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:39 INFO - 'tests': ['tp5n']}}, 11:35:39 INFO - 'talos.zip': {'path': '', 11:35:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:35:39 INFO - Running post-action listener: _resource_record_post_action 11:35:39 INFO - [mozharness: 2017-02-14 19:35:39.931296Z] Finished populate-webroot step (success) 11:35:39 INFO - [mozharness: 2017-02-14 19:35:39.931414Z] Running create-virtualenv step. 11:35:39 INFO - Running pre-action listener: _resource_record_pre_action 11:35:39 INFO - Running main action method: create_virtualenv 11:35:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:35:39 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 11:35:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:35:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:35:40 INFO - Using real prefix '/tools/python27' 11:35:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:35:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:35:43 INFO - Installing pip.................done. 11:35:43 INFO - Return code: 0 11:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:35:44 INFO - Reading from file tmpfile_stdout 11:35:44 INFO - Output received: 11:35:44 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) 11:35:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:35:44 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')]} 11:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:44 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')]} 11:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:44 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:44 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 11:35:44 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 11:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:35:44 INFO - 'HOME': '/Users/cltbld', 11:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:35:44 INFO - 'LOGNAME': 'cltbld', 11:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:44 INFO - 'MOZ_NO_REMOTE': '1', 11:35:44 INFO - 'NO_EM_RESTART': '1', 11:35:44 INFO - 'PAGER': '/bin/cat', 11:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:44 INFO - 'PWD': '/builds/slave/test', 11:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:35:44 INFO - 'SHELL': '/bin/bash', 11:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:35:44 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:35:44 INFO - 'USER': 'cltbld', 11:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:44 INFO - 'XPC_FLAGS': '0x0', 11:35:44 INFO - 'XPC_SERVICE_NAME': '0', 11:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:44 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 11:35:44 INFO - Cleaning up... 11:35:44 INFO - Return code: 0 11:35:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:35:44 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')]} 11:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:44 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')]} 11:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:44 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:44 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 11:35:44 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 11:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:35:44 INFO - 'HOME': '/Users/cltbld', 11:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:35:44 INFO - 'LOGNAME': 'cltbld', 11:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:44 INFO - 'MOZ_NO_REMOTE': '1', 11:35:44 INFO - 'NO_EM_RESTART': '1', 11:35:44 INFO - 'PAGER': '/bin/cat', 11:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:44 INFO - 'PWD': '/builds/slave/test', 11:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:35:44 INFO - 'SHELL': '/bin/bash', 11:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:35:44 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:35:44 INFO - 'USER': 'cltbld', 11:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:44 INFO - 'XPC_FLAGS': '0x0', 11:35:44 INFO - 'XPC_SERVICE_NAME': '0', 11:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:44 INFO - Downloading/unpacking psutil>=3.1.1 11:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:35:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:48 INFO - Installing collected packages: psutil 11:35:48 INFO - Running setup.py install for psutil 11:35:48 INFO - building 'psutil._psutil_osx' extension 11:35:48 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 11:35:48 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 11:35:48 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 11:35:48 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 11:35:48 INFO - building 'psutil._psutil_posix' extension 11:35:48 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 11:35:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:35:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:35:48 INFO - ^ 11:35:48 INFO - 1 warning generated. 11:35:48 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 11:35:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:49 INFO - Successfully installed psutil 11:35:49 INFO - Cleaning up... 11:35:49 INFO - Return code: 0 11:35:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:35:49 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')]} 11:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:49 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')]} 11:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:49 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:49 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 11:35:49 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 11:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:35:49 INFO - 'HOME': '/Users/cltbld', 11:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:35:49 INFO - 'LOGNAME': 'cltbld', 11:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:49 INFO - 'MOZ_NO_REMOTE': '1', 11:35:49 INFO - 'NO_EM_RESTART': '1', 11:35:49 INFO - 'PAGER': '/bin/cat', 11:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:49 INFO - 'PWD': '/builds/slave/test', 11:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:35:49 INFO - 'SHELL': '/bin/bash', 11:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:35:49 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:35:49 INFO - 'USER': 'cltbld', 11:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:49 INFO - 'XPC_FLAGS': '0x0', 11:35:49 INFO - 'XPC_SERVICE_NAME': '0', 11:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:35:49 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 11:35:49 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 11:35:49 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 11:35:49 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 11:35:49 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 11:35:49 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 11:35:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:35:52 INFO - Installing collected packages: mozsystemmonitor 11:35:52 INFO - Running setup.py install for mozsystemmonitor 11:35:52 INFO - Successfully installed mozsystemmonitor 11:35:52 INFO - Cleaning up... 11:35:52 INFO - Return code: 0 11:35:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:35: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')]} 11:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35: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')]} 11:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:52 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:52 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 11:35:52 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 11:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:35:52 INFO - 'HOME': '/Users/cltbld', 11:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:35:52 INFO - 'LOGNAME': 'cltbld', 11:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:52 INFO - 'MOZ_NO_REMOTE': '1', 11:35:52 INFO - 'NO_EM_RESTART': '1', 11:35:52 INFO - 'PAGER': '/bin/cat', 11:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:52 INFO - 'PWD': '/builds/slave/test', 11:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:35:52 INFO - 'SHELL': '/bin/bash', 11:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:35:52 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:35:52 INFO - 'USER': 'cltbld', 11:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:52 INFO - 'XPC_FLAGS': '0x0', 11:35:52 INFO - 'XPC_SERVICE_NAME': '0', 11:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:52 INFO - Downloading/unpacking jsonschema==2.5.1 11:35:52 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 11:35:52 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 11:35:52 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 11:35:52 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 11:35:52 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 11:35:52 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 11:35:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:35:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:35:55 INFO - warning: no files found matching '*.txt' 11:35:55 INFO - no previously-included directories found matching 'build' 11:35:55 INFO - no previously-included directories found matching 'dist' 11:35:55 INFO - no previously-included directories found matching '.git*' 11:35:55 INFO - Installing collected packages: jsonschema, functools32 11:35:55 INFO - Running setup.py install for functools32 11:35:55 INFO - warning: no files found matching '*.txt' 11:35:55 INFO - no previously-included directories found matching 'build' 11:35:55 INFO - no previously-included directories found matching 'dist' 11:35:55 INFO - no previously-included directories found matching '.git*' 11:35:55 INFO - Successfully installed jsonschema functools32 11:35:55 INFO - Cleaning up... 11:35:55 INFO - Return code: 0 11:35:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:35:55 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')]} 11:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:55 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')]} 11:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:55 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:55 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 11:35:55 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 11:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:35:55 INFO - 'HOME': '/Users/cltbld', 11:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:35:55 INFO - 'LOGNAME': 'cltbld', 11:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:55 INFO - 'MOZ_NO_REMOTE': '1', 11:35:55 INFO - 'NO_EM_RESTART': '1', 11:35:55 INFO - 'PAGER': '/bin/cat', 11:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:55 INFO - 'PWD': '/builds/slave/test', 11:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:35:55 INFO - 'SHELL': '/bin/bash', 11:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:35:55 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:35:55 INFO - 'USER': 'cltbld', 11:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:55 INFO - 'XPC_FLAGS': '0x0', 11:35:55 INFO - 'XPC_SERVICE_NAME': '0', 11:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:35:56 INFO - Cleaning up... 11:35:56 INFO - Return code: 0 11:35:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:35:56 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')]} 11:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:56 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')]} 11:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:35:56 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:35:56 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 11:35:56 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 11:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:35:56 INFO - 'HOME': '/Users/cltbld', 11:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:35:56 INFO - 'LOGNAME': 'cltbld', 11:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:56 INFO - 'MOZ_NO_REMOTE': '1', 11:35:56 INFO - 'NO_EM_RESTART': '1', 11:35:56 INFO - 'PAGER': '/bin/cat', 11:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:56 INFO - 'PWD': '/builds/slave/test', 11:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:35:56 INFO - 'SHELL': '/bin/bash', 11:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:35:56 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:35:56 INFO - 'USER': 'cltbld', 11:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:56 INFO - 'XPC_FLAGS': '0x0', 11:35:56 INFO - 'XPC_SERVICE_NAME': '0', 11:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:35:56 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 11:35:56 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 11:35:56 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 11:35:56 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 11:35:56 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 11:35:56 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 11:35:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:35:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:35:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 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 11:35:59 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 11:36:00 INFO - Downloading docopt-0.6.1.tar.gz 11:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:00 INFO - Running setup.py install for blobuploader 11:36:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:00 INFO - Running setup.py install for requests 11:36:01 INFO - Running setup.py install for docopt 11:36:01 INFO - Successfully installed blobuploader requests docopt 11:36:01 INFO - Cleaning up... 11:36:01 INFO - Return code: 0 11:36:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:01 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')]} 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:01 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')]} 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:02 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:36:02 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 11:36:02 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 11:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:02 INFO - 'HOME': '/Users/cltbld', 11:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:02 INFO - 'LOGNAME': 'cltbld', 11:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:02 INFO - 'MOZ_NO_REMOTE': '1', 11:36:02 INFO - 'NO_EM_RESTART': '1', 11:36:02 INFO - 'PAGER': '/bin/cat', 11:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:02 INFO - 'PWD': '/builds/slave/test', 11:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:02 INFO - 'SHELL': '/bin/bash', 11:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:36:02 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:02 INFO - 'USER': 'cltbld', 11:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:02 INFO - 'XPC_FLAGS': '0x0', 11:36:02 INFO - 'XPC_SERVICE_NAME': '0', 11:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-m4LfcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-O828D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-VTJIJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-bGlqvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-cpVPrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:02 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-N7avL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Ehn1sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-GTvFOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-RP35BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-0cZtq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-yTObti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Y02NeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ofstp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-9z_cYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:03 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-FXwaT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:04 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-yqEcuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:04 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-yxNt2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:04 INFO - Running setup.py install for manifestparser 11:36:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozcrash 11:36:04 INFO - Running setup.py install for mozdebug 11:36:04 INFO - Running setup.py install for mozdevice 11:36:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozfile 11:36:04 INFO - Running setup.py install for mozhttpd 11:36:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozinfo 11:36:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozInstall 11:36:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozleak 11:36:05 INFO - Running setup.py install for mozlog 11:36:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for moznetwork 11:36:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozprocess 11:36:06 INFO - Running setup.py install for mozprofile 11:36:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:06 INFO - Running setup.py install for mozrunner 11:36:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:06 INFO - Running setup.py install for mozscreenshot 11:36:06 INFO - Running setup.py install for moztest 11:36:06 INFO - Running setup.py install for mozversion 11:36:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:06 INFO - Cleaning up... 11:36:06 INFO - Return code: 0 11:36:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:06 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')]} 11:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:06 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')]} 11:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:07 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:36:07 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 11:36:07 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 11:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:07 INFO - 'HOME': '/Users/cltbld', 11:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:07 INFO - 'LOGNAME': 'cltbld', 11:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:07 INFO - 'MOZ_NO_REMOTE': '1', 11:36:07 INFO - 'NO_EM_RESTART': '1', 11:36:07 INFO - 'PAGER': '/bin/cat', 11:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:07 INFO - 'PWD': '/builds/slave/test', 11:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:07 INFO - 'SHELL': '/bin/bash', 11:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:36:07 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:07 INFO - 'USER': 'cltbld', 11:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:07 INFO - 'XPC_FLAGS': '0x0', 11:36:07 INFO - 'XPC_SERVICE_NAME': '0', 11:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-qN5OQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:07 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)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-gRaJlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:07 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)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-8Zsq8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:07 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)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-tutrlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:07 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)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-oujoYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-RIB3D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-6kA91u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-7g_fYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ioiNGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-rP46mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-7q4XvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-cV2DXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-RhHVTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-TsYasT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:08 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)) 11:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-nFL813-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:09 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)) 11:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:09 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-rEOnea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:09 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)) 11:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:09 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-saAgeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:09 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)) 11:36:09 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)) 11:36:09 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)) 11:36:09 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)) 11:36:09 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)) 11:36:09 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)) 11:36:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:09 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 11:36:09 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 11:36:09 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 11:36:09 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 11:36:09 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 11:36:09 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 11:36:12 INFO - Downloading blessings-1.6.tar.gz 11:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:12 INFO - Installing collected packages: blessings 11:36:12 INFO - Running setup.py install for blessings 11:36:12 INFO - Successfully installed blessings 11:36:12 INFO - Cleaning up... 11:36:12 INFO - Return code: 0 11:36:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:12 INFO - Reading from file tmpfile_stdout 11:36:12 INFO - Current package versions: 11:36:12 INFO - blessings == 1.6 11:36:12 INFO - blobuploader == 1.2.4 11:36:12 INFO - docopt == 0.6.1 11:36:12 INFO - functools32 == 3.2.3-2 11:36:12 INFO - jsonschema == 2.5.1 11:36:12 INFO - manifestparser == 1.1 11:36:12 INFO - mozInstall == 1.12 11:36:12 INFO - mozcrash == 1.0 11:36:12 INFO - mozdebug == 0.1 11:36:12 INFO - mozdevice == 0.49 11:36:12 INFO - mozfile == 1.2 11:36:12 INFO - mozhttpd == 0.7 11:36:12 INFO - mozinfo == 0.9 11:36:12 INFO - mozleak == 0.1 11:36:12 INFO - mozlog == 3.4 11:36:12 INFO - moznetwork == 0.27 11:36:12 INFO - mozprocess == 0.24 11:36:12 INFO - mozprofile == 0.28 11:36:12 INFO - mozrunner == 6.13 11:36:12 INFO - mozscreenshot == 0.1 11:36:12 INFO - mozsystemmonitor == 0.3 11:36:12 INFO - moztest == 0.8 11:36:12 INFO - mozversion == 1.4 11:36:12 INFO - psutil == 3.1.1 11:36:12 INFO - requests == 1.2.3 11:36:12 INFO - wsgiref == 0.1.2 11:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:12 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 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:36:12 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 11:36:12 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 11:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:12 INFO - 'HOME': '/Users/cltbld', 11:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:12 INFO - 'LOGNAME': 'cltbld', 11:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:12 INFO - 'MOZ_NO_REMOTE': '1', 11:36:12 INFO - 'NO_EM_RESTART': '1', 11:36:12 INFO - 'PAGER': '/bin/cat', 11:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:12 INFO - 'PWD': '/builds/slave/test', 11:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:12 INFO - 'SHELL': '/bin/bash', 11:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:36:12 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:12 INFO - 'USER': 'cltbld', 11:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:12 INFO - 'XPC_FLAGS': '0x0', 11:36:12 INFO - 'XPC_SERVICE_NAME': '0', 11:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 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)) 11:36:13 INFO - Cleaning up... 11:36:13 INFO - Return code: 0 11:36:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe19b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b114a91e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, '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.wvf3MaufSl/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.AS00e8ZIOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 11:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:13 INFO - 'HOME': '/Users/cltbld', 11:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:13 INFO - 'LOGNAME': 'cltbld', 11:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:13 INFO - 'MOZ_NO_REMOTE': '1', 11:36:13 INFO - 'NO_EM_RESTART': '1', 11:36:13 INFO - 'PAGER': '/bin/cat', 11:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:13 INFO - 'PWD': '/builds/slave/test', 11:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:13 INFO - 'SHELL': '/bin/bash', 11:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:36:13 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:13 INFO - 'USER': 'cltbld', 11:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:13 INFO - 'XPC_FLAGS': '0x0', 11:36:13 INFO - 'XPC_SERVICE_NAME': '0', 11:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:13 INFO - Cleaning up... 11:36:13 INFO - Return code: 0 11:36:13 INFO - Running post-action listener: _resource_record_post_action 11:36:13 INFO - Running post-action listener: _start_resource_monitoring 11:36:13 INFO - Starting resource monitoring. 11:36:13 INFO - [mozharness: 2017-02-14 19:36:13.514412Z] Finished create-virtualenv step (success) 11:36:13 INFO - [mozharness: 2017-02-14 19:36:13.515333Z] Running install step. 11:36:13 INFO - Running pre-action listener: _resource_record_pre_action 11:36:13 INFO - Running main action method: install 11:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:13 INFO - Reading from file tmpfile_stdout 11:36:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:13 INFO - Reading from file tmpfile_stdout 11:36:13 INFO - Output received: 11:36:13 INFO - Usage: mozinstall [options] installer 11:36:13 INFO - Options: 11:36:13 INFO - -h, --help show this help message and exit 11:36:13 INFO - -d DEST, --destination=DEST 11:36:13 INFO - Directory to install application into. [default: 11:36:13 INFO - "/builds/slave/test"] 11:36:13 INFO - --app=APP Application being installed. [default: firefox] 11:36:13 INFO - mkdir: /builds/slave/test/build/application 11:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:36:33 INFO - Reading from file tmpfile_stdout 11:36:33 INFO - Output received: 11:36:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:36:33 INFO - Running post-action listener: _resource_record_post_action 11:36:33 INFO - [mozharness: 2017-02-14 19:36:33.974695Z] Finished install step (success) 11:36:33 INFO - [mozharness: 2017-02-14 19:36:33.974853Z] Running run-tests step. 11:36:33 INFO - Running pre-action listener: _resource_record_pre_action 11:36:33 INFO - Running main action method: run_tests 11:36:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:36:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:36:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:36:33 INFO - 2017-02-14 11:36:33.989 screenresolution[1898:20225] starting screenresolution argv=screenresolution get 11:36:33 INFO - 2017-02-14 11:36:33.992 screenresolution[1898:20225] Display 0: 1600x1200x32@60 11:36:33 INFO - 2017-02-14 11:36:33.997 screenresolution[1899:20227] starting screenresolution argv=screenresolution list 11:36:34 INFO - Available Modes on Display 0 11:36:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:36:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:36:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:36:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:36:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:36:34 INFO - Intel Iris: 11:36:34 INFO - Chipset Model: Intel Iris 11:36:34 INFO - Type: GPU 11:36:34 INFO - Bus: Built-In 11:36:34 INFO - VRAM (Dynamic, Max): 1536 MB 11:36:34 INFO - Vendor: Intel (0x8086) 11:36:34 INFO - Device ID: 0x0a2e 11:36:34 INFO - Revision ID: 0x0009 11:36:34 INFO - Displays: 11:36:34 INFO - Display: 11:36:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:36:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:36:34 INFO - Display Serial Number: 1600x1200 60 11:36:34 INFO - Main Display: Yes 11:36:34 INFO - Mirror: Off 11:36:34 INFO - Online: Yes 11:36:34 INFO - Rotation: Supported 11:36:34 INFO - Return code: 0 11:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:36:34 INFO - Python 2.7.3 11:36:34 INFO - Return code: 0 11:36:34 INFO - grabbing minidump binary from tooltool 11:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:34 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 0x10fbf7d30>, '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 0x10fb1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbecbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:36:34 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 11:36:34 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 11:36:34 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 11:36:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:36:34 INFO - Return code: 0 11:36:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:36:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:36:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:36:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:36:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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 11:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0064 --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 11:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wvf3MaufSl/Render', 11:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:34 INFO - 'HOME': '/Users/cltbld', 11:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:34 INFO - 'LOGNAME': 'cltbld', 11:36:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:34 INFO - 'MOZ_NO_REMOTE': '1', 11:36:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:34 INFO - 'NO_EM_RESTART': '1', 11:36:34 INFO - 'PAGER': '/bin/cat', 11:36:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:34 INFO - 'PWD': '/builds/slave/test', 11:36:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:34 INFO - 'SHELL': '/bin/bash', 11:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AS00e8ZIOm/Listeners', 11:36:34 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 11:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:34 INFO - 'USER': 'cltbld', 11:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:34 INFO - 'XPC_FLAGS': '0x0', 11:36:34 INFO - 'XPC_SERVICE_NAME': '0', 11:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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 11:36:34 INFO - mozversion application_buildid: 20170214100844 11:36:34 INFO - mozversion application_changeset: 273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad 11:36:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:36:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:34 INFO - mozversion application_name: Firefox 11:36:34 INFO - mozversion application_remotingname: firefox-dev 11:36:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:36:34 INFO - mozversion application_vendor: Mozilla 11:36:34 INFO - mozversion application_version: 53.0a2 11:36:34 INFO - mozversion platform_buildid: 20170214100844 11:36:34 INFO - mozversion platform_changeset: 273f9d9d0feb3ca99c8966e41ec2eb8caefc57ad 11:36:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:36:34 INFO - mozversion platform_version: 53.0a2 11:36:34 INFO - using testdate: 1487100994 11:36:34 INFO - actual date: 1487100994 11:36:34 INFO - starting webserver on 'localhost:57094' 11:36:34 INFO - SUITE-START | Running 2 tests 11:36:34 INFO - TEST-START | dromaeo_css 11:36:34 INFO - operating with platform_type : mac_ 11:36:34 INFO - Initialising browser for dromaeo_css test... 11:36:34 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpBMNsxs/profile http://localhost:57094/getInfo.html) 11:36:36 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 11:36:36 INFO - PROCESS | 1909 | colorDepth:24 11:36:36 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 11:36:36 INFO - PROCESS | 1909 | __metrics 11:36:36 INFO - PROCESS | 1909 | 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" 11:36:36 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:37 INFO - TEST-INFO | 1909: exit 0 11:36:37 INFO - Browser initialized. 11:36:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:36:37 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpBMNsxs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:49 INFO - PROCESS | 1911 | RSS: Main: 213458944 11:36:49 INFO - PROCESS | 1911 | 11:39:54 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:57094/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57094/tests/dromaeo/cssquery-ext.html) 11:39:56 INFO - PROCESS | 1911 | RSS: Main: 353411072 11:39:56 INFO - PROCESS | 1911 | 11:41:39 INFO - PROCESS | 1911 | ************************* 11:41:39 INFO - PROCESS | 1911 | A coding exception was thrown and uncaught in a Task. 11:41:39 INFO - PROCESS | 1911 | 11:41:39 ERROR - PROCESS | 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:41:39 INFO - PROCESS | 1911 | Full stack: 11:41:39 INFO - PROCESS | 1911 | ************************* 11:42:59 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:57094/tests/dromaeo/cssquery-ext.html (next: http://localhost:57094/tests/dromaeo/cssquery-jquery.html) 11:42:59 INFO - PROCESS | 1911 | RSS: Main: 346144768 11:42:59 INFO - PROCESS | 1911 | 11:46:02 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:57094/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57094/tests/dromaeo/cssquery-mootools.html) 11:46:02 INFO - PROCESS | 1911 | RSS: Main: 324546560 11:46:02 INFO - PROCESS | 1911 | 11:49:05 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:57094/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57094/tests/dromaeo/cssquery-prototype.html) 11:49:05 INFO - PROCESS | 1911 | RSS: Main: 317521920 11:49:05 INFO - PROCESS | 1911 | 11:52:09 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:57094/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57094/tests/dromaeo/cssquery-yui.html) 11:52:09 INFO - PROCESS | 1911 | RSS: Main: 309911552 11:52:09 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:57094/tests/dromaeo/cssquery-yui.html (next: http://localhost:57094/tests/dromaeo/cssquery-dojo.html) 11:55:13 INFO - PROCESS | 1911 | RSS: Main: 387350528 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | __start_tp_report 11:55:13 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 11:55:13 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 11:55:13 INFO - PROCESS | 1911 | |i|pagename|runs| 11:55:13 INFO - PROCESS | 1911 | |0;dojo.html;3298.5217143514187;3325.268440942993;3333.1167240681225;3345.9627515470193;3382.813945233013;4965.925511117336;5371.194320851874;5615;5687.146927960808;5692.231548740924;5596.2165296858475;5695.316562012565;5710.05784045633;5744.6840423776675;5766.625169363989;5170.6122040847085;5188.37739471264;5194.896102077956;5204.869878253055;5240.318758561381;5116.104681680709;5143.871403214931;5148.536631703146;5151.5106064923775;5280.287161233242;5221.6083793715625;5251.054810134175;5279.70961597112;5282.022825777243;5295.629305948585;5227.3465816772905;5248.527632513092;5263.026689069591;5289.920651190255;5323.361196656388;4999.875003124915;5121.129408000649;5217.765200565984;5229.08491014071;5229.346331708536;5538.75075621598;5607.074832652607;5642.012647786621;5655.886882262373;5716.828495145152;6177.042558403455;6205.844853878644;6211.254649442096;6213.254409470893;6219.222597175353;6217.191765070557;6269.028300613412;6290;6296.1500197473215;6311.274203466614;5633.690147041911;5636.239107720447;5697.088465845528;5709;5761.827145185651;6284.811455656338;6289.496840252768;6296.622202667854;6324;6324.494040476843;6126.253311924967;6162;6175.96912015437;6177.073438984188;6187.504999600022;6128.509719222451;6199.504039676905;6282.937170628235;6286.151369565142;6300.21247344082;6083.300420451616;6117.4620395853735;6128.686460748404;6182.28903676083;6201.410865967726;6279.905801412982;6283.5287353448675;6290.025046117859;6293.118963345135;6304.905426418607;4937.629677774181;4985;4986.052649996489;4989.650724449326;4991.07665081961;4343.1747967886;4378.277584198571;4388.561143885586;4444.688871778944;4489.079738653568;5727.799527016535;5738.8278351649515;5740.655560666373;5742.626729262668;5751;6183.474404675563;6196.690165491707;6252.531060170505;6257.7184026718905;6315.5894866833505;5812.796552120655;5838.503727183237;5846.444587764156;5853.473187413153;5876.324222714357;5428.185772134132;5469.398366179717;5488.396276409671;5491.2312276281355;5491.807786727445;6192.938070619236;6242.344553821874;6270.184875966278;6282.02628592578;6292.465140463112;6233.2208473940755;6292.370762923671;6307.24313082433;6310.716017779119;6319.146915166578;6315.463185629273;6324.367563243823;6339.5562310637815;6354.872902541831;6548.279689234085;5963.970180149072;6033.78881739137;6099.207103076572;6119.418655227746;6163.907541386793;6252.781152659635;6292.528060395397;6301.495880329471;6305.085762564494;6324.810255692337;6096.055111457731;6098.786542470993;6101.145839582551;6104.931636963603;6110.358412366815;5789.044807606698;5932.79235226765;5950.851228719317;5988.011978023752;6076.088586712029;5823.272090988627;5938.6436813791315;5940.732667029907;5947.643141411356;5960.284765828128;5869.882602348014;6060.575759696955;6065.059915713072;6082.239720034996;6087.817365479043;5758.596898217253;5783.95888740014;5836.037053886062;5853.0635098384055;5855.268091488564 11:55:13 INFO - PROCESS | 1911 | |1;ext.html;433.0926708545598;438.703874884453;484.6219948440217;503.2627201150314;532.3585079978626;30071;32068;40103.99740006501;41916.79041604795;42075.36886946698;42740.78629606848;43068.353974690326;43108.78445607767;43131;43233;9206.355555111146;9442.480663563501;9449.291303152257;9455.149036586707;9459.10138536838;7510.69957201714;8569.614367353484;11126.499307531181;11364.374959377272;11409.37248451335;11290.435478226096;11335.093192544577;11354.375509346983;11372;11391.259568128087;11334.489947952321;11404.087672986225;11424.71438214043;11443.828342574869;11467.082633389351;8335.291500222489;8506.191911768372;10985;11270.985611295022;11283.435828208556;40623.7968810157;41057;41199;41214.79392603048;41253.55612553576;3914.7651140931634;3992.261431635157;4025.074232926414;4032.8185231664647;4171.958280417188;28846.567301490493;28913.132606021853;29020.839166433318;29151.562726558906;29971.100866974026;3101;3190.8245046522434;3356.5133055706788;3358.899233022989;3360.176756694601;476309.618451909;482346;483422;484881.5755921268;486799;52924;63499;63604;64117;64282.35717642857;66650.66674666596;66703.99944000844;66841;67030;67167;16392.75410868814;16629.91905526137;16651.750223746654;16660.833391666172;16661.583460413585;12884.80672789909;12958.157719748186;12967.962562994937;12978.935105324414;12994.870051299366;13063.150895191971;15315.770263446057;15715.21423928799;17304.740428893576;19713.901430492755;7666.769996900102;8424.452410593292;8580.785480362916;8716.825663486694;8793.472391656522;731.4989232375733;849.6006876767909;909.2816674826813;909.3407279722148;909.8180363927241;26603.600945985825;29056.564151537743;29947.251318717208;30136;30668.233294167378;913.8941880324749;937.9343445958854;947.8056998315329;964.8118616869643;1088.6244245735209;14247.430102795772;14261.144331339945;14490.85509144916;14529;14543.563693089225;395078;396035.01982489903;396361;396627;398135;53909.730451347496;54400;54467.18299225515;54531;54599.727001365536;1419.4038503828417;1420.3963315590834;1447.7828325751223;1449.3550370085422;1450.6010847017155;26898.193054208405;27089.59365609478;28021.719782801913;28673.996410125546;28938.85530572418;47375.28937065878;47696.284555731;47696.7615161922;47699.761501192275;47858.76070619625;377439;377810;379653;380930.0953495215;381031;25676;26242;26289.73710262873;38904.2219155621;39243;29291.560626591043;36142.4578631326;51353.48646513637;52993.470065298854;53183.1731053959;36894.44658330181;36937.828703982;40386.19227615373;40940.38589421221;42159.7892010538;40845;41108.79445602753;41705.79147104245;42196;42856.92857678583;38573.80713096529;39256;39287;39468;40153;33195.33609327752;35824.46263306105;36329.63670363368;36700.26599468049;36993.63006369902;26045.348866277738;26087.60868586935;26300.605490917267;26530.469390612467;26988 11:55:13 INFO - PROCESS | 1911 | |2;jquery.html;391.20390006337107;396.231311256163;396.3598787957446;404.35909084101695;424.1220673206462;14013.719725605482;17510.73733893991;20824.687629685566;21568.676469852966;21599.244026459095;21299.68050479244;21410.25064122756;21462.248821291218;21976.670349944765;22193.889030554867;5751.079827227644;6001.429864162919;6046.7883624073165;6055.21282233309;6059.42435468632;5295.417504074549;5360.91958620621;5937.37657545958;5950.494207992326;6035.939640603604;5958.314793798703;5966.522678185756;5970.582059255854;5972.88054238915;5981.910271345933;5623.240862483573;5837.09525023622;5897.439743224387;5902.940970590282;5961.552883533753;5215.739213039333;5217.034848553029;5217.634765566412;5219.895602087975;5246.449122842085;24005.759942400528;25111.62332565013;25408;26298.21105366842;26653;2110.5884352551257;2531.607600821857;2601.0636170978432;2621.685397752282;2837.6027356170152;9289.163975242192;9469.905300946972;9509.049095090504;9943.701688949342;9992.700218993368;1513.3265696764945;1789.3021721528614;1801.1984666823269;1803.846673032794;1808.2766893242676;131543;134720;135518.3224083883;137593;139896;10014.599416023424;10569.260151789455;10593.576256949636;10691.83962240567;10709.733531273036;12815.679608009874;12907.419166137546;12941.54704585335;13888.4444622216;14462.132272063709;8089.716859909992;8379.413441059067;8506.532140732195;8809.295256379473;8972.596233169523;7559.979402780555;8340.332773378115;8599.269062129664;8627.784305392415;8779.385443019055;4495.9325610115875;4517.260854571014;4563.133004729158;4568.132054909623;4824.758762061953;1988.4631149589818;2009.5177157482099;2025.888576128327;2026.2502873936444;2027.0878104852875;965.9468729219819;966.9033096690275;1003.4581326083979;1003.5032658833778;1020.6325722739808;21540;21887.343379698636;21934.45163870884;21942.670859937112;21962.45093872666;1018.3940555369543;1032.1536340200962;1036.43514284715;1046.7016900183564;1061.0609610494614;10482.842757358645;11341.206115571831;11398.031167350868;11470.254433461965;11544.134189935789;735720;764002;768391;782533;783090;112438;152500;155206;156248;156783;968.2350942755286;971.3297824501071;983.9311248212556;987.7036888933435;989.3618615992644;18161.36435224761;18961.810381896004;19339.033048347246;19346.806531935064;19382.2247110114;59345;59567.808643826014;60390.69804650949;60552.39447605467;61536;73126.90309645465;78918.6054069726;82120.17879821126;87329.12670873464;90135.54932225296;6559.672016399066;6872.659831332842;7256.310650488195;7960.084590271961;8162.387820913336;7618.504797188165;8860.512671803113;9789.070038346346;12378.566750163702;12394.75210495803;11077.446127693744;11215.775684486427;11532.711682207677;11613.43218665503;11629;10751;10959.671209863716;11144.498497567467;11271.463920618124;11665.59170429031;11344.092472602008;11468.254563453349;11541.422928853355;11730.354830484406;11805.586804462146;7803.882941755992;7923.326517246099;8148.144444833207;8282.337413006824;8442.66229350819;9806.460644664327;11061.115110790957;11233.438328083399;11410.94294528522;11450.541978321107 11:55:13 INFO - PROCESS | 1911 | |3;mootools.html;1350.621825888751;1372.6774208061097;1374.3059754823805;1378.283292687802;1379.124256097378;7992.120866704658;8433.493990360583;8447;8453.61958711858;8466.576671166433;7484.251574842513;7702.268284512977;7716.189800070996;8118.228768267005;8312.127226641207;2275;2319.524497478021;2319.652052192168;2321.8955147018423;2321.9071237150492;2318.6290193569034;2347.8943447544902;2355.587772139869;2360.1857359211044;2360.5042940982416;2009.0657844102489;2084.0413409831494;2244.86530808152;2252.245497758253;2305.7463678995296;1945.9318923837598;2299.356180269519;2312.5490529346785;2321.3616255529696;2321.7446080931086;2226.755056943735;2277.6583512473094;2280.076568989545;2335.2760644200184;2342.437814924423;8277.751667449986;8346.290565301957;8369.288610468118;8380.455270407465;8382.83234335316;4961.751912404366;5128.333316668846;5143.177091665353;5144.485551444863;5159.58723302135;3280.114369120324;3416.2484253464445;3441.82790860456;3494.633063528344;3497.4054410749977;1140.914431417647;1213.8846809553079;1225.6935766058486;1464.4801095611117;1708.8718346123967;10651.25441219115;10664.573417063308;10747.946260268727;10753.838692419542;10758.085562727178;4273.829046838154;4400.669949753717;4492.011757413364;4499.76256529457;4516.1419330327135;8441.535715535705;8476.660933562713;8485.490870547786;8502.532360720095;8546.359023073295;4346.565343465628;5129.256257842667;5131.61512886535;5139.331886854685;5159.974200128975;3770.6606405423645;4214.136102099063;4689.320048592935;4736.763161841963;4773.785179666923;3727.1241258304276;3727.7949712765517;3786.280606684721;3812.218495208476;3814.4278358246484;1134.2910680824484;1146.5528443906883;1149.178337488683;1157.8436911017072;1159.750653609461;780.605794073989;850.2390360627204;893.3567831161554;896.5382827843666;920.5949382271779;5297.311349524537;5456.836294911159;5476.644018138808;5758.021136406821;5782.248307720053;935.8783358163395;948.9240860731124;1004.5479534209635;1005.4771518810178;1022.3354819367322;3438.707709844641;3793.2223894101644;3846.9807650962125;3910.687145028391;3950.4074388841905;9856.950715246521;9877.851832222523;9994.700158995242;10014.298999069995;10058.547365368577;9272.629094836266;9777.804443911224;9777.902220977841;9859.26055545837;9955.502224888727;7627.809304767315;7824.882626760603;7835.3731701464885;7846.450748447553;7855.764327070197;5386.380566234933;5479.972600136974;5518.310211223597;5638.661680299195;5768.2501274834;9135.543222838964;9172.587233574639;9278.304127190622;9332.39339442934;9340.159385655325;8116.188381161836;8919.42023768453;9474.336796424184;9515.238780897373;9539.09378609031;6837.2820853809635;7040.295970402919;7051.858962820817;7135.678894449866;7201.063861697946;7973.481723687942;8042.3968202383885;8065.628843096805;8086.1913808618665;8088.312493438124;6926.965365173343;7041.964790176221;7215.242399547972;7299.744508942162;7307.3058059484265;6922.923123063161;6999.1950925644205;7046.859062818818;7111.751088711871;7118.644067796693;6350;6375.904361434489;6435.549511534147;6466.870662586816;6485.708143133476;4954.578860796729;4974.8756281093265;4978.8755281118265;4979.775910084128;5028.2960385546785;4849.81677696506;4944.406671199479;5047.974760126176;5085.923711144262;5159.071367153948 11:55:13 INFO - PROCESS | 1911 | |4;prototype.html;335.7934870054916;357.23016898583546;363.4281731511215;371.9460678201659;374.6815207073986;4255.936015996001;4483.977580112103;5061.620378471615;5089.770960306791;5102.438731739506;4097.651699605537;4171.958280417202;4724.645651576128;4858.295547145671;5094.949050509494;4007.0984028593625;4008.859689910854;4038.4346191533136;4052.331365324718;4076.490438695163;4008.298547754146;4013.357862741962;4017.698672599552;4027.859024934128;4033.556308806029;3553.9338198540463;3742.3825068863603;3843.6925045996254;4001.659858911996;4019.477467929165;3769.227308401771;3979.9801000994808;3999.860004899829;4009.037830920558;4015.7791321477307;3550.5029295898594;3582.498450216972;3587.5694916610173;3593.0058817356357;3621.5110960020324;4829.758512074382;4958.727270000149;4994.300797888299;5047.066292735855;5071.898562028776;3875.65119139276;3885.30064588374;4607.193741095329;4611.4696809866955;4620.1519392243035;4663.580277774982;5057.48275517347;5146.966948055535;5305.4164041955355;5431.429699881495;3404.6595340466;3961.4052795419047;3977.539540599668;4001.339778936472;4006.579309172553;4745.644076694227;5283.603729720248;5601.579881508903;5618.410066942994;5648.209250704905;3448.706859916935;3871.5354157500715;4031.3751368537924;4041.777702226406;4045.1505183911117;4103.589641035873;4115;4123.237201117743;4131.5455299916985;4133.23535145999;4366.868993930188;4560.612347950461;4597.632189424838;4661.370714953506;4669.813207471731;5007;5446.167992643803;5457.2359869618285;5482;5490.450954904478;1324.4834514539336;1330.900182486298;1335.4457899971403;1336.6992426704107;1340.879320861127;746.3693179263514;866.3199388480012;873.8558137907302;947.5025611553989;948.0803620488116;4407.074514351958;4690.756949408409;4694.694844835143;4724.763761811896;4753.5959443447;4584.33527138563;4819.2530157825595;5146.485351464824;5158.97420512895;5204.34945631796;4526.932096018562;4680.338479839676;4711.7879695413785;4718.646101542398;5029.949700503022;2549.9035414771456;2560.807939404552;2651.2443953473166;2724.1418953029734;2749.625187406297;4658.534146585314;5103.87240318995;5128.358955130609;5397.59806885932;5462.2961633990635;4828.8893554482665;5056.519630635084;5315.867103322448;5548.805791797267;5588.804391846266;5176.689398636094;5622.919519777708;5628.324601047901;5651.773929042874;5674.9853801899735;4446.955530444783;5392.649477783932;5414.35027796667;5460.061678104215;5466.5900057495055;4372.868813935587;5076.796928122982;5329.626926115135;5341.866453338697;5389.461053894579;4396.36252743344;4772.76136193182;5120.334356533627;5603.607747457639;5694.515966142924;3697.594913932796;3700.518932538753;3715.68416684574;3733.290674771785;3754.4368344748505;4366.432363792686;5290.550303224269;5442.809501667422;5443.782248710166;5489.176623506506;4459.197344478025;4876.537658262673;5272.578193744414;5293.550048245942;5302.310699609026;5266.63133580661;5274.683518988873;5291.682499050069;5324.866878327918;5331.280277162688;4200.28595138821;4810.8797280068275;4978.651494395358;5138.584865113391;5206.349206349207;4381.838812714697;4670.883227919329;5066.44269130388;5327.653702509325;5353.732313384237;4274.487061552633;4340.764506279332;5045.468172279492;5264.842054738364;5294.867628309323 11:55:13 INFO - PROCESS | 1911 | |5;yui.html;706.3042902740797;714.7748459235337;762.6148794858595;805.8468890910726;824.550619912148;15113.471028514005;15695.215239238021;15722.764158537631;15766.605834854134;15769.369225230992;14125.43498260071;14134.50529231477;14394.712105757879;14413.207273599948;14458.638534036654;674.7132468700808;694.9270326615708;700.4151533469534;844.0968164064423;851.0638297872322;855.7304449098546;867.0852250875324;868.0841711993844;868.9348298877578;871.1680345270283;933.1321870660283;934.0799312677008;935.1817159985013;935.5322338830584;936.5925822267335;924.5562130177552;927.3276874266103;927.8979312275644;928.5867788833972;933.785229397239;530.0988319856222;544.801147581134;549.3407910507407;550.243415303957;550.6751016900048;13932.93033534826;14462;14503.492377766728;14792.852071479256;14814.333354999051;14151.71696566063;14315.212663303515;14322.85677143236;14337;14396.856031439656;11296.491657875415;11514.94242528782;11607.129465290138;11750.447049473492;11866.703332416759;3553.5257870856594;3639.5996440391536;3697.7781333120097;3710.2764960832646;3759.586445490994;103587.33856976379;104177.47911260395;104452.47773761158;104971.47514262379;105548;10897;11145;11217.719557010976;11237.606683766193;11765;22491.88754056219;22581.661275080885;22804.771952280596;22919.770802292096;22983.310500685006;7650.846983060419;7775.844483110306;7791.454598178073;7939.6030198491;8009.279164875189;4226.366045093199;4304.461942257218;4351.412559304516;4435.024294655171;4448.510663826976;3500.177458297298;3607.4228123500116;3608.4226523756074;3617.9276414472088;3620.149264922741;564.5934926852659;651.26407159909;655.9048937903978;670.3598063849013;672.842710537874;654.607235658601;664.3920812456645;686.2794066230438;694.8957656351588;728.2826415980255;8970.775730606787;9941.850872236922;10084.899151008543;10184.592616295413;10564.471776411148;654.1790053482848;684.6405637040593;692.6709812838861;706.4877963476541;716.8852983522611;4481.932771008373;4964.90070198594;4992;5002.299678045077;5034.924476132787;90177;93681.5315923416;102448.48775756222;104618;108693.45653271841;91386;91859.54070229606;93835;96228;96768;80881.59559202284;82058.17941820505;85101.57449212714;85704.14295856962;85894.14105858862;9341.34610577253;9671;9721.756956075871;9728.270379721691;9744.171745401436;45082;45564.31653525133;46571.53428465672;55680.721596391755;56050.43949560452;59023.704881475314;67271;67688.6615566919;70786;76343.3882066185;12751.076932260052;13227.735445290848;13255.602331930058;13319.200847949154;13664;13984.091034082752;13995.090319129224;14684.926575367055;14836.406543738562;15468.14925179126;12963.15739476931;13285.80071298912;14138.78791818103;14262.714745705236;14404.351804169048;11101.278416902875;13469.191848489121;13799.862001379857;13994.300284985913;14126.152430854181;12218.327991960528;13538.187708737507;13573.728525429238;13787.448502059806;14205.928970355082;10191.439470829175;10350.844737329096;11141.275817071864;11342.149338799789;11911.642650720492;10126.44304563256;10827.187960903122;10834.133269338276;10885.292455990335;10897.618583349546 11:55:13 INFO - PROCESS | 1911 | __end_tp_report 11:55:13 INFO - PROCESS | 1911 | __start_cc_report 11:55:13 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1490 11:55:13 INFO - PROCESS | 1911 | __end_cc_report 11:55:13 INFO - PROCESS | 1911 | __startTimestamp1487102113476__endTimestamp 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | ------- Summary: start ------- 11:55:13 INFO - PROCESS | 1911 | Number of tests: 6 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5736.96 Median:5876.32 stddev:641.94 (10.9%) stddev-sans-first:614.75 11:55:13 INFO - PROCESS | 1911 | Values: 3298.5 3325.3 3333.1 3346.0 3382.8 4965.9 5371.2 5615.0 5687.1 5692.2 5596.2 5695.3 5710.1 5744.7 5766.6 5170.6 5188.4 5194.9 5204.9 5240.3 5116.1 5143.9 5148.5 5151.5 5280.3 5221.6 5251.1 5279.7 5282.0 5295.6 5227.3 5248.5 5263.0 5289.9 5323.4 4999.9 5121.1 5217.8 5229.1 5229.3 5538.8 5607.1 5642.0 5655.9 5716.8 6177.0 6205.8 6211.3 6213.3 6219.2 6217.2 6269.0 6290.0 6296.2 6311.3 5633.7 5636.2 5697.1 5709.0 5761.8 6284.8 6289.5 6296.6 6324.0 6324.5 6126.3 6162.0 6176.0 6177.1 6187.5 6128.5 6199.5 6282.9 6286.2 6300.2 6083.3 6117.5 6128.7 6182.3 6201.4 6279.9 6283.5 6290.0 6293.1 6304.9 4937.6 4985.0 4986.1 4989.7 4991.1 4343.2 4378.3 4388.6 4444.7 4489.1 5727.8 5738.8 5740.7 5742.6 5751.0 6183.5 6196.7 6252.5 6257.7 6315.6 5812.8 5838.5 5846.4 5853.5 5876.3 5428.2 5469.4 5488.4 5491.2 5491.8 6192.9 6242.3 6270.2 6282.0 6292.5 6233.2 6292.4 6307.2 6310.7 6319.1 6315.5 6324.4 6339.6 6354.9 6548.3 5964.0 6033.8 6099.2 6119.4 6163.9 6252.8 6292.5 6301.5 6305.1 6324.8 6096.1 6098.8 6101.1 6104.9 6110.4 5789.0 5932.8 5950.9 5988.0 6076.1 5823.3 5938.6 5940.7 5947.6 5960.3 5869.9 6060.6 6065.1 6082.2 6087.8 5758.6 5784.0 5836.0 5853.1 5855.3 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:57985.46 Median:39271.50 stddev:111566.25 (284.1%) stddev-sans-first:111795.54 11:55:13 INFO - PROCESS | 1911 | Values: 433.1 438.7 484.6 503.3 532.4 30071.0 32068.0 40104.0 41916.8 42075.4 42740.8 43068.4 43108.8 43131.0 43233.0 9206.4 9442.5 9449.3 9455.1 9459.1 7510.7 8569.6 11126.5 11364.4 11409.4 11290.4 11335.1 11354.4 11372.0 11391.3 11334.5 11404.1 11424.7 11443.8 11467.1 8335.3 8506.2 10985.0 11271.0 11283.4 40623.8 41057.0 41199.0 41214.8 41253.6 3914.8 3992.3 4025.1 4032.8 4172.0 28846.6 28913.1 29020.8 29151.6 29971.1 3101.0 3190.8 3356.5 3358.9 3360.2 476309.6 482346.0 483422.0 484881.6 486799.0 52924.0 63499.0 63604.0 64117.0 64282.4 66650.7 66704.0 66841.0 67030.0 67167.0 16392.8 16629.9 16651.8 16660.8 16661.6 12884.8 12958.2 12968.0 12978.9 12994.9 13063.2 15315.8 15715.2 17304.7 19713.9 7666.8 8424.5 8580.8 8716.8 8793.5 731.5 849.6 909.3 909.3 909.8 26603.6 29056.6 29947.3 30136.0 30668.2 913.9 937.9 947.8 964.8 1088.6 14247.4 14261.1 14490.9 14529.0 14543.6 395078.0 396035.0 396361.0 396627.0 398135.0 53909.7 54400.0 54467.2 54531.0 54599.7 1419.4 1420.4 1447.8 1449.4 1450.6 26898.2 27089.6 28021.7 28674.0 28938.9 47375.3 47696.3 47696.8 47699.8 47858.8 377439.0 377810.0 379653.0 380930.1 381031.0 25676.0 26242.0 26289.7 38904.2 39243.0 29291.6 36142.5 51353.5 52993.5 53183.2 36894.4 36937.8 40386.2 40940.4 42159.8 40845.0 41108.8 41705.8 42196.0 42856.9 38573.8 39256.0 39287.0 39468.0 40153.0 33195.3 35824.5 36329.6 36700.3 36993.6 26045.3 26087.6 26300.6 26530.5 26988.0 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:40961.55 Median:14459.95 stddev:127550.63 (882.1%) stddev-sans-first:127872.06 11:55:13 INFO - PROCESS | 1911 | Values: 391.2 396.2 396.4 404.4 424.1 14013.7 17510.7 20824.7 21568.7 21599.2 21299.7 21410.3 21462.2 21976.7 22193.9 5751.1 6001.4 6046.8 6055.2 6059.4 5295.4 5360.9 5937.4 5950.5 6035.9 5958.3 5966.5 5970.6 5972.9 5981.9 5623.2 5837.1 5897.4 5902.9 5961.6 5215.7 5217.0 5217.6 5219.9 5246.4 24005.8 25111.6 25408.0 26298.2 26653.0 2110.6 2531.6 2601.1 2621.7 2837.6 9289.2 9469.9 9509.0 9943.7 9992.7 1513.3 1789.3 1801.2 1803.8 1808.3 131543.0 134720.0 135518.3 137593.0 139896.0 10014.6 10569.3 10593.6 10691.8 10709.7 12815.7 12907.4 12941.5 13888.4 14462.1 8089.7 8379.4 8506.5 8809.3 8972.6 7560.0 8340.3 8599.3 8627.8 8779.4 4495.9 4517.3 4563.1 4568.1 4824.8 1988.5 2009.5 2025.9 2026.3 2027.1 965.9 966.9 1003.5 1003.5 1020.6 21540.0 21887.3 21934.5 21942.7 21962.5 1018.4 1032.2 1036.4 1046.7 1061.1 10482.8 11341.2 11398.0 11470.3 11544.1 735720.0 764002.0 768391.0 782533.0 783090.0 112438.0 152500.0 155206.0 156248.0 156783.0 968.2 971.3 983.9 987.7 989.4 18161.4 18961.8 19339.0 19346.8 19382.2 59345.0 59567.8 60390.7 60552.4 61536.0 73126.9 78918.6 82120.2 87329.1 90135.5 6559.7 6872.7 7256.3 7960.1 8162.4 7618.5 8860.5 9789.1 12378.6 12394.8 11077.4 11215.8 11532.7 11613.4 11629.0 10751.0 10959.7 11144.5 11271.5 11665.6 11344.1 11468.3 11541.4 11730.4 11805.6 7803.9 7923.3 8148.1 8282.3 8442.7 9806.5 11061.1 11233.4 11410.9 11450.5 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5375.48 Median:5143.83 stddev:2914.35 (56.7%) stddev-sans-first:2906.83 11:55:13 INFO - PROCESS | 1911 | Values: 1350.6 1372.7 1374.3 1378.3 1379.1 7992.1 8433.5 8447.0 8453.6 8466.6 7484.3 7702.3 7716.2 8118.2 8312.1 2275.0 2319.5 2319.7 2321.9 2321.9 2318.6 2347.9 2355.6 2360.2 2360.5 2009.1 2084.0 2244.9 2252.2 2305.7 1945.9 2299.4 2312.5 2321.4 2321.7 2226.8 2277.7 2280.1 2335.3 2342.4 8277.8 8346.3 8369.3 8380.5 8382.8 4961.8 5128.3 5143.2 5144.5 5159.6 3280.1 3416.2 3441.8 3494.6 3497.4 1140.9 1213.9 1225.7 1464.5 1708.9 10651.3 10664.6 10747.9 10753.8 10758.1 4273.8 4400.7 4492.0 4499.8 4516.1 8441.5 8476.7 8485.5 8502.5 8546.4 4346.6 5129.3 5131.6 5139.3 5160.0 3770.7 4214.1 4689.3 4736.8 4773.8 3727.1 3727.8 3786.3 3812.2 3814.4 1134.3 1146.6 1149.2 1157.8 1159.8 780.6 850.2 893.4 896.5 920.6 5297.3 5456.8 5476.6 5758.0 5782.2 935.9 948.9 1004.5 1005.5 1022.3 3438.7 3793.2 3847.0 3910.7 3950.4 9857.0 9877.9 9994.7 10014.3 10058.5 9272.6 9777.8 9777.9 9859.3 9955.5 7627.8 7824.9 7835.4 7846.5 7855.8 5386.4 5480.0 5518.3 5638.7 5768.3 9135.5 9172.6 9278.3 9332.4 9340.2 8116.2 8919.4 9474.3 9515.2 9539.1 6837.3 7040.3 7051.9 7135.7 7201.1 7973.5 8042.4 8065.6 8086.2 8088.3 6927.0 7042.0 7215.2 7299.7 7307.3 6922.9 6999.2 7046.9 7111.8 7118.6 6350.0 6375.9 6435.5 6466.9 6485.7 4954.6 4974.9 4978.9 4979.8 5028.3 4849.8 4944.4 5048.0 5085.9 5159.1 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4316.57 Median:4692.73 stddev:1254.88 (26.7%) stddev-sans-first:1222.31 11:55:13 INFO - PROCESS | 1911 | Values: 335.8 357.2 363.4 371.9 374.7 4255.9 4484.0 5061.6 5089.8 5102.4 4097.7 4172.0 4724.6 4858.3 5094.9 4007.1 4008.9 4038.4 4052.3 4076.5 4008.3 4013.4 4017.7 4027.9 4033.6 3553.9 3742.4 3843.7 4001.7 4019.5 3769.2 3980.0 3999.9 4009.0 4015.8 3550.5 3582.5 3587.6 3593.0 3621.5 4829.8 4958.7 4994.3 5047.1 5071.9 3875.7 3885.3 4607.2 4611.5 4620.2 4663.6 5057.5 5147.0 5305.4 5431.4 3404.7 3961.4 3977.5 4001.3 4006.6 4745.6 5283.6 5601.6 5618.4 5648.2 3448.7 3871.5 4031.4 4041.8 4045.2 4103.6 4115.0 4123.2 4131.5 4133.2 4366.9 4560.6 4597.6 4661.4 4669.8 5007.0 5446.2 5457.2 5482.0 5490.5 1324.5 1330.9 1335.4 1336.7 1340.9 746.4 866.3 873.9 947.5 948.1 4407.1 4690.8 4694.7 4724.8 4753.6 4584.3 4819.3 5146.5 5159.0 5204.3 4526.9 4680.3 4711.8 4718.6 5029.9 2549.9 2560.8 2651.2 2724.1 2749.6 4658.5 5103.9 5128.4 5397.6 5462.3 4828.9 5056.5 5315.9 5548.8 5588.8 5176.7 5622.9 5628.3 5651.8 5675.0 4447.0 5392.6 5414.4 5460.1 5466.6 4372.9 5076.8 5329.6 5341.9 5389.5 4396.4 4772.8 5120.3 5603.6 5694.5 3697.6 3700.5 3715.7 3733.3 3754.4 4366.4 5290.6 5442.8 5443.8 5489.2 4459.2 4876.5 5272.6 5293.6 5302.3 5266.6 5274.7 5291.7 5324.9 5331.3 4200.3 4810.9 4978.7 5138.6 5206.3 4381.8 4670.9 5066.4 5327.7 5353.7 4274.5 4340.8 5045.5 5264.8 5294.9 11:55:13 INFO - PROCESS | 1911 | 11:55:13 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:20711.81 Median:3992.98 stddev:29779.67 (745.8%) stddev-sans-first:29825.33 11:55:13 INFO - PROCESS | 1911 | Values: 706.3 714.8 762.6 805.8 824.6 15113.5 15695.2 15722.8 15766.6 15769.4 14125.4 14134.5 14394.7 14413.2 14458.6 674.7 694.9 700.4 844.1 851.1 855.7 867.1 868.1 868.9 871.2 933.1 934.1 935.2 935.5 936.6 924.6 927.3 927.9 928.6 933.8 530.1 544.8 549.3 550.2 550.7 13932.9 14462.0 14503.5 14792.9 14814.3 14151.7 14315.2 14322.9 14337.0 14396.9 11296.5 11514.9 11607.1 11750.4 11866.7 3553.5 3639.6 3697.8 3710.3 3759.6 103587.3 104177.5 104452.5 104971.5 105548.0 10897.0 11145.0 11217.7 11237.6 11765.0 22491.9 22581.7 22804.8 22919.8 22983.3 7650.8 7775.8 7791.5 7939.6 8009.3 4226.4 4304.5 4351.4 4435.0 4448.5 3500.2 3607.4 3608.4 3617.9 3620.1 564.6 651.3 655.9 670.4 672.8 654.6 664.4 686.3 694.9 728.3 8970.8 9941.9 10084.9 10184.6 10564.5 654.2 684.6 692.7 706.5 716.9 4481.9 4964.9 4992.0 5002.3 5034.9 90177.0 93681.5 102448.5 104618.0 108693.5 91386.0 91859.5 93835.0 96228.0 96768.0 80881.6 82058.2 85101.6 85704.1 85894.1 9341.3 9671.0 9721.8 9728.3 9744.2 45082.0 45564.3 46571.5 55680.7 56050.4 59023.7 67271.0 67688.7 70786.0 76343.4 12751.1 13227.7 13255.6 13319.2 13664.0 13984.1 13995.1 14684.9 14836.4 15468.1 12963.2 13285.8 14138.8 14262.7 14404.4 11101.3 13469.2 13799.9 13994.3 14126.2 12218.3 13538.2 13573.7 13787.4 14205.9 10191.4 10350.8 11141.3 11342.1 11911.6 10126.4 10827.2 10834.1 10885.3 10897.6 11:55:13 INFO - PROCESS | 1911 | -------- Summary: end -------- 11:55:13 INFO - PROCESS | 1911 | 11:55:14 INFO - TEST-INFO | 1911: exit 0 11:55:14 INFO - TEST-OK | dromaeo_css | took 1119570ms 11:55:14 INFO - TEST-START | kraken 11:55:14 INFO - operating with platform_type : mac_ 11:55:14 INFO - Initialising browser for kraken test... 11:55:14 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpAfbfxw/profile http://localhost:57094/getInfo.html) 11:55:16 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 11:55:16 INFO - PROCESS | 1914 | colorDepth:24 11:55:16 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 11:55:16 INFO - PROCESS | 1914 | __metrics 11:55:16 INFO - PROCESS | 1914 | 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" 11:55:16 INFO - PROCESS | 1914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:17 INFO - TEST-INFO | 1914: exit 0 11:55:17 INFO - Browser initialized. 11:55:17 INFO - Running cycle 1/1 for kraken test... 11:55:17 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpAfbfxw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:29 INFO - PROCESS | 1915 | RSS: Main: 213319680 11:55:29 INFO - PROCESS | 1915 | 11:55:32 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57094/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:32 INFO - PROCESS | 1915 | RSS: Main: 266022912 11:55:32 INFO - PROCESS | 1915 | 11:55:35 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57094/tests/kraken/driver.html?testName=audio-dft) 11:55:36 INFO - PROCESS | 1915 | RSS: Main: 276303872 11:55:36 INFO - PROCESS | 1915 | 11:55:39 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57094/tests/kraken/driver.html?testName=audio-fft) 11:55:40 INFO - PROCESS | 1915 | RSS: Main: 372969472 11:55:40 INFO - PROCESS | 1915 | 11:55:42 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57094/tests/kraken/driver.html?testName=audio-oscillator) 11:55:42 INFO - PROCESS | 1915 | RSS: Main: 276774912 11:55:42 INFO - PROCESS | 1915 | 11:55:44 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57094/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:55:45 INFO - PROCESS | 1915 | RSS: Main: 279605248 11:55:45 INFO - PROCESS | 1915 | 11:55:48 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57094/tests/kraken/driver.html?testName=imaging-darkroom) 11:55:48 INFO - PROCESS | 1915 | RSS: Main: 318615552 11:55:48 INFO - PROCESS | 1915 | 11:55:51 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57094/tests/kraken/driver.html?testName=imaging-desaturate) 11:55:52 INFO - PROCESS | 1915 | RSS: Main: 320376832 11:55:52 INFO - PROCESS | 1915 | 11:55:54 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57094/tests/kraken/driver.html?testName=json-parse-financial) 11:55:55 INFO - PROCESS | 1915 | RSS: Main: 315809792 11:55:55 INFO - PROCESS | 1915 | 11:55:57 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57094/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:55:57 INFO - PROCESS | 1915 | RSS: Main: 294891520 11:55:57 INFO - PROCESS | 1915 | 11:55:59 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:56:00 INFO - PROCESS | 1915 | RSS: Main: 295665664 11:56:00 INFO - PROCESS | 1915 | 11:56:02 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:03 INFO - PROCESS | 1915 | RSS: Main: 297959424 11:56:03 INFO - PROCESS | 1915 | 11:56:05 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:06 INFO - PROCESS | 1915 | RSS: Main: 315572224 11:56:06 INFO - PROCESS | 1915 | 11:56:09 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:10 INFO - PROCESS | 1915 | RSS: Main: 309571584 11:56:10 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:57094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57094/tests/kraken/driver.html?testName=ai-astar) 11:56:11 INFO - PROCESS | 1915 | RSS: Main: 354267136 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | __start_tp_report 11:56:11 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 11:56:11 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 11:56:11 INFO - PROCESS | 1915 | |i|pagename|runs| 11:56:11 INFO - PROCESS | 1915 | |0;ai-astar;116;114;113;113;113;114;113;113;113;114 11:56:11 INFO - PROCESS | 1915 | |1;audio-beat-detection;139;112;138;169;113;110;110;112;157;137 11:56:11 INFO - PROCESS | 1915 | |2;audio-dft;185;183;183;185;184;185;185;185;187;185 11:56:11 INFO - PROCESS | 1915 | |3;audio-fft;87;60;74;113;87;57;57;59;73;56 11:56:11 INFO - PROCESS | 1915 | |4;audio-oscillator;89;70;85;69;68;69;81;68;68;82 11:56:11 INFO - PROCESS | 1915 | |5;imaging-gaussian-blur;88;85;88;86;87;85;89;86;87;85 11:56:11 INFO - PROCESS | 1915 | |6;imaging-darkroom;94;94;94;94;94;94;95;95;95;94 11:56:11 INFO - PROCESS | 1915 | |7;imaging-desaturate;85;85;87;87;85;86;85;85;86;85 11:56:11 INFO - PROCESS | 1915 | |8;json-parse-financial;57;56;56;56;56;57;57;55;56;56 11:56:11 INFO - PROCESS | 1915 | |9;json-stringify-tinderbox;64;75;69;75;73;70;70;70;70;72 11:56:11 INFO - PROCESS | 1915 | |10;stanford-crypto-aes;85;84;83;84;84;82;83;84;84;83 11:56:11 INFO - PROCESS | 1915 | |11;stanford-crypto-ccm;139;139;137;139;139;139;143;142;182;148 11:56:11 INFO - PROCESS | 1915 | |12;stanford-crypto-pbkdf2;166;163;168;167;162;162;168;167;164;167 11:56:11 INFO - PROCESS | 1915 | |13;stanford-crypto-sha256-iterative;68;66;66;65;64;64;65;64;67;65 11:56:11 INFO - PROCESS | 1915 | __end_tp_report 11:56:11 INFO - PROCESS | 1915 | __start_cc_report 11:56:11 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,1955 11:56:11 INFO - PROCESS | 1915 | __end_cc_report 11:56:11 INFO - PROCESS | 1915 | __startTimestamp1487102171982__endTimestamp 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | ------- Summary: start ------- 11:56:11 INFO - PROCESS | 1915 | Number of tests: 14 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:0.97 (0.9%) stddev-sans-first:0.50 11:56:11 INFO - PROCESS | 1915 | Values: 116.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:137.50 stddev:21.55 (15.7%) stddev-sans-first:22.59 11:56:11 INFO - PROCESS | 1915 | Values: 139.0 112.0 138.0 169.0 113.0 110.0 110.0 112.0 157.0 137.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.16 (0.6%) stddev-sans-first:1.22 11:56:11 INFO - PROCESS | 1915 | Values: 185.0 183.0 183.0 185.0 184.0 185.0 185.0 185.0 187.0 185.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#3] audio-fft Cycles:10 Average:72.30 Median:66.50 stddev:18.72 (28.2%) stddev-sans-first:19.09 11:56:11 INFO - PROCESS | 1915 | Values: 87.0 60.0 74.0 113.0 87.0 57.0 57.0 59.0 73.0 56.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.50 stddev:8.33 (11.0%) stddev-sans-first:7.11 11:56:11 INFO - PROCESS | 1915 | Values: 89.0 70.0 85.0 69.0 68.0 69.0 81.0 68.0 68.0 82.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.42 11:56:11 INFO - PROCESS | 1915 | Values: 88.0 85.0 88.0 86.0 87.0 85.0 89.0 86.0 87.0 85.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:56:11 INFO - PROCESS | 1915 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 11:56:11 INFO - PROCESS | 1915 | Values: 85.0 85.0 87.0 87.0 85.0 86.0 85.0 85.0 86.0 85.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 11:56:11 INFO - PROCESS | 1915 | Values: 57.0 56.0 56.0 56.0 56.0 57.0 57.0 55.0 56.0 56.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:3.22 (4.5%) stddev-sans-first:2.30 11:56:11 INFO - PROCESS | 1915 | Values: 64.0 75.0 69.0 75.0 73.0 70.0 70.0 70.0 70.0 72.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:0.84 (1.0%) stddev-sans-first:0.73 11:56:11 INFO - PROCESS | 1915 | Values: 85.0 84.0 83.0 84.0 84.0 82.0 83.0 84.0 84.0 83.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:140.50 stddev:13.47 (9.6%) stddev-sans-first:14.13 11:56:11 INFO - PROCESS | 1915 | Values: 139.0 139.0 137.0 139.0 139.0 139.0 143.0 142.0 182.0 148.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:167.00 stddev:2.41 (1.4%) stddev-sans-first:2.55 11:56:11 INFO - PROCESS | 1915 | Values: 166.0 163.0 168.0 167.0 162.0 162.0 168.0 167.0 164.0 167.0 11:56:11 INFO - PROCESS | 1915 | 11:56:11 INFO - PROCESS | 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.35 (2.1%) stddev-sans-first:1.05 11:56:11 INFO - PROCESS | 1915 | Values: 68.0 66.0 66.0 65.0 64.0 64.0 65.0 64.0 67.0 65.0 11:56:11 INFO - PROCESS | 1915 | -------- Summary: end -------- 11:56:11 INFO - PROCESS | 1915 | 11:56:12 INFO - TEST-INFO | 1915: exit 0 11:56:12 INFO - TEST-OK | kraken | took 58747ms 11:56:12 INFO - SUITE-END | took 1178s 11:56:13 INFO - Completed test suite (00:19:38) 11:56:13 INFO - javascript benchmark 11:56:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.5217143514187, 3325.268440942993, 3333.1167240681225, 3345.9627515470193, 3382.813945233013, 4965.925511117336, 5371.194320851874, 5615.0, 5687.146927960808, 5692.231548740924, 5596.2165296858475, 5695.316562012565, 5710.05784045633, 5744.6840423776675, 5766.625169363989, 5170.6122040847085, 5188.37739471264, 5194.896102077956, 5204.869878253055, 5240.318758561381, 5116.104681680709, 5143.871403214931, 5148.536631703146, 5151.5106064923775, 5280.287161233242, 5221.6083793715625, 5251.054810134175, 5279.70961597112, 5282.022825777243, 5295.629305948585, 5227.3465816772905, 5248.527632513092, 5263.026689069591, 5289.920651190255, 5323.361196656388, 4999.875003124915, 5121.129408000649, 5217.765200565984, 5229.08491014071, 5229.346331708536, 5538.75075621598, 5607.074832652607, 5642.012647786621, 5655.886882262373, 5716.828495145152, 6177.042558403455, 6205.844853878644, 6211.254649442096, 6213.254409470893, 6219.222597175353, 6217.191765070557, 6269.028300613412, 6290.0, 6296.1500197473215, 6311.274203466614, 5633.690147041911, 5636.239107720447, 5697.088465845528, 5709.0, 5761.827145185651, 6284.811455656338, 6289.496840252768, 6296.622202667854, 6324.0, 6324.494040476843, 6126.253311924967, 6162.0, 6175.96912015437, 6177.073438984188, 6187.504999600022, 6128.509719222451, 6199.504039676905, 6282.937170628235, 6286.151369565142, 6300.21247344082, 6083.300420451616, 6117.4620395853735, 6128.686460748404, 6182.28903676083, 6201.410865967726, 6279.905801412982, 6283.5287353448675, 6290.025046117859, 6293.118963345135, 6304.905426418607, 4937.629677774181, 4985.0, 4986.052649996489, 4989.650724449326, 4991.07665081961, 4343.1747967886, 4378.277584198571, 4388.561143885586, 4444.688871778944, 4489.079738653568, 5727.799527016535, 5738.8278351649515, 5740.655560666373, 5742.626729262668, 5751.0, 6183.474404675563, 6196.690165491707, 6252.531060170505, 6257.7184026718905, 6315.5894866833505, 5812.796552120655, 5838.503727183237, 5846.444587764156, 5853.473187413153, 5876.324222714357, 5428.185772134132, 5469.398366179717, 5488.396276409671, 5491.2312276281355, 5491.807786727445, 6192.938070619236, 6242.344553821874, 6270.184875966278, 6282.02628592578, 6292.465140463112, 6233.2208473940755, 6292.370762923671, 6307.24313082433, 6310.716017779119, 6319.146915166578, 6315.463185629273, 6324.367563243823, 6339.5562310637815, 6354.872902541831, 6548.279689234085, 5963.970180149072, 6033.78881739137, 6099.207103076572, 6119.418655227746, 6163.907541386793, 6252.781152659635, 6292.528060395397, 6301.495880329471, 6305.085762564494, 6324.810255692337, 6096.055111457731, 6098.786542470993, 6101.145839582551, 6104.931636963603, 6110.358412366815, 5789.044807606698, 5932.79235226765, 5950.851228719317, 5988.011978023752, 6076.088586712029, 5823.272090988627, 5938.6436813791315, 5940.732667029907, 5947.643141411356, 5960.284765828128, 5869.882602348014, 6060.575759696955, 6065.059915713072, 6082.239720034996, 6087.817365479043, 5758.596898217253, 5783.95888740014, 5836.037053886062, 5853.0635098384055, 5855.268091488564], "value": 5694.821532684494, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.0926708545598, 438.703874884453, 484.6219948440217, 503.2627201150314, 532.3585079978626, 30071.0, 32068.0, 40103.99740006501, 41916.79041604795, 42075.36886946698, 42740.78629606848, 43068.353974690326, 43108.78445607767, 43131.0, 43233.0, 9206.355555111146, 9442.480663563501, 9449.291303152257, 9455.149036586707, 9459.10138536838, 7510.69957201714, 8569.614367353484, 11126.499307531181, 11364.374959377272, 11409.37248451335, 11290.435478226096, 11335.093192544577, 11354.375509346983, 11372.0, 11391.259568128087, 11334.489947952321, 11404.087672986225, 11424.71438214043, 11443.828342574869, 11467.082633389351, 8335.291500222489, 8506.191911768372, 10985.0, 11270.985611295022, 11283.435828208556, 40623.7968810157, 41057.0, 41199.0, 41214.79392603048, 41253.55612553576, 3914.7651140931634, 3992.261431635157, 4025.074232926414, 4032.8185231664647, 4171.958280417188, 28846.567301490493, 28913.132606021853, 29020.839166433318, 29151.562726558906, 29971.100866974026, 3101.0, 3190.8245046522434, 3356.5133055706788, 3358.899233022989, 3360.176756694601, 476309.618451909, 482346.0, 483422.0, 484881.5755921268, 486799.0, 52924.0, 63499.0, 63604.0, 64117.0, 64282.35717642857, 66650.66674666596, 66703.99944000844, 66841.0, 67030.0, 67167.0, 16392.75410868814, 16629.91905526137, 16651.750223746654, 16660.833391666172, 16661.583460413585, 12884.80672789909, 12958.157719748186, 12967.962562994937, 12978.935105324414, 12994.870051299366, 13063.150895191971, 15315.770263446057, 15715.21423928799, 17304.740428893576, 19713.901430492755, 7666.769996900102, 8424.452410593292, 8580.785480362916, 8716.825663486694, 8793.472391656522, 731.4989232375733, 849.6006876767909, 909.2816674826813, 909.3407279722148, 909.8180363927241, 26603.600945985825, 29056.564151537743, 29947.251318717208, 30136.0, 30668.233294167378, 913.8941880324749, 937.9343445958854, 947.8056998315329, 964.8118616869643, 1088.6244245735209, 14247.430102795772, 14261.144331339945, 14490.85509144916, 14529.0, 14543.563693089225, 395078.0, 396035.01982489903, 396361.0, 396627.0, 398135.0, 53909.730451347496, 54400.0, 54467.18299225515, 54531.0, 54599.727001365536, 1419.4038503828417, 1420.3963315590834, 1447.7828325751223, 1449.3550370085422, 1450.6010847017155, 26898.193054208405, 27089.59365609478, 28021.719782801913, 28673.996410125546, 28938.85530572418, 47375.28937065878, 47696.284555731, 47696.7615161922, 47699.761501192275, 47858.76070619625, 377439.0, 377810.0, 379653.0, 380930.0953495215, 381031.0, 25676.0, 26242.0, 26289.73710262873, 38904.2219155621, 39243.0, 29291.560626591043, 36142.4578631326, 51353.48646513637, 52993.470065298854, 53183.1731053959, 36894.44658330181, 36937.828703982, 40386.19227615373, 40940.38589421221, 42159.7892010538, 40845.0, 41108.79445602753, 41705.79147104245, 42196.0, 42856.92857678583, 38573.80713096529, 39256.0, 39287.0, 39468.0, 40153.0, 33195.33609327752, 35824.46263306105, 36329.63670363368, 36700.26599468049, 36993.63006369902, 26045.348866277738, 26087.60868586935, 26300.605490917267, 26530.469390612467, 26988.0], "value": 19719.87566905636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.20390006337107, 396.231311256163, 396.3598787957446, 404.35909084101695, 424.1220673206462, 14013.719725605482, 17510.73733893991, 20824.687629685566, 21568.676469852966, 21599.244026459095, 21299.68050479244, 21410.25064122756, 21462.248821291218, 21976.670349944765, 22193.889030554867, 5751.079827227644, 6001.429864162919, 6046.7883624073165, 6055.21282233309, 6059.42435468632, 5295.417504074549, 5360.91958620621, 5937.37657545958, 5950.494207992326, 6035.939640603604, 5958.314793798703, 5966.522678185756, 5970.582059255854, 5972.88054238915, 5981.910271345933, 5623.240862483573, 5837.09525023622, 5897.439743224387, 5902.940970590282, 5961.552883533753, 5215.739213039333, 5217.034848553029, 5217.634765566412, 5219.895602087975, 5246.449122842085, 24005.759942400528, 25111.62332565013, 25408.0, 26298.21105366842, 26653.0, 2110.5884352551257, 2531.607600821857, 2601.0636170978432, 2621.685397752282, 2837.6027356170152, 9289.163975242192, 9469.905300946972, 9509.049095090504, 9943.701688949342, 9992.700218993368, 1513.3265696764945, 1789.3021721528614, 1801.1984666823269, 1803.846673032794, 1808.2766893242676, 131543.0, 134720.0, 135518.3224083883, 137593.0, 139896.0, 10014.599416023424, 10569.260151789455, 10593.576256949636, 10691.83962240567, 10709.733531273036, 12815.679608009874, 12907.419166137546, 12941.54704585335, 13888.4444622216, 14462.132272063709, 8089.716859909992, 8379.413441059067, 8506.532140732195, 8809.295256379473, 8972.596233169523, 7559.979402780555, 8340.332773378115, 8599.269062129664, 8627.784305392415, 8779.385443019055, 4495.9325610115875, 4517.260854571014, 4563.133004729158, 4568.132054909623, 4824.758762061953, 1988.4631149589818, 2009.5177157482099, 2025.888576128327, 2026.2502873936444, 2027.0878104852875, 965.9468729219819, 966.9033096690275, 1003.4581326083979, 1003.5032658833778, 1020.6325722739808, 21540.0, 21887.343379698636, 21934.45163870884, 21942.670859937112, 21962.45093872666, 1018.3940555369543, 1032.1536340200962, 1036.43514284715, 1046.7016900183564, 1061.0609610494614, 10482.842757358645, 11341.206115571831, 11398.031167350868, 11470.254433461965, 11544.134189935789, 735720.0, 764002.0, 768391.0, 782533.0, 783090.0, 112438.0, 152500.0, 155206.0, 156248.0, 156783.0, 968.2350942755286, 971.3297824501071, 983.9311248212556, 987.7036888933435, 989.3618615992644, 18161.36435224761, 18961.810381896004, 19339.033048347246, 19346.806531935064, 19382.2247110114, 59345.0, 59567.808643826014, 60390.69804650949, 60552.39447605467, 61536.0, 73126.90309645465, 78918.6054069726, 82120.17879821126, 87329.12670873464, 90135.54932225296, 6559.672016399066, 6872.659831332842, 7256.310650488195, 7960.084590271961, 8162.387820913336, 7618.504797188165, 8860.512671803113, 9789.070038346346, 12378.566750163702, 12394.75210495803, 11077.446127693744, 11215.775684486427, 11532.711682207677, 11613.43218665503, 11629.0, 10751.0, 10959.671209863716, 11144.498497567467, 11271.463920618124, 11665.59170429031, 11344.092472602008, 11468.254563453349, 11541.422928853355, 11730.354830484406, 11805.586804462146, 7803.882941755992, 7923.326517246099, 8148.144444833207, 8282.337413006824, 8442.66229350819, 9806.460644664327, 11061.115110790957, 11233.438328083399, 11410.94294528522, 11450.541978321107], "value": 9732.602147423919, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.621825888751, 1372.6774208061097, 1374.3059754823805, 1378.283292687802, 1379.124256097378, 7992.120866704658, 8433.493990360583, 8447.0, 8453.61958711858, 8466.576671166433, 7484.251574842513, 7702.268284512977, 7716.189800070996, 8118.228768267005, 8312.127226641207, 2275.0, 2319.524497478021, 2319.652052192168, 2321.8955147018423, 2321.9071237150492, 2318.6290193569034, 2347.8943447544902, 2355.587772139869, 2360.1857359211044, 2360.5042940982416, 2009.0657844102489, 2084.0413409831494, 2244.86530808152, 2252.245497758253, 2305.7463678995296, 1945.9318923837598, 2299.356180269519, 2312.5490529346785, 2321.3616255529696, 2321.7446080931086, 2226.755056943735, 2277.6583512473094, 2280.076568989545, 2335.2760644200184, 2342.437814924423, 8277.751667449986, 8346.290565301957, 8369.288610468118, 8380.455270407465, 8382.83234335316, 4961.751912404366, 5128.333316668846, 5143.177091665353, 5144.485551444863, 5159.58723302135, 3280.114369120324, 3416.2484253464445, 3441.82790860456, 3494.633063528344, 3497.4054410749977, 1140.914431417647, 1213.8846809553079, 1225.6935766058486, 1464.4801095611117, 1708.8718346123967, 10651.25441219115, 10664.573417063308, 10747.946260268727, 10753.838692419542, 10758.085562727178, 4273.829046838154, 4400.669949753717, 4492.011757413364, 4499.76256529457, 4516.1419330327135, 8441.535715535705, 8476.660933562713, 8485.490870547786, 8502.532360720095, 8546.359023073295, 4346.565343465628, 5129.256257842667, 5131.61512886535, 5139.331886854685, 5159.974200128975, 3770.6606405423645, 4214.136102099063, 4689.320048592935, 4736.763161841963, 4773.785179666923, 3727.1241258304276, 3727.7949712765517, 3786.280606684721, 3812.218495208476, 3814.4278358246484, 1134.2910680824484, 1146.5528443906883, 1149.178337488683, 1157.8436911017072, 1159.750653609461, 780.605794073989, 850.2390360627204, 893.3567831161554, 896.5382827843666, 920.5949382271779, 5297.311349524537, 5456.836294911159, 5476.644018138808, 5758.021136406821, 5782.248307720053, 935.8783358163395, 948.9240860731124, 1004.5479534209635, 1005.4771518810178, 1022.3354819367322, 3438.707709844641, 3793.2223894101644, 3846.9807650962125, 3910.687145028391, 3950.4074388841905, 9856.950715246521, 9877.851832222523, 9994.700158995242, 10014.298999069995, 10058.547365368577, 9272.629094836266, 9777.804443911224, 9777.902220977841, 9859.26055545837, 9955.502224888727, 7627.809304767315, 7824.882626760603, 7835.3731701464885, 7846.450748447553, 7855.764327070197, 5386.380566234933, 5479.972600136974, 5518.310211223597, 5638.661680299195, 5768.2501274834, 9135.543222838964, 9172.587233574639, 9278.304127190622, 9332.39339442934, 9340.159385655325, 8116.188381161836, 8919.42023768453, 9474.336796424184, 9515.238780897373, 9539.09378609031, 6837.2820853809635, 7040.295970402919, 7051.858962820817, 7135.678894449866, 7201.063861697946, 7973.481723687942, 8042.3968202383885, 8065.628843096805, 8086.1913808618665, 8088.312493438124, 6926.965365173343, 7041.964790176221, 7215.242399547972, 7299.744508942162, 7307.3058059484265, 6922.923123063161, 6999.1950925644205, 7046.859062818818, 7111.751088711871, 7118.644067796693, 6350.0, 6375.904361434489, 6435.549511534147, 6466.870662586816, 6485.708143133476, 4954.578860796729, 4974.8756281093265, 4978.8755281118265, 4979.775910084128, 5028.2960385546785, 4849.81677696506, 4944.406671199479, 5047.974760126176, 5085.923711144262, 5159.071367153948], "value": 4378.7655963778625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.7934870054916, 357.23016898583546, 363.4281731511215, 371.9460678201659, 374.6815207073986, 4255.936015996001, 4483.977580112103, 5061.620378471615, 5089.770960306791, 5102.438731739506, 4097.651699605537, 4171.958280417202, 4724.645651576128, 4858.295547145671, 5094.949050509494, 4007.0984028593625, 4008.859689910854, 4038.4346191533136, 4052.331365324718, 4076.490438695163, 4008.298547754146, 4013.357862741962, 4017.698672599552, 4027.859024934128, 4033.556308806029, 3553.9338198540463, 3742.3825068863603, 3843.6925045996254, 4001.659858911996, 4019.477467929165, 3769.227308401771, 3979.9801000994808, 3999.860004899829, 4009.037830920558, 4015.7791321477307, 3550.5029295898594, 3582.498450216972, 3587.5694916610173, 3593.0058817356357, 3621.5110960020324, 4829.758512074382, 4958.727270000149, 4994.300797888299, 5047.066292735855, 5071.898562028776, 3875.65119139276, 3885.30064588374, 4607.193741095329, 4611.4696809866955, 4620.1519392243035, 4663.580277774982, 5057.48275517347, 5146.966948055535, 5305.4164041955355, 5431.429699881495, 3404.6595340466, 3961.4052795419047, 3977.539540599668, 4001.339778936472, 4006.579309172553, 4745.644076694227, 5283.603729720248, 5601.579881508903, 5618.410066942994, 5648.209250704905, 3448.706859916935, 3871.5354157500715, 4031.3751368537924, 4041.777702226406, 4045.1505183911117, 4103.589641035873, 4115.0, 4123.237201117743, 4131.5455299916985, 4133.23535145999, 4366.868993930188, 4560.612347950461, 4597.632189424838, 4661.370714953506, 4669.813207471731, 5007.0, 5446.167992643803, 5457.2359869618285, 5482.0, 5490.450954904478, 1324.4834514539336, 1330.900182486298, 1335.4457899971403, 1336.6992426704107, 1340.879320861127, 746.3693179263514, 866.3199388480012, 873.8558137907302, 947.5025611553989, 948.0803620488116, 4407.074514351958, 4690.756949408409, 4694.694844835143, 4724.763761811896, 4753.5959443447, 4584.33527138563, 4819.2530157825595, 5146.485351464824, 5158.97420512895, 5204.34945631796, 4526.932096018562, 4680.338479839676, 4711.7879695413785, 4718.646101542398, 5029.949700503022, 2549.9035414771456, 2560.807939404552, 2651.2443953473166, 2724.1418953029734, 2749.625187406297, 4658.534146585314, 5103.87240318995, 5128.358955130609, 5397.59806885932, 5462.2961633990635, 4828.8893554482665, 5056.519630635084, 5315.867103322448, 5548.805791797267, 5588.804391846266, 5176.689398636094, 5622.919519777708, 5628.324601047901, 5651.773929042874, 5674.9853801899735, 4446.955530444783, 5392.649477783932, 5414.35027796667, 5460.061678104215, 5466.5900057495055, 4372.868813935587, 5076.796928122982, 5329.626926115135, 5341.866453338697, 5389.461053894579, 4396.36252743344, 4772.76136193182, 5120.334356533627, 5603.607747457639, 5694.515966142924, 3697.594913932796, 3700.518932538753, 3715.68416684574, 3733.290674771785, 3754.4368344748505, 4366.432363792686, 5290.550303224269, 5442.809501667422, 5443.782248710166, 5489.176623506506, 4459.197344478025, 4876.537658262673, 5272.578193744414, 5293.550048245942, 5302.310699609026, 5266.63133580661, 5274.683518988873, 5291.682499050069, 5324.866878327918, 5331.280277162688, 4200.28595138821, 4810.8797280068275, 4978.651494395358, 5138.584865113391, 5206.349206349207, 4381.838812714697, 4670.883227919329, 5066.44269130388, 5327.653702509325, 5353.732313384237, 4274.487061552633, 4340.764506279332, 5045.468172279492, 5264.842054738364, 5294.867628309323], "value": 3937.751787624683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.3042902740797, 714.7748459235337, 762.6148794858595, 805.8468890910726, 824.550619912148, 15113.471028514005, 15695.215239238021, 15722.764158537631, 15766.605834854134, 15769.369225230992, 14125.43498260071, 14134.50529231477, 14394.712105757879, 14413.207273599948, 14458.638534036654, 674.7132468700808, 694.9270326615708, 700.4151533469534, 844.0968164064423, 851.0638297872322, 855.7304449098546, 867.0852250875324, 868.0841711993844, 868.9348298877578, 871.1680345270283, 933.1321870660283, 934.0799312677008, 935.1817159985013, 935.5322338830584, 936.5925822267335, 924.5562130177552, 927.3276874266103, 927.8979312275644, 928.5867788833972, 933.785229397239, 530.0988319856222, 544.801147581134, 549.3407910507407, 550.243415303957, 550.6751016900048, 13932.93033534826, 14462.0, 14503.492377766728, 14792.852071479256, 14814.333354999051, 14151.71696566063, 14315.212663303515, 14322.85677143236, 14337.0, 14396.856031439656, 11296.491657875415, 11514.94242528782, 11607.129465290138, 11750.447049473492, 11866.703332416759, 3553.5257870856594, 3639.5996440391536, 3697.7781333120097, 3710.2764960832646, 3759.586445490994, 103587.33856976379, 104177.47911260395, 104452.47773761158, 104971.47514262379, 105548.0, 10897.0, 11145.0, 11217.719557010976, 11237.606683766193, 11765.0, 22491.88754056219, 22581.661275080885, 22804.771952280596, 22919.770802292096, 22983.310500685006, 7650.846983060419, 7775.844483110306, 7791.454598178073, 7939.6030198491, 8009.279164875189, 4226.366045093199, 4304.461942257218, 4351.412559304516, 4435.024294655171, 4448.510663826976, 3500.177458297298, 3607.4228123500116, 3608.4226523756074, 3617.9276414472088, 3620.149264922741, 564.5934926852659, 651.26407159909, 655.9048937903978, 670.3598063849013, 672.842710537874, 654.607235658601, 664.3920812456645, 686.2794066230438, 694.8957656351588, 728.2826415980255, 8970.775730606787, 9941.850872236922, 10084.899151008543, 10184.592616295413, 10564.471776411148, 654.1790053482848, 684.6405637040593, 692.6709812838861, 706.4877963476541, 716.8852983522611, 4481.932771008373, 4964.90070198594, 4992.0, 5002.299678045077, 5034.924476132787, 90177.0, 93681.5315923416, 102448.48775756222, 104618.0, 108693.45653271841, 91386.0, 91859.54070229606, 93835.0, 96228.0, 96768.0, 80881.59559202284, 82058.17941820505, 85101.57449212714, 85704.14295856962, 85894.14105858862, 9341.34610577253, 9671.0, 9721.756956075871, 9728.270379721691, 9744.171745401436, 45082.0, 45564.31653525133, 46571.53428465672, 55680.721596391755, 56050.43949560452, 59023.704881475314, 67271.0, 67688.6615566919, 70786.0, 76343.3882066185, 12751.076932260052, 13227.735445290848, 13255.602331930058, 13319.200847949154, 13664.0, 13984.091034082752, 13995.090319129224, 14684.926575367055, 14836.406543738562, 15468.14925179126, 12963.15739476931, 13285.80071298912, 14138.78791818103, 14262.714745705236, 14404.351804169048, 11101.278416902875, 13469.191848489121, 13799.862001379857, 13994.300284985913, 14126.152430854181, 12218.327991960528, 13538.187708737507, 13573.728525429238, 13787.448502059806, 14205.928970355082, 10191.439470829175, 10350.844737329096, 11141.275817071864, 11342.149338799789, 11911.642650720492, 10126.44304563256, 10827.187960903122, 10834.133269338276, 10885.292455990335, 10897.618583349546], "value": 7508.922479701898, "unit": "score"}], "name": "dromaeo_css", "value": 7218.938790435544, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 112.0, 138.0, 169.0, 113.0, 110.0, 110.0, 112.0, 157.0, 137.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 185.0, 184.0, 185.0, 185.0, 185.0, 187.0, 185.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 74.0, 113.0, 87.0, 57.0, 57.0, 59.0, 73.0, 56.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 69.0, 68.0, 69.0, 81.0, 68.0, 68.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 87.0, 85.0, 89.0, 86.0, 87.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 87.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 55.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 69.0, 75.0, 73.0, 70.0, 70.0, 70.0, 70.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 84.0, 82.0, 83.0, 84.0, 84.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 137.0, 139.0, 139.0, 139.0, 143.0, 142.0, 182.0, 148.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 168.0, 167.0, 162.0, 162.0, 168.0, 167.0, 164.0, 167.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0, 67.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1427.8000000000002, "alertThreshold": 2.0}]} 11:56:13 INFO - Return code: 0 11:56:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:56:13 ERROR - # TBPL SUCCESS # 11:56:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:56:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:56:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:56:13 INFO - 2017-02-14 11:56:13.274 screenresolution[1919:22259] starting screenresolution argv=screenresolution get 11:56:13 INFO - 2017-02-14 11:56:13.277 screenresolution[1919:22259] Display 0: 1600x1200x32@60 11:56:13 INFO - 2017-02-14 11:56:13.283 screenresolution[1920:22262] starting screenresolution argv=screenresolution list 11:56:13 INFO - Available Modes on Display 0 11:56:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:56:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:56:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:56:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:56:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:56:13 INFO - Intel Iris: 11:56:13 INFO - Chipset Model: Intel Iris 11:56:13 INFO - Type: GPU 11:56:13 INFO - Bus: Built-In 11:56:13 INFO - VRAM (Dynamic, Max): 1536 MB 11:56:13 INFO - Vendor: Intel (0x8086) 11:56:13 INFO - Device ID: 0x0a2e 11:56:13 INFO - Revision ID: 0x0009 11:56:13 INFO - Displays: 11:56:13 INFO - Display: 11:56:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:56:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:56:13 INFO - Display Serial Number: 1600x1200 60 11:56:13 INFO - Main Display: Yes 11:56:13 INFO - Mirror: Off 11:56:13 INFO - Online: Yes 11:56:13 INFO - Rotation: Supported 11:56:13 INFO - Return code: 0 11:56:13 INFO - Running post-action listener: _resource_record_post_action 11:56:13 INFO - [mozharness: 2017-02-14 19:56:13.522282Z] Finished run-tests step (success) 11:56:13 INFO - Running post-run listener: _resource_record_post_run 11:56:13 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 815104; Write bytes: 507062272; Read time: 11; Write time: 1716 11:56:13 INFO - TinderboxPrint: CPU usage
53.5% 11:56:13 INFO - TinderboxPrint: I/O read bytes / time
815,104 / 11 11:56:13 INFO - TinderboxPrint: I/O write bytes / time
507,062,272 / 1,716 11:56:13 INFO - TinderboxPrint: CPU idle
2,230.8 (46.5%) 11:56:13 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 11:56:13 INFO - TinderboxPrint: CPU user
1,605.5 (33.5%) 11:56:13 INFO - TinderboxPrint: Swap in / out
208,822,272 / 0 11:56:13 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203248128; Write bytes: 198959104; Read time: 15708; Write time: 399 11:56:13 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 815104; Write bytes: 297351168; Read time: 11; Write time: 1279 11:56:13 INFO - Running post-run listener: _upload_blobber_files 11:56:13 INFO - Blob upload gear active. 11:56:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:56:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:56:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:15 INFO - (blobuploader) - INFO - Done attempting. 11:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:18 INFO - (blobuploader) - INFO - Done attempting. 11:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:56:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:56:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:19 INFO - (blobuploader) - INFO - Done attempting. 11:56:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:56:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:56:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:21 INFO - (blobuploader) - INFO - Done attempting. 11:56:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:21 INFO - Return code: 0 11:56:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6cb5dec11bb0d5a31c58bd099ba9a6b9174497adffab92da90af78e4bfa0df9246a47f34245b7c843bb0769b98b6810d5c3fd14603b710ff05f5753355cbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bceae32863dfe63adf785455c62e7089f17408f9a546a8c7f6fa8d9421e887ddf28f9f7c6628b002385e29863b6d9f5120db2b47bb69733aba068138282f974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43da5c5b90f51150d6441779af7c054bdd2294e79a85f912bf212cde4924147fc52cd61927acea9cce439cc405539a1e26c7bcbb87341d831db1455c23ceeb16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6178d6fa8d2bf62a5fe1379e335d2b51a090cf95c704f75921ced946f3581d675e5ab1013289903de0e5c5fe5724e204ccc4325a5ad959e32aebad18b307091b"} 11:56:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:21 INFO - Contents: 11:56:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6cb5dec11bb0d5a31c58bd099ba9a6b9174497adffab92da90af78e4bfa0df9246a47f34245b7c843bb0769b98b6810d5c3fd14603b710ff05f5753355cbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bceae32863dfe63adf785455c62e7089f17408f9a546a8c7f6fa8d9421e887ddf28f9f7c6628b002385e29863b6d9f5120db2b47bb69733aba068138282f974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43da5c5b90f51150d6441779af7c054bdd2294e79a85f912bf212cde4924147fc52cd61927acea9cce439cc405539a1e26c7bcbb87341d831db1455c23ceeb16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6178d6fa8d2bf62a5fe1379e335d2b51a090cf95c704f75921ced946f3581d675e5ab1013289903de0e5c5fe5724e204ccc4325a5ad959e32aebad18b307091b"} 11:56:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:21 INFO - Copying logs to upload dir... 11:56:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.560181 ========= master_lag: 1.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-02-14 11:56:22.498353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 11:56:22.501966) ========= 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.wvf3MaufSl/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.AS00e8ZIOm/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6cb5dec11bb0d5a31c58bd099ba9a6b9174497adffab92da90af78e4bfa0df9246a47f34245b7c843bb0769b98b6810d5c3fd14603b710ff05f5753355cbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bceae32863dfe63adf785455c62e7089f17408f9a546a8c7f6fa8d9421e887ddf28f9f7c6628b002385e29863b6d9f5120db2b47bb69733aba068138282f974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43da5c5b90f51150d6441779af7c054bdd2294e79a85f912bf212cde4924147fc52cd61927acea9cce439cc405539a1e26c7bcbb87341d831db1455c23ceeb16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6178d6fa8d2bf62a5fe1379e335d2b51a090cf95c704f75921ced946f3581d675e5ab1013289903de0e5c5fe5724e204ccc4325a5ad959e32aebad18b307091b"} build_url:https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/IMuBSAMoSdCutIHg9csjhA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6cb5dec11bb0d5a31c58bd099ba9a6b9174497adffab92da90af78e4bfa0df9246a47f34245b7c843bb0769b98b6810d5c3fd14603b710ff05f5753355cbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bceae32863dfe63adf785455c62e7089f17408f9a546a8c7f6fa8d9421e887ddf28f9f7c6628b002385e29863b6d9f5120db2b47bb69733aba068138282f974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43da5c5b90f51150d6441779af7c054bdd2294e79a85f912bf212cde4924147fc52cd61927acea9cce439cc405539a1e26c7bcbb87341d831db1455c23ceeb16", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6178d6fa8d2bf62a5fe1379e335d2b51a090cf95c704f75921ced946f3581d675e5ab1013289903de0e5c5fe5724e204ccc4325a5ad959e32aebad18b307091b"}' ========= master_lag: 0.67 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 11:56:23.187251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:56:23.187566) ========= 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.wvf3MaufSl/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.AS00e8ZIOm/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005246 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:56:23.310691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 11:56:23.310994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 11:56:23.316389) ========= ========= Total master_lag: 2.94 =========