builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0119 starttime: 1479955824.61 results: success (0) buildid: 20161123172836 builduid: 201ab6d47fba471c92850b76f917e570 revision: 08b67f1167751fd9cde52cd0f3da8da46e65426e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.611180) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.611813) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.612082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.637246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.637552) ========= 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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-23 18:50:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.36M=0.001s 2016-11-23 18:50:24 (8.36 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108023 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.768462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.768786) ========= 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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.019883 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:24.817124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 18:50:24.817473) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08b67f1167751fd9cde52cd0f3da8da46e65426e --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 08b67f1167751fd9cde52cd0f3da8da46e65426e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-23 18:50:24,890 truncating revision to first 12 chars 2016-11-23 18:50:24,890 Setting DEBUG logging. 2016-11-23 18:50:24,890 attempt 1/10 2016-11-23 18:50:24,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08b67f116775?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 18:50:26,133 unpacking tar archive at: mozilla-aurora-08b67f116775/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 18:50:26.341931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:26.342297) ========= script_repo_revision: 08b67f1167751fd9cde52cd0f3da8da46e65426e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:26.342903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:26.343172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 18:50:26.363066) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-23 18:50:26.363709) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:50:26 INFO - MultiFileLogger online at 20161123 18:50:26 in /builds/slave/test 18:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:50:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:50:26 INFO - {'append_to_log': False, 18:50:26 INFO - 'base_work_dir': '/builds/slave/test', 18:50:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:50:26 INFO - 'branch': 'Mozilla-Aurora', 18:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:50:26 INFO - 'config_files': ('talos/mac_config.py',), 18:50:26 INFO - 'default_actions': ('clobber', 18:50:26 INFO - 'read-buildbot-config', 18:50:26 INFO - 'download-and-extract', 18:50:26 INFO - 'populate-webroot', 18:50:26 INFO - 'create-virtualenv', 18:50:26 INFO - 'install', 18:50:26 INFO - 'run-tests'), 18:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:50:26 INFO - 'download_minidump_stackwalk': True, 18:50:26 INFO - 'download_symbols': 'ondemand', 18:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:50:26 INFO - 'installer_path': 'installer.exe', 18:50:26 INFO - 'log_level': 'info', 18:50:26 INFO - 'log_name': 'talos', 18:50:26 INFO - 'log_to_console': True, 18:50:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:50:26 INFO - 'opt_config_files': (), 18:50:26 INFO - 'pip_index': False, 18:50:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:50:26 INFO - 'cmd': ('bash', 18:50:26 INFO - '-c', 18:50:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:50:26 INFO - 'enabled': True, 18:50:26 INFO - 'halt_on_failure': False, 18:50:26 INFO - 'name': 'check_screen_resolution'},), 18:50:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:50:26 INFO - 'cmd': ('bash', 18:50:26 INFO - '-c', 18:50:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:50:26 INFO - 'enabled': True, 18:50:26 INFO - 'halt_on_failure': False, 18:50:26 INFO - 'name': 'check_screen_resolution'},), 18:50:26 INFO - 'run_cmd_checks_enabled': True, 18:50:26 INFO - 'sps_profile': False, 18:50:26 INFO - 'sps_profile_interval': 0, 18:50:26 INFO - 'suite': 'dromaeojs-e10s', 18:50:26 INFO - 'system_bits': '32', 18:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:50:26 INFO - 'title': 't-yosemite-r7-0119', 18:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:50:26 INFO - 'use_talos_json': True, 18:50:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:50:26 INFO - 'work_dir': 'build'} 18:50:26 INFO - [mozharness: 2016-11-24 02:50:26.563604Z] Running clobber step. 18:50:26 INFO - Running pre-action listener: _resource_record_pre_action 18:50:26 INFO - Running main action method: clobber 18:50:26 INFO - rmtree: /builds/slave/test/build 18:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:50:27 INFO - Running post-action listener: _resource_record_post_action 18:50:27 INFO - [mozharness: 2016-11-24 02:50:27.650550Z] Finished clobber step (success) 18:50:27 INFO - [mozharness: 2016-11-24 02:50:27.650671Z] Running read-buildbot-config step. 18:50:27 INFO - Running pre-action listener: _resource_record_pre_action 18:50:27 INFO - Running main action method: read_buildbot_config 18:50:27 INFO - Using buildbot properties: 18:50:27 INFO - { 18:50:27 INFO - "project": "", 18:50:27 INFO - "product": "firefox", 18:50:27 INFO - "script_repo_revision": "production", 18:50:27 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:50:27 INFO - "repository": "", 18:50:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:50:27 INFO - "buildid": "20161123172836", 18:50:27 INFO - "pgo_build": "False", 18:50:27 INFO - "basedir": "/builds/slave/test", 18:50:27 INFO - "buildnumber": 46, 18:50:27 INFO - "slavename": "t-yosemite-r7-0119", 18:50:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:50:27 INFO - "platform": "yosemite_r7", 18:50:27 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:50:27 INFO - "branch": "mozilla-aurora", 18:50:27 INFO - "repo_path": "releases/mozilla-aurora", 18:50:27 INFO - "revision": "08b67f1167751fd9cde52cd0f3da8da46e65426e", 18:50:27 INFO - "stage_platform": "macosx64", 18:50:27 INFO - "builduid": "201ab6d47fba471c92850b76f917e570", 18:50:27 INFO - "slavebuilddir": "test" 18:50:27 INFO - } 18:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 18:50:27 INFO - Running post-action listener: _resource_record_post_action 18:50:27 INFO - [mozharness: 2016-11-24 02:50:27.654093Z] Finished read-buildbot-config step (success) 18:50:27 INFO - [mozharness: 2016-11-24 02:50:27.654179Z] Running download-and-extract step. 18:50:27 INFO - Running pre-action listener: _resource_record_pre_action 18:50:27 INFO - Running main action method: download_and_extract 18:50:27 INFO - mkdir: /builds/slave/test/build/tests 18:50:27 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')]} 18:50:27 INFO - trying https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 18:50:27 INFO - Downloading https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 18:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 18:50:29 INFO - Downloaded 1199 bytes. 18:50:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 18:50:29 INFO - Using the following test package requirements: 18:50:29 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 18:50:29 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 18:50:29 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 18:50:29 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'jsshell-mac.zip'], 18:50:29 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 18:50:29 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 18:50:29 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 18:50:29 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 18:50:29 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 18:50:29 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 18:50:29 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 18:50:29 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:50:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 18:50:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:50:29 INFO - Fetch https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 18:50:29 INFO - Http code: 200 18:50:29 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 18:50:29 INFO - x-amz-cf-id: buEILa1oXZR2KPoZ9-OAmexfzWsEb5dJY3_ruY-O_smh3tFS_M5Agg== 18:50:29 INFO - x-amz-version-id: GT9VnpllLq1V3zERb4gqLI3Xk2pzYsJw 18:50:29 INFO - Expected file size: 16278222 18:50:29 INFO - Obtained file size: 16278222 18:50:36 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:50:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 18:50:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:50:36 INFO - Fetch https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 18:50:36 INFO - Http code: 200 18:50:36 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:50:36 INFO - x-amz-cf-id: qWp2zatKzs6i2hRnLGLHjbtSwqnrFhgafSVdiZ9630eILVSMq1k8nw== 18:50:36 INFO - x-amz-version-id: GT9VnpllLq1V3zERb4gqLI3Xk2pzYsJw 18:50:37 INFO - Expected file size: 16278222 18:50:37 INFO - Obtained file size: 16278222 18:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 18:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 18:50:44 INFO - Http code: 200 18:50:44 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 18:50:44 INFO - x-amz-cf-id: -zvewhaU83866W_l6dmi1N2AJpyYMeRWnGJvRYjOsHtf5e9G2scTiA== 18:50:44 INFO - x-amz-version-id: jcTLXVySg8l0qreUpXxSrcHjKGychCdj 18:50:44 INFO - Expected file size: 14409038 18:50:44 INFO - Obtained file size: 14409038 18:50: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')]} 18:50:44 INFO - trying https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 18:50:44 INFO - Downloading https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 18:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 18:50:48 INFO - Downloaded 109691542 bytes. 18:50:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 18:50:48 INFO - mkdir: /builds/slave/test/properties 18:50:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:50:48 INFO - Writing to file /builds/slave/test/properties/build_url 18:50:48 INFO - Contents: 18:50:48 INFO - build_url:https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 18:50:48 INFO - Running post-action listener: _resource_record_post_action 18:50:48 INFO - Running post-action listener: set_extra_try_arguments 18:50:48 INFO - [mozharness: 2016-11-24 02:50:48.749746Z] Finished download-and-extract step (success) 18:50:48 INFO - [mozharness: 2016-11-24 02:50:48.749868Z] Running populate-webroot step. 18:50:48 INFO - Running pre-action listener: _resource_record_pre_action 18:50:48 INFO - Running main action method: populate_webroot 18:50:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:50:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:50:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:50:48 INFO - '--tppagecycles', 18:50:48 INFO - '7'], 18:50:48 INFO - 'tests': ['tsvgm']}}, 18:50:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:50:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:50:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:50:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:50:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['damp', 'tps']}, 18:50:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'tests': ['damp', 'tps']}, 18:50:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['dromaeo_dom']}, 18:50:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:50:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['basic_compositor_video']}, 18:50:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:50:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['a11yr', 18:50:48 INFO - 'ts_paint', 18:50:48 INFO - 'tpaint', 18:50:48 INFO - 'sessionrestore', 18:50:48 INFO - 'sessionrestore_no_auto_restore', 18:50:48 INFO - 'tabpaint']}, 18:50:48 INFO - 'other-e10s': {'tests': ['a11yr', 18:50:48 INFO - 'ts_paint', 18:50:48 INFO - 'tpaint', 18:50:48 INFO - 'sessionrestore', 18:50:48 INFO - 'sessionrestore_no_auto_restore', 18:50:48 INFO - 'tabpaint']}, 18:50:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:50:48 INFO - 'ts_paint', 18:50:48 INFO - 'tpaint', 18:50:48 INFO - 'sessionrestore', 18:50:48 INFO - 'sessionrestore_no_auto_restore', 18:50:48 INFO - 'tabpaint']}, 18:50:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:50:48 INFO - 'ts_paint', 18:50:48 INFO - 'tpaint', 18:50:48 INFO - 'sessionrestore', 18:50:48 INFO - 'sessionrestore_no_auto_restore', 18:50:48 INFO - 'tabpaint']}, 18:50:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['a11yr', 18:50:48 INFO - 'ts_paint', 18:50:48 INFO - 'tpaint', 18:50:48 INFO - 'sessionrestore', 18:50:48 INFO - 'sessionrestore_no_auto_restore', 18:50:48 INFO - 'tabpaint']}, 18:50:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['a11yr', 18:50:48 INFO - 'ts_paint', 18:50:48 INFO - 'tpaint', 18:50:48 INFO - 'sessionrestore', 18:50:48 INFO - 'sessionrestore_no_auto_restore', 18:50:48 INFO - 'tabpaint']}, 18:50:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['tsvgx', 18:50:48 INFO - 'tsvgr_opacity', 18:50:48 INFO - 'tart', 18:50:48 INFO - 'tscrollx', 18:50:48 INFO - 'cart']}, 18:50:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:50:48 INFO - 'tsvgr_opacity', 18:50:48 INFO - 'tart', 18:50:48 INFO - 'tscrollx', 18:50:48 INFO - 'cart']}, 18:50:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'talos_options': ['--disable-e10s'], 18:50:48 INFO - 'tests': ['tp5o']}, 18:50:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'tests': ['tp5o']}, 18:50:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'talos_options': ['--disable-e10s', 18:50:48 INFO - '--xperf_path', 18:50:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:48 INFO - 'tests': ['tp5n']}, 18:50:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:48 INFO - 'talos_options': ['--xperf_path', 18:50:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:48 INFO - 'tests': ['tp5n']}}, 18:50:48 INFO - 'talos.zip': {'path': '', 18:50:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:50:48 INFO - Running post-action listener: _resource_record_post_action 18:50:48 INFO - [mozharness: 2016-11-24 02:50:48.768874Z] Finished populate-webroot step (success) 18:50:48 INFO - [mozharness: 2016-11-24 02:50:48.769003Z] Running create-virtualenv step. 18:50:48 INFO - Running pre-action listener: _resource_record_pre_action 18:50:48 INFO - Running main action method: create_virtualenv 18:50:48 INFO - Creating virtualenv /builds/slave/test/build/venv 18:50:48 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 18:50:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:50:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:50:48 INFO - Using real prefix '/tools/python27' 18:50:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:50:49 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:52 INFO - Installing pip.................done. 18:50:52 INFO - Return code: 0 18:50:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:50:52 INFO - Reading from file tmpfile_stdout 18:50:52 INFO - Output received: 18:50:52 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) 18:50:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:50: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', 'pip>=1.5'] in /builds/slave/test/build 18:50: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 pip>=1.5 18:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:52 INFO - 'HOME': '/Users/cltbld', 18:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:52 INFO - 'LOGNAME': 'cltbld', 18:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:52 INFO - 'MOZ_NO_REMOTE': '1', 18:50:52 INFO - 'NO_EM_RESTART': '1', 18:50:52 INFO - 'PAGER': '/bin/cat', 18:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:52 INFO - 'PWD': '/builds/slave/test', 18:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:52 INFO - 'SHELL': '/bin/bash', 18:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:50:52 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:52 INFO - 'USER': 'cltbld', 18:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:52 INFO - 'XPC_FLAGS': '0x0', 18:50:52 INFO - 'XPC_SERVICE_NAME': '0', 18:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:52 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 18:50:52 INFO - Cleaning up... 18:50:52 INFO - Return code: 0 18:50:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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', '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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:50: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 psutil>=3.1.1 18:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:53 INFO - 'HOME': '/Users/cltbld', 18:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:53 INFO - 'LOGNAME': 'cltbld', 18:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:53 INFO - 'MOZ_NO_REMOTE': '1', 18:50:53 INFO - 'NO_EM_RESTART': '1', 18:50:53 INFO - 'PAGER': '/bin/cat', 18:50:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:53 INFO - 'PWD': '/builds/slave/test', 18:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:53 INFO - 'SHELL': '/bin/bash', 18:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:50:53 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:53 INFO - 'USER': 'cltbld', 18:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:53 INFO - 'XPC_FLAGS': '0x0', 18:50:53 INFO - 'XPC_SERVICE_NAME': '0', 18:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:53 INFO - Downloading/unpacking psutil>=3.1.1 18:50:53 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 18:50:53 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 18:50:53 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 18:50:53 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 18:50:53 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 18:50:53 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 18:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:56 INFO - Installing collected packages: psutil 18:50:56 INFO - Running setup.py install for psutil 18:50:56 INFO - building 'psutil._psutil_osx' extension 18:50:56 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 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 INFO - building 'psutil._psutil_posix' extension 18:50:57 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 18:50:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:50:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:50:57 INFO - ^ 18:50:57 INFO - 1 warning generated. 18:50:57 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 18:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:57 INFO - Successfully installed psutil 18:50:57 INFO - Cleaning up... 18:50:57 INFO - Return code: 0 18:50:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50:57 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')]} 18:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:57 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')]} 18:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:57 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:50:57 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 18:50:57 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 18:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:57 INFO - 'HOME': '/Users/cltbld', 18:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:57 INFO - 'LOGNAME': 'cltbld', 18:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:57 INFO - 'MOZ_NO_REMOTE': '1', 18:50:57 INFO - 'NO_EM_RESTART': '1', 18:50:57 INFO - 'PAGER': '/bin/cat', 18:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:57 INFO - 'PWD': '/builds/slave/test', 18:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:57 INFO - 'SHELL': '/bin/bash', 18:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:50:57 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:57 INFO - 'USER': 'cltbld', 18:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:57 INFO - 'XPC_FLAGS': '0x0', 18:50:57 INFO - 'XPC_SERVICE_NAME': '0', 18:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 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 18:50:57 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 18:51:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:51:00 INFO - Installing collected packages: mozsystemmonitor 18:51:00 INFO - Running setup.py install for mozsystemmonitor 18:51:00 INFO - Successfully installed mozsystemmonitor 18:51:00 INFO - Cleaning up... 18:51:00 INFO - Return code: 0 18:51:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:00 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:00 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 18:51:00 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 18:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:00 INFO - 'HOME': '/Users/cltbld', 18:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:00 INFO - 'LOGNAME': 'cltbld', 18:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:00 INFO - 'MOZ_NO_REMOTE': '1', 18:51:00 INFO - 'NO_EM_RESTART': '1', 18:51:00 INFO - 'PAGER': '/bin/cat', 18:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:00 INFO - 'PWD': '/builds/slave/test', 18:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:00 INFO - 'SHELL': '/bin/bash', 18:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:00 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:00 INFO - 'USER': 'cltbld', 18:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:00 INFO - 'XPC_FLAGS': '0x0', 18:51:00 INFO - 'XPC_SERVICE_NAME': '0', 18:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:00 INFO - Downloading/unpacking jsonschema==2.5.1 18:51:00 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 18:51:00 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 18:51:00 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 18:51:00 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 18:51:00 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 18:51:01 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 18:51:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:51:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:51:03 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 18:51:03 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 18:51:03 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 18:51:03 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 18:51:03 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 18:51:03 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 18:51:03 INFO - Downloading functools32-3.2.3-2.tar.gz 18:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:51:04 INFO - warning: no files found matching '*.txt' 18:51:04 INFO - no previously-included directories found matching 'build' 18:51:04 INFO - no previously-included directories found matching 'dist' 18:51:04 INFO - no previously-included directories found matching '.git*' 18:51:04 INFO - Installing collected packages: jsonschema, functools32 18:51:04 INFO - Running setup.py install for functools32 18:51:04 INFO - warning: no files found matching '*.txt' 18:51:04 INFO - no previously-included directories found matching 'build' 18:51:04 INFO - no previously-included directories found matching 'dist' 18:51:04 INFO - no previously-included directories found matching '.git*' 18:51:04 INFO - Successfully installed jsonschema functools32 18:51:04 INFO - Cleaning up... 18:51:04 INFO - Return code: 0 18:51:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:51:04 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')]} 18:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:04 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')]} 18:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:04 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:04 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 18:51:04 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 18:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:04 INFO - 'HOME': '/Users/cltbld', 18:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:04 INFO - 'LOGNAME': 'cltbld', 18:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:04 INFO - 'MOZ_NO_REMOTE': '1', 18:51:04 INFO - 'NO_EM_RESTART': '1', 18:51:04 INFO - 'PAGER': '/bin/cat', 18:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:04 INFO - 'PWD': '/builds/slave/test', 18:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:04 INFO - 'SHELL': '/bin/bash', 18:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:04 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:04 INFO - 'USER': 'cltbld', 18:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:04 INFO - 'XPC_FLAGS': '0x0', 18:51:04 INFO - 'XPC_SERVICE_NAME': '0', 18:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:51:04 INFO - Cleaning up... 18:51:04 INFO - Return code: 0 18:51:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:51:04 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')]} 18:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:04 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')]} 18:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:04 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:04 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 18:51:04 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 18:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:04 INFO - 'HOME': '/Users/cltbld', 18:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:04 INFO - 'LOGNAME': 'cltbld', 18:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:04 INFO - 'MOZ_NO_REMOTE': '1', 18:51:04 INFO - 'NO_EM_RESTART': '1', 18:51:04 INFO - 'PAGER': '/bin/cat', 18:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:04 INFO - 'PWD': '/builds/slave/test', 18:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:04 INFO - 'SHELL': '/bin/bash', 18:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:04 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:04 INFO - 'USER': 'cltbld', 18:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:04 INFO - 'XPC_FLAGS': '0x0', 18:51:04 INFO - 'XPC_SERVICE_NAME': '0', 18:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:04 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:04 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 18:51:04 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 18:51:04 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 18:51:04 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 18:51:04 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 18:51:04 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 18:51:07 INFO - Downloading blobuploader-1.2.4.tar.gz 18:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:51:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:51:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:08 INFO - Downloading docopt-0.6.1.tar.gz 18:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:51:08 INFO - Installing collected packages: blobuploader, requests, docopt 18:51:08 INFO - Running setup.py install for blobuploader 18:51:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:51:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:51:08 INFO - Running setup.py install for requests 18:51:09 INFO - Running setup.py install for docopt 18:51:09 INFO - Successfully installed blobuploader requests docopt 18:51:09 INFO - Cleaning up... 18:51:09 INFO - Return code: 0 18:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:09 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:09 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 18:51:09 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 18:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:09 INFO - 'HOME': '/Users/cltbld', 18:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:09 INFO - 'LOGNAME': 'cltbld', 18:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:09 INFO - 'MOZ_NO_REMOTE': '1', 18:51:09 INFO - 'NO_EM_RESTART': '1', 18:51:09 INFO - 'PAGER': '/bin/cat', 18:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:09 INFO - 'PWD': '/builds/slave/test', 18:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:09 INFO - 'SHELL': '/bin/bash', 18:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:09 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:09 INFO - 'USER': 'cltbld', 18:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:09 INFO - 'XPC_FLAGS': '0x0', 18:51:09 INFO - 'XPC_SERVICE_NAME': '0', 18:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-1UuZ9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-VXFuJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-RSTy43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-4Z39Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-UJ9uZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-3sDsu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-FQgybs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-OAl4Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-6RyRr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-foRIFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-rYASpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:11 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-I79D3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:11 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-6Rf1_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:11 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-eCISEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:11 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-wPTDgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:11 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-VRJhGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:11 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-sZsG3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:51:11 INFO - Running setup.py install for manifestparser 18:51:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:51:11 INFO - Running setup.py install for mozcrash 18:51:11 INFO - Running setup.py install for mozdebug 18:51:12 INFO - Running setup.py install for mozdevice 18:51:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Running setup.py install for mozfile 18:51:12 INFO - Running setup.py install for mozhttpd 18:51:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Running setup.py install for mozinfo 18:51:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Running setup.py install for mozInstall 18:51:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:51:12 INFO - Running setup.py install for mozleak 18:51:12 INFO - Running setup.py install for mozlog 18:51:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:51:13 INFO - Running setup.py install for moznetwork 18:51:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:51:13 INFO - Running setup.py install for mozprocess 18:51:13 INFO - Running setup.py install for mozprofile 18:51:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:51:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:51:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:51:13 INFO - Running setup.py install for mozrunner 18:51:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:51:13 INFO - Running setup.py install for mozscreenshot 18:51:13 INFO - Running setup.py install for moztest 18:51:14 INFO - Running setup.py install for mozversion 18:51:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:51:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:51:14 INFO - Cleaning up... 18:51:14 INFO - Return code: 0 18:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:14 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')]} 18:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:14 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')]} 18:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:14 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:14 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 18:51:14 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 18:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:14 INFO - 'HOME': '/Users/cltbld', 18:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:14 INFO - 'LOGNAME': 'cltbld', 18:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:14 INFO - 'MOZ_NO_REMOTE': '1', 18:51:14 INFO - 'NO_EM_RESTART': '1', 18:51:14 INFO - 'PAGER': '/bin/cat', 18:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:14 INFO - 'PWD': '/builds/slave/test', 18:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:14 INFO - 'SHELL': '/bin/bash', 18:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:14 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:14 INFO - 'USER': 'cltbld', 18:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:14 INFO - 'XPC_FLAGS': '0x0', 18:51:14 INFO - 'XPC_SERVICE_NAME': '0', 18:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:14 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-E9XREt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:14 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)) 18:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:14 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-0ZcvJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:14 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)) 18:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:14 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-V8znxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:14 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)) 18:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:14 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-DsY12n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:14 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-P6G4LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Ur1kTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-fwApOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-sXPATM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-gPj7gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ZFyhOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-7Oa7vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-1Rlp9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ll9DP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:15 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)) 18:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:15 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-xswH0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:16 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)) 18:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-0ve6x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:16 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)) 18:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-_Luu9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-huyBNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:16 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)) 18:51:16 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)) 18:51:16 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)) 18:51:16 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)) 18:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:51:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:18 INFO - Downloading blessings-1.6.tar.gz 18:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:51:18 INFO - Installing collected packages: blessings 18:51:18 INFO - Running setup.py install for blessings 18:51:19 INFO - Successfully installed blessings 18:51:19 INFO - Cleaning up... 18:51:19 INFO - Return code: 0 18:51:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:19 INFO - Reading from file tmpfile_stdout 18:51:19 INFO - Current package versions: 18:51:19 INFO - blessings == 1.6 18:51:19 INFO - blobuploader == 1.2.4 18:51:19 INFO - docopt == 0.6.1 18:51:19 INFO - functools32 == 3.2.3-2 18:51:19 INFO - jsonschema == 2.5.1 18:51:19 INFO - manifestparser == 1.1 18:51:19 INFO - mozInstall == 1.12 18:51:19 INFO - mozcrash == 1.0 18:51:19 INFO - mozdebug == 0.1 18:51:19 INFO - mozdevice == 0.48 18:51:19 INFO - mozfile == 1.2 18:51:19 INFO - mozhttpd == 0.7 18:51:19 INFO - mozinfo == 0.9 18:51:19 INFO - mozleak == 0.1 18:51:19 INFO - mozlog == 3.4 18:51:19 INFO - moznetwork == 0.27 18:51:19 INFO - mozprocess == 0.23 18:51:19 INFO - mozprofile == 0.28 18:51:19 INFO - mozrunner == 6.13 18:51:19 INFO - mozscreenshot == 0.1 18:51:19 INFO - mozsystemmonitor == 0.3 18:51:19 INFO - moztest == 0.7 18:51:19 INFO - mozversion == 1.4 18:51:19 INFO - psutil == 3.1.1 18:51:19 INFO - requests == 1.2.3 18:51:19 INFO - wsgiref == 0.1.2 18:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:19 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 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:19 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 18:51:19 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 18:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:19 INFO - 'HOME': '/Users/cltbld', 18:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:19 INFO - 'LOGNAME': 'cltbld', 18:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:19 INFO - 'MOZ_NO_REMOTE': '1', 18:51:19 INFO - 'NO_EM_RESTART': '1', 18:51:19 INFO - 'PAGER': '/bin/cat', 18:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:19 INFO - 'PWD': '/builds/slave/test', 18:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:19 INFO - 'SHELL': '/bin/bash', 18:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:19 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:19 INFO - 'USER': 'cltbld', 18:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:19 INFO - 'XPC_FLAGS': '0x0', 18:51:19 INFO - 'XPC_SERVICE_NAME': '0', 18:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 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)) 18:51:19 INFO - Cleaning up... 18:51:19 INFO - Return code: 0 18:51:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1069cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106945570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8a4dc670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, '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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 18:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:19 INFO - 'HOME': '/Users/cltbld', 18:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:19 INFO - 'LOGNAME': 'cltbld', 18:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:19 INFO - 'MOZ_NO_REMOTE': '1', 18:51:19 INFO - 'NO_EM_RESTART': '1', 18:51:19 INFO - 'PAGER': '/bin/cat', 18:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:19 INFO - 'PWD': '/builds/slave/test', 18:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:19 INFO - 'SHELL': '/bin/bash', 18:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:19 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:19 INFO - 'USER': 'cltbld', 18:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:19 INFO - 'XPC_FLAGS': '0x0', 18:51:19 INFO - 'XPC_SERVICE_NAME': '0', 18:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:51:19 INFO - Cleaning up... 18:51:19 INFO - Return code: 0 18:51:19 INFO - Running post-action listener: _resource_record_post_action 18:51:19 INFO - Running post-action listener: _start_resource_monitoring 18:51:19 INFO - Starting resource monitoring. 18:51:20 INFO - [mozharness: 2016-11-24 02:51:20.001541Z] Finished create-virtualenv step (success) 18:51:20 INFO - [mozharness: 2016-11-24 02:51:20.002532Z] Running install step. 18:51:20 INFO - Running pre-action listener: _resource_record_pre_action 18:51:20 INFO - Running main action method: install 18:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:20 INFO - Reading from file tmpfile_stdout 18:51:20 INFO - Detecting whether we're running mozinstall >=1.0... 18:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:51:20 INFO - Reading from file tmpfile_stdout 18:51:20 INFO - Output received: 18:51:20 INFO - Usage: mozinstall [options] installer 18:51:20 INFO - Options: 18:51:20 INFO - -h, --help show this help message and exit 18:51:20 INFO - -d DEST, --destination=DEST 18:51:20 INFO - Directory to install application into. [default: 18:51:20 INFO - "/builds/slave/test"] 18:51:20 INFO - --app=APP Application being installed. [default: firefox] 18:51:20 INFO - mkdir: /builds/slave/test/build/application 18:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:51:51 INFO - Reading from file tmpfile_stdout 18:51:51 INFO - Output received: 18:51:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:51:51 INFO - Running post-action listener: _resource_record_post_action 18:51:51 INFO - [mozharness: 2016-11-24 02:51:51.334710Z] Finished install step (success) 18:51:51 INFO - [mozharness: 2016-11-24 02:51:51.334852Z] Running run-tests step. 18:51:51 INFO - Running pre-action listener: _resource_record_pre_action 18:51:51 INFO - Running main action method: run_tests 18:51:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:51 INFO - 2016-11-23 18:51:51.349 screenresolution[1891:13967] starting screenresolution argv=screenresolution get 18:51:51 INFO - 2016-11-23 18:51:51.352 screenresolution[1891:13967] Display 0: 1600x1200x32@60 18:51:51 INFO - 2016-11-23 18:51:51.357 screenresolution[1892:13969] starting screenresolution argv=screenresolution list 18:51:51 INFO - Available Modes on Display 0 18:51:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:51 INFO - Intel Iris: 18:51:51 INFO - Chipset Model: Intel Iris 18:51:51 INFO - Type: GPU 18:51:51 INFO - Bus: Built-In 18:51:51 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:51 INFO - Vendor: Intel (0x8086) 18:51:51 INFO - Device ID: 0x0a2e 18:51:51 INFO - Revision ID: 0x0009 18:51:51 INFO - Displays: 18:51:51 INFO - Display: 18:51:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:51 INFO - Display Serial Number: 1600x1200 60 18:51:51 INFO - Main Display: Yes 18:51:51 INFO - Mirror: Off 18:51:51 INFO - Online: Yes 18:51:51 INFO - Rotation: Supported 18:51:51 INFO - Return code: 0 18:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:51:51 INFO - Python 2.7.3 18:51:51 INFO - Return code: 0 18:51:51 INFO - grabbing minidump binary from tooltool 18:51:51 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')]} 18:51:51 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 0x1067e3d30>, '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 0x106649db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067dbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:51:51 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 18:51:51 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 18:51:51 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 18:51:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:51:51 INFO - Return code: 0 18:51:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:51:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:51:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:51:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:51:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:51:51 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:51:51 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0119 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxeTUn36IP/Render', 18:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:51 INFO - 'HOME': '/Users/cltbld', 18:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:51 INFO - 'LOGNAME': 'cltbld', 18:51:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:51:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:51 INFO - 'MOZ_NO_REMOTE': '1', 18:51:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:51:51 INFO - 'NO_EM_RESTART': '1', 18:51:51 INFO - 'PAGER': '/bin/cat', 18:51:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:51 INFO - 'PWD': '/builds/slave/test', 18:51:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:51 INFO - 'SHELL': '/bin/bash', 18:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D5QzJ7Mdnn/Listeners', 18:51:51 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 18:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:51 INFO - 'USER': 'cltbld', 18:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:51 INFO - 'XPC_FLAGS': '0x0', 18:51:51 INFO - 'XPC_SERVICE_NAME': '0', 18:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:51:51 INFO - mozversion application_buildid: 20161123172836 18:51:51 INFO - mozversion application_changeset: 08b67f1167751fd9cde52cd0f3da8da46e65426e 18:51:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:51:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:51:51 INFO - mozversion application_name: Firefox 18:51:51 INFO - mozversion application_remotingname: firefox-dev 18:51:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:51:51 INFO - mozversion application_vendor: Mozilla 18:51:51 INFO - mozversion application_version: 52.0a2 18:51:51 INFO - mozversion platform_buildid: 20161123172836 18:51:51 INFO - mozversion platform_changeset: 08b67f1167751fd9cde52cd0f3da8da46e65426e 18:51:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:51:51 INFO - mozversion platform_version: 52.0a2 18:51:51 INFO - using testdate: 1479955911 18:51:51 INFO - actual date: 1479955911 18:51:51 INFO - starting webserver on 'localhost:49364' 18:51:51 INFO - SUITE-START | Running 2 tests 18:51:51 INFO - TEST-START | dromaeo_css 18:51:51 INFO - operating with platform_type : mac_ 18:51:51 INFO - Initialising browser for dromaeo_css test... 18:51:51 INFO - TEST-INFO | started process 1902 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmplAHDCP/profile http://localhost:49364/getInfo.html) 18:51:53 ERROR - PROCESS | 1902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 18:51:54 INFO - PROCESS | 1902 | __metrics Screen width/height:1600/1200 18:51:54 INFO - PROCESS | 1902 | colorDepth:24 18:51:54 INFO - PROCESS | 1902 | Browser inner width/height: 1024/689 18:51:54 INFO - PROCESS | 1902 | __metrics 18:51:55 ERROR - PROCESS | 1902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 18:51:55 INFO - TEST-INFO | 1902: exit 0 18:51:55 INFO - Browser initialized. 18:51:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:51:55 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmplAHDCP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:07 INFO - PROCESS | 1905 | RSS: Main: 229867520 18:52:07 INFO - PROCESS | 1905 | 18:52:57 INFO - PROCESS | 1905 | 1479955977618 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:55:11 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49364/tests/dromaeo/cssquery-ext.html) 18:55:13 INFO - PROCESS | 1905 | RSS: Main: 232312832 18:55:13 INFO - PROCESS | 1905 | 18:58:16 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-ext.html (next: http://localhost:49364/tests/dromaeo/cssquery-jquery.html) 18:58:16 INFO - PROCESS | 1905 | RSS: Main: 243470336 18:58:16 INFO - PROCESS | 1905 | 19:01:18 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49364/tests/dromaeo/cssquery-mootools.html) 19:01:19 INFO - PROCESS | 1905 | RSS: Main: 246423552 19:01:19 INFO - PROCESS | 1905 | 19:04:21 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49364/tests/dromaeo/cssquery-prototype.html) 19:04:21 INFO - PROCESS | 1905 | RSS: Main: 245665792 19:04:21 INFO - PROCESS | 1905 | 19:07:24 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49364/tests/dromaeo/cssquery-yui.html) 19:07:25 INFO - PROCESS | 1905 | RSS: Main: 249180160 19:07:25 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-yui.html (next: http://localhost:49364/tests/dromaeo/cssquery-dojo.html) 19:10:27 INFO - PROCESS | 1905 | RSS: Main: 250793984 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | __start_tp_report 19:10:27 INFO - PROCESS | 1905 | _x_x_mozilla_page_load 19:10:27 INFO - PROCESS | 1905 | _x_x_mozilla_page_load_details 19:10:27 INFO - PROCESS | 1905 | |i|pagename|runs| 19:10:27 INFO - PROCESS | 1905 | |0;dojo.html;3354.2620623462835;3367.2928684976155;3389.864405423783;3400.7959522428655;3410.113370523663;5603.859903502414;5634.126710359896;5665.915011274834;5669.801556945513;5700.572457065727;4109.547949725536;5682.232898558694;5730.570207234453;5732.312122545301;5747.137929310606;5143.125668636331;5197.298364720771;5199.428062913076;5256.397490789608;5276.551493123089;5248.0815857225025;5270.341207349082;5273.604479664022;5308.044551980642;5315.7873685052555;5153.458886816887;5176.120059589879;5271.209318602221;5283.128283833163;5324.494173053554;4711.623070154379;5082.856357319611;5241.711705856176;5244.60665450089;5261.421243663194;4261.382099595572;5074.112030394666;5155.355580552431;5158.2520534522655;5195.272661827347;5687.232223649796;5724.169995350692;5755.68343741094;5781.566382521328;5800.593958422912;5991.880162396771;5994;6076.878462430771;6091.664958427285;6186.536009799238;6136.21274067861;6145.770845830807;6163.907541386883;6171.290301615327;6193.071039344134;5771.163181338682;5783.132530120515;5786.594938354317;5796.8550786229835;5805.7387417566315;6129.509639228851;6183.165272688219;6193.566450348432;6216.160818289473;6270.968645156745;6018.247719035121;6092.208012958287;6110.450059494667;6117.357677443804;6122.123717501779;6174.598651087665;6199.256089269316;6263.091851681481;6265.780697675559;6269.965455699849;6072.635641861502;6170.290416602058;6192.721327540272;6204.100405441276;6240.095186197976;6026.668533230627;6049.667268300198;6099.786507472217;6112.938870611326;6135.845176233341;4778.378810754649;4805.975970120127;4847.854564363075;4849.903001940012;4854.732989685531;4333.025069359369;4351.10802285537;4353.978230108893;4354.303311470149;4364.432623758891;5591.944080559142;5834.5624078194305;5838.883222335529;5942.7920022799;5943;6111.014442317695;6133.671320645445;6193.907091393633;6207.317195108534;6257.2804127525005;5168.733660253187;5581.7209139543675;5724.542036637059;5746.9712651436475;5979.641221526722;5249.921251181236;5269.262303277545;5276.3932147802725;5287.867803304871;5313.946860531345;6306.747730090837;6374.713137908712;6401.231852177769;6417.807465776034;6422.582532135396;6093.664848433379;6268.279147897868;6302.180716506825;6309.7160627770945;6316.957701979306;6237.719302631302;6241.906371404341;6273.62358258506;6316.968415158079;6438.549301548846;6035.6076855004285;6193.318734939243;6196.318404975359;6206.4724498416335;6220.222472190976;6030.427109424598;6214;6269.561130720988;6308.116863639186;6312.43188113072;5928.199693041557;5951.732172052355;5962.1951036611235;5985.132155837467;6042.093685947143;6014.6391216527145;6039.912815693217;6042.456178943916;6046.153538504701;6084.11780291864;5148.253503241934;5405.324334458192;5958.195643588234;5962.970185149046;5984.640921544721;6021.578489505868;6084.8783024340155;6101.237345331833;6120.510359171345;6150.50795936333;5722.656640601577;5784.855378615568;5912.379200184091;5946.226990491208;5968.343482217039 19:10:27 INFO - PROCESS | 1905 | |1;ext.html;448.1954890970707;467.67730266116376;477.979513738169;500.42451181141683;520.7162096657327;37730.43404348934;39208;39232.21535569287;39487.60512394875;40235.59764402355;40449.7977510112;40753;40822.183556328855;40866.18267634653;40932.18135637286;9195.63217471302;9355.345125841193;9378.906210937907;9382.249420046413;9408;9386.342955993083;9453.385529940531;9491.240700743923;9516.09597088279;9525.904740952607;9462.29032822541;9479.289053320994;9489.857652135224;9510.381825181375;9533.285003624722;8110.3511719062335;9431.905680943171;9500.197441754699;9511.381760185566;9523.80952380952;9204.723858284262;9287.442753434816;9288.489133097677;9294.117058879396;9319.76700582484;38635;38640.22719545622;38786.612133878865;38846.417303740185;39086.41370379447;3235.7573182011442;3572.6427357264324;3870.767753934773;3898.8245528951265;3934.7245692801516;21400.357989260192;25277.24168274936;28098.578521322197;28201.85899070512;29647.851760741272;2625.501154780605;3229.9354012919844;3238.983805080983;3246;3321.0202990117973;400397;487479;491279;494500;496713.5164324191;47478.76260618675;54272.185917211275;54421;55229.44770552243;55858.720706396205;48175;58616;58631.41368586259;58670.70664646735;58685.11972320419;12392.194507357173;14348.354324055443;14686.853131468763;14697.55907322782;14732.631684207981;11298.54805807775;11495.77008459843;11533.019693326161;11578;11678.941605291919;14089.85910140906;14835.258237088103;14985.475508357154;14986.850131498764;15106.54680359591;5750.741216645261;6209.695963847552;6270.529710271748;6395.936040639534;6399.840003999844;847.9915200847912;938.9624415023322;947.5783276441917;1010.8483727440796;1012.1447376966452;28098.016569420382;28171.577426338623;28586.28378310848;29293.26766830846;29377.265568360534;966.1932286540817;980.3725615606018;1029.1406675425953;1031.257494603884;1051.5636011055478;14541.563753087425;15151.166685832164;15234.619134521725;15564.533064008097;15819.367225310858;668681;673879;674074;674354;674388;55269;55279.72360138174;55355;55452.72273638606;55688;1291.7599104859253;1317.1372750848209;1352.9729405412033;1363.9522616708368;1371.348609410542;26106.60840087362;29786.553201701558;29913.252168695955;30156;30429.543556847108;34219.65780342264;47905.76047119742;48016.75991620019;48068.759656201495;48150.277745834544;470951;472629;473592;474155.2584474111;474919;24529.141480048114;24731.381715457257;24890.875545622155;24922.501549968536;24960.375990599652;42196.57803421927;42793.572064280204;42864.78567607142;43461.565384345755;44141.77929110334;29126.70873291325;35885.820570896976;36645;36647.81676091602;37130.6286937138;35977.82011089928;36050.91847244587;37031.6296837039;37083.443748343256;37165;34729;35003.64996350004;35712.642873570934;35742.64257357393;36268.09329766777;28484.71818768119;31025.224369390944;32274.031779046665;32449.026529204162;32568;18910.432687019413;21043.158273668883;21840.781592183874;22059.558808824055;22789.430264243525 19:10:27 INFO - PROCESS | 1905 | |2;jquery.html;359.782331689328;369.9593044765077;376.617733001004;382.7894657938137;401.6544575671501;18536.536586585324;19084.713729294053;19391;19794.40616781497;19972.50068748282;10582.947085264583;11598.768024639503;11707.765844683101;11724.12069094817;11743.941280293586;4927.728974906378;5321.973390133063;5392.1911713242935;5395.29861118056;5398.082326004589;3834.9424758628643;4024.25551273014;5240;6327.7785277515295;6641.900371494407;5710.343310519281;6496.204554534577;6620.834479138012;6633.2703402625675;6656.467482601381;5839.591228613998;5937.050071988504;5953.047512398017;5979.5515336349945;5986.072158815369;5108.540231379194;5402.513773760341;5795.449432303924;5796.942030579682;5801.129830525413;12777.488900443972;12916.41876115577;12964.48142074316;12964.935175324157;18520.722189167172;2086.780888006768;2089.1956596710224;2237.3847192022163;2281.6919715838317;2710.037936532542;9657.855132173023;9695.66065187722;9869.85466104238;9909.950450247774;10170.9491452543;1673.3055781850517;1784.3041213926579;1811.845993090589;1812.4109664359137;1903.0674969265099;91476.54261728715;114981;121501;122269;123173;11307.773844523064;11435.656930292105;11612.187146899636;11816.88183118175;12103.152779305365;14540.781888271684;14557.344919478648;14569.927150364181;14581.052231604912;14624.756895663988;7900.920990790133;8166.959165204136;8171.673133074611;8246.175382461706;8262.462939908886;7831.177726338767;7883.093444253869;7899.052113746272;8008;8027.317677997319;3792.3363411402893;4404.097160082176;4483.08096840147;4527.773611319487;4634.328022436728;1393.7212557488542;1396.6717821311984;1659.2118743596936;1919.5680971781517;1974.5458544534838;713.1976526407791;803.9035315762146;941.6233506597279;945.5414124149781;982.2436723722693;19533.609327813647;20694.896525517277;20834.374968750657;20885.37343879686;20898.477538061365;918.6555041859302;928.0811996123924;942.8915674697361;948.5304774136708;1000.2548101664306;10276;10583.94708026455;10873.130149588014;10948.671539853816;10986.945065274622;588750;590463;594187;598769;625415;106137.93862061435;123235;126814.36592817161;128876;130945.69054309335;951.9190868776093;966.7003228999033;993.1508560181086;995.4127065031666;995.835687111633;14615.92692036533;15561.144137072117;17766.822331776515;17999.19003644813;18824.811751882306;51911.2213316793;52643.473565263856;52863;52871;53711.045892476286;67793.6610316965;67805.66097169483;69536;70160;79108;6873.931260687529;7800.219978002155;7991.520508769492;8215.79460513468;8254.463459875089;9683.32216744821;10472.266941314036;12420.0063994882;12471.750564988468;12592.559260425842;10793;10952.726181845517;11183.161262905152;11295.887041129483;11377.54489820398;10852.945735271272;10948.124150067817;11069.284260939567;11122;11291.830622540832;11106.278091924;11200.327980321206;11215.681962444682;11339;11668.241564298633;8009.479383840032;8022.799430014063;8163.551004694561;8388;8493.980722313116;9960.352577082467;10980;11049.668509944715;11091.944540277247;11405.828912566152 19:10:27 INFO - PROCESS | 1905 | |3;mootools.html;1463.2244910197596;1508.0273223770669;1679.3786299069345;1815.4825874625735;1826.5251034730975;7633.351165150969;7886.329661978739;8180.263776260135;8623.482591044542;8652.22130008299;8038.678452861878;8413.747587572367;8423.326133909288;8445.535495547743;8463.153684631534;2315.143396943133;2344.941376465585;2362.83460157789;2364;2370.3481542575755;2001;2347.6009078456705;2394.174009966559;2396.7243766966762;2400.2799160251943;2331.25399872041;2338.988305058481;2362.527494501098;2363.361892289081;2364.089825417218;2321.292005938188;2325.616273314901;2340.3096086654477;2348.8473249238914;2351.3651314145254;2341.227394959676;2367.348979030763;2370.454795397051;2371.466420055474;2376.5959786836106;8380.24577788002;8432.83134337316;8446.197611226924;8499.235068843773;8503.447275927045;5106.8212612558755;5164.715940623264;5285.075111855448;5309.044372013036;5322.0952438085615;3041.4829478988627;3410.8124053177066;3481.9129521761906;3598.7300952428673;3640.8179591020344;1043.2749239278705;1045.8194664125308;1090.738222826524;1100.499272830868;1104.8729396119388;10887.891121088845;11025.338479691245;11057.06014988719;11082.61210857616;11101.278416902956;4510.616597589176;4707.082118986765;4769.546893045155;4784.856454306377;4786.95213047872;9615.375000624937;9633.988431214762;9643.373180743369;9649.662261820802;9669.419834809934;5298.099323115002;5308.416074231832;5309.070912590359;5310.787568497217;5315.574754019669;4141.503019637663;4764.332993380929;4764.475907650156;4848.660593758403;4864.416270047546;3854.768713877176;3884.592117827644;3945.191235796655;3984.1633257015774;3991.1618560102124;1076.5155679944057;1308.4373719300602;1312.3307113372248;1320.6236222676491;1326.774448343784;870.4429165334191;875.6847534887436;888.9511076890833;889.7898857553722;894.190757364586;5544.390117087117;5580.967521008626;5731.426857314235;5823.359430462646;5865;879.2218886285683;938.483833891357;939.769756409684;956.5791051937125;975.2003357247131;3193.3134376109247;3712.5916149223563;3725.441183822394;3738.476613274144;3746.3818469952153;9191.632334706537;9512.28657850664;9939.950300248596;10282.794344113225;10303.072723454925;10083.49582520871;10180.287379883337;10182.694519164437;10231.283810133367;10261.127804136582;7512.286332798375;7875.606219689107;7890.132085470594;8032.0361556612415;8075.111737708848;4252.04329025979;4623.86128416148;5016.799328026838;5406.432324605859;5725.799597014085;7908.723194688158;9331.300152488726;9352.438853668802;9608.231341492525;9667.564959576695;9233.676821311223;9488.478133702713;9621.759456013655;9855.507224638883;9872.703818885446;6498.772542960974;7180.102487189101;7182.461315401261;7316.4146868249345;7377.225391334047;6709.6580683864395;7254.129504459499;7994.960655115031;8045.275925166763;8132.390070744599;7039.084918960502;7209.026781384446;7228.421726261991;7236.457265704988;7293.088363954505;6970.666852498054;7073.752418665528;7080.362767350963;7183.317584829433;7191.532550384209;6713;6734.764283250062;6780.491463140185;6809.931900681128;6832.180138383425;4707.458642256048;4714.882127946828;4742.78657460422;4750.168720473972;4762.738049407316;4582.908341833211;4638.466576343763;4682.321063445713;4817.9036419272115;4866.391701037371 19:10:27 INFO - PROCESS | 1905 | |4;prototype.html;303.54619843334217;305.72179316821683;308.8918878392564;310.3591084410691;316.28046194906585;4388.025388575138;5106.974465127679;5205.453427390122;5279;5375.9193612095805;4749.596284315829;4997.800087996476;5186.32577764891;5213.279617726151;5277.865258969321;4084.732973199873;4088.9386659200136;4098.221337945795;4100.692448066392;4131.5455299916985;3379.3748156590987;3543.0787995121327;3657.670809627133;3917.5886531914166;4029.992501874531;4057.7159598828093;4072.879958011541;4075.8369665213504;4077.3068578341754;4081.8367265309353;3554.928901421957;3881.9611803882162;4066.1867626474823;4070.3690927906073;4072.75563466193;3129.796563223406;3295.307985323085;3343.966560334414;3563.572371315459;3570.732195085353;5153.896922061538;5189.558887494568;5198.376194856603;5235.293235413246;5243.318368612094;3837.3668344723087;4229.38673892287;4594.356790049395;4617.746023968681;4621.514740952219;4652.62778977681;4881.560659540658;5130.666506677054;5539.14143307788;5609.102543593046;3798.696104311676;3823.7896915669626;3831.942520862189;3845.115893212334;3852.4799152114388;4708.505606911259;5418.322709661332;5867.207926929853;5870.6477611343025;5891.175235466995;3099.643540992815;3307.1897385140796;3629.564452265745;3763.736538442283;3849.88353377523;3323.9833800831325;3910.511186101737;3946.9802650987135;3954.367301231789;3968.0556527301414;3864.5555761087835;4281.7582900959;4324.13517296542;4372.103718737651;4615.26155815068;4718.551737584924;5559.8880223955375;5641.335805937259;5675.177099320658;5686.43135686428;1108.545496346494;1116.771159874621;1123.5955056179769;1150.6835620204342;1263.4819723913151;858.8582883824224;859.2653281444275;877.8024944387589;881.3125761905724;882.7307671160357;4123.505179378494;4484.39460672805;5004.574611158092;5084.059449001947;5216.739163041909;4716.64167916042;5065.3161823153405;5341.759620817073;5538.307711536058;5546.833594992157;4206.453161089039;4734.55021772931;4910.410750709938;5079.933214025096;5099.413567439718;2786.21985843964;2836.9432611347656;2851;2856.3858770364473;2886.769058475317;5278.416475057467;5670.262865827416;5737.110747834093;5800.230929566438;5800.883982320414;5016.724080175625;5204.869878253074;5261.1706725753775;5465.988792073479;5616.865591075447;4856.0135516657;5132.820351287762;5730.7421166047625;5839.883202335929;5932.851678708067;4836.322914791862;5299.708516031656;5400.972995135156;5501.779928802803;5534.612577119563;4653;5058.585454818057;5205.5835533158015;5292.417834038176;5734.340550836707;4780.593649539828;5487.314085739283;5843.802020585685;5908.025175846109;6189.81430557084;3710.2394009227505;3812.332841752627;3906.4921560196995;3943;3961.2869683457257;4822.807087716593;5112.565431938327;5505.8527174401215;5796.188533605215;5806.080895395676;5025.974870125626;5662.639767379177;5664.85837854057;5675.814811297598;5678.630888992202;5428.511433970803;5527.751251193626;5559.805406810742;5646.463585959327;5682.602217844711;5457.863553411038;5527;5527.723613819373;5547.805826796204;5552.444755524415;4692.366530518337;5404.86497835459;5634.7464364104535;5638.85902852432;5642.71786410686;4547.658925580528;5083.517065878736;5293;5531.6257083180035;5536.671198912151 19:10:27 INFO - PROCESS | 1905 | |5;yui.html;686.8763622547942;697.6860412814233;761.1247065874244;783.9647215875285;797.1629788721842;14236.359363828627;14852.1088734676;14873.033252838557;14874.77687834682;14935.701285974274;13256.93371533141;13407.128536645112;13409.463621455154;13410.128341657786;13438.731225375512;838.727413590584;856.07543852639;859.1451505751786;860.5783166248524;862.5342315149811;821.6261600971544;836.995815020924;839.1482645115213;848.007830837918;850.995745021274;882.2500874256863;899.3704406915153;899.536738579632;899.5547204133962;902.4810733828042;860.1054902901006;876.5310558850985;879.974829323837;881.7575166829141;887.6227603268617;657.4773055420904;666.6566718140161;668.5988406955836;669.504566620702;670.4837275297994;12382.81425778614;12415.44130514129;12540.561080362235;12585.622431327074;13573.321333933263;11739.706507337385;13227.933860330733;13637.863621363758;13644.249566273851;13685.589432317047;9886.703398898044;11035.227534072537;11241.381724005176;11282.605108821152;11349.03533199679;3584.0681422830253;3592.8203589820405;3660.158163622355;3717.6096509866343;3799.6580307772433;69575;80031.599842001;82669.58665206695;84303;87121.56439217826;10573;10698.625548105934;10801.405922674172;10893.564257429614;10931.836022459669;20904.386951631048;21050.789492104883;21123.577528449347;21194.04626791798;21207.363779086652;7120.145582530129;7249.601271929989;7344.375728063174;7495.1005879294835;7681.347085497795;3561.5726112866623;4069.89825254371;4098.631123198927;4174.415581818548;4239.1521695660995;3341.498775183742;3439.6904278615043;3441.1225137590254;3442.586889573217;3445.844936977842;492.61575970742877;575.5798267264836;590.1354515634616;612.8498517863063;620.3703241210176;532.7203218310418;540.5351397797891;669.6650679615542;671.4594751225311;672.7746205021373;8755;9082.682106126254;9085.798154182887;9129.45223286605;9408.294377921684;630.7098734582052;657.2179106862818;668.1714673804545;673.3905815237218;685.1812084558904;3852.7110466715108;4263.132684017237;4474.530174331713;4497.977510112429;4550.49944506104;117271;117568;119165.40417297858;119668;124131;80585.19414805894;89970;98115.09424528744;107635;108774;87023;89968;90140.09859901317;94210.99999999863;96754;8855.247303979233;8858.069902660129;8861.424007439497;8935.642574297215;9058.637654493747;48736.512634873194;59073.70463147657;60590;61196;62048.06927895995;82381;85675.57162214149;87634;88921.11078889128;89583.55208223917;11745.882541174478;11752.11859110553;11757;11787;11935.985441237592;12193.451294691582;12320.507179712711;12392.256464612152;12802.295873727035;12975.416106275052;11793.705157371134;11809.468573914366;12013.939930300292;12051.156419050581;12112.697182570506;11320.660380188607;11522.827157592475;11877.22798018126;11887.465064071965;11950.984166345957;11764.294142351486;11825.704357391134;11840.993515551274;11845.644630661094;11938.76122477563;9322.161005509537;9605.903940960501;9902.75243118899;10165.18678505703;10185.185185185019;9973.339191388646;10116.848247276444;10117.544710488193;10135.290529663147;10164.237682174014 19:10:27 INFO - PROCESS | 1905 | __end_tp_report 19:10:27 INFO - PROCESS | 1905 | __start_cc_report 19:10:27 INFO - PROCESS | 1905 | _x_x_mozilla_cycle_collect,369 19:10:27 INFO - PROCESS | 1905 | __end_cc_report 19:10:27 INFO - PROCESS | 1905 | __startTimestamp1479957027739__endTimestamp 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | ------- Summary: start ------- 19:10:27 INFO - PROCESS | 1905 | Number of tests: 6 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | [#0] dojo.html Cycles:165 Average:5695.05 Median:5958.20 stddev:659.78 (11.1%) stddev-sans-first:635.74 19:10:27 INFO - PROCESS | 1905 | Values: 3354.3 3367.3 3389.9 3400.8 3410.1 5603.9 5634.1 5665.9 5669.8 5700.6 4109.5 5682.2 5730.6 5732.3 5747.1 5143.1 5197.3 5199.4 5256.4 5276.6 5248.1 5270.3 5273.6 5308.0 5315.8 5153.5 5176.1 5271.2 5283.1 5324.5 4711.6 5082.9 5241.7 5244.6 5261.4 4261.4 5074.1 5155.4 5158.3 5195.3 5687.2 5724.2 5755.7 5781.6 5800.6 5991.9 5994.0 6076.9 6091.7 6186.5 6136.2 6145.8 6163.9 6171.3 6193.1 5771.2 5783.1 5786.6 5796.9 5805.7 6129.5 6183.2 6193.6 6216.2 6271.0 6018.2 6092.2 6110.5 6117.4 6122.1 6174.6 6199.3 6263.1 6265.8 6270.0 6072.6 6170.3 6192.7 6204.1 6240.1 6026.7 6049.7 6099.8 6112.9 6135.8 4778.4 4806.0 4847.9 4849.9 4854.7 4333.0 4351.1 4354.0 4354.3 4364.4 5591.9 5834.6 5838.9 5942.8 5943.0 6111.0 6133.7 6193.9 6207.3 6257.3 5168.7 5581.7 5724.5 5747.0 5979.6 5249.9 5269.3 5276.4 5287.9 5313.9 6306.7 6374.7 6401.2 6417.8 6422.6 6093.7 6268.3 6302.2 6309.7 6317.0 6237.7 6241.9 6273.6 6317.0 6438.5 6035.6 6193.3 6196.3 6206.5 6220.2 6030.4 6214.0 6269.6 6308.1 6312.4 5928.2 5951.7 5962.2 5985.1 6042.1 6014.6 6039.9 6042.5 6046.2 6084.1 5148.3 5405.3 5958.2 5963.0 5984.6 6021.6 6084.9 6101.2 6120.5 6150.5 5722.7 5784.9 5912.4 5946.2 5968.3 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | [#1] ext.html Cycles:180 Average:66154.20 Median:39147.21 stddev:146937.81 (375.3%) stddev-sans-first:147267.19 19:10:27 INFO - PROCESS | 1905 | Values: 448.2 467.7 478.0 500.4 520.7 37730.4 39208.0 39232.2 39487.6 40235.6 40449.8 40753.0 40822.2 40866.2 40932.2 9195.6 9355.3 9378.9 9382.2 9408.0 9386.3 9453.4 9491.2 9516.1 9525.9 9462.3 9479.3 9489.9 9510.4 9533.3 8110.4 9431.9 9500.2 9511.4 9523.8 9204.7 9287.4 9288.5 9294.1 9319.8 38635.0 38640.2 38786.6 38846.4 39086.4 3235.8 3572.6 3870.8 3898.8 3934.7 21400.4 25277.2 28098.6 28201.9 29647.9 2625.5 3229.9 3239.0 3246.0 3321.0 400397.0 487479.0 491279.0 494500.0 496713.5 47478.8 54272.2 54421.0 55229.4 55858.7 48175.0 58616.0 58631.4 58670.7 58685.1 12392.2 14348.4 14686.9 14697.6 14732.6 11298.5 11495.8 11533.0 11578.0 11678.9 14089.9 14835.3 14985.5 14986.9 15106.5 5750.7 6209.7 6270.5 6395.9 6399.8 848.0 939.0 947.6 1010.8 1012.1 28098.0 28171.6 28586.3 29293.3 29377.3 966.2 980.4 1029.1 1031.3 1051.6 14541.6 15151.2 15234.6 15564.5 15819.4 668681.0 673879.0 674074.0 674354.0 674388.0 55269.0 55279.7 55355.0 55452.7 55688.0 1291.8 1317.1 1353.0 1364.0 1371.3 26106.6 29786.6 29913.3 30156.0 30429.5 34219.7 47905.8 48016.8 48068.8 48150.3 470951.0 472629.0 473592.0 474155.3 474919.0 24529.1 24731.4 24890.9 24922.5 24960.4 42196.6 42793.6 42864.8 43461.6 44141.8 29126.7 35885.8 36645.0 36647.8 37130.6 35977.8 36050.9 37031.6 37083.4 37165.0 34729.0 35003.6 35712.6 35742.6 36268.1 28484.7 31025.2 32274.0 32449.0 32568.0 18910.4 21043.2 21840.8 22059.6 22789.4 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | [#2] jquery.html Cycles:180 Average:33890.47 Median:373.29 stddev:99958.11 (26777.7%) stddev-sans-first:100206.81 19:10:27 INFO - PROCESS | 1905 | Values: 359.8 370.0 376.6 382.8 401.7 18536.5 19084.7 19391.0 19794.4 19972.5 10582.9 11598.8 11707.8 11724.1 11743.9 4927.7 5322.0 5392.2 5395.3 5398.1 3834.9 4024.3 5240.0 6327.8 6641.9 5710.3 6496.2 6620.8 6633.3 6656.5 5839.6 5937.1 5953.0 5979.6 5986.1 5108.5 5402.5 5795.4 5796.9 5801.1 12777.5 12916.4 12964.5 12964.9 18520.7 2086.8 2089.2 2237.4 2281.7 2710.0 9657.9 9695.7 9869.9 9910.0 10170.9 1673.3 1784.3 1811.8 1812.4 1903.1 91476.5 114981.0 121501.0 122269.0 123173.0 11307.8 11435.7 11612.2 11816.9 12103.2 14540.8 14557.3 14569.9 14581.1 14624.8 7900.9 8167.0 8171.7 8246.2 8262.5 7831.2 7883.1 7899.1 8008.0 8027.3 3792.3 4404.1 4483.1 4527.8 4634.3 1393.7 1396.7 1659.2 1919.6 1974.5 713.2 803.9 941.6 945.5 982.2 19533.6 20694.9 20834.4 20885.4 20898.5 918.7 928.1 942.9 948.5 1000.3 10276.0 10583.9 10873.1 10948.7 10986.9 588750.0 590463.0 594187.0 598769.0 625415.0 106137.9 123235.0 126814.4 128876.0 130945.7 951.9 966.7 993.2 995.4 995.8 14615.9 15561.1 17766.8 17999.2 18824.8 51911.2 52643.5 52863.0 52871.0 53711.0 67793.7 67805.7 69536.0 70160.0 79108.0 6873.9 7800.2 7991.5 8215.8 8254.5 9683.3 10472.3 12420.0 12471.8 12592.6 10793.0 10952.7 11183.2 11295.9 11377.5 10852.9 10948.1 11069.3 11122.0 11291.8 11106.3 11200.3 11215.7 11339.0 11668.2 8009.5 8022.8 8163.6 8388.0 8494.0 9960.4 10980.0 11049.7 11091.9 11405.8 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | [#3] mootools.html Cycles:180 Average:5467.28 Median:5135.77 stddev:2999.93 (58.4%) stddev-sans-first:2993.26 19:10:27 INFO - PROCESS | 1905 | Values: 1463.2 1508.0 1679.4 1815.5 1826.5 7633.4 7886.3 8180.3 8623.5 8652.2 8038.7 8413.7 8423.3 8445.5 8463.2 2315.1 2344.9 2362.8 2364.0 2370.3 2001.0 2347.6 2394.2 2396.7 2400.3 2331.3 2339.0 2362.5 2363.4 2364.1 2321.3 2325.6 2340.3 2348.8 2351.4 2341.2 2367.3 2370.5 2371.5 2376.6 8380.2 8432.8 8446.2 8499.2 8503.4 5106.8 5164.7 5285.1 5309.0 5322.1 3041.5 3410.8 3481.9 3598.7 3640.8 1043.3 1045.8 1090.7 1100.5 1104.9 10887.9 11025.3 11057.1 11082.6 11101.3 4510.6 4707.1 4769.5 4784.9 4787.0 9615.4 9634.0 9643.4 9649.7 9669.4 5298.1 5308.4 5309.1 5310.8 5315.6 4141.5 4764.3 4764.5 4848.7 4864.4 3854.8 3884.6 3945.2 3984.2 3991.2 1076.5 1308.4 1312.3 1320.6 1326.8 870.4 875.7 889.0 889.8 894.2 5544.4 5581.0 5731.4 5823.4 5865.0 879.2 938.5 939.8 956.6 975.2 3193.3 3712.6 3725.4 3738.5 3746.4 9191.6 9512.3 9940.0 10282.8 10303.1 10083.5 10180.3 10182.7 10231.3 10261.1 7512.3 7875.6 7890.1 8032.0 8075.1 4252.0 4623.9 5016.8 5406.4 5725.8 7908.7 9331.3 9352.4 9608.2 9667.6 9233.7 9488.5 9621.8 9855.5 9872.7 6498.8 7180.1 7182.5 7316.4 7377.2 6709.7 7254.1 7995.0 8045.3 8132.4 7039.1 7209.0 7228.4 7236.5 7293.1 6970.7 7073.8 7080.4 7183.3 7191.5 6713.0 6734.8 6780.5 6809.9 6832.2 4707.5 4714.9 4742.8 4750.2 4762.7 4582.9 4638.5 4682.3 4817.9 4866.4 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | [#4] prototype.html Cycles:180 Average:4436.23 Median:5010.65 stddev:1370.25 (27.3%) stddev-sans-first:1338.52 19:10:27 INFO - PROCESS | 1905 | Values: 303.5 305.7 308.9 310.4 316.3 4388.0 5107.0 5205.5 5279.0 5375.9 4749.6 4997.8 5186.3 5213.3 5277.9 4084.7 4088.9 4098.2 4100.7 4131.5 3379.4 3543.1 3657.7 3917.6 4030.0 4057.7 4072.9 4075.8 4077.3 4081.8 3554.9 3882.0 4066.2 4070.4 4072.8 3129.8 3295.3 3344.0 3563.6 3570.7 5153.9 5189.6 5198.4 5235.3 5243.3 3837.4 4229.4 4594.4 4617.7 4621.5 4652.6 4881.6 5130.7 5539.1 5609.1 3798.7 3823.8 3831.9 3845.1 3852.5 4708.5 5418.3 5867.2 5870.6 5891.2 3099.6 3307.2 3629.6 3763.7 3849.9 3324.0 3910.5 3947.0 3954.4 3968.1 3864.6 4281.8 4324.1 4372.1 4615.3 4718.6 5559.9 5641.3 5675.2 5686.4 1108.5 1116.8 1123.6 1150.7 1263.5 858.9 859.3 877.8 881.3 882.7 4123.5 4484.4 5004.6 5084.1 5216.7 4716.6 5065.3 5341.8 5538.3 5546.8 4206.5 4734.6 4910.4 5079.9 5099.4 2786.2 2836.9 2851.0 2856.4 2886.8 5278.4 5670.3 5737.1 5800.2 5800.9 5016.7 5204.9 5261.2 5466.0 5616.9 4856.0 5132.8 5730.7 5839.9 5932.9 4836.3 5299.7 5401.0 5501.8 5534.6 4653.0 5058.6 5205.6 5292.4 5734.3 4780.6 5487.3 5843.8 5908.0 6189.8 3710.2 3812.3 3906.5 3943.0 3961.3 4822.8 5112.6 5505.9 5796.2 5806.1 5026.0 5662.6 5664.9 5675.8 5678.6 5428.5 5527.8 5559.8 5646.5 5682.6 5457.9 5527.0 5527.7 5547.8 5552.4 4692.4 5404.9 5634.7 5638.9 5642.7 4547.7 5083.5 5293.0 5531.6 5536.7 19:10:27 INFO - PROCESS | 1905 | 19:10:27 INFO - PROCESS | 1905 | [#5] yui.html Cycles:180 Average:21064.39 Median:4524.24 stddev:31887.29 (704.8%) stddev-sans-first:31940.04 19:10:27 INFO - PROCESS | 1905 | Values: 686.9 697.7 761.1 784.0 797.2 14236.4 14852.1 14873.0 14874.8 14935.7 13256.9 13407.1 13409.5 13410.1 13438.7 838.7 856.1 859.1 860.6 862.5 821.6 837.0 839.1 848.0 851.0 882.3 899.4 899.5 899.6 902.5 860.1 876.5 880.0 881.8 887.6 657.5 666.7 668.6 669.5 670.5 12382.8 12415.4 12540.6 12585.6 13573.3 11739.7 13227.9 13637.9 13644.2 13685.6 9886.7 11035.2 11241.4 11282.6 11349.0 3584.1 3592.8 3660.2 3717.6 3799.7 69575.0 80031.6 82669.6 84303.0 87121.6 10573.0 10698.6 10801.4 10893.6 10931.8 20904.4 21050.8 21123.6 21194.0 21207.4 7120.1 7249.6 7344.4 7495.1 7681.3 3561.6 4069.9 4098.6 4174.4 4239.2 3341.5 3439.7 3441.1 3442.6 3445.8 492.6 575.6 590.1 612.8 620.4 532.7 540.5 669.7 671.5 672.8 8755.0 9082.7 9085.8 9129.5 9408.3 630.7 657.2 668.2 673.4 685.2 3852.7 4263.1 4474.5 4498.0 4550.5 117271.0 117568.0 119165.4 119668.0 124131.0 80585.2 89970.0 98115.1 107635.0 108774.0 87023.0 89968.0 90140.1 94211.0 96754.0 8855.2 8858.1 8861.4 8935.6 9058.6 48736.5 59073.7 60590.0 61196.0 62048.1 82381.0 85675.6 87634.0 88921.1 89583.6 11745.9 11752.1 11757.0 11787.0 11936.0 12193.5 12320.5 12392.3 12802.3 12975.4 11793.7 11809.5 12013.9 12051.2 12112.7 11320.7 11522.8 11877.2 11887.5 11951.0 11764.3 11825.7 11841.0 11845.6 11938.8 9322.2 9605.9 9902.8 10165.2 10185.2 9973.3 10116.8 10117.5 10135.3 10164.2 19:10:27 INFO - PROCESS | 1905 | -------- Summary: end -------- 19:10:27 INFO - PROCESS | 1905 | 19:10:28 INFO - TEST-INFO | 1905: exit 0 19:10:28 INFO - TEST-OK | dromaeo_css | took 1116465ms 19:10:28 INFO - TEST-START | kraken 19:10:28 INFO - operating with platform_type : mac_ 19:10:28 INFO - Initialising browser for kraken test... 19:10:28 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpzSdG0y/profile http://localhost:49364/getInfo.html) 19:10:30 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 19:10:31 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 19:10:31 INFO - PROCESS | 1911 | colorDepth:24 19:10:31 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 19:10:31 INFO - PROCESS | 1911 | __metrics 19:10:31 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 19:10:32 INFO - TEST-INFO | 1911: exit 0 19:10:32 INFO - Browser initialized. 19:10:32 INFO - Running cycle 1/1 for kraken test... 19:10:32 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpzSdG0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:44 INFO - PROCESS | 1913 | RSS: Main: 229728256 19:10:44 INFO - PROCESS | 1913 | 19:10:47 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-beat-detection) 19:10:48 INFO - PROCESS | 1913 | RSS: Main: 241655808 19:10:48 INFO - PROCESS | 1913 | 19:10:50 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-dft) 19:10:51 INFO - PROCESS | 1913 | RSS: Main: 249229312 19:10:51 INFO - PROCESS | 1913 | 19:10:54 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-fft) 19:10:55 INFO - PROCESS | 1913 | RSS: Main: 253063168 19:10:55 INFO - PROCESS | 1913 | 19:10:57 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-oscillator) 19:10:57 INFO - PROCESS | 1913 | RSS: Main: 254693376 19:10:57 INFO - PROCESS | 1913 | 19:10:59 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:11:00 INFO - PROCESS | 1913 | RSS: Main: 254377984 19:11:00 INFO - PROCESS | 1913 | 19:11:03 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49364/tests/kraken/driver.html?testName=imaging-darkroom) 19:11:04 INFO - PROCESS | 1913 | RSS: Main: 258486272 19:11:04 INFO - PROCESS | 1913 | 19:11:07 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49364/tests/kraken/driver.html?testName=imaging-desaturate) 19:11:07 INFO - PROCESS | 1913 | RSS: Main: 258023424 19:11:07 INFO - PROCESS | 1913 | 19:11:10 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49364/tests/kraken/driver.html?testName=json-parse-financial) 19:11:11 INFO - PROCESS | 1913 | RSS: Main: 257998848 19:11:11 INFO - PROCESS | 1913 | 19:11:13 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:11:13 INFO - PROCESS | 1913 | RSS: Main: 256987136 19:11:13 INFO - PROCESS | 1913 | 19:11:15 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:11:16 INFO - PROCESS | 1913 | RSS: Main: 257044480 19:11:16 INFO - PROCESS | 1913 | 19:11:18 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:11:19 INFO - PROCESS | 1913 | RSS: Main: 257118208 19:11:19 INFO - PROCESS | 1913 | 19:11:22 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:11:23 INFO - PROCESS | 1913 | RSS: Main: 257388544 19:11:23 INFO - PROCESS | 1913 | 19:11:26 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:11:26 INFO - PROCESS | 1913 | RSS: Main: 257421312 19:11:26 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49364/tests/kraken/driver.html?testName=ai-astar) 19:11:28 INFO - PROCESS | 1913 | RSS: Main: 258961408 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | __start_tp_report 19:11:28 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 19:11:28 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 19:11:28 INFO - PROCESS | 1913 | |i|pagename|runs| 19:11:28 INFO - PROCESS | 1913 | |0;ai-astar;107;120;121;122;120;121;123;132;125;122 19:11:28 INFO - PROCESS | 1913 | |1;audio-beat-detection;144;118;116;147;116;116;116;119;142;118 19:11:28 INFO - PROCESS | 1913 | |2;audio-dft;196;199;229;280;202;199;199;197;198;198 19:11:28 INFO - PROCESS | 1913 | |3;audio-fft;83;58;60;88;61;58;60;60;76;58 19:11:28 INFO - PROCESS | 1913 | |4;audio-oscillator;87;73;90;71;70;70;84;71;71;89 19:11:28 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;99;131;136;130;84;121;77;131;97;130 19:11:28 INFO - PROCESS | 1913 | |6;imaging-darkroom;108;95;96;95;97;96;94;134;103;101 19:11:28 INFO - PROCESS | 1913 | |7;imaging-desaturate;88;125;102;142;139;90;133;137;90;86 19:11:28 INFO - PROCESS | 1913 | |8;json-parse-financial;56;57;60;89;91;58;59;59;60;59 19:11:28 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;69;110;104;103;84;73;68;74;71;72 19:11:28 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;84;86;87;86;85;89;86;85;87;88 19:11:28 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;154;162;159;150;149;149;176;169;210;167 19:11:28 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;180;203;198;216;170;170;171;167;170;170 19:11:28 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;67;69;67;68;70;66;67;66;70;69 19:11:28 INFO - PROCESS | 1913 | __end_tp_report 19:11:28 INFO - PROCESS | 1913 | __start_cc_report 19:11:28 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,968 19:11:28 INFO - PROCESS | 1913 | __end_cc_report 19:11:28 INFO - PROCESS | 1913 | __startTimestamp1479957088662__endTimestamp 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | ------- Summary: start ------- 19:11:28 INFO - PROCESS | 1913 | Number of tests: 14 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:121.30 Median:122.00 stddev:6.15 (5.0%) stddev-sans-first:3.76 19:11:28 INFO - PROCESS | 1913 | Values: 107.0 120.0 121.0 122.0 120.0 121.0 123.0 132.0 125.0 122.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:118.50 stddev:13.30 (11.2%) stddev-sans-first:12.24 19:11:28 INFO - PROCESS | 1913 | Values: 144.0 118.0 116.0 147.0 116.0 116.0 116.0 119.0 142.0 118.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:209.70 Median:199.00 stddev:26.54 (13.3%) stddev-sans-first:27.68 19:11:28 INFO - PROCESS | 1913 | Values: 196.0 199.0 229.0 280.0 202.0 199.0 199.0 197.0 198.0 198.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:11.54 (19.1%) stddev-sans-first:10.51 19:11:28 INFO - PROCESS | 1913 | Values: 83.0 58.0 60.0 88.0 61.0 58.0 60.0 60.0 76.0 58.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:8.69 (11.1%) stddev-sans-first:8.53 19:11:28 INFO - PROCESS | 1913 | Values: 87.0 73.0 90.0 71.0 70.0 70.0 84.0 71.0 71.0 89.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:106.50 stddev:22.12 (20.8%) stddev-sans-first:22.82 19:11:28 INFO - PROCESS | 1913 | Values: 99.0 131.0 136.0 130.0 84.0 121.0 77.0 131.0 97.0 130.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:101.90 Median:95.00 stddev:12.11 (12.8%) stddev-sans-first:12.65 19:11:28 INFO - PROCESS | 1913 | Values: 108.0 95.0 96.0 95.0 97.0 96.0 94.0 134.0 103.0 101.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:113.20 Median:114.00 stddev:23.97 (21.0%) stddev-sans-first:23.62 19:11:28 INFO - PROCESS | 1913 | Values: 88.0 125.0 102.0 142.0 139.0 90.0 133.0 137.0 90.0 86.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:59.50 stddev:13.35 (22.4%) stddev-sans-first:13.77 19:11:28 INFO - PROCESS | 1913 | Values: 56.0 57.0 60.0 89.0 91.0 58.0 59.0 59.0 60.0 59.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:82.80 Median:71.50 stddev:16.46 (23.0%) stddev-sans-first:16.68 19:11:28 INFO - PROCESS | 1913 | Values: 69.0 110.0 104.0 103.0 84.0 73.0 68.0 74.0 71.0 72.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.49 (1.7%) stddev-sans-first:1.33 19:11:28 INFO - PROCESS | 1913 | Values: 84.0 86.0 87.0 86.0 85.0 89.0 86.0 85.0 87.0 88.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:164.50 Median:164.50 stddev:18.46 (11.2%) stddev-sans-first:19.18 19:11:28 INFO - PROCESS | 1913 | Values: 154.0 162.0 159.0 150.0 149.0 149.0 176.0 169.0 210.0 167.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:175.50 stddev:17.56 (10.0%) stddev-sans-first:18.62 19:11:28 INFO - PROCESS | 1913 | Values: 180.0 203.0 198.0 216.0 170.0 170.0 171.0 167.0 170.0 170.0 19:11:28 INFO - PROCESS | 1913 | 19:11:28 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.52 (2.2%) stddev-sans-first:1.58 19:11:28 INFO - PROCESS | 1913 | Values: 67.0 69.0 67.0 68.0 70.0 66.0 67.0 66.0 70.0 69.0 19:11:28 INFO - PROCESS | 1913 | -------- Summary: end -------- 19:11:28 INFO - PROCESS | 1913 | 19:11:29 INFO - TEST-INFO | 1913: exit 0 19:11:29 INFO - TEST-OK | kraken | took 61364ms 19:11:29 INFO - SUITE-END | took 1177s 19:11:29 INFO - Completed test suite (00:19:37) 19:11:29 INFO - javascript benchmark 19:11:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7043.446087884627, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.2620623462835, 3367.2928684976155, 3389.864405423783, 3400.7959522428655, 3410.113370523663, 5603.859903502414, 5634.126710359896, 5665.915011274834, 5669.801556945513, 5700.572457065727, 4109.547949725536, 5682.232898558694, 5730.570207234453, 5732.312122545301, 5747.137929310606, 5143.125668636331, 5197.298364720771, 5199.428062913076, 5256.397490789608, 5276.551493123089, 5248.0815857225025, 5270.341207349082, 5273.604479664022, 5308.044551980642, 5315.7873685052555, 5153.458886816887, 5176.120059589879, 5271.209318602221, 5283.128283833163, 5324.494173053554, 4711.623070154379, 5082.856357319611, 5241.711705856176, 5244.60665450089, 5261.421243663194, 4261.382099595572, 5074.112030394666, 5155.355580552431, 5158.2520534522655, 5195.272661827347, 5687.232223649796, 5724.169995350692, 5755.68343741094, 5781.566382521328, 5800.593958422912, 5991.880162396771, 5994.0, 6076.878462430771, 6091.664958427285, 6186.536009799238, 6136.21274067861, 6145.770845830807, 6163.907541386883, 6171.290301615327, 6193.071039344134, 5771.163181338682, 5783.132530120515, 5786.594938354317, 5796.8550786229835, 5805.7387417566315, 6129.509639228851, 6183.165272688219, 6193.566450348432, 6216.160818289473, 6270.968645156745, 6018.247719035121, 6092.208012958287, 6110.450059494667, 6117.357677443804, 6122.123717501779, 6174.598651087665, 6199.256089269316, 6263.091851681481, 6265.780697675559, 6269.965455699849, 6072.635641861502, 6170.290416602058, 6192.721327540272, 6204.100405441276, 6240.095186197976, 6026.668533230627, 6049.667268300198, 6099.786507472217, 6112.938870611326, 6135.845176233341, 4778.378810754649, 4805.975970120127, 4847.854564363075, 4849.903001940012, 4854.732989685531, 4333.025069359369, 4351.10802285537, 4353.978230108893, 4354.303311470149, 4364.432623758891, 5591.944080559142, 5834.5624078194305, 5838.883222335529, 5942.7920022799, 5943.0, 6111.014442317695, 6133.671320645445, 6193.907091393633, 6207.317195108534, 6257.2804127525005, 5168.733660253187, 5581.7209139543675, 5724.542036637059, 5746.9712651436475, 5979.641221526722, 5249.921251181236, 5269.262303277545, 5276.3932147802725, 5287.867803304871, 5313.946860531345, 6306.747730090837, 6374.713137908712, 6401.231852177769, 6417.807465776034, 6422.582532135396, 6093.664848433379, 6268.279147897868, 6302.180716506825, 6309.7160627770945, 6316.957701979306, 6237.719302631302, 6241.906371404341, 6273.62358258506, 6316.968415158079, 6438.549301548846, 6035.6076855004285, 6193.318734939243, 6196.318404975359, 6206.4724498416335, 6220.222472190976, 6030.427109424598, 6214.0, 6269.561130720988, 6308.116863639186, 6312.43188113072, 5928.199693041557, 5951.732172052355, 5962.1951036611235, 5985.132155837467, 6042.093685947143, 6014.6391216527145, 6039.912815693217, 6042.456178943916, 6046.153538504701, 6084.11780291864, 5148.253503241934, 5405.324334458192, 5958.195643588234, 5962.970185149046, 5984.640921544721, 6021.578489505868, 6084.8783024340155, 6101.237345331833, 6120.510359171345, 6150.50795936333, 5722.656640601577, 5784.855378615568, 5912.379200184091, 5946.226990491208, 5968.343482217039], "value": 5653.034981265926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.1954890970707, 467.67730266116376, 477.979513738169, 500.42451181141683, 520.7162096657327, 37730.43404348934, 39208.0, 39232.21535569287, 39487.60512394875, 40235.59764402355, 40449.7977510112, 40753.0, 40822.183556328855, 40866.18267634653, 40932.18135637286, 9195.63217471302, 9355.345125841193, 9378.906210937907, 9382.249420046413, 9408.0, 9386.342955993083, 9453.385529940531, 9491.240700743923, 9516.09597088279, 9525.904740952607, 9462.29032822541, 9479.289053320994, 9489.857652135224, 9510.381825181375, 9533.285003624722, 8110.3511719062335, 9431.905680943171, 9500.197441754699, 9511.381760185566, 9523.80952380952, 9204.723858284262, 9287.442753434816, 9288.489133097677, 9294.117058879396, 9319.76700582484, 38635.0, 38640.22719545622, 38786.612133878865, 38846.417303740185, 39086.41370379447, 3235.7573182011442, 3572.6427357264324, 3870.767753934773, 3898.8245528951265, 3934.7245692801516, 21400.357989260192, 25277.24168274936, 28098.578521322197, 28201.85899070512, 29647.851760741272, 2625.501154780605, 3229.9354012919844, 3238.983805080983, 3246.0, 3321.0202990117973, 400397.0, 487479.0, 491279.0, 494500.0, 496713.5164324191, 47478.76260618675, 54272.185917211275, 54421.0, 55229.44770552243, 55858.720706396205, 48175.0, 58616.0, 58631.41368586259, 58670.70664646735, 58685.11972320419, 12392.194507357173, 14348.354324055443, 14686.853131468763, 14697.55907322782, 14732.631684207981, 11298.54805807775, 11495.77008459843, 11533.019693326161, 11578.0, 11678.941605291919, 14089.85910140906, 14835.258237088103, 14985.475508357154, 14986.850131498764, 15106.54680359591, 5750.741216645261, 6209.695963847552, 6270.529710271748, 6395.936040639534, 6399.840003999844, 847.9915200847912, 938.9624415023322, 947.5783276441917, 1010.8483727440796, 1012.1447376966452, 28098.016569420382, 28171.577426338623, 28586.28378310848, 29293.26766830846, 29377.265568360534, 966.1932286540817, 980.3725615606018, 1029.1406675425953, 1031.257494603884, 1051.5636011055478, 14541.563753087425, 15151.166685832164, 15234.619134521725, 15564.533064008097, 15819.367225310858, 668681.0, 673879.0, 674074.0, 674354.0, 674388.0, 55269.0, 55279.72360138174, 55355.0, 55452.72273638606, 55688.0, 1291.7599104859253, 1317.1372750848209, 1352.9729405412033, 1363.9522616708368, 1371.348609410542, 26106.60840087362, 29786.553201701558, 29913.252168695955, 30156.0, 30429.543556847108, 34219.65780342264, 47905.76047119742, 48016.75991620019, 48068.759656201495, 48150.277745834544, 470951.0, 472629.0, 473592.0, 474155.2584474111, 474919.0, 24529.141480048114, 24731.381715457257, 24890.875545622155, 24922.501549968536, 24960.375990599652, 42196.57803421927, 42793.572064280204, 42864.78567607142, 43461.565384345755, 44141.77929110334, 29126.70873291325, 35885.820570896976, 36645.0, 36647.81676091602, 37130.6286937138, 35977.82011089928, 36050.91847244587, 37031.6296837039, 37083.443748343256, 37165.0, 34729.0, 35003.64996350004, 35712.642873570934, 35742.64257357393, 36268.09329766777, 28484.71818768119, 31025.224369390944, 32274.031779046665, 32449.026529204162, 32568.0, 18910.432687019413, 21043.158273668883, 21840.781592183874, 22059.558808824055, 22789.430264243525], "value": 18704.254351029245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.782331689328, 369.9593044765077, 376.617733001004, 382.7894657938137, 401.6544575671501, 18536.536586585324, 19084.713729294053, 19391.0, 19794.40616781497, 19972.50068748282, 10582.947085264583, 11598.768024639503, 11707.765844683101, 11724.12069094817, 11743.941280293586, 4927.728974906378, 5321.973390133063, 5392.1911713242935, 5395.29861118056, 5398.082326004589, 3834.9424758628643, 4024.25551273014, 5240.0, 6327.7785277515295, 6641.900371494407, 5710.343310519281, 6496.204554534577, 6620.834479138012, 6633.2703402625675, 6656.467482601381, 5839.591228613998, 5937.050071988504, 5953.047512398017, 5979.5515336349945, 5986.072158815369, 5108.540231379194, 5402.513773760341, 5795.449432303924, 5796.942030579682, 5801.129830525413, 12777.488900443972, 12916.41876115577, 12964.48142074316, 12964.935175324157, 18520.722189167172, 2086.780888006768, 2089.1956596710224, 2237.3847192022163, 2281.6919715838317, 2710.037936532542, 9657.855132173023, 9695.66065187722, 9869.85466104238, 9909.950450247774, 10170.9491452543, 1673.3055781850517, 1784.3041213926579, 1811.845993090589, 1812.4109664359137, 1903.0674969265099, 91476.54261728715, 114981.0, 121501.0, 122269.0, 123173.0, 11307.773844523064, 11435.656930292105, 11612.187146899636, 11816.88183118175, 12103.152779305365, 14540.781888271684, 14557.344919478648, 14569.927150364181, 14581.052231604912, 14624.756895663988, 7900.920990790133, 8166.959165204136, 8171.673133074611, 8246.175382461706, 8262.462939908886, 7831.177726338767, 7883.093444253869, 7899.052113746272, 8008.0, 8027.317677997319, 3792.3363411402893, 4404.097160082176, 4483.08096840147, 4527.773611319487, 4634.328022436728, 1393.7212557488542, 1396.6717821311984, 1659.2118743596936, 1919.5680971781517, 1974.5458544534838, 713.1976526407791, 803.9035315762146, 941.6233506597279, 945.5414124149781, 982.2436723722693, 19533.609327813647, 20694.896525517277, 20834.374968750657, 20885.37343879686, 20898.477538061365, 918.6555041859302, 928.0811996123924, 942.8915674697361, 948.5304774136708, 1000.2548101664306, 10276.0, 10583.94708026455, 10873.130149588014, 10948.671539853816, 10986.945065274622, 588750.0, 590463.0, 594187.0, 598769.0, 625415.0, 106137.93862061435, 123235.0, 126814.36592817161, 128876.0, 130945.69054309335, 951.9190868776093, 966.7003228999033, 993.1508560181086, 995.4127065031666, 995.835687111633, 14615.92692036533, 15561.144137072117, 17766.822331776515, 17999.19003644813, 18824.811751882306, 51911.2213316793, 52643.473565263856, 52863.0, 52871.0, 53711.045892476286, 67793.6610316965, 67805.66097169483, 69536.0, 70160.0, 79108.0, 6873.931260687529, 7800.219978002155, 7991.520508769492, 8215.79460513468, 8254.463459875089, 9683.32216744821, 10472.266941314036, 12420.0063994882, 12471.750564988468, 12592.559260425842, 10793.0, 10952.726181845517, 11183.161262905152, 11295.887041129483, 11377.54489820398, 10852.945735271272, 10948.124150067817, 11069.284260939567, 11122.0, 11291.830622540832, 11106.278091924, 11200.327980321206, 11215.681962444682, 11339.0, 11668.241564298633, 8009.479383840032, 8022.799430014063, 8163.551004694561, 8388.0, 8493.980722313116, 9960.352577082467, 10980.0, 11049.668509944715, 11091.944540277247, 11405.828912566152], "value": 9020.436477348063, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.2244910197596, 1508.0273223770669, 1679.3786299069345, 1815.4825874625735, 1826.5251034730975, 7633.351165150969, 7886.329661978739, 8180.263776260135, 8623.482591044542, 8652.22130008299, 8038.678452861878, 8413.747587572367, 8423.326133909288, 8445.535495547743, 8463.153684631534, 2315.143396943133, 2344.941376465585, 2362.83460157789, 2364.0, 2370.3481542575755, 2001.0, 2347.6009078456705, 2394.174009966559, 2396.7243766966762, 2400.2799160251943, 2331.25399872041, 2338.988305058481, 2362.527494501098, 2363.361892289081, 2364.089825417218, 2321.292005938188, 2325.616273314901, 2340.3096086654477, 2348.8473249238914, 2351.3651314145254, 2341.227394959676, 2367.348979030763, 2370.454795397051, 2371.466420055474, 2376.5959786836106, 8380.24577788002, 8432.83134337316, 8446.197611226924, 8499.235068843773, 8503.447275927045, 5106.8212612558755, 5164.715940623264, 5285.075111855448, 5309.044372013036, 5322.0952438085615, 3041.4829478988627, 3410.8124053177066, 3481.9129521761906, 3598.7300952428673, 3640.8179591020344, 1043.2749239278705, 1045.8194664125308, 1090.738222826524, 1100.499272830868, 1104.8729396119388, 10887.891121088845, 11025.338479691245, 11057.06014988719, 11082.61210857616, 11101.278416902956, 4510.616597589176, 4707.082118986765, 4769.546893045155, 4784.856454306377, 4786.95213047872, 9615.375000624937, 9633.988431214762, 9643.373180743369, 9649.662261820802, 9669.419834809934, 5298.099323115002, 5308.416074231832, 5309.070912590359, 5310.787568497217, 5315.574754019669, 4141.503019637663, 4764.332993380929, 4764.475907650156, 4848.660593758403, 4864.416270047546, 3854.768713877176, 3884.592117827644, 3945.191235796655, 3984.1633257015774, 3991.1618560102124, 1076.5155679944057, 1308.4373719300602, 1312.3307113372248, 1320.6236222676491, 1326.774448343784, 870.4429165334191, 875.6847534887436, 888.9511076890833, 889.7898857553722, 894.190757364586, 5544.390117087117, 5580.967521008626, 5731.426857314235, 5823.359430462646, 5865.0, 879.2218886285683, 938.483833891357, 939.769756409684, 956.5791051937125, 975.2003357247131, 3193.3134376109247, 3712.5916149223563, 3725.441183822394, 3738.476613274144, 3746.3818469952153, 9191.632334706537, 9512.28657850664, 9939.950300248596, 10282.794344113225, 10303.072723454925, 10083.49582520871, 10180.287379883337, 10182.694519164437, 10231.283810133367, 10261.127804136582, 7512.286332798375, 7875.606219689107, 7890.132085470594, 8032.0361556612415, 8075.111737708848, 4252.04329025979, 4623.86128416148, 5016.799328026838, 5406.432324605859, 5725.799597014085, 7908.723194688158, 9331.300152488726, 9352.438853668802, 9608.231341492525, 9667.564959576695, 9233.676821311223, 9488.478133702713, 9621.759456013655, 9855.507224638883, 9872.703818885446, 6498.772542960974, 7180.102487189101, 7182.461315401261, 7316.4146868249345, 7377.225391334047, 6709.6580683864395, 7254.129504459499, 7994.960655115031, 8045.275925166763, 8132.390070744599, 7039.084918960502, 7209.026781384446, 7228.421726261991, 7236.457265704988, 7293.088363954505, 6970.666852498054, 7073.752418665528, 7080.362767350963, 7183.317584829433, 7191.532550384209, 6713.0, 6734.764283250062, 6780.491463140185, 6809.931900681128, 6832.180138383425, 4707.458642256048, 4714.882127946828, 4742.78657460422, 4750.168720473972, 4762.738049407316, 4582.908341833211, 4638.466576343763, 4682.321063445713, 4817.9036419272115, 4866.391701037371], "value": 4441.759988782364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.54619843334217, 305.72179316821683, 308.8918878392564, 310.3591084410691, 316.28046194906585, 4388.025388575138, 5106.974465127679, 5205.453427390122, 5279.0, 5375.9193612095805, 4749.596284315829, 4997.800087996476, 5186.32577764891, 5213.279617726151, 5277.865258969321, 4084.732973199873, 4088.9386659200136, 4098.221337945795, 4100.692448066392, 4131.5455299916985, 3379.3748156590987, 3543.0787995121327, 3657.670809627133, 3917.5886531914166, 4029.992501874531, 4057.7159598828093, 4072.879958011541, 4075.8369665213504, 4077.3068578341754, 4081.8367265309353, 3554.928901421957, 3881.9611803882162, 4066.1867626474823, 4070.3690927906073, 4072.75563466193, 3129.796563223406, 3295.307985323085, 3343.966560334414, 3563.572371315459, 3570.732195085353, 5153.896922061538, 5189.558887494568, 5198.376194856603, 5235.293235413246, 5243.318368612094, 3837.3668344723087, 4229.38673892287, 4594.356790049395, 4617.746023968681, 4621.514740952219, 4652.62778977681, 4881.560659540658, 5130.666506677054, 5539.14143307788, 5609.102543593046, 3798.696104311676, 3823.7896915669626, 3831.942520862189, 3845.115893212334, 3852.4799152114388, 4708.505606911259, 5418.322709661332, 5867.207926929853, 5870.6477611343025, 5891.175235466995, 3099.643540992815, 3307.1897385140796, 3629.564452265745, 3763.736538442283, 3849.88353377523, 3323.9833800831325, 3910.511186101737, 3946.9802650987135, 3954.367301231789, 3968.0556527301414, 3864.5555761087835, 4281.7582900959, 4324.13517296542, 4372.103718737651, 4615.26155815068, 4718.551737584924, 5559.8880223955375, 5641.335805937259, 5675.177099320658, 5686.43135686428, 1108.545496346494, 1116.771159874621, 1123.5955056179769, 1150.6835620204342, 1263.4819723913151, 858.8582883824224, 859.2653281444275, 877.8024944387589, 881.3125761905724, 882.7307671160357, 4123.505179378494, 4484.39460672805, 5004.574611158092, 5084.059449001947, 5216.739163041909, 4716.64167916042, 5065.3161823153405, 5341.759620817073, 5538.307711536058, 5546.833594992157, 4206.453161089039, 4734.55021772931, 4910.410750709938, 5079.933214025096, 5099.413567439718, 2786.21985843964, 2836.9432611347656, 2851.0, 2856.3858770364473, 2886.769058475317, 5278.416475057467, 5670.262865827416, 5737.110747834093, 5800.230929566438, 5800.883982320414, 5016.724080175625, 5204.869878253074, 5261.1706725753775, 5465.988792073479, 5616.865591075447, 4856.0135516657, 5132.820351287762, 5730.7421166047625, 5839.883202335929, 5932.851678708067, 4836.322914791862, 5299.708516031656, 5400.972995135156, 5501.779928802803, 5534.612577119563, 4653.0, 5058.585454818057, 5205.5835533158015, 5292.417834038176, 5734.340550836707, 4780.593649539828, 5487.314085739283, 5843.802020585685, 5908.025175846109, 6189.81430557084, 3710.2394009227505, 3812.332841752627, 3906.4921560196995, 3943.0, 3961.2869683457257, 4822.807087716593, 5112.565431938327, 5505.8527174401215, 5796.188533605215, 5806.080895395676, 5025.974870125626, 5662.639767379177, 5664.85837854057, 5675.814811297598, 5678.630888992202, 5428.511433970803, 5527.751251193626, 5559.805406810742, 5646.463585959327, 5682.602217844711, 5457.863553411038, 5527.0, 5527.723613819373, 5547.805826796204, 5552.444755524415, 4692.366530518337, 5404.86497835459, 5634.7464364104535, 5638.85902852432, 5642.71786410686, 4547.658925580528, 5083.517065878736, 5293.0, 5531.6257083180035, 5536.671198912151], "value": 3997.178295462856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.8763622547942, 697.6860412814233, 761.1247065874244, 783.9647215875285, 797.1629788721842, 14236.359363828627, 14852.1088734676, 14873.033252838557, 14874.77687834682, 14935.701285974274, 13256.93371533141, 13407.128536645112, 13409.463621455154, 13410.128341657786, 13438.731225375512, 838.727413590584, 856.07543852639, 859.1451505751786, 860.5783166248524, 862.5342315149811, 821.6261600971544, 836.995815020924, 839.1482645115213, 848.007830837918, 850.995745021274, 882.2500874256863, 899.3704406915153, 899.536738579632, 899.5547204133962, 902.4810733828042, 860.1054902901006, 876.5310558850985, 879.974829323837, 881.7575166829141, 887.6227603268617, 657.4773055420904, 666.6566718140161, 668.5988406955836, 669.504566620702, 670.4837275297994, 12382.81425778614, 12415.44130514129, 12540.561080362235, 12585.622431327074, 13573.321333933263, 11739.706507337385, 13227.933860330733, 13637.863621363758, 13644.249566273851, 13685.589432317047, 9886.703398898044, 11035.227534072537, 11241.381724005176, 11282.605108821152, 11349.03533199679, 3584.0681422830253, 3592.8203589820405, 3660.158163622355, 3717.6096509866343, 3799.6580307772433, 69575.0, 80031.599842001, 82669.58665206695, 84303.0, 87121.56439217826, 10573.0, 10698.625548105934, 10801.405922674172, 10893.564257429614, 10931.836022459669, 20904.386951631048, 21050.789492104883, 21123.577528449347, 21194.04626791798, 21207.363779086652, 7120.145582530129, 7249.601271929989, 7344.375728063174, 7495.1005879294835, 7681.347085497795, 3561.5726112866623, 4069.89825254371, 4098.631123198927, 4174.415581818548, 4239.1521695660995, 3341.498775183742, 3439.6904278615043, 3441.1225137590254, 3442.586889573217, 3445.844936977842, 492.61575970742877, 575.5798267264836, 590.1354515634616, 612.8498517863063, 620.3703241210176, 532.7203218310418, 540.5351397797891, 669.6650679615542, 671.4594751225311, 672.7746205021373, 8755.0, 9082.682106126254, 9085.798154182887, 9129.45223286605, 9408.294377921684, 630.7098734582052, 657.2179106862818, 668.1714673804545, 673.3905815237218, 685.1812084558904, 3852.7110466715108, 4263.132684017237, 4474.530174331713, 4497.977510112429, 4550.49944506104, 117271.0, 117568.0, 119165.40417297858, 119668.0, 124131.0, 80585.19414805894, 89970.0, 98115.09424528744, 107635.0, 108774.0, 87023.0, 89968.0, 90140.09859901317, 94210.99999999863, 96754.0, 8855.247303979233, 8858.069902660129, 8861.424007439497, 8935.642574297215, 9058.637654493747, 48736.512634873194, 59073.70463147657, 60590.0, 61196.0, 62048.06927895995, 82381.0, 85675.57162214149, 87634.0, 88921.11078889128, 89583.55208223917, 11745.882541174478, 11752.11859110553, 11757.0, 11787.0, 11935.985441237592, 12193.451294691582, 12320.507179712711, 12392.256464612152, 12802.295873727035, 12975.416106275052, 11793.705157371134, 11809.468573914366, 12013.939930300292, 12051.156419050581, 12112.697182570506, 11320.660380188607, 11522.827157592475, 11877.22798018126, 11887.465064071965, 11950.984166345957, 11764.294142351486, 11825.704357391134, 11840.993515551274, 11845.644630661094, 11938.76122477563, 9322.161005509537, 9605.903940960501, 9902.75243118899, 10165.18678505703, 10185.185185185019, 9973.339191388646, 10116.848247276444, 10117.544710488193, 10135.290529663147, 10164.237682174014], "value": 7209.548207169703, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 121.0, 122.0, 120.0, 121.0, 123.0, 132.0, 125.0, 122.0], "value": 121.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 116.0, 147.0, 116.0, 116.0, 116.0, 119.0, 142.0, 118.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 229.0, 280.0, 202.0, 199.0, 199.0, 197.0, 198.0, 198.0], "value": 209.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 88.0, 61.0, 58.0, 60.0, 60.0, 76.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 90.0, 71.0, 70.0, 70.0, 84.0, 71.0, 71.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 131.0, 136.0, 130.0, 84.0, 121.0, 77.0, 131.0, 97.0, 130.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 95.0, 96.0, 95.0, 97.0, 96.0, 94.0, 134.0, 103.0, 101.0], "value": 101.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 125.0, 102.0, 142.0, 139.0, 90.0, 133.0, 137.0, 90.0, 86.0], "value": 113.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 60.0, 89.0, 91.0, 58.0, 59.0, 59.0, 60.0, 59.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 110.0, 104.0, 103.0, 84.0, 73.0, 68.0, 74.0, 71.0, 72.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 87.0, 86.0, 85.0, 89.0, 86.0, 85.0, 87.0, 88.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 162.0, 159.0, 150.0, 149.0, 149.0, 176.0, 169.0, 210.0, 167.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 203.0, 198.0, 216.0, 170.0, 170.0, 171.0, 167.0, 170.0, 170.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 68.0, 70.0, 66.0, 67.0, 66.0, 70.0, 69.0], "value": 67.9, "unit": "score"}]}]} 19:11:29 INFO - Return code: 0 19:11:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:11:29 ERROR - # TBPL SUCCESS # 19:11:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:11:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:11:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:11:30 INFO - 2016-11-23 19:11:30.002 screenresolution[1918:16895] starting screenresolution argv=screenresolution get 19:11:30 INFO - 2016-11-23 19:11:30.005 screenresolution[1918:16895] Display 0: 1600x1200x32@60 19:11:30 INFO - 2016-11-23 19:11:30.012 screenresolution[1919:16898] starting screenresolution argv=screenresolution list 19:11:30 INFO - Available Modes on Display 0 19:11:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:11:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:11:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:11:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:11:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:11:30 INFO - Intel Iris: 19:11:30 INFO - Chipset Model: Intel Iris 19:11:30 INFO - Type: GPU 19:11:30 INFO - Bus: Built-In 19:11:30 INFO - VRAM (Dynamic, Max): 1536 MB 19:11:30 INFO - Vendor: Intel (0x8086) 19:11:30 INFO - Device ID: 0x0a2e 19:11:30 INFO - Revision ID: 0x0009 19:11:30 INFO - Displays: 19:11:30 INFO - Display: 19:11:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:11:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:11:30 INFO - Display Serial Number: 1600x1200 60 19:11:30 INFO - Main Display: Yes 19:11:30 INFO - Mirror: Off 19:11:30 INFO - Online: Yes 19:11:30 INFO - Rotation: Supported 19:11:30 INFO - Return code: 0 19:11:30 INFO - Running post-action listener: _resource_record_post_action 19:11:30 INFO - [mozharness: 2016-11-24 03:11:30.257757Z] Finished run-tests step (success) 19:11:30 INFO - Running post-run listener: _resource_record_post_run 19:11:30 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1236992; Write bytes: 655217664; Read time: 25; Write time: 1868 19:11:30 INFO - TinderboxPrint: CPU usage
54.4% 19:11:30 INFO - TinderboxPrint: I/O read bytes / time
1,236,992 / 25 19:11:30 INFO - TinderboxPrint: I/O write bytes / time
655,217,664 / 1,868 19:11:30 INFO - TinderboxPrint: CPU idle
2,207.7 (45.6%) 19:11:30 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 19:11:30 INFO - TinderboxPrint: CPU user
1,649.5 (34.1%) 19:11:30 INFO - TinderboxPrint: Swap in / out
350,171,136 / 0 19:11:30 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345338368; Write bytes: 344999936; Read time: 26991; Write time: 612 19:11:30 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1228800; Write bytes: 303033344; Read time: 15; Write time: 1225 19:11:30 INFO - Running post-run listener: _upload_blobber_files 19:11:30 INFO - Blob upload gear active. 19:11:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:11:30 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 19:11:30 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'] 19:11:30 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 19:11:31 INFO - (blobuploader) - INFO - Open directory for files ... 19:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:11:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:32 INFO - (blobuploader) - INFO - Done attempting. 19:11:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:11:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:33 INFO - (blobuploader) - INFO - Done attempting. 19:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:35 INFO - (blobuploader) - INFO - Done attempting. 19:11:35 INFO - (blobuploader) - INFO - Iteration through files over. 19:11:35 INFO - Return code: 0 19:11:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:11:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:11:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f0f02c37e80cdb79dcdc62f8ac12dad6037dc5ffba2427a85114c3edbe920a2ab888a57fa1c07d94e0c475f0843f73d523e471acaf23a1580ddea58029768cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb17e12e828e46c7b3514bf360a3c32a515bd761b7a4fd7af5e4cfbdd689a59f94f573a67f644ddeeb8feeb3a14b5f12c701f731ac8fcefeb3a6541b90e085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad4937fe05e8a28dbfdf103832e1a63a1f881609e0f25e892f730f9b6867bba6996514d8d76fa24d9d3d7053cac67368acbb81be592d027c583d2fa23825aa04"} 19:11:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:11:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:11:35 INFO - Contents: 19:11:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f0f02c37e80cdb79dcdc62f8ac12dad6037dc5ffba2427a85114c3edbe920a2ab888a57fa1c07d94e0c475f0843f73d523e471acaf23a1580ddea58029768cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb17e12e828e46c7b3514bf360a3c32a515bd761b7a4fd7af5e4cfbdd689a59f94f573a67f644ddeeb8feeb3a14b5f12c701f731ac8fcefeb3a6541b90e085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad4937fe05e8a28dbfdf103832e1a63a1f881609e0f25e892f730f9b6867bba6996514d8d76fa24d9d3d7053cac67368acbb81be592d027c583d2fa23825aa04"} 19:11:35 INFO - Running post-run listener: copy_logs_to_upload_dir 19:11:35 INFO - Copying logs to upload dir... 19:11:35 INFO - mkdir: /builds/slave/test/build/upload/logs 19:11:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.612790 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-23 19:11:36.017370) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 19:11:36.020848) ========= 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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f0f02c37e80cdb79dcdc62f8ac12dad6037dc5ffba2427a85114c3edbe920a2ab888a57fa1c07d94e0c475f0843f73d523e471acaf23a1580ddea58029768cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb17e12e828e46c7b3514bf360a3c32a515bd761b7a4fd7af5e4cfbdd689a59f94f573a67f644ddeeb8feeb3a14b5f12c701f731ac8fcefeb3a6541b90e085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad4937fe05e8a28dbfdf103832e1a63a1f881609e0f25e892f730f9b6867bba6996514d8d76fa24d9d3d7053cac67368acbb81be592d027c583d2fa23825aa04"} build_url:https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/UiQbbcrCR3a8Q8W9DOiw-g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f0f02c37e80cdb79dcdc62f8ac12dad6037dc5ffba2427a85114c3edbe920a2ab888a57fa1c07d94e0c475f0843f73d523e471acaf23a1580ddea58029768cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb17e12e828e46c7b3514bf360a3c32a515bd761b7a4fd7af5e4cfbdd689a59f94f573a67f644ddeeb8feeb3a14b5f12c701f731ac8fcefeb3a6541b90e085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad4937fe05e8a28dbfdf103832e1a63a1f881609e0f25e892f730f9b6867bba6996514d8d76fa24d9d3d7053cac67368acbb81be592d027c583d2fa23825aa04"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 19:11:36.055908) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 19:11:36.056250) ========= 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.RxeTUn36IP/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.D5QzJ7Mdnn/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005142 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 19:11:36.105216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 19:11:36.105532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 19:11:36.105856) ========= ========= Total master_lag: 0.18 =========