builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0264 starttime: 1479148306.42 results: success (0) buildid: 20161114074144 builduid: c0ce765cf2c74afa85cbf7cb62a44e31 revision: 8cdff71808a0e11361bca7f218658c4343c730ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.415729) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.416205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.416497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.441569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.441953) ========= 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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-14 10:31:46-- 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% 155M=0s 2016-11-14 10:31:46 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074271 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.538503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.538837) ========= 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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.024734 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:46.587410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 10:31:46.587765) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8cdff71808a0e11361bca7f218658c4343c730ca --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 8cdff71808a0e11361bca7f218658c4343c730ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.g94ZyyKmp4/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.2YAjQM4EGT/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-14 10:31:46,677 truncating revision to first 12 chars 2016-11-14 10:31:46,677 Setting DEBUG logging. 2016-11-14 10:31:46,677 attempt 1/10 2016-11-14 10:31:46,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8cdff71808a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 10:31:47,571 unpacking tar archive at: mozilla-aurora-8cdff71808a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.144645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 10:31:47.754494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:47.754829) ========= script_repo_revision: 8cdff71808a0e11361bca7f218658c4343c730ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:47.755209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:47.755473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 10:31:47.773896) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 10:31:47.774285) ========= /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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:31:47 INFO - MultiFileLogger online at 20161114 10:31:47 in /builds/slave/test 10:31:47 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 10:31:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:31:47 INFO - {'append_to_log': False, 10:31:47 INFO - 'base_work_dir': '/builds/slave/test', 10:31:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:31:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:31:47 INFO - 'branch': 'Mozilla-Aurora', 10:31:47 INFO - 'buildbot_json_path': 'buildprops.json', 10:31:47 INFO - 'config_files': ('talos/mac_config.py',), 10:31:47 INFO - 'default_actions': ('clobber', 10:31:47 INFO - 'read-buildbot-config', 10:31:47 INFO - 'download-and-extract', 10:31:47 INFO - 'populate-webroot', 10:31:47 INFO - 'create-virtualenv', 10:31:47 INFO - 'install', 10:31:47 INFO - 'run-tests'), 10:31:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:31:47 INFO - 'download_minidump_stackwalk': True, 10:31:47 INFO - 'download_symbols': 'ondemand', 10:31:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:31:47 INFO - 'tooltool.py': '/tools/tooltool.py', 10:31:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:31:47 INFO - '/tools/misc-python/virtualenv.py')}, 10:31:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:31:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:31:47 INFO - 'installer_path': 'installer.exe', 10:31:47 INFO - 'log_level': 'info', 10:31:47 INFO - 'log_name': 'talos', 10:31:47 INFO - 'log_to_console': True, 10:31:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:31:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:31:47 INFO - 'opt_config_files': (), 10:31:47 INFO - 'pip_index': False, 10:31:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:31:47 INFO - 'cmd': ('bash', 10:31:47 INFO - '-c', 10:31:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:31:47 INFO - 'enabled': True, 10:31:47 INFO - 'halt_on_failure': False, 10:31:47 INFO - 'name': 'check_screen_resolution'},), 10:31:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:31:47 INFO - 'cmd': ('bash', 10:31:47 INFO - '-c', 10:31:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:31:47 INFO - 'enabled': True, 10:31:47 INFO - 'halt_on_failure': False, 10:31:47 INFO - 'name': 'check_screen_resolution'},), 10:31:47 INFO - 'run_cmd_checks_enabled': True, 10:31:47 INFO - 'sps_profile': False, 10:31:47 INFO - 'sps_profile_interval': 0, 10:31:47 INFO - 'suite': 'dromaeojs-e10s', 10:31:47 INFO - 'system_bits': '32', 10:31:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:31:47 INFO - 'title': 't-yosemite-r7-0264', 10:31:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:31:47 INFO - 'use_talos_json': True, 10:31:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:31:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:31:47 INFO - 'work_dir': 'build'} 10:31:47 INFO - [mozharness: 2016-11-14 18:31:47.988863Z] Running clobber step. 10:31:47 INFO - Running pre-action listener: _resource_record_pre_action 10:31:47 INFO - Running main action method: clobber 10:31:47 INFO - rmtree: /builds/slave/test/build 10:31:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:31:50 INFO - Running post-action listener: _resource_record_post_action 10:31:50 INFO - [mozharness: 2016-11-14 18:31:50.388666Z] Finished clobber step (success) 10:31:50 INFO - [mozharness: 2016-11-14 18:31:50.388815Z] Running read-buildbot-config step. 10:31:50 INFO - Running pre-action listener: _resource_record_pre_action 10:31:50 INFO - Running main action method: read_buildbot_config 10:31:50 INFO - Using buildbot properties: 10:31:50 INFO - { 10:31:50 INFO - "project": "", 10:31:50 INFO - "product": "firefox", 10:31:50 INFO - "script_repo_revision": "production", 10:31:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:31:50 INFO - "repository": "", 10:31:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:31:50 INFO - "buildid": "20161114074144", 10:31:50 INFO - "pgo_build": "False", 10:31:50 INFO - "basedir": "/builds/slave/test", 10:31:50 INFO - "buildnumber": 17, 10:31:50 INFO - "slavename": "t-yosemite-r7-0264", 10:31:50 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:31:50 INFO - "platform": "yosemite_r7", 10:31:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:31:50 INFO - "branch": "mozilla-aurora", 10:31:50 INFO - "repo_path": "releases/mozilla-aurora", 10:31:50 INFO - "revision": "8cdff71808a0e11361bca7f218658c4343c730ca", 10:31:50 INFO - "stage_platform": "macosx64", 10:31:50 INFO - "builduid": "c0ce765cf2c74afa85cbf7cb62a44e31", 10:31:50 INFO - "slavebuilddir": "test" 10:31:50 INFO - } 10:31:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:31:50 INFO - Running post-action listener: _resource_record_post_action 10:31:50 INFO - [mozharness: 2016-11-14 18:31:50.392511Z] Finished read-buildbot-config step (success) 10:31:50 INFO - [mozharness: 2016-11-14 18:31:50.392664Z] Running download-and-extract step. 10:31:50 INFO - Running pre-action listener: _resource_record_pre_action 10:31:50 INFO - Running main action method: download_and_extract 10:31:50 INFO - mkdir: /builds/slave/test/build/tests 10:31:50 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')]} 10:31:50 INFO - trying https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:31:50 INFO - Downloading https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/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 10:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/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 10:31:51 INFO - Downloaded 1199 bytes. 10:31:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:31:51 INFO - Using the following test package requirements: 10:31:51 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:31:51 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:31:51 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:31:51 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'jsshell-mac.zip'], 10:31:51 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:31:51 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:31:51 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:31:51 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:31:51 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:31:51 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:31:51 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:31:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:31:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:31:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:31:51 INFO - Fetch https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:31:51 INFO - Http code: 200 10:31:51 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 10:31:51 INFO - x-amz-cf-id: uLDmUNnQhy88V9g3I6tLlt1eqHJDbrJyFPSq_qO_t9tGEcdxesa0GQ== 10:31:51 INFO - x-amz-version-id: qEZpoxVrb8K_lOtz8d1xXpN4NyRiiL2Q 10:31:52 INFO - Expected file size: 16327509 10:31:52 INFO - Obtained file size: 16327509 10:31:58 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 10:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:31:59 INFO - Http code: 200 10:31:59 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 10:31:59 INFO - x-amz-cf-id: ERfREAF28MMW1VIMWduoPZ4hsyFxvcooXvkWGwxO9uDvL_CMbXZ-mQ== 10:31:59 INFO - x-amz-version-id: qEZpoxVrb8K_lOtz8d1xXpN4NyRiiL2Q 10:31:59 INFO - Expected file size: 16327509 10:31:59 INFO - Obtained file size: 16327509 10:32:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:32:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:32:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:32:07 INFO - Http code: 200 10:32:07 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 10:32:07 INFO - x-amz-cf-id: M5IUloHaxm9a7v1ygZu2ceKHQp-WU8IWIvrRoHMgqCFAM4-bUy3LzA== 10:32:07 INFO - x-amz-version-id: jXsupoNyJ.YzlDUqzWygU8BmOV_JFB8G 10:32:07 INFO - Expected file size: 14409038 10:32:07 INFO - Obtained file size: 14409038 10:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:07 INFO - trying https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/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 10:32:10 INFO - Downloaded 114362341 bytes. 10:32:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:32:10 INFO - mkdir: /builds/slave/test/properties 10:32:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:10 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:10 INFO - Contents: 10:32:10 INFO - build_url:https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:32:11 INFO - Running post-action listener: _resource_record_post_action 10:32:11 INFO - Running post-action listener: set_extra_try_arguments 10:32:11 INFO - [mozharness: 2016-11-14 18:32:11.321043Z] Finished download-and-extract step (success) 10:32:11 INFO - [mozharness: 2016-11-14 18:32:11.321171Z] Running populate-webroot step. 10:32:11 INFO - Running pre-action listener: _resource_record_pre_action 10:32:11 INFO - Running main action method: populate_webroot 10:32:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:32:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:32:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:32:11 INFO - '--tppagecycles', 10:32:11 INFO - '7'], 10:32:11 INFO - 'tests': ['tsvgm']}}, 10:32:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:32:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:32:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['damp', 'tps']}, 10:32:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'tests': ['damp', 'tps']}, 10:32:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['dromaeo_dom']}, 10:32:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['basic_compositor_video']}, 10:32:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:32:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['a11yr', 10:32:11 INFO - 'ts_paint', 10:32:11 INFO - 'tpaint', 10:32:11 INFO - 'sessionrestore', 10:32:11 INFO - 'sessionrestore_no_auto_restore', 10:32:11 INFO - 'tabpaint']}, 10:32:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:11 INFO - 'ts_paint', 10:32:11 INFO - 'tpaint', 10:32:11 INFO - 'sessionrestore', 10:32:11 INFO - 'sessionrestore_no_auto_restore', 10:32:11 INFO - 'tabpaint']}, 10:32:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:32:11 INFO - 'ts_paint', 10:32:11 INFO - 'tpaint', 10:32:11 INFO - 'sessionrestore', 10:32:11 INFO - 'sessionrestore_no_auto_restore', 10:32:11 INFO - 'tabpaint']}, 10:32:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:32:11 INFO - 'ts_paint', 10:32:11 INFO - 'tpaint', 10:32:11 INFO - 'sessionrestore', 10:32:11 INFO - 'sessionrestore_no_auto_restore', 10:32:11 INFO - 'tabpaint']}, 10:32:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['a11yr', 10:32:11 INFO - 'ts_paint', 10:32:11 INFO - 'tpaint', 10:32:11 INFO - 'sessionrestore', 10:32:11 INFO - 'sessionrestore_no_auto_restore', 10:32:11 INFO - 'tabpaint']}, 10:32:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['a11yr', 10:32:11 INFO - 'ts_paint', 10:32:11 INFO - 'tpaint', 10:32:11 INFO - 'sessionrestore', 10:32:11 INFO - 'sessionrestore_no_auto_restore', 10:32:11 INFO - 'tabpaint']}, 10:32:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['tsvgx', 10:32:11 INFO - 'tsvgr_opacity', 10:32:11 INFO - 'tart', 10:32:11 INFO - 'tscrollx', 10:32:11 INFO - 'cart']}, 10:32:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:11 INFO - 'tsvgr_opacity', 10:32:11 INFO - 'tart', 10:32:11 INFO - 'tscrollx', 10:32:11 INFO - 'cart']}, 10:32:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'talos_options': ['--disable-e10s'], 10:32:11 INFO - 'tests': ['tp5o']}, 10:32:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'tests': ['tp5o']}, 10:32:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'talos_options': ['--disable-e10s', 10:32:11 INFO - '--xperf_path', 10:32:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:11 INFO - 'tests': ['tp5n']}, 10:32:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:11 INFO - 'talos_options': ['--xperf_path', 10:32:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:11 INFO - 'tests': ['tp5n']}}, 10:32:11 INFO - 'talos.zip': {'path': '', 10:32:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:32:11 INFO - Running post-action listener: _resource_record_post_action 10:32:11 INFO - [mozharness: 2016-11-14 18:32:11.340340Z] Finished populate-webroot step (success) 10:32:11 INFO - [mozharness: 2016-11-14 18:32:11.340476Z] Running create-virtualenv step. 10:32:11 INFO - Running pre-action listener: _resource_record_pre_action 10:32:11 INFO - Running main action method: create_virtualenv 10:32:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:11 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 10:32:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:11 INFO - Using real prefix '/tools/python27' 10:32:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:15 INFO - Installing pip.................done. 10:32:15 INFO - Return code: 0 10:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:32:15 INFO - Reading from file tmpfile_stdout 10:32:15 INFO - Output received: 10:32:15 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) 10:32:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:15 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')]} 10:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 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')]} 10:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:15 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 10:32:15 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 10:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:15 INFO - 'HOME': '/Users/cltbld', 10:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:15 INFO - 'LOGNAME': 'cltbld', 10:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:15 INFO - 'MOZ_NO_REMOTE': '1', 10:32:15 INFO - 'NO_EM_RESTART': '1', 10:32:15 INFO - 'PAGER': '/bin/cat', 10:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:15 INFO - 'PWD': '/builds/slave/test', 10:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:15 INFO - 'SHELL': '/bin/bash', 10:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:15 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:15 INFO - 'USER': 'cltbld', 10:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:15 INFO - 'XPC_FLAGS': '0x0', 10:32:15 INFO - 'XPC_SERVICE_NAME': '0', 10:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:15 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 10:32:15 INFO - Cleaning up... 10:32:15 INFO - Return code: 0 10:32:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:32:15 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')]} 10:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 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')]} 10:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:15 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:15 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 10:32:15 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 10:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:15 INFO - 'HOME': '/Users/cltbld', 10:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:15 INFO - 'LOGNAME': 'cltbld', 10:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:15 INFO - 'MOZ_NO_REMOTE': '1', 10:32:15 INFO - 'NO_EM_RESTART': '1', 10:32:15 INFO - 'PAGER': '/bin/cat', 10:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:15 INFO - 'PWD': '/builds/slave/test', 10:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:15 INFO - 'SHELL': '/bin/bash', 10:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:15 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:15 INFO - 'USER': 'cltbld', 10:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:15 INFO - 'XPC_FLAGS': '0x0', 10:32:15 INFO - 'XPC_SERVICE_NAME': '0', 10:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:15 INFO - Downloading/unpacking psutil>=3.1.1 10:32:15 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 10:32:15 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 10:32:15 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 10:32:15 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 10:32:15 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 10:32:15 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 10:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:19 INFO - Installing collected packages: psutil 10:32:19 INFO - Running setup.py install for psutil 10:32:19 INFO - building 'psutil._psutil_osx' extension 10:32:19 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 10:32:20 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 10:32:20 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 10:32:20 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 10:32:20 INFO - building 'psutil._psutil_posix' extension 10:32:20 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 10:32:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:32:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:32:20 INFO - ^ 10:32:20 INFO - 1 warning generated. 10:32:20 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 10:32:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:20 INFO - Successfully installed psutil 10:32:20 INFO - Cleaning up... 10:32:20 INFO - Return code: 0 10:32:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:20 INFO - 'HOME': '/Users/cltbld', 10:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:20 INFO - 'LOGNAME': 'cltbld', 10:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:20 INFO - 'MOZ_NO_REMOTE': '1', 10:32:20 INFO - 'NO_EM_RESTART': '1', 10:32:20 INFO - 'PAGER': '/bin/cat', 10:32:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:20 INFO - 'PWD': '/builds/slave/test', 10:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:20 INFO - 'SHELL': '/bin/bash', 10:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:20 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:20 INFO - 'USER': 'cltbld', 10:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:20 INFO - 'XPC_FLAGS': '0x0', 10:32:20 INFO - 'XPC_SERVICE_NAME': '0', 10:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:32:23 INFO - Installing collected packages: mozsystemmonitor 10:32:23 INFO - Running setup.py install for mozsystemmonitor 10:32:23 INFO - Successfully installed mozsystemmonitor 10:32:23 INFO - Cleaning up... 10:32:23 INFO - Return code: 0 10:32:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:32:23 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')]} 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:23 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')]} 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:23 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:23 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 10:32:23 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 10:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:23 INFO - 'HOME': '/Users/cltbld', 10:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:23 INFO - 'LOGNAME': 'cltbld', 10:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:23 INFO - 'MOZ_NO_REMOTE': '1', 10:32:23 INFO - 'NO_EM_RESTART': '1', 10:32:23 INFO - 'PAGER': '/bin/cat', 10:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:23 INFO - 'PWD': '/builds/slave/test', 10:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:23 INFO - 'SHELL': '/bin/bash', 10:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:23 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:23 INFO - 'USER': 'cltbld', 10:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:23 INFO - 'XPC_FLAGS': '0x0', 10:32:23 INFO - 'XPC_SERVICE_NAME': '0', 10:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:23 INFO - Downloading/unpacking jsonschema==2.5.1 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:32:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:26 INFO - Downloading functools32-3.2.3-2.tar.gz 10:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:32:26 INFO - warning: no files found matching '*.txt' 10:32:26 INFO - no previously-included directories found matching 'build' 10:32:26 INFO - no previously-included directories found matching 'dist' 10:32:26 INFO - no previously-included directories found matching '.git*' 10:32:26 INFO - Installing collected packages: jsonschema, functools32 10:32:26 INFO - Running setup.py install for functools32 10:32:27 INFO - warning: no files found matching '*.txt' 10:32:27 INFO - no previously-included directories found matching 'build' 10:32:27 INFO - no previously-included directories found matching 'dist' 10:32:27 INFO - no previously-included directories found matching '.git*' 10:32:27 INFO - Successfully installed jsonschema functools32 10:32:27 INFO - Cleaning up... 10:32:27 INFO - Return code: 0 10:32:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:32: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')]} 10:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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')]} 10:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:27 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:27 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 10:32:27 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 10:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:27 INFO - 'HOME': '/Users/cltbld', 10:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:27 INFO - 'LOGNAME': 'cltbld', 10:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:27 INFO - 'MOZ_NO_REMOTE': '1', 10:32:27 INFO - 'NO_EM_RESTART': '1', 10:32:27 INFO - 'PAGER': '/bin/cat', 10:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:27 INFO - 'PWD': '/builds/slave/test', 10:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:27 INFO - 'SHELL': '/bin/bash', 10:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:27 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:27 INFO - 'USER': 'cltbld', 10:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:27 INFO - 'XPC_FLAGS': '0x0', 10:32:27 INFO - 'XPC_SERVICE_NAME': '0', 10:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:32:27 INFO - Cleaning up... 10:32:27 INFO - Return code: 0 10:32:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32: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')]} 10:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32: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')]} 10:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:27 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:27 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 10:32:27 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 10:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:27 INFO - 'HOME': '/Users/cltbld', 10:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:27 INFO - 'LOGNAME': 'cltbld', 10:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:27 INFO - 'MOZ_NO_REMOTE': '1', 10:32:27 INFO - 'NO_EM_RESTART': '1', 10:32:27 INFO - 'PAGER': '/bin/cat', 10:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:27 INFO - 'PWD': '/builds/slave/test', 10:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:27 INFO - 'SHELL': '/bin/bash', 10:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:27 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:27 INFO - 'USER': 'cltbld', 10:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:27 INFO - 'XPC_FLAGS': '0x0', 10:32:27 INFO - 'XPC_SERVICE_NAME': '0', 10:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:27 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 10:32:27 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 10:32:27 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 10:32:27 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 10:32:27 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 10:32:27 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 10:32:30 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:31 INFO - Downloading docopt-0.6.1.tar.gz 10:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:31 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:31 INFO - Running setup.py install for blobuploader 10:32:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:31 INFO - Running setup.py install for requests 10:32:32 INFO - Running setup.py install for docopt 10:32:32 INFO - Successfully installed blobuploader requests docopt 10:32:32 INFO - Cleaning up... 10:32:32 INFO - Return code: 0 10:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:32 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:32 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 10:32:32 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 10:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:32 INFO - 'HOME': '/Users/cltbld', 10:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:32 INFO - 'LOGNAME': 'cltbld', 10:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:32 INFO - 'MOZ_NO_REMOTE': '1', 10:32:32 INFO - 'NO_EM_RESTART': '1', 10:32:32 INFO - 'PAGER': '/bin/cat', 10:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:32 INFO - 'PWD': '/builds/slave/test', 10:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:32 INFO - 'SHELL': '/bin/bash', 10:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:32 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:32 INFO - 'USER': 'cltbld', 10:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:32 INFO - 'XPC_FLAGS': '0x0', 10:32:32 INFO - 'XPC_SERVICE_NAME': '0', 10:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Q3yrio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TMVIQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:32 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KdPTry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-a1mjU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-7zLvHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-z0KZTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-jtHjJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-FeXuhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-jLvDBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-h4NEYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-fHG_eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-udcsTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:33 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KSA2wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-kRurKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-lIzmvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-7KK_u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Wg_7WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:34 INFO - Running setup.py install for manifestparser 10:32:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:34 INFO - Running setup.py install for mozcrash 10:32:34 INFO - Running setup.py install for mozdebug 10:32:34 INFO - Running setup.py install for mozdevice 10:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozfile 10:32:35 INFO - Running setup.py install for mozhttpd 10:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozinfo 10:32:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozInstall 10:32:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for mozleak 10:32:35 INFO - Running setup.py install for mozlog 10:32:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:35 INFO - Running setup.py install for moznetwork 10:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Running setup.py install for mozprocess 10:32:36 INFO - Running setup.py install for mozprofile 10:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Running setup.py install for mozrunner 10:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:32:36 INFO - Running setup.py install for mozscreenshot 10:32:36 INFO - Running setup.py install for moztest 10:32:36 INFO - Running setup.py install for mozversion 10:32:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:32:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:32:37 INFO - Cleaning up... 10:32:37 INFO - Return code: 0 10:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:37 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')]} 10:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:37 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')]} 10:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:37 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:37 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 10:32:37 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 10:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:37 INFO - 'HOME': '/Users/cltbld', 10:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:37 INFO - 'LOGNAME': 'cltbld', 10:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:37 INFO - 'MOZ_NO_REMOTE': '1', 10:32:37 INFO - 'NO_EM_RESTART': '1', 10:32:37 INFO - 'PAGER': '/bin/cat', 10:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:37 INFO - 'PWD': '/builds/slave/test', 10:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:37 INFO - 'SHELL': '/bin/bash', 10:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:37 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:37 INFO - 'USER': 'cltbld', 10:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:37 INFO - 'XPC_FLAGS': '0x0', 10:32:37 INFO - 'XPC_SERVICE_NAME': '0', 10:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-3CxUX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-16YKoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Y3AmCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BshEzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-IAhDUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-9E_hrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:37 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)) 10:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:37 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-9f5AAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-kGRT_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-lxeXZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-q6YH8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Vez5Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-bQF3Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-m2WA8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-5yFVS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-xdWkqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:38 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)) 10:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:38 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-4bafNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:39 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)) 10:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:39 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-kl_Wa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:39 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)) 10:32:39 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)) 10:32:39 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)) 10:32:39 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)) 10:32:39 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)) 10:32:39 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)) 10:32:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:32:39 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 10:32:39 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 10:32:39 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 10:32:39 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 10:32:39 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 10:32:39 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 10:32:41 INFO - Downloading blessings-1.6.tar.gz 10:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:32:41 INFO - Installing collected packages: blessings 10:32:41 INFO - Running setup.py install for blessings 10:32:41 INFO - Successfully installed blessings 10:32:41 INFO - Cleaning up... 10:32:42 INFO - Return code: 0 10:32:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:42 INFO - Reading from file tmpfile_stdout 10:32:42 INFO - Current package versions: 10:32:42 INFO - blessings == 1.6 10:32:42 INFO - blobuploader == 1.2.4 10:32:42 INFO - docopt == 0.6.1 10:32:42 INFO - functools32 == 3.2.3-2 10:32:42 INFO - jsonschema == 2.5.1 10:32:42 INFO - manifestparser == 1.1 10:32:42 INFO - mozInstall == 1.12 10:32:42 INFO - mozcrash == 1.0 10:32:42 INFO - mozdebug == 0.1 10:32:42 INFO - mozdevice == 0.48 10:32:42 INFO - mozfile == 1.2 10:32:42 INFO - mozhttpd == 0.7 10:32:42 INFO - mozinfo == 0.9 10:32:42 INFO - mozleak == 0.1 10:32:42 INFO - mozlog == 3.4 10:32:42 INFO - moznetwork == 0.27 10:32:42 INFO - mozprocess == 0.23 10:32:42 INFO - mozprofile == 0.28 10:32:42 INFO - mozrunner == 6.13 10:32:42 INFO - mozscreenshot == 0.1 10:32:42 INFO - mozsystemmonitor == 0.3 10:32:42 INFO - moztest == 0.7 10:32:42 INFO - mozversion == 1.4 10:32:42 INFO - psutil == 3.1.1 10:32:42 INFO - requests == 1.2.3 10:32:42 INFO - wsgiref == 0.1.2 10:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:42 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:42 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 10:32:42 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 10:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:42 INFO - 'HOME': '/Users/cltbld', 10:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:42 INFO - 'LOGNAME': 'cltbld', 10:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:42 INFO - 'MOZ_NO_REMOTE': '1', 10:32:42 INFO - 'NO_EM_RESTART': '1', 10:32:42 INFO - 'PAGER': '/bin/cat', 10:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:42 INFO - 'PWD': '/builds/slave/test', 10:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:42 INFO - 'SHELL': '/bin/bash', 10:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:42 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:42 INFO - 'USER': 'cltbld', 10:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:42 INFO - 'XPC_FLAGS': '0x0', 10:32:42 INFO - 'XPC_SERVICE_NAME': '0', 10:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 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)) 10:32:42 INFO - Cleaning up... 10:32:42 INFO - Return code: 0 10:32:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:42 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 0x101f4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ec2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc010cc8250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, '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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 10:32:42 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 10:32:42 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 10:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:42 INFO - 'HOME': '/Users/cltbld', 10:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:42 INFO - 'LOGNAME': 'cltbld', 10:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:42 INFO - 'MOZ_NO_REMOTE': '1', 10:32:42 INFO - 'NO_EM_RESTART': '1', 10:32:42 INFO - 'PAGER': '/bin/cat', 10:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:42 INFO - 'PWD': '/builds/slave/test', 10:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:42 INFO - 'SHELL': '/bin/bash', 10:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:32:42 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:42 INFO - 'USER': 'cltbld', 10:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:42 INFO - 'XPC_FLAGS': '0x0', 10:32:42 INFO - 'XPC_SERVICE_NAME': '0', 10:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:32:42 INFO - Cleaning up... 10:32:42 INFO - Return code: 0 10:32:42 INFO - Running post-action listener: _resource_record_post_action 10:32:42 INFO - Running post-action listener: _start_resource_monitoring 10:32:42 INFO - Starting resource monitoring. 10:32:42 INFO - [mozharness: 2016-11-14 18:32:42.837456Z] Finished create-virtualenv step (success) 10:32:42 INFO - [mozharness: 2016-11-14 18:32:42.838487Z] Running install step. 10:32:42 INFO - Running pre-action listener: _resource_record_pre_action 10:32:42 INFO - Running main action method: install 10:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:32:43 INFO - Reading from file tmpfile_stdout 10:32:43 INFO - Detecting whether we're running mozinstall >=1.0... 10:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:32:43 INFO - Reading from file tmpfile_stdout 10:32:43 INFO - Output received: 10:32:43 INFO - Usage: mozinstall [options] installer 10:32:43 INFO - Options: 10:32:43 INFO - -h, --help show this help message and exit 10:32:43 INFO - -d DEST, --destination=DEST 10:32:43 INFO - Directory to install application into. [default: 10:32:43 INFO - "/builds/slave/test"] 10:32:43 INFO - --app=APP Application being installed. [default: firefox] 10:32:43 INFO - mkdir: /builds/slave/test/build/application 10:32:43 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'] 10:32:43 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 10:33:14 INFO - Reading from file tmpfile_stdout 10:33:14 INFO - Output received: 10:33:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:33:14 INFO - Running post-action listener: _resource_record_post_action 10:33:14 INFO - [mozharness: 2016-11-14 18:33:14.798513Z] Finished install step (success) 10:33:14 INFO - [mozharness: 2016-11-14 18:33:14.798660Z] Running run-tests step. 10:33:14 INFO - Running pre-action listener: _resource_record_pre_action 10:33:14 INFO - Running main action method: run_tests 10:33:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:14 INFO - 2016-11-14 10:33:14.813 screenresolution[1645:7588] starting screenresolution argv=screenresolution get 10:33:14 INFO - 2016-11-14 10:33:14.816 screenresolution[1645:7588] Display 0: 1600x1200x32@60 10:33:14 INFO - 2016-11-14 10:33:14.822 screenresolution[1646:7591] starting screenresolution argv=screenresolution list 10:33:14 INFO - Available Modes on Display 0 10:33:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:15 INFO - Intel Iris: 10:33:15 INFO - Chipset Model: Intel Iris 10:33:15 INFO - Type: GPU 10:33:15 INFO - Bus: Built-In 10:33:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:15 INFO - Vendor: Intel (0x8086) 10:33:15 INFO - Device ID: 0x0a2e 10:33:15 INFO - Revision ID: 0x0009 10:33:15 INFO - Displays: 10:33:15 INFO - Display: 10:33:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:15 INFO - Display Serial Number: 1600x1200 60 10:33:15 INFO - Main Display: Yes 10:33:15 INFO - Mirror: Off 10:33:15 INFO - Online: Yes 10:33:15 INFO - Rotation: Supported 10:33:15 INFO - Return code: 0 10:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:33:15 INFO - Python 2.7.3 10:33:15 INFO - Return code: 0 10:33:15 INFO - grabbing minidump binary from tooltool 10:33:15 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')]} 10:33:15 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 0x101d60d30>, '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 0x101bc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d58b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:33:15 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 10:33:15 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 10:33:15 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 10:33:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:33:15 INFO - Return code: 0 10:33:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:33:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:33:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:33:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:33:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:33:15 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/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 10:33:15 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/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --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 10:33:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g94ZyyKmp4/Render', 10:33:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:15 INFO - 'HOME': '/Users/cltbld', 10:33:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:15 INFO - 'LOGNAME': 'cltbld', 10:33:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:33:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:15 INFO - 'MOZ_NO_REMOTE': '1', 10:33:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:33:15 INFO - 'NO_EM_RESTART': '1', 10:33:15 INFO - 'PAGER': '/bin/cat', 10:33:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:15 INFO - 'PWD': '/builds/slave/test', 10:33:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:33:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:15 INFO - 'SHELL': '/bin/bash', 10:33:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2YAjQM4EGT/Listeners', 10:33:15 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 10:33:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:15 INFO - 'USER': 'cltbld', 10:33:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:15 INFO - 'XPC_FLAGS': '0x0', 10:33:15 INFO - 'XPC_SERVICE_NAME': '0', 10:33:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:15 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/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 10:33:15 INFO - mozversion application_buildid: 20161114074144 10:33:15 INFO - mozversion application_changeset: 8cdff71808a0e11361bca7f218658c4343c730ca 10:33:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:33:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:33:15 INFO - mozversion application_name: Firefox 10:33:15 INFO - mozversion application_remotingname: firefox-dev 10:33:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:33:15 INFO - mozversion application_vendor: Mozilla 10:33:15 INFO - mozversion application_version: 52.0a2 10:33:15 INFO - mozversion platform_buildid: 20161114074144 10:33:15 INFO - mozversion platform_changeset: 8cdff71808a0e11361bca7f218658c4343c730ca 10:33:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:33:15 INFO - mozversion platform_version: 52.0a2 10:33:15 INFO - using testdate: 1479148395 10:33:15 INFO - actual date: 1479148395 10:33:15 INFO - starting webserver on 'localhost:49274' 10:33:15 INFO - SUITE-START | Running 2 tests 10:33:15 INFO - TEST-START | dromaeo_css 10:33:15 INFO - operating with platform_type : mac_ 10:33:15 INFO - Initialising browser for dromaeo_css test... 10:33:15 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp4_c_Tr/profile http://localhost:49274/getInfo.html) 10:33:17 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:33:18 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:33:18 INFO - PROCESS | 1656 | colorDepth:24 10:33:18 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:33:18 INFO - PROCESS | 1656 | __metrics 10:33:18 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 10:33:19 INFO - TEST-INFO | 1656: exit 0 10:33:19 INFO - Browser initialized. 10:33:19 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:19 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp4_c_Tr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:31 INFO - PROCESS | 1659 | RSS: Main: 223993856 10:33:31 INFO - PROCESS | 1659 | 10:34:21 INFO - PROCESS | 1659 | 1479148461060 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] 10:36:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 10:36:36 INFO - PROCESS | 1659 | RSS: Main: 239906816 10:36:36 INFO - PROCESS | 1659 | 10:39:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 10:39:39 INFO - PROCESS | 1659 | RSS: Main: 247414784 10:39:39 INFO - PROCESS | 1659 | 10:42:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 10:42:42 INFO - PROCESS | 1659 | RSS: Main: 250269696 10:42:42 INFO - PROCESS | 1659 | 10:45:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 10:45:44 INFO - PROCESS | 1659 | RSS: Main: 250822656 10:45:44 INFO - PROCESS | 1659 | 10:48:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 10:48:48 INFO - PROCESS | 1659 | RSS: Main: 255225856 10:48:48 INFO - PROCESS | 1659 | 10:51:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 10:51:51 INFO - PROCESS | 1659 | RSS: Main: 256737280 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | __start_tp_report 10:51:51 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 10:51:51 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 10:51:51 INFO - PROCESS | 1659 | |i|pagename|runs| 10:51:51 INFO - PROCESS | 1659 | |0;dojo.html;3383.7969721816694;3407.3015031918458;3407.761456698031;3428.228648554076;3456.5160877477156;5794.449527294905;5837.795677151301;5853.853653658655;5870.677112758796;5917.585768996172;5828.2423284973;5865.736041878115;5923.703814809253;5960.5529585281165;5974.641521508713;5320.1487761958;5326.227696983935;5363.54409875161;5405.8107966221;5459.781608735666;5402.081646120149;5413.106837371829;5413.837584872441;5427.9185812212845;5434.755436005369;4295.441592592974;5260.447652996438;5285.365756109272;5409.215663728776;5433.646812957165;5316.415194328621;5358.276632654581;5360.115580929142;5376;5385.3268341457315;5212.869678258036;5285.973570132125;5329.653572517813;5351;5385.542228910547;5878.941210587925;6001.399860014008;6071.483923866476;6093.512518998469;6138.324784273726;5356.196570514415;6154.476869466101;6256.217972753406;6286.811395658092;6318.557700960934;6192.721327540272;6236.815005149007;6316.368363163693;6322.083297921776;6380.298167201604;5901.793437229677;5918;5955.106733989936;5996.190514280604;6006.459418652343;5369.838904832861;6324.272708638566;6399.9040014399825;6474.902876456857;6480;6241.687915604292;6290.182276304143;6293.339199383999;6294.527910406738;6307;6217.098520714471;6229.470495007885;6288.496920246369;6332.746690132343;6359.3640635936035;5996.550258730613;6263.467605253604;6281.874362512815;6308.179936608303;6333.46165575922;5031.974840125849;5196.376434827769;6212.409821066992;6296.433321001132;6297.622142671455;4901.877453063702;4923.8276660316715;4934.432540257844;4938.037082768898;5041.193409054534;3743.9438408423352;4493.326001099796;4513.255312873339;4513.796879140446;4557.772111394417;4979.954209616021;5934.495567876693;6004.159417681528;6028.336882942873;6030.095485677183;5232.476752324737;6204.976178930426;6253.53098517613;6282.874342513215;6313.873722525524;6007.879842403215;6053.576249662569;6080.787172448943;6084.908726369108;6102.694865256808;4819.180739274332;5431.158170483582;5459.918101228484;5521.779128834882;5548.195511650788;6226.50187984951;6258.593191442542;6384.489240860813;6499.155109835691;6555.147830781968;6248.218972628421;6309.936900630935;6316.494680425463;6324.177856878577;6332.936670633235;6509.511786615928;6514.641694706647;6514.869702606016;6517.055027020961;6548.705308261045;6130.275842464065;6270.498360131087;6271.247450305992;6291.245050593958;6293.874122517615;6045.758169673164;6223.844403889939;6274.247090349188;6293.3391993841815;6332.050192471166;5407.567394608343;6186.628802271878;6253.812385628438;6275.6862156892885;6294.339094395205;6177.166082578794;6242.5942313749465;6244;6246.9062964054665;6275.403836635513;4722.929156062731;5738.483536481736;5757.453041961007;5796.391378905154;6047.123167140652;6125.357545073132;6201.472874805692;6287.056941458818;6288.874222515433;6297.4017468340435;6022.548308876764;6074.696265186812;6105.755769769159;6144.4777193937225;6157.230346206724 10:51:51 INFO - PROCESS | 1659 | |1;ext.html;472.3835394809773;522.5166720783276;546.9890602187957;557.205981476396;564.7176411794105;29352.41295174098;30429.847850760743;39206.803965980165;39264.607353926454;39361;39686.40470392947;40552.79723601385;40565.391519127166;40569.797151014274;40599.188016239656;9050.72847814565;9162.267018638493;9372.297077719164;9396.812063758754;9403.62385504579;7867.331276841475;9221.40060896043;9301.72094837156;9317.81364372712;9318.347715659907;9256.907430925672;9294.163525282724;9311.022342654025;9338.112879276458;9339.626414943428;9241.260699144086;9284.767880803034;9310.906890931106;9350;9359.532023398802;9201.355905086646;9308.208802251816;9320.72037838866;9321.300902432346;9335.579898904498;29375.853120734475;38335.04162395935;38794;39793;39893.80053099745;3471.392506311385;3506.8597256109724;3686.3548878946344;3922.313595120871;3947.940780888289;22037.559248815094;29978.85010574955;30615.38769224603;30682.386352272828;30979;3110.673379295187;3175.555422240888;3181.9204519886957;3211.229304966791;3251.821149836758;493907;504003;504098;506074.4696276532;509248;58190.41809581935;58403.66385344623;58491.70754146287;58595.70702146462;58642.41357586455;60231.397686023454;61040.69479652662;61794.38205617886;61807.690961545806;61837.38162618316;15919.920400398156;16148.596285092966;16154.838451615333;16167;16193.352265909232;12438.378081095909;12590.43343049565;12634.494620215271;12641.873581264254;12675.366231688564;14359.425622974964;14736.042157259744;16051.197440127948;16289.185540722916;16319.102449365399;3172.127664892127;3279.4261004324626;6587.80236592903;6674.666266686646;6688.598684078971;850.9149085091565;931.5575101826578;941.8728471656376;958.7842735384482;962.7532345612449;29740.702592974227;29936.95220667266;29950.251243718645;30145.397092058476;30161;901.8061116859907;920.5443305563789;940.9717708468756;1009.5658866687395;1053.9209559283083;14829.480968166063;15213;15215.543533694006;15241.00933439323;15373.154476503676;681263.5936820384;685381;686043;686894;687269;56768.14847777287;57093.572660682985;57111.14333285004;57213;57235.14147287794;1210.958575624962;1257.861635220125;1320.3662242123835;1350.8378994520524;1360.3810266328796;21820.781792181875;28575;28897.711022889504;29489.087425030997;30251.63867625918;38052.619473806015;41139.588604113575;43504.34743478914;49833.75083124561;49864;631143;634022;634395;635143;637194;26264.73735262623;26580.468390632464;26631.33421664474;26650.466990660465;26777.464450711268;39487;45293.77353113213;45441.545584545056;45902;46434.767826160656;38415.807920960215;39357.60642393654;40431.19137617172;40477.39283910685;41956;37076.81461592675;37713.43429848609;38361.808190958865;38388.232235354575;38452.230955380175;35983.92048238557;37668.2466350666;37737.811310944366;38051.42922856215;38202;31226;34502.82748586342;34517.92244343877;34914.82542587372;34961.47557786686;25571.23286301414;25686.614700779875;25712.485750285265;25776.84004219852;26219.868900655376 10:51:51 INFO - PROCESS | 1659 | |2;jquery.html;315.1915337160184;367.15004763971405;369.4550537956513;381.807187370378;395.5490740555767;18202.635947281047;18815.71776423353;19231.615367692673;19723.013849307532;19979.700304495444;19026.42920712381;19590.41228763136;19802.603947921034;20070.197192112297;20071.598568028632;5476.151196564529;5719.971400143014;5732.31212254528;5736.110902810071;5746.569007324447;7108.715651373965;7354.411647068222;7441.144268409148;7511.549307041568;7517.962410187942;7294.525855819355;7378.151512576042;7391.852162956738;7502.699892004341;7588.734394296201;6143.385661433866;7242.818929526804;7538.547687138762;7605.163432022501;7610.277023682741;7237.963810180968;7279.745208917662;7280.890786638205;7285.708571657127;7285.963570182168;26103.08639197638;26407.47185056288;26423.207303780917;27187.320316992034;27389.04138355168;2294.3346429535413;2394.3295877154424;2438.366024833556;2563.461673048662;2631.2632462910415;15131.319090640838;16289.429869954613;16424;16507.504774856774;16989.57526061846;1964.577615812593;2002.7596688397339;2012.939611811648;2030.2488079410564;2039.4085715142592;124344.37827810894;126959;127655.36172319172;148387;148453.51546484613;21401.78598213998;21834.598194198625;21865.781342186692;22057.33827985163;22069;34005;34370.82814585911;35208.471872921924;35213.647863521546;35228.295434091175;10299.536520856429;10553.788924221473;10698.251122421512;10753;10806.783864322826;6992.79021629352;7722.806929826799;8625.482471051757;8789.121087891288;8952.23905968;7790.702322420808;7886.369090472748;7948.602569871483;9747.317687761788;9794.314397992071;3834.159144549403;3839.5968423315708;3855.383138697795;3867.6325749053794;3869.2648396804516;687.3264201082967;747.2826086956474;766.4022062791032;884.4781578868499;886.9179600887037;19788.71373360727;20740.377788666363;20800.271990480564;20891.26880559173;20912.47718807042;899.3749344205714;929.163752622645;939.9389039712397;946.1248345280588;949.8052899155656;10283.485825708685;10376.273660843668;10635.308704934154;10969.012788849042;10988.011079002768;593661;609852;611071;612095;622034;87923;91303;123830;126102;134728;920.581135583308;924.2190349154953;945.7446489447948;949.8955114937352;953.2850362228329;18194.81805181931;18247.996360200315;18443.801152925018;18542.25830966746;18650.81349186491;46225;49899.75250618764;55127.72436137954;55342;56552;73282;75313;76222.61888690521;77321;78840;7950.920490795018;8045.436819422584;8216.876746848682;8256.587170641324;8531.914680853111;10646.20153488476;11570.768584628091;12324;12638.747225055631;12738.872611274139;8556.486610803371;9206.952066231052;10637.468126593485;11084.61203857861;11141.554337826396;10467.581296748349;10480.790384192122;10813.891861081289;10826.67519974402;10956.959088886542;9997.450140242356;10810.405427701551;10823.296485728402;10898.836517452402;10902.182336324966;7025.437964962893;7392.4086073115095;7931.572316982768;8019.959900200462;8251.051129119987;9985.650502232387;10565.101966332948;10611.09805666527;11006.504707288032;11050.889491105308 10:51:51 INFO - PROCESS | 1659 | |3;mootools.html;1460.664047269128;1490.5751860719695;1607.5338151935932;1627.210802760661;1675.296375522282;7619.390448764099;7865.724699635514;8147.226013528712;8601.268892144168;8618.655253789848;7021.75423860165;8029.598520074002;8327.58362081895;8340.582970851448;8480.982282126153;2292.9656055159185;2333.2183718454253;2336.8130549555995;2344.542814151241;2347.8473899196583;2329.5457385809773;2368.1948137633203;2377.1798729438315;2384.6899903012586;2392.9162479313227;2327.2320134355623;2328.9650655240184;2356.670066190735;2361.291612516247;2361.95276094478;2305.296884450242;2310.2260742651233;2325.9185928492507;2331.440454290958;2339.532093581282;2339.9649005264932;2352.8353015288935;2361.716594008713;2367.0176876596192;2373.6083546214854;8396.328293736486;8542.0176679682;8573.056963733985;8574.914250857473;8577.185167409087;4273.803335066155;5090.669106508065;5250.343707036621;5251.816186433456;5258.579313654936;3351.346487434951;3438.673326034023;3497.3005398920063;3565.5186549815962;3585.4980302757635;1023.268363120365;1038.5897570459701;1079.697684648292;1082.3614067700096;1086.37533418284;10942.343459392461;11005.889941100566;11064.889351106467;11081.390523521202;11108.222424430374;4498.752568608693;4625.444946606362;4709.387779588632;4710.081534100817;4786.688865223749;9518.286128540249;9575.808483830284;9588.280878934107;9600;9663.27525435581;5204.7918083277;5224.477552244745;5228.607854410934;5232.319798426181;5239.345081864767;4289.978550107292;4290.871273861789;4736;4786.664933454695;4789.137955168103;3835.2329534092737;3921.7254792164276;3925.0579860833764;3960.5247370315747;3974.523057233093;1265.240855486719;1266.4301064521003;1272.9809052864214;1280.4570492556447;1281.8141369501557;740.9925900741032;847.3687103108224;898.4339865884582;903.7785742493131;908.0692290402391;5623.606347555714;5722.313322401338;5754.88490230193;5776.133579962955;5975.910361344583;816.1267443835159;844.9957750211332;864.4424346296604;864.7838040489878;872.3108744092096;3831.6743076838225;4000.5199376075057;4083.816228269735;4173.08192197716;4202.432671589297;8476.576171191417;10361.222908281758;10366.533505992249;10370.740731481774;10421.895781042092;10251.58993640261;10314.690559283234;10322.432266225429;10352.223583231287;10357.223208259411;6296.968515157395;7793.7272195474025;7912.841743165104;7938.206179382016;8007.559584222924;5909.87712334655;5916.615419997686;5939.387279021456;5976.641401515923;6038.939610604013;7898.249666281694;9516.524173791144;9642.42145471274;9650.662226822027;9656.227501799698;9468.763280917756;9586.760330991501;9635.22918166559;9653.951730241304;9783.02169783016;5542.944570554243;6596.142501474777;7218.711251549879;7288.052553168054;7554.962225188839;6589.538732288694;7884.487508311941;7987;8002.239787220205;8002.679892804455;6164.537659675632;6375.6174629522375;7143.964280178566;7291.635418229173;7300.780976570712;5843.970780146072;7002.544834585736;7079.115110611174;7080.362767350963;7122.537035092702;6594.769183078569;6733.69698363565;6800.659967001531;6810.046593476818;6816.454683625199;4703.270992996091;4789.066132104206;4918.040982008617;4972.453030166751;4983;4369.388285640077;4381.364702118239;4783.258594917794;4811.807527698853;5133.383993920754 10:51:51 INFO - PROCESS | 1659 | |4;prototype.html;263.3718581183877;266.68131582758605;304.15293407859104;307.6646455363653;312.1525059463556;4682.836100736471;4686.875149964009;5183.896322073561;5430.91853622196;5627.777028073913;5042.974785126069;5312.946870531294;5397.919031214535;5525.689961829769;5543.556515478762;4147.502299724029;4168.333066709327;4195.160967806436;4231.8785521836735;4256.787160641971;4133.2089012212045;4221.395869569559;4248.277792775236;4282.700210985232;4292.9949035675;3675.9231034465574;4180.077164504331;4184.372344148387;4239.5548467410945;4244.405783190356;3344.4481660526108;3669.082729317671;3669.9082522936874;4058.9188216235807;4109.856155034589;3514.5765964784046;3710.348894741841;3712.313222053902;3718.535183102112;3729.3287208302495;5190.870228244286;5284.943011397736;5326.467353264681;5368.62419630626;5393.433689462589;4411.470623525165;4718.41019872516;4852.733099679516;4862.78117484714;4873.220284754458;4876.269653714911;5360.463953604647;5479.1781232815;5688.488036076773;5857.531397488191;3761.567419746737;3968.6626636735914;4015.4980627421573;4034.5763694811917;4047.372657238133;5042.344495215599;5371.409144994048;5642;6079.604825686316;6134.846628834315;4100.523811427884;4104.56902025289;4119.505659320901;4121.1345617420675;4121.876343709693;3814.771113733185;3904.141088960424;4160.271952408317;4196.286631272691;4208.494980602347;3760.6239376062176;4764.951710623657;4906.632002599819;4911.140550403665;4913.606911447076;5834.795782147605;5857.062869940789;5875.41245875409;5878.911816322759;5932.822015339547;1155.5031336525374;1246.376811594203;1248.0015987210377;1344.7444985452928;1357.2942070123481;811.9634616442274;854.786303424144;880.7537334671368;937.5078084005952;939.8684184214216;4393.704721458906;5232.319798426181;5273.707941554344;5286.577073834084;5287.629865909426;4811.869210735475;5570;5645.604807663424;5662.235598194274;5665.858353541194;4361.629261512807;4869.586085182799;5219.8434046978655;5249.160134378481;5260.343526519084;2446.425090103824;2917.154025332672;2973.226960990158;2973.6359594122723;2979.3743313903888;5184.651990482426;5279.287296214962;5596.636218645856;5633.788735421904;5824.767009319579;4895.069936712013;5300.31095957523;5535.418781028015;5629.634073785191;5761.567882408836;5400.91981603673;5440.945590544044;5700.4299570043495;5801.287176207231;5820.738066787005;4426.826890873986;4676.953230467651;4760.809567617395;4941.382327209099;5596.524295434933;4763.499832517536;4866.48901865299;5374.023222815167;5406.378266499403;5513.200585914939;4853.417589889236;5626.831195064155;5706.9714651426475;5768.365479797135;5932.436418540232;3411.5223868658904;3497.562804649419;3919.0594257378593;3936.2324346752107;3968.301554942667;4524.715018915426;5480.369757477941;5517.834464966058;5553.888922221452;5561.944380556304;5339.7597108131;5583.609147359646;5706.032862911346;5800.76796928135;5823;5016.322796422436;5188.662736922088;5534.169874518693;5820.970895145497;5878.529717622494;4447.688661793643;5415.5359311512375;5690.658560486384;5746.2529871116485;5815.505682017076;4992.127952017993;5887.676177810262;5930.792422265373;5935.614185077956;5958;4842.685225460334;4860.3195552621955;5787.565932554991;5843.649381037151;5911.192183712702 10:51:51 INFO - PROCESS | 1659 | |5;yui.html;649.8375406148463;678.6776281266398;717.6698718589448;735.334522257357;781.7498400511837;13520.526781562636;14312.570622881303;14324.35540400682;14370.712585748279;14374.712505749892;12795.424205910733;12883.420246088925;12893.484260629564;14058;14667.486637967673;640.5548144039894;663.3002182697253;799.952002879829;805.8509175802495;817.5830326533481;830.256920056549;834.586879494648;834.7871292820353;834.9521350704857;836.0970152235572;851.0468275531414;879.0945326313876;881.0616693221731;882.7793051737066;885.8892638420198;870.8301881133182;875.5840975536601;877.2017464107695;877.6401675313123;879.0462348352014;622.0668996505242;647.1489990662311;650.388634683396;651.2445563146726;655.0632595388593;13723.382447789774;14174.574762757135;14174.858251417458;14199.78700319496;14483.78274325886;12541.247525148521;12558.120931534797;13747.106438081493;14101.929490352482;14130.22283774392;12104.152709310263;12122.212056216318;12204.633860984184;12315.26108433488;12322.507099716;3587.856485740567;4011.2378648056774;4320.503142138663;4338.284183109783;4357.237483440417;87856.68214976716;87860;88439;91334.54332728294;91587;10466.738331541772;10473.057424831803;10646.041856232976;10823.621173258898;11101.278416902875;19998.003095202377;20298.086586103662;20380;20858.47853803667;20868.26961056356;7584.772456826304;7606.733764318223;7634.122075961224;7735.419843511759;7820.374370050382;3962.7715408223544;4178.8328466860985;4241.809118589671;4250.362445633118;4307.138572285493;3316.2538428853795;3496.0735405117666;3519.7008254298157;3527.982360088183;3531.8168413581225;628.3779058731914;629.5184184099168;634.8285962790021;638.0238235499693;647.7085311609794;604.1602172979561;639.1850390751829;642.4314481683743;656.678227668439;669.4677731203705;8472.44929079608;9141.862872056925;9155.633774649074;9236.214921731593;9279.304052196112;615.2770494668836;629.2637613991641;635.7171058878755;636.2714691678095;661.424560632253;4470.508244093147;4471.5081341052455;4476.26141686618;4506.7070640408265;4566.70316429431;117396;119938.4003079979;122324.16513752301;122659.54680906332;122718;78760;79720;83662.16337836665;86422;88675.11324886797;63429;77900.22099779043;78762;78964.60517697375;83727.32545349059;9490.288228383037;9549.90450095518;9625;9711.611535538783;9727.562259698472;43179.78410107929;50778.74610626923;52283.73858130685;52895;56533;53795.19307210317;56168;60052.099218510884;67222;72349.27650723635;12343.19769214998;12497.312647804458;12536.686582835502;12555.12114152037;12608.87391126077;13176.60470185896;13946.093503922213;14146;14393.21452776771;14514.419423223375;12403.875961240272;12952.93523532414;13154.80267796003;13156.671083222613;13324.733505330032;12792.78294693016;12875.613731587693;13122.516276316735;13292.268925209206;13758.243296618783;12554.372281386077;12798.16811907223;12832.615021549369;12871.613851584467;12949.223046617233;10119.342242754197;10552.050315471644;10669.839952400565;11088.279261847954;11215.130779880928;8212.030210214185;9048.230900373543;11402.82895756581;11538.423078845855;11540.134489913458 10:51:51 INFO - PROCESS | 1659 | __end_tp_report 10:51:51 INFO - PROCESS | 1659 | __start_cc_report 10:51:51 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,373 10:51:51 INFO - PROCESS | 1659 | __end_cc_report 10:51:51 INFO - PROCESS | 1659 | __startTimestamp1479149511043__endTimestamp 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | ------- Summary: start ------- 10:51:51 INFO - PROCESS | 1659 | Number of tests: 6 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5803.76 Median:6053.58 stddev:678.05 (11.2%) stddev-sans-first:653.01 10:51:51 INFO - PROCESS | 1659 | Values: 3383.8 3407.3 3407.8 3428.2 3456.5 5794.4 5837.8 5853.9 5870.7 5917.6 5828.2 5865.7 5923.7 5960.6 5974.6 5320.1 5326.2 5363.5 5405.8 5459.8 5402.1 5413.1 5413.8 5427.9 5434.8 4295.4 5260.4 5285.4 5409.2 5433.6 5316.4 5358.3 5360.1 5376.0 5385.3 5212.9 5286.0 5329.7 5351.0 5385.5 5878.9 6001.4 6071.5 6093.5 6138.3 5356.2 6154.5 6256.2 6286.8 6318.6 6192.7 6236.8 6316.4 6322.1 6380.3 5901.8 5918.0 5955.1 5996.2 6006.5 5369.8 6324.3 6399.9 6474.9 6480.0 6241.7 6290.2 6293.3 6294.5 6307.0 6217.1 6229.5 6288.5 6332.7 6359.4 5996.6 6263.5 6281.9 6308.2 6333.5 5032.0 5196.4 6212.4 6296.4 6297.6 4901.9 4923.8 4934.4 4938.0 5041.2 3743.9 4493.3 4513.3 4513.8 4557.8 4980.0 5934.5 6004.2 6028.3 6030.1 5232.5 6205.0 6253.5 6282.9 6313.9 6007.9 6053.6 6080.8 6084.9 6102.7 4819.2 5431.2 5459.9 5521.8 5548.2 6226.5 6258.6 6384.5 6499.2 6555.1 6248.2 6309.9 6316.5 6324.2 6332.9 6509.5 6514.6 6514.9 6517.1 6548.7 6130.3 6270.5 6271.2 6291.2 6293.9 6045.8 6223.8 6274.2 6293.3 6332.1 5407.6 6186.6 6253.8 6275.7 6294.3 6177.2 6242.6 6244.0 6246.9 6275.4 4722.9 5738.5 5757.5 5796.4 6047.1 6125.4 6201.5 6287.1 6288.9 6297.4 6022.5 6074.7 6105.8 6144.5 6157.2 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:72569.34 Median:39586.70 stddev:164243.73 (414.9%) stddev-sans-first:164615.28 10:51:51 INFO - PROCESS | 1659 | Values: 472.4 522.5 547.0 557.2 564.7 29352.4 30429.8 39206.8 39264.6 39361.0 39686.4 40552.8 40565.4 40569.8 40599.2 9050.7 9162.3 9372.3 9396.8 9403.6 7867.3 9221.4 9301.7 9317.8 9318.3 9256.9 9294.2 9311.0 9338.1 9339.6 9241.3 9284.8 9310.9 9350.0 9359.5 9201.4 9308.2 9320.7 9321.3 9335.6 29375.9 38335.0 38794.0 39793.0 39893.8 3471.4 3506.9 3686.4 3922.3 3947.9 22037.6 29978.9 30615.4 30682.4 30979.0 3110.7 3175.6 3181.9 3211.2 3251.8 493907.0 504003.0 504098.0 506074.5 509248.0 58190.4 58403.7 58491.7 58595.7 58642.4 60231.4 61040.7 61794.4 61807.7 61837.4 15919.9 16148.6 16154.8 16167.0 16193.4 12438.4 12590.4 12634.5 12641.9 12675.4 14359.4 14736.0 16051.2 16289.2 16319.1 3172.1 3279.4 6587.8 6674.7 6688.6 850.9 931.6 941.9 958.8 962.8 29740.7 29937.0 29950.3 30145.4 30161.0 901.8 920.5 941.0 1009.6 1053.9 14829.5 15213.0 15215.5 15241.0 15373.2 681263.6 685381.0 686043.0 686894.0 687269.0 56768.1 57093.6 57111.1 57213.0 57235.1 1211.0 1257.9 1320.4 1350.8 1360.4 21820.8 28575.0 28897.7 29489.1 30251.6 38052.6 41139.6 43504.3 49833.8 49864.0 631143.0 634022.0 634395.0 635143.0 637194.0 26264.7 26580.5 26631.3 26650.5 26777.5 39487.0 45293.8 45441.5 45902.0 46434.8 38415.8 39357.6 40431.2 40477.4 41956.0 37076.8 37713.4 38361.8 38388.2 38452.2 35983.9 37668.2 37737.8 38051.4 38202.0 31226.0 34502.8 34517.9 34914.8 34961.5 25571.2 25686.6 25712.5 25776.8 26219.9 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:36628.58 Median:368.30 stddev:101551.36 (27572.8%) stddev-sans-first:101799.63 10:51:51 INFO - PROCESS | 1659 | Values: 315.2 367.2 369.5 381.8 395.5 18202.6 18815.7 19231.6 19723.0 19979.7 19026.4 19590.4 19802.6 20070.2 20071.6 5476.2 5720.0 5732.3 5736.1 5746.6 7108.7 7354.4 7441.1 7511.5 7518.0 7294.5 7378.2 7391.9 7502.7 7588.7 6143.4 7242.8 7538.5 7605.2 7610.3 7238.0 7279.7 7280.9 7285.7 7286.0 26103.1 26407.5 26423.2 27187.3 27389.0 2294.3 2394.3 2438.4 2563.5 2631.3 15131.3 16289.4 16424.0 16507.5 16989.6 1964.6 2002.8 2012.9 2030.2 2039.4 124344.4 126959.0 127655.4 148387.0 148453.5 21401.8 21834.6 21865.8 22057.3 22069.0 34005.0 34370.8 35208.5 35213.6 35228.3 10299.5 10553.8 10698.3 10753.0 10806.8 6992.8 7722.8 8625.5 8789.1 8952.2 7790.7 7886.4 7948.6 9747.3 9794.3 3834.2 3839.6 3855.4 3867.6 3869.3 687.3 747.3 766.4 884.5 886.9 19788.7 20740.4 20800.3 20891.3 20912.5 899.4 929.2 939.9 946.1 949.8 10283.5 10376.3 10635.3 10969.0 10988.0 593661.0 609852.0 611071.0 612095.0 622034.0 87923.0 91303.0 123830.0 126102.0 134728.0 920.6 924.2 945.7 949.9 953.3 18194.8 18248.0 18443.8 18542.3 18650.8 46225.0 49899.8 55127.7 55342.0 56552.0 73282.0 75313.0 76222.6 77321.0 78840.0 7950.9 8045.4 8216.9 8256.6 8531.9 10646.2 11570.8 12324.0 12638.7 12738.9 8556.5 9207.0 10637.5 11084.6 11141.6 10467.6 10480.8 10813.9 10826.7 10957.0 9997.5 10810.4 10823.3 10898.8 10902.2 7025.4 7392.4 7931.6 8020.0 8251.1 9985.7 10565.1 10611.1 11006.5 11050.9 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5465.47 Median:5169.09 stddev:3000.30 (58.0%) stddev-sans-first:2993.62 10:51:51 INFO - PROCESS | 1659 | Values: 1460.7 1490.6 1607.5 1627.2 1675.3 7619.4 7865.7 8147.2 8601.3 8618.7 7021.8 8029.6 8327.6 8340.6 8481.0 2293.0 2333.2 2336.8 2344.5 2347.8 2329.5 2368.2 2377.2 2384.7 2392.9 2327.2 2329.0 2356.7 2361.3 2362.0 2305.3 2310.2 2325.9 2331.4 2339.5 2340.0 2352.8 2361.7 2367.0 2373.6 8396.3 8542.0 8573.1 8574.9 8577.2 4273.8 5090.7 5250.3 5251.8 5258.6 3351.3 3438.7 3497.3 3565.5 3585.5 1023.3 1038.6 1079.7 1082.4 1086.4 10942.3 11005.9 11064.9 11081.4 11108.2 4498.8 4625.4 4709.4 4710.1 4786.7 9518.3 9575.8 9588.3 9600.0 9663.3 5204.8 5224.5 5228.6 5232.3 5239.3 4290.0 4290.9 4736.0 4786.7 4789.1 3835.2 3921.7 3925.1 3960.5 3974.5 1265.2 1266.4 1273.0 1280.5 1281.8 741.0 847.4 898.4 903.8 908.1 5623.6 5722.3 5754.9 5776.1 5975.9 816.1 845.0 864.4 864.8 872.3 3831.7 4000.5 4083.8 4173.1 4202.4 8476.6 10361.2 10366.5 10370.7 10421.9 10251.6 10314.7 10322.4 10352.2 10357.2 6297.0 7793.7 7912.8 7938.2 8007.6 5909.9 5916.6 5939.4 5976.6 6038.9 7898.2 9516.5 9642.4 9650.7 9656.2 9468.8 9586.8 9635.2 9654.0 9783.0 5542.9 6596.1 7218.7 7288.1 7555.0 6589.5 7884.5 7987.0 8002.2 8002.7 6164.5 6375.6 7144.0 7291.6 7300.8 5844.0 7002.5 7079.1 7080.4 7122.5 6594.8 6733.7 6800.7 6810.0 6816.5 4703.3 4789.1 4918.0 4972.5 4983.0 4369.4 4381.4 4783.3 4811.8 5133.4 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4560.91 Median:5029.33 stddev:1379.33 (27.4%) stddev-sans-first:1344.95 10:51:51 INFO - PROCESS | 1659 | Values: 263.4 266.7 304.2 307.7 312.2 4682.8 4686.9 5183.9 5430.9 5627.8 5043.0 5312.9 5397.9 5525.7 5543.6 4147.5 4168.3 4195.2 4231.9 4256.8 4133.2 4221.4 4248.3 4282.7 4293.0 3675.9 4180.1 4184.4 4239.6 4244.4 3344.4 3669.1 3669.9 4058.9 4109.9 3514.6 3710.3 3712.3 3718.5 3729.3 5190.9 5284.9 5326.5 5368.6 5393.4 4411.5 4718.4 4852.7 4862.8 4873.2 4876.3 5360.5 5479.2 5688.5 5857.5 3761.6 3968.7 4015.5 4034.6 4047.4 5042.3 5371.4 5642.0 6079.6 6134.8 4100.5 4104.6 4119.5 4121.1 4121.9 3814.8 3904.1 4160.3 4196.3 4208.5 3760.6 4765.0 4906.6 4911.1 4913.6 5834.8 5857.1 5875.4 5878.9 5932.8 1155.5 1246.4 1248.0 1344.7 1357.3 812.0 854.8 880.8 937.5 939.9 4393.7 5232.3 5273.7 5286.6 5287.6 4811.9 5570.0 5645.6 5662.2 5665.9 4361.6 4869.6 5219.8 5249.2 5260.3 2446.4 2917.2 2973.2 2973.6 2979.4 5184.7 5279.3 5596.6 5633.8 5824.8 4895.1 5300.3 5535.4 5629.6 5761.6 5400.9 5440.9 5700.4 5801.3 5820.7 4426.8 4677.0 4760.8 4941.4 5596.5 4763.5 4866.5 5374.0 5406.4 5513.2 4853.4 5626.8 5707.0 5768.4 5932.4 3411.5 3497.6 3919.1 3936.2 3968.3 4524.7 5480.4 5517.8 5553.9 5561.9 5339.8 5583.6 5706.0 5800.8 5823.0 5016.3 5188.7 5534.2 5821.0 5878.5 4447.7 5415.5 5690.7 5746.3 5815.5 4992.1 5887.7 5930.8 5935.6 5958.0 4842.7 4860.3 5787.6 5843.6 5911.2 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:19942.12 Median:4473.88 stddev:29220.46 (653.1%) stddev-sans-first:29266.53 10:51:51 INFO - PROCESS | 1659 | Values: 649.8 678.7 717.7 735.3 781.7 13520.5 14312.6 14324.4 14370.7 14374.7 12795.4 12883.4 12893.5 14058.0 14667.5 640.6 663.3 800.0 805.9 817.6 830.3 834.6 834.8 835.0 836.1 851.0 879.1 881.1 882.8 885.9 870.8 875.6 877.2 877.6 879.0 622.1 647.1 650.4 651.2 655.1 13723.4 14174.6 14174.9 14199.8 14483.8 12541.2 12558.1 13747.1 14101.9 14130.2 12104.2 12122.2 12204.6 12315.3 12322.5 3587.9 4011.2 4320.5 4338.3 4357.2 87856.7 87860.0 88439.0 91334.5 91587.0 10466.7 10473.1 10646.0 10823.6 11101.3 19998.0 20298.1 20380.0 20858.5 20868.3 7584.8 7606.7 7634.1 7735.4 7820.4 3962.8 4178.8 4241.8 4250.4 4307.1 3316.3 3496.1 3519.7 3528.0 3531.8 628.4 629.5 634.8 638.0 647.7 604.2 639.2 642.4 656.7 669.5 8472.4 9141.9 9155.6 9236.2 9279.3 615.3 629.3 635.7 636.3 661.4 4470.5 4471.5 4476.3 4506.7 4566.7 117396.0 119938.4 122324.2 122659.5 122718.0 78760.0 79720.0 83662.2 86422.0 88675.1 63429.0 77900.2 78762.0 78964.6 83727.3 9490.3 9549.9 9625.0 9711.6 9727.6 43179.8 50778.7 52283.7 52895.0 56533.0 53795.2 56168.0 60052.1 67222.0 72349.3 12343.2 12497.3 12536.7 12555.1 12608.9 13176.6 13946.1 14146.0 14393.2 14514.4 12403.9 12952.9 13154.8 13156.7 13324.7 12792.8 12875.6 13122.5 13292.3 13758.2 12554.4 12798.2 12832.6 12871.6 12949.2 10119.3 10552.1 10669.8 11088.3 11215.1 8212.0 9048.2 11402.8 11538.4 11540.1 10:51:51 INFO - PROCESS | 1659 | -------- Summary: end -------- 10:51:51 INFO - PROCESS | 1659 | 10:51:51 INFO - TEST-INFO | 1659: exit 0 10:51:51 INFO - TEST-OK | dromaeo_css | took 1116286ms 10:51:51 INFO - TEST-START | kraken 10:51:51 INFO - operating with platform_type : mac_ 10:51:51 INFO - Initialising browser for kraken test... 10:51:51 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpMjNl2W/profile http://localhost:49274/getInfo.html) 10:51:53 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:51:54 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 10:51:54 INFO - PROCESS | 1671 | colorDepth:24 10:51:54 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 10:51:54 INFO - PROCESS | 1671 | __metrics 10:51:54 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 10:51:55 INFO - TEST-INFO | 1671: exit 0 10:51:55 INFO - Browser initialized. 10:51:55 INFO - Running cycle 1/1 for kraken test... 10:51:55 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpMjNl2W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:07 INFO - PROCESS | 1673 | RSS: Main: 224555008 10:52:07 INFO - PROCESS | 1673 | 10:52:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 10:52:11 INFO - PROCESS | 1673 | RSS: Main: 236716032 10:52:11 INFO - PROCESS | 1673 | 10:52:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 10:52:14 INFO - PROCESS | 1673 | RSS: Main: 244396032 10:52:14 INFO - PROCESS | 1673 | 10:52:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 10:52:18 INFO - PROCESS | 1673 | RSS: Main: 246288384 10:52:18 INFO - PROCESS | 1673 | 10:52:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 10:52:21 INFO - PROCESS | 1673 | RSS: Main: 248827904 10:52:21 INFO - PROCESS | 1673 | 10:52:23 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:52:24 INFO - PROCESS | 1673 | RSS: Main: 249131008 10:52:24 INFO - PROCESS | 1673 | 10:52:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:27 INFO - PROCESS | 1673 | RSS: Main: 253460480 10:52:27 INFO - PROCESS | 1673 | 10:52:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 10:52:31 INFO - PROCESS | 1673 | RSS: Main: 253116416 10:52:31 INFO - PROCESS | 1673 | 10:52:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 10:52:34 INFO - PROCESS | 1673 | RSS: Main: 252694528 10:52:34 INFO - PROCESS | 1673 | 10:52:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:52:36 INFO - PROCESS | 1673 | RSS: Main: 252026880 10:52:36 INFO - PROCESS | 1673 | 10:52:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:52:39 INFO - PROCESS | 1673 | RSS: Main: 251965440 10:52:39 INFO - PROCESS | 1673 | 10:52:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:52:42 INFO - PROCESS | 1673 | RSS: Main: 251994112 10:52:42 INFO - PROCESS | 1673 | 10:52:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:52:46 INFO - PROCESS | 1673 | RSS: Main: 252444672 10:52:46 INFO - PROCESS | 1673 | 10:52:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:52:50 INFO - PROCESS | 1673 | RSS: Main: 252227584 10:52:50 INFO - PROCESS | 1673 | 10:52:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 10:52:52 INFO - PROCESS | 1673 | RSS: Main: 254103552 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | __start_tp_report 10:52:52 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 10:52:52 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 10:52:52 INFO - PROCESS | 1673 | |i|pagename|runs| 10:52:52 INFO - PROCESS | 1673 | |0;ai-astar;105;114;113;120;118;116;119;118;118;117 10:52:52 INFO - PROCESS | 1673 | |1;audio-beat-detection;136;131;147;183;108;112;139;152;140;131 10:52:52 INFO - PROCESS | 1673 | |2;audio-dft;198;195;250;200;286;203;273;288;200;198 10:52:52 INFO - PROCESS | 1673 | |3;audio-fft;82;59;60;82;60;60;60;59;81;59 10:52:52 INFO - PROCESS | 1673 | |4;audio-oscillator;92;105;122;104;69;70;88;99;69;91 10:52:52 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;106;88;90;102;91;87;92;90;90;87 10:52:52 INFO - PROCESS | 1673 | |6;imaging-darkroom;98;130;152;170;138;101;99;126;134;100 10:52:52 INFO - PROCESS | 1673 | |7;imaging-desaturate;88;92;89;84;91;87;92;91;89;88 10:52:52 INFO - PROCESS | 1673 | |8;json-parse-financial;56;56;55;58;60;58;59;59;58;60 10:52:52 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;67;67;74;127;113;89;72;75;75;75 10:52:52 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;81;88;104;80;82;85;90;88;86;85 10:52:52 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;181;174;141;164;164;168;169;166;197;149 10:52:52 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;169;171;154;208;237;172;170;194;228;194 10:52:52 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;69;81;91;91;91;90;67;69;85 10:52:52 INFO - PROCESS | 1673 | __end_tp_report 10:52:52 INFO - PROCESS | 1673 | __start_cc_report 10:52:52 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1009 10:52:52 INFO - PROCESS | 1673 | __end_cc_report 10:52:52 INFO - PROCESS | 1673 | __startTimestamp1479149572233__endTimestamp 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | ------- Summary: start ------- 10:52:52 INFO - PROCESS | 1673 | Number of tests: 14 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:115.80 Median:118.00 stddev:4.37 (3.7%) stddev-sans-first:2.29 10:52:52 INFO - PROCESS | 1673 | Values: 105.0 114.0 113.0 120.0 118.0 116.0 119.0 118.0 118.0 117.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:139.50 stddev:21.04 (15.1%) stddev-sans-first:22.31 10:52:52 INFO - PROCESS | 1673 | Values: 136.0 131.0 147.0 183.0 108.0 112.0 139.0 152.0 140.0 131.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:229.10 Median:226.50 stddev:40.20 (17.7%) stddev-sans-first:41.03 10:52:52 INFO - PROCESS | 1673 | Values: 198.0 195.0 250.0 200.0 286.0 203.0 273.0 288.0 200.0 198.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:10.69 (17.8%) stddev-sans-first:9.68 10:52:52 INFO - PROCESS | 1673 | Values: 82.0 59.0 60.0 82.0 60.0 60.0 60.0 59.0 81.0 59.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:79.00 stddev:17.67 (22.4%) stddev-sans-first:18.73 10:52:52 INFO - PROCESS | 1673 | Values: 92.0 105.0 122.0 104.0 69.0 70.0 88.0 99.0 69.0 91.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:90.00 stddev:6.45 (7.2%) stddev-sans-first:4.55 10:52:52 INFO - PROCESS | 1673 | Values: 106.0 88.0 90.0 102.0 91.0 87.0 92.0 90.0 90.0 87.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:124.80 Median:145.00 stddev:25.02 (17.3%) stddev-sans-first:24.59 10:52:52 INFO - PROCESS | 1673 | Values: 98.0 130.0 152.0 170.0 138.0 101.0 99.0 126.0 134.0 100.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:89.10 Median:90.00 stddev:2.51 (2.8%) stddev-sans-first:2.64 10:52:52 INFO - PROCESS | 1673 | Values: 88.0 92.0 89.0 84.0 91.0 87.0 92.0 91.0 89.0 88.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:1.73 (3.0%) stddev-sans-first:1.69 10:52:52 INFO - PROCESS | 1673 | Values: 56.0 56.0 55.0 58.0 60.0 58.0 59.0 59.0 58.0 60.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:83.40 Median:74.50 stddev:20.48 (27.5%) stddev-sans-first:20.85 10:52:52 INFO - PROCESS | 1673 | Values: 67.0 67.0 74.0 127.0 113.0 89.0 72.0 75.0 75.0 75.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:85.50 stddev:6.82 (8.0%) stddev-sans-first:6.89 10:52:52 INFO - PROCESS | 1673 | Values: 81.0 88.0 104.0 80.0 82.0 85.0 90.0 88.0 86.0 85.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:167.30 Median:168.50 stddev:15.52 (9.2%) stddev-sans-first:15.65 10:52:52 INFO - PROCESS | 1673 | Values: 181.0 174.0 141.0 164.0 164.0 168.0 169.0 166.0 197.0 149.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.70 Median:194.00 stddev:27.55 (14.2%) stddev-sans-first:28.18 10:52:52 INFO - PROCESS | 1673 | Values: 169.0 171.0 154.0 208.0 237.0 172.0 170.0 194.0 228.0 194.0 10:52:52 INFO - PROCESS | 1673 | 10:52:52 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:87.50 stddev:10.65 (12.2%) stddev-sans-first:10.48 10:52:52 INFO - PROCESS | 1673 | Values: 69.0 69.0 81.0 91.0 91.0 91.0 90.0 67.0 69.0 85.0 10:52:52 INFO - PROCESS | 1673 | -------- Summary: end -------- 10:52:52 INFO - PROCESS | 1673 | 10:52:53 INFO - TEST-INFO | 1673: exit 0 10:52:53 INFO - TEST-OK | kraken | took 61505ms 10:52:53 INFO - SUITE-END | took 1177s 10:52:53 INFO - Completed test suite (00:19:37) 10:52:53 INFO - javascript benchmark 10:52:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7344.155862500029, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.7969721816694, 3407.3015031918458, 3407.761456698031, 3428.228648554076, 3456.5160877477156, 5794.449527294905, 5837.795677151301, 5853.853653658655, 5870.677112758796, 5917.585768996172, 5828.2423284973, 5865.736041878115, 5923.703814809253, 5960.5529585281165, 5974.641521508713, 5320.1487761958, 5326.227696983935, 5363.54409875161, 5405.8107966221, 5459.781608735666, 5402.081646120149, 5413.106837371829, 5413.837584872441, 5427.9185812212845, 5434.755436005369, 4295.441592592974, 5260.447652996438, 5285.365756109272, 5409.215663728776, 5433.646812957165, 5316.415194328621, 5358.276632654581, 5360.115580929142, 5376.0, 5385.3268341457315, 5212.869678258036, 5285.973570132125, 5329.653572517813, 5351.0, 5385.542228910547, 5878.941210587925, 6001.399860014008, 6071.483923866476, 6093.512518998469, 6138.324784273726, 5356.196570514415, 6154.476869466101, 6256.217972753406, 6286.811395658092, 6318.557700960934, 6192.721327540272, 6236.815005149007, 6316.368363163693, 6322.083297921776, 6380.298167201604, 5901.793437229677, 5918.0, 5955.106733989936, 5996.190514280604, 6006.459418652343, 5369.838904832861, 6324.272708638566, 6399.9040014399825, 6474.902876456857, 6480.0, 6241.687915604292, 6290.182276304143, 6293.339199383999, 6294.527910406738, 6307.0, 6217.098520714471, 6229.470495007885, 6288.496920246369, 6332.746690132343, 6359.3640635936035, 5996.550258730613, 6263.467605253604, 6281.874362512815, 6308.179936608303, 6333.46165575922, 5031.974840125849, 5196.376434827769, 6212.409821066992, 6296.433321001132, 6297.622142671455, 4901.877453063702, 4923.8276660316715, 4934.432540257844, 4938.037082768898, 5041.193409054534, 3743.9438408423352, 4493.326001099796, 4513.255312873339, 4513.796879140446, 4557.772111394417, 4979.954209616021, 5934.495567876693, 6004.159417681528, 6028.336882942873, 6030.095485677183, 5232.476752324737, 6204.976178930426, 6253.53098517613, 6282.874342513215, 6313.873722525524, 6007.879842403215, 6053.576249662569, 6080.787172448943, 6084.908726369108, 6102.694865256808, 4819.180739274332, 5431.158170483582, 5459.918101228484, 5521.779128834882, 5548.195511650788, 6226.50187984951, 6258.593191442542, 6384.489240860813, 6499.155109835691, 6555.147830781968, 6248.218972628421, 6309.936900630935, 6316.494680425463, 6324.177856878577, 6332.936670633235, 6509.511786615928, 6514.641694706647, 6514.869702606016, 6517.055027020961, 6548.705308261045, 6130.275842464065, 6270.498360131087, 6271.247450305992, 6291.245050593958, 6293.874122517615, 6045.758169673164, 6223.844403889939, 6274.247090349188, 6293.3391993841815, 6332.050192471166, 5407.567394608343, 6186.628802271878, 6253.812385628438, 6275.6862156892885, 6294.339094395205, 6177.166082578794, 6242.5942313749465, 6244.0, 6246.9062964054665, 6275.403836635513, 4722.929156062731, 5738.483536481736, 5757.453041961007, 5796.391378905154, 6047.123167140652, 6125.357545073132, 6201.472874805692, 6287.056941458818, 6288.874222515433, 6297.4017468340435, 6022.548308876764, 6074.696265186812, 6105.755769769159, 6144.4777193937225, 6157.230346206724], "value": 5762.033519590479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.3835394809773, 522.5166720783276, 546.9890602187957, 557.205981476396, 564.7176411794105, 29352.41295174098, 30429.847850760743, 39206.803965980165, 39264.607353926454, 39361.0, 39686.40470392947, 40552.79723601385, 40565.391519127166, 40569.797151014274, 40599.188016239656, 9050.72847814565, 9162.267018638493, 9372.297077719164, 9396.812063758754, 9403.62385504579, 7867.331276841475, 9221.40060896043, 9301.72094837156, 9317.81364372712, 9318.347715659907, 9256.907430925672, 9294.163525282724, 9311.022342654025, 9338.112879276458, 9339.626414943428, 9241.260699144086, 9284.767880803034, 9310.906890931106, 9350.0, 9359.532023398802, 9201.355905086646, 9308.208802251816, 9320.72037838866, 9321.300902432346, 9335.579898904498, 29375.853120734475, 38335.04162395935, 38794.0, 39793.0, 39893.80053099745, 3471.392506311385, 3506.8597256109724, 3686.3548878946344, 3922.313595120871, 3947.940780888289, 22037.559248815094, 29978.85010574955, 30615.38769224603, 30682.386352272828, 30979.0, 3110.673379295187, 3175.555422240888, 3181.9204519886957, 3211.229304966791, 3251.821149836758, 493907.0, 504003.0, 504098.0, 506074.4696276532, 509248.0, 58190.41809581935, 58403.66385344623, 58491.70754146287, 58595.70702146462, 58642.41357586455, 60231.397686023454, 61040.69479652662, 61794.38205617886, 61807.690961545806, 61837.38162618316, 15919.920400398156, 16148.596285092966, 16154.838451615333, 16167.0, 16193.352265909232, 12438.378081095909, 12590.43343049565, 12634.494620215271, 12641.873581264254, 12675.366231688564, 14359.425622974964, 14736.042157259744, 16051.197440127948, 16289.185540722916, 16319.102449365399, 3172.127664892127, 3279.4261004324626, 6587.80236592903, 6674.666266686646, 6688.598684078971, 850.9149085091565, 931.5575101826578, 941.8728471656376, 958.7842735384482, 962.7532345612449, 29740.702592974227, 29936.95220667266, 29950.251243718645, 30145.397092058476, 30161.0, 901.8061116859907, 920.5443305563789, 940.9717708468756, 1009.5658866687395, 1053.9209559283083, 14829.480968166063, 15213.0, 15215.543533694006, 15241.00933439323, 15373.154476503676, 681263.5936820384, 685381.0, 686043.0, 686894.0, 687269.0, 56768.14847777287, 57093.572660682985, 57111.14333285004, 57213.0, 57235.14147287794, 1210.958575624962, 1257.861635220125, 1320.3662242123835, 1350.8378994520524, 1360.3810266328796, 21820.781792181875, 28575.0, 28897.711022889504, 29489.087425030997, 30251.63867625918, 38052.619473806015, 41139.588604113575, 43504.34743478914, 49833.75083124561, 49864.0, 631143.0, 634022.0, 634395.0, 635143.0, 637194.0, 26264.73735262623, 26580.468390632464, 26631.33421664474, 26650.466990660465, 26777.464450711268, 39487.0, 45293.77353113213, 45441.545584545056, 45902.0, 46434.767826160656, 38415.807920960215, 39357.60642393654, 40431.19137617172, 40477.39283910685, 41956.0, 37076.81461592675, 37713.43429848609, 38361.808190958865, 38388.232235354575, 38452.230955380175, 35983.92048238557, 37668.2466350666, 37737.811310944366, 38051.42922856215, 38202.0, 31226.0, 34502.82748586342, 34517.92244343877, 34914.82542587372, 34961.47557786686, 25571.23286301414, 25686.614700779875, 25712.485750285265, 25776.84004219852, 26219.868900655376], "value": 19301.795600116147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.1915337160184, 367.15004763971405, 369.4550537956513, 381.807187370378, 395.5490740555767, 18202.635947281047, 18815.71776423353, 19231.615367692673, 19723.013849307532, 19979.700304495444, 19026.42920712381, 19590.41228763136, 19802.603947921034, 20070.197192112297, 20071.598568028632, 5476.151196564529, 5719.971400143014, 5732.31212254528, 5736.110902810071, 5746.569007324447, 7108.715651373965, 7354.411647068222, 7441.144268409148, 7511.549307041568, 7517.962410187942, 7294.525855819355, 7378.151512576042, 7391.852162956738, 7502.699892004341, 7588.734394296201, 6143.385661433866, 7242.818929526804, 7538.547687138762, 7605.163432022501, 7610.277023682741, 7237.963810180968, 7279.745208917662, 7280.890786638205, 7285.708571657127, 7285.963570182168, 26103.08639197638, 26407.47185056288, 26423.207303780917, 27187.320316992034, 27389.04138355168, 2294.3346429535413, 2394.3295877154424, 2438.366024833556, 2563.461673048662, 2631.2632462910415, 15131.319090640838, 16289.429869954613, 16424.0, 16507.504774856774, 16989.57526061846, 1964.577615812593, 2002.7596688397339, 2012.939611811648, 2030.2488079410564, 2039.4085715142592, 124344.37827810894, 126959.0, 127655.36172319172, 148387.0, 148453.51546484613, 21401.78598213998, 21834.598194198625, 21865.781342186692, 22057.33827985163, 22069.0, 34005.0, 34370.82814585911, 35208.471872921924, 35213.647863521546, 35228.295434091175, 10299.536520856429, 10553.788924221473, 10698.251122421512, 10753.0, 10806.783864322826, 6992.79021629352, 7722.806929826799, 8625.482471051757, 8789.121087891288, 8952.23905968, 7790.702322420808, 7886.369090472748, 7948.602569871483, 9747.317687761788, 9794.314397992071, 3834.159144549403, 3839.5968423315708, 3855.383138697795, 3867.6325749053794, 3869.2648396804516, 687.3264201082967, 747.2826086956474, 766.4022062791032, 884.4781578868499, 886.9179600887037, 19788.71373360727, 20740.377788666363, 20800.271990480564, 20891.26880559173, 20912.47718807042, 899.3749344205714, 929.163752622645, 939.9389039712397, 946.1248345280588, 949.8052899155656, 10283.485825708685, 10376.273660843668, 10635.308704934154, 10969.012788849042, 10988.011079002768, 593661.0, 609852.0, 611071.0, 612095.0, 622034.0, 87923.0, 91303.0, 123830.0, 126102.0, 134728.0, 920.581135583308, 924.2190349154953, 945.7446489447948, 949.8955114937352, 953.2850362228329, 18194.81805181931, 18247.996360200315, 18443.801152925018, 18542.25830966746, 18650.81349186491, 46225.0, 49899.75250618764, 55127.72436137954, 55342.0, 56552.0, 73282.0, 75313.0, 76222.61888690521, 77321.0, 78840.0, 7950.920490795018, 8045.436819422584, 8216.876746848682, 8256.587170641324, 8531.914680853111, 10646.20153488476, 11570.768584628091, 12324.0, 12638.747225055631, 12738.872611274139, 8556.486610803371, 9206.952066231052, 10637.468126593485, 11084.61203857861, 11141.554337826396, 10467.581296748349, 10480.790384192122, 10813.891861081289, 10826.67519974402, 10956.959088886542, 9997.450140242356, 10810.405427701551, 10823.296485728402, 10898.836517452402, 10902.182336324966, 7025.437964962893, 7392.4086073115095, 7931.572316982768, 8019.959900200462, 8251.051129119987, 9985.650502232387, 10565.101966332948, 10611.09805666527, 11006.504707288032, 11050.889491105308], "value": 10679.28853722199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.664047269128, 1490.5751860719695, 1607.5338151935932, 1627.210802760661, 1675.296375522282, 7619.390448764099, 7865.724699635514, 8147.226013528712, 8601.268892144168, 8618.655253789848, 7021.75423860165, 8029.598520074002, 8327.58362081895, 8340.582970851448, 8480.982282126153, 2292.9656055159185, 2333.2183718454253, 2336.8130549555995, 2344.542814151241, 2347.8473899196583, 2329.5457385809773, 2368.1948137633203, 2377.1798729438315, 2384.6899903012586, 2392.9162479313227, 2327.2320134355623, 2328.9650655240184, 2356.670066190735, 2361.291612516247, 2361.95276094478, 2305.296884450242, 2310.2260742651233, 2325.9185928492507, 2331.440454290958, 2339.532093581282, 2339.9649005264932, 2352.8353015288935, 2361.716594008713, 2367.0176876596192, 2373.6083546214854, 8396.328293736486, 8542.0176679682, 8573.056963733985, 8574.914250857473, 8577.185167409087, 4273.803335066155, 5090.669106508065, 5250.343707036621, 5251.816186433456, 5258.579313654936, 3351.346487434951, 3438.673326034023, 3497.3005398920063, 3565.5186549815962, 3585.4980302757635, 1023.268363120365, 1038.5897570459701, 1079.697684648292, 1082.3614067700096, 1086.37533418284, 10942.343459392461, 11005.889941100566, 11064.889351106467, 11081.390523521202, 11108.222424430374, 4498.752568608693, 4625.444946606362, 4709.387779588632, 4710.081534100817, 4786.688865223749, 9518.286128540249, 9575.808483830284, 9588.280878934107, 9600.0, 9663.27525435581, 5204.7918083277, 5224.477552244745, 5228.607854410934, 5232.319798426181, 5239.345081864767, 4289.978550107292, 4290.871273861789, 4736.0, 4786.664933454695, 4789.137955168103, 3835.2329534092737, 3921.7254792164276, 3925.0579860833764, 3960.5247370315747, 3974.523057233093, 1265.240855486719, 1266.4301064521003, 1272.9809052864214, 1280.4570492556447, 1281.8141369501557, 740.9925900741032, 847.3687103108224, 898.4339865884582, 903.7785742493131, 908.0692290402391, 5623.606347555714, 5722.313322401338, 5754.88490230193, 5776.133579962955, 5975.910361344583, 816.1267443835159, 844.9957750211332, 864.4424346296604, 864.7838040489878, 872.3108744092096, 3831.6743076838225, 4000.5199376075057, 4083.816228269735, 4173.08192197716, 4202.432671589297, 8476.576171191417, 10361.222908281758, 10366.533505992249, 10370.740731481774, 10421.895781042092, 10251.58993640261, 10314.690559283234, 10322.432266225429, 10352.223583231287, 10357.223208259411, 6296.968515157395, 7793.7272195474025, 7912.841743165104, 7938.206179382016, 8007.559584222924, 5909.87712334655, 5916.615419997686, 5939.387279021456, 5976.641401515923, 6038.939610604013, 7898.249666281694, 9516.524173791144, 9642.42145471274, 9650.662226822027, 9656.227501799698, 9468.763280917756, 9586.760330991501, 9635.22918166559, 9653.951730241304, 9783.02169783016, 5542.944570554243, 6596.142501474777, 7218.711251549879, 7288.052553168054, 7554.962225188839, 6589.538732288694, 7884.487508311941, 7987.0, 8002.239787220205, 8002.679892804455, 6164.537659675632, 6375.6174629522375, 7143.964280178566, 7291.635418229173, 7300.780976570712, 5843.970780146072, 7002.544834585736, 7079.115110611174, 7080.362767350963, 7122.537035092702, 6594.769183078569, 6733.69698363565, 6800.659967001531, 6810.046593476818, 6816.454683625199, 4703.270992996091, 4789.066132104206, 4918.040982008617, 4972.453030166751, 4983.0, 4369.388285640077, 4381.364702118239, 4783.258594917794, 4811.807527698853, 5133.383993920754], "value": 4430.821742299159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.3718581183877, 266.68131582758605, 304.15293407859104, 307.6646455363653, 312.1525059463556, 4682.836100736471, 4686.875149964009, 5183.896322073561, 5430.91853622196, 5627.777028073913, 5042.974785126069, 5312.946870531294, 5397.919031214535, 5525.689961829769, 5543.556515478762, 4147.502299724029, 4168.333066709327, 4195.160967806436, 4231.8785521836735, 4256.787160641971, 4133.2089012212045, 4221.395869569559, 4248.277792775236, 4282.700210985232, 4292.9949035675, 3675.9231034465574, 4180.077164504331, 4184.372344148387, 4239.5548467410945, 4244.405783190356, 3344.4481660526108, 3669.082729317671, 3669.9082522936874, 4058.9188216235807, 4109.856155034589, 3514.5765964784046, 3710.348894741841, 3712.313222053902, 3718.535183102112, 3729.3287208302495, 5190.870228244286, 5284.943011397736, 5326.467353264681, 5368.62419630626, 5393.433689462589, 4411.470623525165, 4718.41019872516, 4852.733099679516, 4862.78117484714, 4873.220284754458, 4876.269653714911, 5360.463953604647, 5479.1781232815, 5688.488036076773, 5857.531397488191, 3761.567419746737, 3968.6626636735914, 4015.4980627421573, 4034.5763694811917, 4047.372657238133, 5042.344495215599, 5371.409144994048, 5642.0, 6079.604825686316, 6134.846628834315, 4100.523811427884, 4104.56902025289, 4119.505659320901, 4121.1345617420675, 4121.876343709693, 3814.771113733185, 3904.141088960424, 4160.271952408317, 4196.286631272691, 4208.494980602347, 3760.6239376062176, 4764.951710623657, 4906.632002599819, 4911.140550403665, 4913.606911447076, 5834.795782147605, 5857.062869940789, 5875.41245875409, 5878.911816322759, 5932.822015339547, 1155.5031336525374, 1246.376811594203, 1248.0015987210377, 1344.7444985452928, 1357.2942070123481, 811.9634616442274, 854.786303424144, 880.7537334671368, 937.5078084005952, 939.8684184214216, 4393.704721458906, 5232.319798426181, 5273.707941554344, 5286.577073834084, 5287.629865909426, 4811.869210735475, 5570.0, 5645.604807663424, 5662.235598194274, 5665.858353541194, 4361.629261512807, 4869.586085182799, 5219.8434046978655, 5249.160134378481, 5260.343526519084, 2446.425090103824, 2917.154025332672, 2973.226960990158, 2973.6359594122723, 2979.3743313903888, 5184.651990482426, 5279.287296214962, 5596.636218645856, 5633.788735421904, 5824.767009319579, 4895.069936712013, 5300.31095957523, 5535.418781028015, 5629.634073785191, 5761.567882408836, 5400.91981603673, 5440.945590544044, 5700.4299570043495, 5801.287176207231, 5820.738066787005, 4426.826890873986, 4676.953230467651, 4760.809567617395, 4941.382327209099, 5596.524295434933, 4763.499832517536, 4866.48901865299, 5374.023222815167, 5406.378266499403, 5513.200585914939, 4853.417589889236, 5626.831195064155, 5706.9714651426475, 5768.365479797135, 5932.436418540232, 3411.5223868658904, 3497.562804649419, 3919.0594257378593, 3936.2324346752107, 3968.301554942667, 4524.715018915426, 5480.369757477941, 5517.834464966058, 5553.888922221452, 5561.944380556304, 5339.7597108131, 5583.609147359646, 5706.032862911346, 5800.76796928135, 5823.0, 5016.322796422436, 5188.662736922088, 5534.169874518693, 5820.970895145497, 5878.529717622494, 4447.688661793643, 5415.5359311512375, 5690.658560486384, 5746.2529871116485, 5815.505682017076, 4992.127952017993, 5887.676177810262, 5930.792422265373, 5935.614185077956, 5958.0, 4842.685225460334, 4860.3195552621955, 5787.565932554991, 5843.649381037151, 5911.192183712702], "value": 4111.563512238628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.8375406148463, 678.6776281266398, 717.6698718589448, 735.334522257357, 781.7498400511837, 13520.526781562636, 14312.570622881303, 14324.35540400682, 14370.712585748279, 14374.712505749892, 12795.424205910733, 12883.420246088925, 12893.484260629564, 14058.0, 14667.486637967673, 640.5548144039894, 663.3002182697253, 799.952002879829, 805.8509175802495, 817.5830326533481, 830.256920056549, 834.586879494648, 834.7871292820353, 834.9521350704857, 836.0970152235572, 851.0468275531414, 879.0945326313876, 881.0616693221731, 882.7793051737066, 885.8892638420198, 870.8301881133182, 875.5840975536601, 877.2017464107695, 877.6401675313123, 879.0462348352014, 622.0668996505242, 647.1489990662311, 650.388634683396, 651.2445563146726, 655.0632595388593, 13723.382447789774, 14174.574762757135, 14174.858251417458, 14199.78700319496, 14483.78274325886, 12541.247525148521, 12558.120931534797, 13747.106438081493, 14101.929490352482, 14130.22283774392, 12104.152709310263, 12122.212056216318, 12204.633860984184, 12315.26108433488, 12322.507099716, 3587.856485740567, 4011.2378648056774, 4320.503142138663, 4338.284183109783, 4357.237483440417, 87856.68214976716, 87860.0, 88439.0, 91334.54332728294, 91587.0, 10466.738331541772, 10473.057424831803, 10646.041856232976, 10823.621173258898, 11101.278416902875, 19998.003095202377, 20298.086586103662, 20380.0, 20858.47853803667, 20868.26961056356, 7584.772456826304, 7606.733764318223, 7634.122075961224, 7735.419843511759, 7820.374370050382, 3962.7715408223544, 4178.8328466860985, 4241.809118589671, 4250.362445633118, 4307.138572285493, 3316.2538428853795, 3496.0735405117666, 3519.7008254298157, 3527.982360088183, 3531.8168413581225, 628.3779058731914, 629.5184184099168, 634.8285962790021, 638.0238235499693, 647.7085311609794, 604.1602172979561, 639.1850390751829, 642.4314481683743, 656.678227668439, 669.4677731203705, 8472.44929079608, 9141.862872056925, 9155.633774649074, 9236.214921731593, 9279.304052196112, 615.2770494668836, 629.2637613991641, 635.7171058878755, 636.2714691678095, 661.424560632253, 4470.508244093147, 4471.5081341052455, 4476.26141686618, 4506.7070640408265, 4566.70316429431, 117396.0, 119938.4003079979, 122324.16513752301, 122659.54680906332, 122718.0, 78760.0, 79720.0, 83662.16337836665, 86422.0, 88675.11324886797, 63429.0, 77900.22099779043, 78762.0, 78964.60517697375, 83727.32545349059, 9490.288228383037, 9549.90450095518, 9625.0, 9711.611535538783, 9727.562259698472, 43179.78410107929, 50778.74610626923, 52283.73858130685, 52895.0, 56533.0, 53795.19307210317, 56168.0, 60052.099218510884, 67222.0, 72349.27650723635, 12343.19769214998, 12497.312647804458, 12536.686582835502, 12555.12114152037, 12608.87391126077, 13176.60470185896, 13946.093503922213, 14146.0, 14393.21452776771, 14514.419423223375, 12403.875961240272, 12952.93523532414, 13154.80267796003, 13156.671083222613, 13324.733505330032, 12792.78294693016, 12875.613731587693, 13122.516276316735, 13292.268925209206, 13758.243296618783, 12554.372281386077, 12798.16811907223, 12832.615021549369, 12871.613851584467, 12949.223046617233, 10119.342242754197, 10552.050315471644, 10669.839952400565, 11088.279261847954, 11215.130779880928, 8212.030210214185, 9048.230900373543, 11402.82895756581, 11538.423078845855, 11540.134489913458], "value": 7250.984215274477, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1611.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 120.0, 118.0, 116.0, 119.0, 118.0, 118.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 147.0, 183.0, 108.0, 112.0, 139.0, 152.0, 140.0, 131.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 250.0, 200.0, 286.0, 203.0, 273.0, 288.0, 200.0, 198.0], "value": 229.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 82.0, 60.0, 60.0, 60.0, 59.0, 81.0, 59.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 105.0, 122.0, 104.0, 69.0, 70.0, 88.0, 99.0, 69.0, 91.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 88.0, 90.0, 102.0, 91.0, 87.0, 92.0, 90.0, 90.0, 87.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 130.0, 152.0, 170.0, 138.0, 101.0, 99.0, 126.0, 134.0, 100.0], "value": 124.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 89.0, 84.0, 91.0, 87.0, 92.0, 91.0, 89.0, 88.0], "value": 89.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 58.0, 60.0, 58.0, 59.0, 59.0, 58.0, 60.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 74.0, 127.0, 113.0, 89.0, 72.0, 75.0, 75.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 104.0, 80.0, 82.0, 85.0, 90.0, 88.0, 86.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 174.0, 141.0, 164.0, 164.0, 168.0, 169.0, 166.0, 197.0, 149.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 154.0, 208.0, 237.0, 172.0, 170.0, 194.0, 228.0, 194.0], "value": 189.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 81.0, 91.0, 91.0, 91.0, 90.0, 67.0, 69.0, 85.0], "value": 80.3, "unit": "score"}]}]} 10:52:53 INFO - Return code: 0 10:52:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:52:53 ERROR - # TBPL SUCCESS # 10:52:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:52:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:52:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:52:53 INFO - 2016-11-14 10:52:53.560 screenresolution[1678:10740] starting screenresolution argv=screenresolution get 10:52:53 INFO - 2016-11-14 10:52:53.563 screenresolution[1678:10740] Display 0: 1600x1200x32@60 10:52:53 INFO - 2016-11-14 10:52:53.569 screenresolution[1679:10743] starting screenresolution argv=screenresolution list 10:52:53 INFO - Available Modes on Display 0 10:52:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:52:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:52:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:52:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:52:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:52:53 INFO - Intel Iris: 10:52:53 INFO - Chipset Model: Intel Iris 10:52:53 INFO - Type: GPU 10:52:53 INFO - Bus: Built-In 10:52:53 INFO - VRAM (Dynamic, Max): 1536 MB 10:52:53 INFO - Vendor: Intel (0x8086) 10:52:53 INFO - Device ID: 0x0a2e 10:52:53 INFO - Revision ID: 0x0009 10:52:53 INFO - Displays: 10:52:53 INFO - Display: 10:52:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:52:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:52:53 INFO - Display Serial Number: 1600x1200 60 10:52:53 INFO - Main Display: Yes 10:52:53 INFO - Mirror: Off 10:52:53 INFO - Online: Yes 10:52:53 INFO - Rotation: Supported 10:52:53 INFO - Return code: 0 10:52:53 INFO - Running post-action listener: _resource_record_post_action 10:52:53 INFO - [mozharness: 2016-11-14 18:52:53.811127Z] Finished run-tests step (success) 10:52:53 INFO - Running post-run listener: _resource_record_post_run 10:52:53 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37544960; Write bytes: 657134080; Read time: 240; Write time: 1970 10:52:53 INFO - TinderboxPrint: CPU usage
54.2% 10:52:53 INFO - TinderboxPrint: I/O read bytes / time
37,544,960 / 240 10:52:53 INFO - TinderboxPrint: I/O write bytes / time
657,134,080 / 1,970 10:52:53 INFO - TinderboxPrint: CPU idle
2,217.6 (45.8%) 10:52:53 INFO - TinderboxPrint: CPU system
975.6 (20.1%) 10:52:53 INFO - TinderboxPrint: CPU user
1,648.5 (34.0%) 10:52:53 INFO - TinderboxPrint: Swap in / out
390,643,712 / 0 10:52:53 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 340996608; Write bytes: 335759360; Read time: 26381; Write time: 724 10:52:53 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36590592; Write bytes: 300710400; Read time: 227; Write time: 1182 10:52:54 INFO - Running post-run listener: _upload_blobber_files 10:52:54 INFO - Blob upload gear active. 10:52:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:52:54 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 10:52:54 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'] 10:52:54 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 10:52:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:55 INFO - (blobuploader) - INFO - Done attempting. 10:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:56 INFO - (blobuploader) - INFO - Done attempting. 10:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:52:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:52:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:52:58 INFO - (blobuploader) - INFO - Done attempting. 10:52:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:52:58 INFO - Return code: 0 10:52:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:52:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:52:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae09fbb5f3d0fa2f78ca1cb41369863ea9347349fc4f0ffa0bc0e31f2473c0acd7fdf34fb2ba4e715bae6207f7a82e2dc72373d95ecd210694e983b8ed870ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4e2cacc9c735ee051c698e33d126de4deb0d142bceaf5429dbbf6e4a1d56ac07346feb7f4bf4eb224177e21200665d8351fb58c5c1c9308f58fee4649ac917f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab38178abcc1a14053555926249c95665f59c1de4c28c0b58ad9bfdb3f6b7d230275bbffdc4b9bf9d030f27c1628ebb69fd008cb1a2140c6ca5380b718b38fa1"} 10:52:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:52:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:52:58 INFO - Contents: 10:52:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ae09fbb5f3d0fa2f78ca1cb41369863ea9347349fc4f0ffa0bc0e31f2473c0acd7fdf34fb2ba4e715bae6207f7a82e2dc72373d95ecd210694e983b8ed870ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4e2cacc9c735ee051c698e33d126de4deb0d142bceaf5429dbbf6e4a1d56ac07346feb7f4bf4eb224177e21200665d8351fb58c5c1c9308f58fee4649ac917f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab38178abcc1a14053555926249c95665f59c1de4c28c0b58ad9bfdb3f6b7d230275bbffdc4b9bf9d030f27c1628ebb69fd008cb1a2140c6ca5380b718b38fa1"} 10:52:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:52:58 INFO - Copying logs to upload dir... 10:52:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:52:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.188929 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 10:52:59.051056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:52:59.054895) ========= 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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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/0ae09fbb5f3d0fa2f78ca1cb41369863ea9347349fc4f0ffa0bc0e31f2473c0acd7fdf34fb2ba4e715bae6207f7a82e2dc72373d95ecd210694e983b8ed870ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4e2cacc9c735ee051c698e33d126de4deb0d142bceaf5429dbbf6e4a1d56ac07346feb7f4bf4eb224177e21200665d8351fb58c5c1c9308f58fee4649ac917f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab38178abcc1a14053555926249c95665f59c1de4c28c0b58ad9bfdb3f6b7d230275bbffdc4b9bf9d030f27c1628ebb69fd008cb1a2140c6ca5380b718b38fa1"} build_url:https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/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/0ae09fbb5f3d0fa2f78ca1cb41369863ea9347349fc4f0ffa0bc0e31f2473c0acd7fdf34fb2ba4e715bae6207f7a82e2dc72373d95ecd210694e983b8ed870ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4e2cacc9c735ee051c698e33d126de4deb0d142bceaf5429dbbf6e4a1d56ac07346feb7f4bf4eb224177e21200665d8351fb58c5c1c9308f58fee4649ac917f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab38178abcc1a14053555926249c95665f59c1de4c28c0b58ad9bfdb3f6b7d230275bbffdc4b9bf9d030f27c1628ebb69fd008cb1a2140c6ca5380b718b38fa1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 10:52:59.087401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:52:59.087733) ========= 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.g94ZyyKmp4/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.2YAjQM4EGT/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005143 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:52:59.136200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:52:59.136508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 10:52:59.136818) ========= ========= Total master_lag: 0.22 =========