builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0217 starttime: 1483740915.09 results: success (0) buildid: 20170106110655 builduid: a29d33bdb87d45d0a63f262095dd82d3 revision: 1a815865294fbf234f166c075986f587b2b72a89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.095322) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.095787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.096068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.127046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.127631) ========= 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.zZKCIvMABT/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.H50GkPBWan/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-06 14:15:15-- 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% 168M=0s 2017-01-06 14:15:15 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109749 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.263112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.263549) ========= 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.zZKCIvMABT/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.H50GkPBWan/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.025477 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:15.312635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 14:15:15.312996) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 1a815865294fbf234f166c075986f587b2b72a89 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 1a815865294fbf234f166c075986f587b2b72a89 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zZKCIvMABT/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.H50GkPBWan/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-06 14:15:15,483 truncating revision to first 12 chars 2017-01-06 14:15:15,483 Setting DEBUG logging. 2017-01-06 14:15:15,483 attempt 1/10 2017-01-06 14:15:15,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/1a815865294f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 14:15:16,198 unpacking tar archive at: graphics-1a815865294f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.991588 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-06 14:15:16.329990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:16.330534) ========= script_repo_revision: 1a815865294fbf234f166c075986f587b2b72a89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:16.331161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:16.331603) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 14:15:16.356424) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-06 14:15:16.357685) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zZKCIvMABT/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.H50GkPBWan/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15:16 INFO - MultiFileLogger online at 20170106 14:15:16 in /builds/slave/test 14:15:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 14:15:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:16 INFO - {'append_to_log': False, 14:15:16 INFO - 'base_work_dir': '/builds/slave/test', 14:15:16 INFO - 'blob_upload_branch': 'Graphics', 14:15:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:16 INFO - 'branch': 'Graphics', 14:15:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:16 INFO - 'config_files': ('talos/mac_config.py',), 14:15:16 INFO - 'default_actions': ('clobber', 14:15:16 INFO - 'read-buildbot-config', 14:15:16 INFO - 'download-and-extract', 14:15:16 INFO - 'populate-webroot', 14:15:16 INFO - 'create-virtualenv', 14:15:16 INFO - 'install', 14:15:16 INFO - 'run-tests'), 14:15:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:16 INFO - 'download_minidump_stackwalk': True, 14:15:16 INFO - 'download_symbols': 'ondemand', 14:15:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:16 INFO - 'installer_path': 'installer.exe', 14:15:16 INFO - 'log_level': 'info', 14:15:16 INFO - 'log_name': 'talos', 14:15:16 INFO - 'log_to_console': True, 14:15:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:15:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:15:16 INFO - 'opt_config_files': (), 14:15:16 INFO - 'pip_index': False, 14:15:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:15:16 INFO - 'cmd': ('bash', 14:15:16 INFO - '-c', 14:15:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:15:16 INFO - 'enabled': True, 14:15:16 INFO - 'halt_on_failure': False, 14:15:16 INFO - 'name': 'check_screen_resolution'},), 14:15:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:15:16 INFO - 'cmd': ('bash', 14:15:16 INFO - '-c', 14:15:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:15:16 INFO - 'enabled': True, 14:15:16 INFO - 'halt_on_failure': False, 14:15:16 INFO - 'name': 'check_screen_resolution'},), 14:15:16 INFO - 'run_cmd_checks_enabled': True, 14:15:16 INFO - 'sps_profile': False, 14:15:16 INFO - 'sps_profile_interval': 0, 14:15:16 INFO - 'suite': 'dromaeojs-e10s', 14:15:16 INFO - 'system_bits': '32', 14:15:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:16 INFO - 'title': 't-yosemite-r7-0217', 14:15:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:16 INFO - 'use_talos_json': True, 14:15:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:16 INFO - 'work_dir': 'build'} 14:15:16 INFO - [mozharness: 2017-01-06 22:15:16.641072Z] Running clobber step. 14:15:16 INFO - Running pre-action listener: _resource_record_pre_action 14:15:16 INFO - Running main action method: clobber 14:15:16 INFO - rmtree: /builds/slave/test/build 14:15:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:18 INFO - Running post-action listener: _resource_record_post_action 14:15:18 INFO - [mozharness: 2017-01-06 22:15:18.876294Z] Finished clobber step (success) 14:15:18 INFO - [mozharness: 2017-01-06 22:15:18.876465Z] Running read-buildbot-config step. 14:15:18 INFO - Running pre-action listener: _resource_record_pre_action 14:15:18 INFO - Running main action method: read_buildbot_config 14:15:18 INFO - Using buildbot properties: 14:15:18 INFO - { 14:15:18 INFO - "project": "", 14:15:18 INFO - "product": "firefox", 14:15:18 INFO - "script_repo_revision": "default", 14:15:18 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 14:15:18 INFO - "repository": "", 14:15:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 14:15:18 INFO - "buildid": "20170106110655", 14:15:18 INFO - "pgo_build": "False", 14:15:18 INFO - "basedir": "/builds/slave/test", 14:15:18 INFO - "buildnumber": 15, 14:15:18 INFO - "slavename": "t-yosemite-r7-0217", 14:15:18 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:15:18 INFO - "platform": "yosemite_r7", 14:15:18 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 14:15:18 INFO - "branch": "graphics", 14:15:18 INFO - "repo_path": "projects/graphics", 14:15:18 INFO - "revision": "1a815865294fbf234f166c075986f587b2b72a89", 14:15:18 INFO - "stage_platform": "macosx64", 14:15:18 INFO - "builduid": "a29d33bdb87d45d0a63f262095dd82d3", 14:15:18 INFO - "slavebuilddir": "test" 14:15:18 INFO - } 14:15:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:15:18 INFO - Running post-action listener: _resource_record_post_action 14:15:18 INFO - [mozharness: 2017-01-06 22:15:18.879783Z] Finished read-buildbot-config step (success) 14:15:18 INFO - [mozharness: 2017-01-06 22:15:18.879879Z] Running download-and-extract step. 14:15:18 INFO - Running pre-action listener: _resource_record_pre_action 14:15:18 INFO - Running main action method: download_and_extract 14:15:18 INFO - mkdir: /builds/slave/test/build/tests 14:15:18 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')]} 14:15:18 INFO - trying https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:15:18 INFO - Downloading https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:15:19 INFO - Downloaded 1199 bytes. 14:15:19 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:15:19 INFO - Using the following test package requirements: 14:15:19 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:15:19 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:15:19 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:15:19 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'jsshell-mac.zip'], 14:15:19 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:15:19 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:15:19 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:15:19 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:15:19 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:15:19 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:15:19 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:15:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:15:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:15:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:15:19 INFO - Fetch https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:15:20 INFO - Expected file size: 16300408 14:15:20 INFO - Obtained file size: 16300408 14:15:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:15:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:15:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:15:27 INFO - Fetch https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:15:28 INFO - Expected file size: 16300408 14:15:28 INFO - Obtained file size: 16300408 14:15:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:15:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:15:34 INFO - Fetch https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:15:35 INFO - Expected file size: 14403730 14:15:35 INFO - Obtained file size: 14403730 14:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:35 INFO - trying https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:15:35 INFO - Downloading https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:15:37 INFO - Downloaded 69730191 bytes. 14:15:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:15:37 INFO - mkdir: /builds/slave/test/properties 14:15:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:37 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:37 INFO - Contents: 14:15:37 INFO - build_url:https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:15:38 INFO - Running post-action listener: _resource_record_post_action 14:15:38 INFO - Running post-action listener: set_extra_try_arguments 14:15:38 INFO - [mozharness: 2017-01-06 22:15:38.479729Z] Finished download-and-extract step (success) 14:15:38 INFO - [mozharness: 2017-01-06 22:15:38.479852Z] Running populate-webroot step. 14:15:38 INFO - Running pre-action listener: _resource_record_pre_action 14:15:38 INFO - Running main action method: populate_webroot 14:15:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:38 INFO - '--tppagecycles', 14:15:38 INFO - '7'], 14:15:38 INFO - 'tests': ['tsvgm']}}, 14:15:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['damp', 'tps']}, 14:15:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'tests': ['damp', 'tps']}, 14:15:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['dromaeo_dom']}, 14:15:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['basic_compositor_video']}, 14:15:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:15:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['a11yr', 14:15:38 INFO - 'ts_paint', 14:15:38 INFO - 'tpaint', 14:15:38 INFO - 'sessionrestore', 14:15:38 INFO - 'sessionrestore_no_auto_restore', 14:15:38 INFO - 'tabpaint']}, 14:15:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tsvgx', 14:15:38 INFO - 'tsvgr_opacity', 14:15:38 INFO - 'tart', 14:15:38 INFO - 'tscrollx', 14:15:38 INFO - 'cart', 14:15:38 INFO - 'tsvg_static']}, 14:15:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:38 INFO - 'tsvgr_opacity', 14:15:38 INFO - 'tart', 14:15:38 INFO - 'tscrollx', 14:15:38 INFO - 'cart', 14:15:38 INFO - 'tsvg_static']}, 14:15:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s'], 14:15:38 INFO - 'tests': ['tp5o']}, 14:15:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:15:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'talos_options': ['--disable-e10s', 14:15:38 INFO - '--xperf_path', 14:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:38 INFO - 'tests': ['tp5n']}, 14:15:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:15:38 INFO - 'talos_options': ['--xperf_path', 14:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:38 INFO - 'tests': ['tp5n']}}, 14:15:38 INFO - 'talos.zip': {'path': '', 14:15:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:38 INFO - Running post-action listener: _resource_record_post_action 14:15:38 INFO - [mozharness: 2017-01-06 22:15:38.498394Z] Finished populate-webroot step (success) 14:15:38 INFO - [mozharness: 2017-01-06 22:15:38.498508Z] Running create-virtualenv step. 14:15:38 INFO - Running pre-action listener: _resource_record_pre_action 14:15:38 INFO - Running main action method: create_virtualenv 14:15:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:38 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 14:15:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:38 INFO - Using real prefix '/tools/python27' 14:15:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:42 INFO - Installing pip.................done. 14:15:42 INFO - Return code: 0 14:15:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:15:42 INFO - Reading from file tmpfile_stdout 14:15:42 INFO - Output received: 14:15:42 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) 14:15:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15: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', 'pip>=1.5'] in /builds/slave/test/build 14:15: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 pip>=1.5 14:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:42 INFO - 'HOME': '/Users/cltbld', 14:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:42 INFO - 'LOGNAME': 'cltbld', 14:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:42 INFO - 'MOZ_NO_REMOTE': '1', 14:15:42 INFO - 'NO_EM_RESTART': '1', 14:15:42 INFO - 'PAGER': '/bin/cat', 14:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:42 INFO - 'PWD': '/builds/slave/test', 14:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:42 INFO - 'SHELL': '/bin/bash', 14:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:42 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:42 INFO - 'USER': 'cltbld', 14:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:42 INFO - 'XPC_FLAGS': '0x0', 14:15:42 INFO - 'XPC_SERVICE_NAME': '0', 14:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:42 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 14:15:42 INFO - Cleaning up... 14:15:42 INFO - Return code: 0 14:15:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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', '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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:15: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 psutil>=3.1.1 14:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:42 INFO - 'HOME': '/Users/cltbld', 14:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:42 INFO - 'LOGNAME': 'cltbld', 14:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:42 INFO - 'MOZ_NO_REMOTE': '1', 14:15:42 INFO - 'NO_EM_RESTART': '1', 14:15:42 INFO - 'PAGER': '/bin/cat', 14:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:42 INFO - 'PWD': '/builds/slave/test', 14:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:42 INFO - 'SHELL': '/bin/bash', 14:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:42 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:42 INFO - 'USER': 'cltbld', 14:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:42 INFO - 'XPC_FLAGS': '0x0', 14:15:42 INFO - 'XPC_SERVICE_NAME': '0', 14:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:43 INFO - Downloading/unpacking psutil>=3.1.1 14:15:43 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 14:15:43 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 14:15:43 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 14:15:43 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 14:15:43 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 14:15:43 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 14:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:46 INFO - Installing collected packages: psutil 14:15:46 INFO - Running setup.py install for psutil 14:15:46 INFO - building 'psutil._psutil_osx' extension 14:15:46 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 INFO - building 'psutil._psutil_posix' extension 14:15:47 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 14:15:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:15:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:15:47 INFO - ^ 14:15:47 INFO - 1 warning generated. 14:15:47 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 14:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:47 INFO - Successfully installed psutil 14:15:47 INFO - Cleaning up... 14:15:47 INFO - Return code: 0 14:15:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:15:47 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')]} 14:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:47 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')]} 14:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:47 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15:47 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 14:15:47 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 14:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:47 INFO - 'HOME': '/Users/cltbld', 14:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:47 INFO - 'LOGNAME': 'cltbld', 14:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:47 INFO - 'MOZ_NO_REMOTE': '1', 14:15:47 INFO - 'NO_EM_RESTART': '1', 14:15:47 INFO - 'PAGER': '/bin/cat', 14:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:47 INFO - 'PWD': '/builds/slave/test', 14:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:47 INFO - 'SHELL': '/bin/bash', 14:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:47 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:47 INFO - 'USER': 'cltbld', 14:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:47 INFO - 'XPC_FLAGS': '0x0', 14:15:47 INFO - 'XPC_SERVICE_NAME': '0', 14:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:15:50 INFO - Installing collected packages: mozsystemmonitor 14:15:50 INFO - Running setup.py install for mozsystemmonitor 14:15:50 INFO - Successfully installed mozsystemmonitor 14:15:50 INFO - Cleaning up... 14:15:50 INFO - Return code: 0 14:15:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:50 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15:50 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 14:15:50 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 14:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:50 INFO - 'HOME': '/Users/cltbld', 14:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:50 INFO - 'LOGNAME': 'cltbld', 14:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:50 INFO - 'MOZ_NO_REMOTE': '1', 14:15:50 INFO - 'NO_EM_RESTART': '1', 14:15:50 INFO - 'PAGER': '/bin/cat', 14:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:50 INFO - 'PWD': '/builds/slave/test', 14:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:50 INFO - 'SHELL': '/bin/bash', 14:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:50 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:50 INFO - 'USER': 'cltbld', 14:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:50 INFO - 'XPC_FLAGS': '0x0', 14:15:50 INFO - 'XPC_SERVICE_NAME': '0', 14:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:51 INFO - Downloading/unpacking jsonschema==2.5.1 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:54 INFO - warning: no files found matching '*.txt' 14:15:54 INFO - no previously-included directories found matching 'build' 14:15:54 INFO - no previously-included directories found matching 'dist' 14:15:54 INFO - no previously-included directories found matching '.git*' 14:15:54 INFO - Installing collected packages: jsonschema, functools32 14:15:54 INFO - Running setup.py install for functools32 14:15:54 INFO - warning: no files found matching '*.txt' 14:15:54 INFO - no previously-included directories found matching 'build' 14:15:54 INFO - no previously-included directories found matching 'dist' 14:15:54 INFO - no previously-included directories found matching '.git*' 14:15:54 INFO - Successfully installed jsonschema functools32 14:15:54 INFO - Cleaning up... 14:15:54 INFO - Return code: 0 14:15:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:15:54 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')]} 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 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')]} 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15:54 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 14:15:54 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 14:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:54 INFO - 'HOME': '/Users/cltbld', 14:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:54 INFO - 'LOGNAME': 'cltbld', 14:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:54 INFO - 'MOZ_NO_REMOTE': '1', 14:15:54 INFO - 'NO_EM_RESTART': '1', 14:15:54 INFO - 'PAGER': '/bin/cat', 14:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:54 INFO - 'PWD': '/builds/slave/test', 14:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:54 INFO - 'SHELL': '/bin/bash', 14:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:54 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:54 INFO - 'USER': 'cltbld', 14:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:54 INFO - 'XPC_FLAGS': '0x0', 14:15:54 INFO - 'XPC_SERVICE_NAME': '0', 14:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:15:54 INFO - Cleaning up... 14:15:54 INFO - Return code: 0 14:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:54 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')]} 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 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')]} 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15:54 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 14:15:54 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 14:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:54 INFO - 'HOME': '/Users/cltbld', 14:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:54 INFO - 'LOGNAME': 'cltbld', 14:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:54 INFO - 'MOZ_NO_REMOTE': '1', 14:15:54 INFO - 'NO_EM_RESTART': '1', 14:15:54 INFO - 'PAGER': '/bin/cat', 14:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:54 INFO - 'PWD': '/builds/slave/test', 14:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:54 INFO - 'SHELL': '/bin/bash', 14:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:54 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:54 INFO - 'USER': 'cltbld', 14:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:54 INFO - 'XPC_FLAGS': '0x0', 14:15:54 INFO - 'XPC_SERVICE_NAME': '0', 14:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:57 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:58 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 14:15:58 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 14:15:58 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 14:15:58 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 14:15:58 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 14:15:58 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 14:15:58 INFO - Downloading docopt-0.6.1.tar.gz 14:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:59 INFO - Running setup.py install for blobuploader 14:15:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:59 INFO - Running setup.py install for requests 14:15:59 INFO - Running setup.py install for docopt 14:15:59 INFO - Successfully installed blobuploader requests docopt 14:15:59 INFO - Cleaning up... 14:15:59 INFO - Return code: 0 14:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:59 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:15:59 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 14:15:59 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 14:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:15:59 INFO - 'HOME': '/Users/cltbld', 14:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:15:59 INFO - 'LOGNAME': 'cltbld', 14:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:59 INFO - 'MOZ_NO_REMOTE': '1', 14:15:59 INFO - 'NO_EM_RESTART': '1', 14:15:59 INFO - 'PAGER': '/bin/cat', 14:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:59 INFO - 'PWD': '/builds/slave/test', 14:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:15:59 INFO - 'SHELL': '/bin/bash', 14:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:15:59 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:15:59 INFO - 'USER': 'cltbld', 14:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:59 INFO - 'XPC_FLAGS': '0x0', 14:15:59 INFO - 'XPC_SERVICE_NAME': '0', 14:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-zpuf1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-imvT8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Obsvla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-9JkyLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-6V1JVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Q6wB4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-MCX2Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:00 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-VmOhwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-SpLY0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-at_EBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Szq05g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-FeQJiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-iyAozC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-sn_Kb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-fGk7o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-zNBq2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:01 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Ez4aZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:16:01 INFO - Running setup.py install for manifestparser 14:16:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:16:02 INFO - Running setup.py install for mozcrash 14:16:02 INFO - Running setup.py install for mozdebug 14:16:02 INFO - Running setup.py install for mozdevice 14:16:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:16:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:16:02 INFO - Running setup.py install for mozfile 14:16:02 INFO - Running setup.py install for mozhttpd 14:16:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:16:02 INFO - Running setup.py install for mozinfo 14:16:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Running setup.py install for mozInstall 14:16:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Running setup.py install for mozleak 14:16:03 INFO - Running setup.py install for mozlog 14:16:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Running setup.py install for moznetwork 14:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Running setup.py install for mozprocess 14:16:03 INFO - Running setup.py install for mozprofile 14:16:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:16:03 INFO - Running setup.py install for mozrunner 14:16:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:16:04 INFO - Running setup.py install for mozscreenshot 14:16:04 INFO - Running setup.py install for moztest 14:16:04 INFO - Running setup.py install for mozversion 14:16:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:16:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:16:04 INFO - Cleaning up... 14:16:04 INFO - Return code: 0 14:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:04 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:16:04 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 14:16:04 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 14:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:04 INFO - 'HOME': '/Users/cltbld', 14:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:04 INFO - 'LOGNAME': 'cltbld', 14:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:04 INFO - 'MOZ_NO_REMOTE': '1', 14:16:04 INFO - 'NO_EM_RESTART': '1', 14:16:04 INFO - 'PAGER': '/bin/cat', 14:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:04 INFO - 'PWD': '/builds/slave/test', 14:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:04 INFO - 'SHELL': '/bin/bash', 14:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:16:04 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:04 INFO - 'USER': 'cltbld', 14:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:04 INFO - 'XPC_FLAGS': '0x0', 14:16:04 INFO - 'XPC_SERVICE_NAME': '0', 14:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:04 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-nr7uxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:04 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)) 14:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:04 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-nLnDIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-BHuzsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-VABeZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-LMkhZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-3ELCpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-uaJcwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-zIMHBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Lf5L_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-7GeP14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Hn8Hxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:05 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)) 14:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:05 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-3AsTZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:06 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)) 14:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-FZOgRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:06 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)) 14:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-bRS9Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:06 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)) 14:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-4RazVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:06 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)) 14:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-BGZZNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:06 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-pYoIBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 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)) 14:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:16:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:16:06 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 14:16:06 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 14:16:06 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 14:16:06 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 14:16:06 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 14:16:06 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 14:16:09 INFO - Downloading blessings-1.6.tar.gz 14:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:16:09 INFO - Installing collected packages: blessings 14:16:09 INFO - Running setup.py install for blessings 14:16:09 INFO - Successfully installed blessings 14:16:09 INFO - Cleaning up... 14:16:09 INFO - Return code: 0 14:16:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:09 INFO - Reading from file tmpfile_stdout 14:16:09 INFO - Current package versions: 14:16:09 INFO - blessings == 1.6 14:16:09 INFO - blobuploader == 1.2.4 14:16:09 INFO - docopt == 0.6.1 14:16:09 INFO - functools32 == 3.2.3-2 14:16:09 INFO - jsonschema == 2.5.1 14:16:09 INFO - manifestparser == 1.1 14:16:09 INFO - mozInstall == 1.12 14:16:09 INFO - mozcrash == 1.0 14:16:09 INFO - mozdebug == 0.1 14:16:09 INFO - mozdevice == 0.49 14:16:09 INFO - mozfile == 1.2 14:16:09 INFO - mozhttpd == 0.7 14:16:09 INFO - mozinfo == 0.9 14:16:09 INFO - mozleak == 0.1 14:16:09 INFO - mozlog == 3.4 14:16:09 INFO - moznetwork == 0.27 14:16:09 INFO - mozprocess == 0.23 14:16:09 INFO - mozprofile == 0.28 14:16:09 INFO - mozrunner == 6.13 14:16:09 INFO - mozscreenshot == 0.1 14:16:09 INFO - mozsystemmonitor == 0.3 14:16:09 INFO - moztest == 0.8 14:16:09 INFO - mozversion == 1.4 14:16:09 INFO - psutil == 3.1.1 14:16:09 INFO - requests == 1.2.3 14:16:09 INFO - wsgiref == 0.1.2 14:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:09 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:16:09 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 14:16:09 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 14:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:09 INFO - 'HOME': '/Users/cltbld', 14:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:09 INFO - 'LOGNAME': 'cltbld', 14:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:09 INFO - 'MOZ_NO_REMOTE': '1', 14:16:09 INFO - 'NO_EM_RESTART': '1', 14:16:09 INFO - 'PAGER': '/bin/cat', 14:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:09 INFO - 'PWD': '/builds/slave/test', 14:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:09 INFO - 'SHELL': '/bin/bash', 14:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:16:09 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:09 INFO - 'USER': 'cltbld', 14:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:09 INFO - 'XPC_FLAGS': '0x0', 14:16:09 INFO - 'XPC_SERVICE_NAME': '0', 14:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 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)) 14:16:10 INFO - Cleaning up... 14:16:10 INFO - Return code: 0 14:16:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:10 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 0x103c0cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c0f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe914d1440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, '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.zZKCIvMABT/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.H50GkPBWan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 14:16:10 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 14:16:10 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 14:16:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:16:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:10 INFO - 'HOME': '/Users/cltbld', 14:16:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:10 INFO - 'LOGNAME': 'cltbld', 14:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:10 INFO - 'MOZ_NO_REMOTE': '1', 14:16:10 INFO - 'NO_EM_RESTART': '1', 14:16:10 INFO - 'PAGER': '/bin/cat', 14:16:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:10 INFO - 'PWD': '/builds/slave/test', 14:16:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:10 INFO - 'SHELL': '/bin/bash', 14:16:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:16:10 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:16:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:10 INFO - 'USER': 'cltbld', 14:16:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:10 INFO - 'XPC_FLAGS': '0x0', 14:16:10 INFO - 'XPC_SERVICE_NAME': '0', 14:16:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:16:10 INFO - Cleaning up... 14:16:10 INFO - Return code: 0 14:16:10 INFO - Running post-action listener: _resource_record_post_action 14:16:10 INFO - Running post-action listener: _start_resource_monitoring 14:16:10 INFO - Starting resource monitoring. 14:16:10 INFO - [mozharness: 2017-01-06 22:16:10.504131Z] Finished create-virtualenv step (success) 14:16:10 INFO - [mozharness: 2017-01-06 22:16:10.505034Z] Running install step. 14:16:10 INFO - Running pre-action listener: _resource_record_pre_action 14:16:10 INFO - Running main action method: install 14:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:10 INFO - Reading from file tmpfile_stdout 14:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:10 INFO - Reading from file tmpfile_stdout 14:16:10 INFO - Output received: 14:16:10 INFO - Usage: mozinstall [options] installer 14:16:10 INFO - Options: 14:16:10 INFO - -h, --help show this help message and exit 14:16:10 INFO - -d DEST, --destination=DEST 14:16:10 INFO - Directory to install application into. [default: 14:16:10 INFO - "/builds/slave/test"] 14:16:10 INFO - --app=APP Application being installed. [default: firefox] 14:16:10 INFO - mkdir: /builds/slave/test/build/application 14:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:16:32 INFO - Reading from file tmpfile_stdout 14:16:32 INFO - Output received: 14:16:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:16:32 INFO - Running post-action listener: _resource_record_post_action 14:16:32 INFO - [mozharness: 2017-01-06 22:16:32.425324Z] Finished install step (success) 14:16:32 INFO - [mozharness: 2017-01-06 22:16:32.425483Z] Running run-tests step. 14:16:32 INFO - Running pre-action listener: _resource_record_pre_action 14:16:32 INFO - Running main action method: run_tests 14:16:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:32 INFO - 2017-01-06 14:16:32.440 screenresolution[1629:7413] starting screenresolution argv=screenresolution get 14:16:32 INFO - 2017-01-06 14:16:32.442 screenresolution[1629:7413] Display 0: 1600x1200x32@60 14:16:32 INFO - 2017-01-06 14:16:32.448 screenresolution[1630:7416] starting screenresolution argv=screenresolution list 14:16:32 INFO - Available Modes on Display 0 14:16:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:32 INFO - Intel Iris: 14:16:32 INFO - Chipset Model: Intel Iris 14:16:32 INFO - Type: GPU 14:16:32 INFO - Bus: Built-In 14:16:32 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:32 INFO - Vendor: Intel (0x8086) 14:16:32 INFO - Device ID: 0x0a2e 14:16:32 INFO - Revision ID: 0x0009 14:16:32 INFO - Displays: 14:16:32 INFO - Display: 14:16:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:32 INFO - Display Serial Number: 1600x1200 60 14:16:32 INFO - Main Display: Yes 14:16:32 INFO - Mirror: Off 14:16:32 INFO - Online: Yes 14:16:32 INFO - Rotation: Supported 14:16:32 INFO - Return code: 0 14:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:32 INFO - Python 2.7.3 14:16:32 INFO - Return code: 0 14:16:32 INFO - grabbing minidump binary from tooltool 14:16: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')]} 14:16:32 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 0x1039ead30>, '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 0x103911db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039dfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:32 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 14:16:32 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 14:16:32 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 14:16:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:32 INFO - Return code: 0 14:16:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:16:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:16:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 14:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0217 --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 14:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zZKCIvMABT/Render', 14:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:32 INFO - 'HOME': '/Users/cltbld', 14:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:32 INFO - 'LOGNAME': 'cltbld', 14:16:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:32 INFO - 'MOZ_NO_REMOTE': '1', 14:16:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:32 INFO - 'NO_EM_RESTART': '1', 14:16:32 INFO - 'PAGER': '/bin/cat', 14:16:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:32 INFO - 'PWD': '/builds/slave/test', 14:16:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:32 INFO - 'SHELL': '/bin/bash', 14:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H50GkPBWan/Listeners', 14:16:32 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 14:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:32 INFO - 'USER': 'cltbld', 14:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:32 INFO - 'XPC_FLAGS': '0x0', 14:16:32 INFO - 'XPC_SERVICE_NAME': '0', 14:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--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 14:16:33 INFO - mozversion application_buildid: 20170106110655 14:16:33 INFO - mozversion application_changeset: 1a815865294fbf234f166c075986f587b2b72a89 14:16:33 INFO - mozversion application_display_name: Nightly 14:16:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:33 INFO - mozversion application_name: Firefox 14:16:33 INFO - mozversion application_remotingname: firefox 14:16:33 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:16:33 INFO - mozversion application_vendor: Mozilla 14:16:33 INFO - mozversion application_version: 53.0a1 14:16:33 INFO - mozversion platform_buildid: 20170106110655 14:16:33 INFO - mozversion platform_changeset: 1a815865294fbf234f166c075986f587b2b72a89 14:16:33 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:16:33 INFO - mozversion platform_version: 53.0a1 14:16:33 INFO - using testdate: 1483740993 14:16:33 INFO - actual date: 1483740993 14:16:33 INFO - starting webserver on 'localhost:49240' 14:16:33 INFO - SUITE-START | Running 2 tests 14:16:33 INFO - TEST-START | dromaeo_css 14:16:33 INFO - operating with platform_type : mac_ 14:16:33 INFO - Initialising browser for dromaeo_css test... 14:16:33 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpRnAYwz/profile http://localhost:49240/getInfo.html) 14:16:33 INFO - PROCESS | 1640 | 1483740993571 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 14:16:35 INFO - PROCESS | 1640 | 2017-01-06 14:16:35.931 plugin-container[1642:7575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 14:16:35 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:35 INFO - PROCESS | 1640 | 2017-01-06 14:16:35.934 plugin-container[1642:7575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 14:16:35 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:35 INFO - PROCESS | 1640 | 2017-01-06 14:16:35.934 plugin-container[1642:7575] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:16:35 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 14:16:35 INFO - PROCESS | 1640 | colorDepth:24 14:16:35 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 14:16:35 INFO - PROCESS | 1640 | __metrics 14:16:36 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:16:36 INFO - TEST-INFO | 1640: exit 0 14:16:36 INFO - Browser initialized. 14:16:36 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:36 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpRnAYwz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:39 INFO - PROCESS | 1643 | 2017-01-06 14:16:39.095 plugin-container[1644:7701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:16:39 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:39 INFO - PROCESS | 1643 | 2017-01-06 14:16:39.096 plugin-container[1644:7701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 14:16:39 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:16:39 INFO - PROCESS | 1643 | 2017-01-06 14:16:39.096 plugin-container[1644:7701] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:16:48 INFO - PROCESS | 1643 | RSS: Main: 233410560 14:16:48 INFO - PROCESS | 1643 | 14:19:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:19:53 INFO - PROCESS | 1643 | RSS: Main: 250613760 14:19:53 INFO - PROCESS | 1643 | 14:21:37 INFO - PROCESS | 1643 | ************************* 14:21:37 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 14:21:37 INFO - PROCESS | 1643 | 14:21:37 INFO - PROCESS | 1643 | Full message: ReferenceError: fetch is not defined 14:21:37 INFO - PROCESS | 1643 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 14:21:37 INFO - PROCESS | 1643 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 14:21:37 INFO - PROCESS | 1643 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 14:21:37 INFO - PROCESS | 1643 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:21:37 INFO - PROCESS | 1643 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:21:37 INFO - PROCESS | 1643 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:21:37 INFO - PROCESS | 1643 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 14:21:37 INFO - PROCESS | 1643 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:21:37 INFO - PROCESS | 1643 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:21:37 INFO - PROCESS | 1643 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:21:37 INFO - PROCESS | 1643 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 14:21:37 INFO - PROCESS | 1643 | 14:21:37 INFO - PROCESS | 1643 | ************************* 14:22:55 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:22:56 INFO - PROCESS | 1643 | RSS: Main: 261226496 14:22:56 INFO - PROCESS | 1643 | 14:25:58 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:25:58 INFO - PROCESS | 1643 | RSS: Main: 269115392 14:25:58 INFO - PROCESS | 1643 | 14:29:00 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:29:01 INFO - PROCESS | 1643 | RSS: Main: 266133504 14:29:01 INFO - PROCESS | 1643 | 14:32:04 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:32:04 INFO - PROCESS | 1643 | RSS: Main: 270761984 14:32:04 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:35:07 INFO - PROCESS | 1643 | RSS: Main: 272969728 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | __start_tp_report 14:35:07 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:35:07 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:35:07 INFO - PROCESS | 1643 | |i|pagename|runs| 14:35:07 INFO - PROCESS | 1643 | |0;dojo.html;2731.9317017074573;2956.4973954427737;3280.5735254416923;3309.9338013239735;3310.3213841162565;5496.725163741817;5577.44225577442;5578.581606379517;5604.215409842615;5647.8588035299135;5437.73193408084;5492.176173573956;5542.889142217154;5552.805651802188;5580.330360356763;3675.705943524525;5051.393832740058;5113.5909127269915;5138.563222126105;5171.741412929338;5132.666376685522;5161.122609156434;5187.0922588546855;5202.167653175493;5217.713025783581;473.79280480245865;5123.103456895065;5129.820456284049;5205.089109405858;5278.3665960084845;4349.804258808361;5130.333056702642;5141.357330333708;5156.149235376196;5177.094008548489;5097.8215762448135;5103.260027296058;5105.438401775802;5127.307813445212;5157.9941911327305;5392.865178370533;5481.424450432687;5520.420355862617;5542.307211598551;5692.658440493542;6032.45707886288;6083;6114.023656277648;6137.622145771035;6140.324564297924;6175.5985860919345;6178.69106544671;6199.287081985584;6201.565890387675;6202.596831205957;5595.104783234663;5711.343195532525;5746.569007324468;5756.539476841843;5802.33273173582;6151.692415379213;6157.784477543264;6166.691665416712;6191.938080619227;6221.5333849961435;6072.848178795477;6097.115918191837;6113.993245360534;6121.265448146251;6125.816225513242;6015.669138197353;6123.755049798047;6131.448169664663;6151.630902145886;6193.81418557444;5965.55258355625;6016.759329626853;6018.458338749533;6187.659678717624;6189.597676151036;6103.38966103395;6111.96944015277;6127.234095738033;6132.2947860996555;6133.018717005258;4853.757312134379;4891.730954797449;4892.0705066037335;4988.6507944444265;5019.598432125495;4339.305711086274;4344.9348259776125;4372.540883207217;4400.383946247528;4421.182081314967;4810.7835147418455;5738.483536481736;5776.306843178845;5781.392953739881;5826.126081087786;6050.757969681164;6103.298120716086;6115.480184184395;6147.293061297919;6209.2548894133;5684.147377893267;5687.60186786921;5688.658680479184;5690.061139911951;5710;4385.88160019193;4833.299171620166;5419.83740487786;5441.319835020622;5443.782248710087;6223.066540019034;6225.657588832658;6225.875482490415;6226.1905952225925;6230.563860529719;6000.21997140369;6094.573379863367;6138.355472675305;6141.140240366263;6152.723127459186;5252.1596544552685;5338.706371149624;6137.938620613915;6151.169592105188;6156.476699480594;4899.559039686303;6043.758249669964;6048.939510605013;6051.33435322123;6067.787627433018;5728.312602487728;6068.605540639845;6101.610781564156;6110.052941794029;6132.540059495466;5864.9413505864395;5963.7912673056235;5970;5985.461308482258;6001.519878409804;5934.881302373842;5951.613145145551;5955.255593050869;5975.014122669711;6007;5644.6613203207935;5664.603477756682;5664.745086471036;5799.710014499343;5815.127730840408;5792.623479473821;5968.76124954997;5990;5994.580379373402;5997.460228579449;4952.603791696728;5778.335491418541;5784.768609255751;5848.093545500455;5863.560232982629 14:35:07 INFO - PROCESS | 1643 | |1;ext.html;439.2247682839788;470.2757753060287;499.74013512973255;501.1080277106749;542.5767901037192;37875.62124378759;40291;40417.79791101044;40428.393574096335;40473.797631011876;32701.18247043819;40957.79521102398;41505.58494415055;41641.791791041076;41698.37452438216;8303.418760686754;8528.445651032664;9125.224355929753;9331.626734930629;9370.203532699728;9732.902670973306;11040.3375797452;11319.547218111265;11362.659120226364;11504.25222360544;11358.432078396088;11392.25950313231;11410.144239182053;11411.087113030979;11427.028702560292;11269.54921803131;11311.377874216914;11333.716657083556;11342.546298148065;11350.602728904449;11253.212275140744;11279.774404511945;11300.434978251136;11315.321080735182;11316.207865449422;39503.60496395028;39638.60361396407;39875.601243987476;39955.60044399548;39956.200875982606;3925.548561915388;3941.783201923893;3944.408338749182;3945;4054.7567145971334;29120.625579906766;30565.847170764227;30657.38685226283;30662.386752265054;30733.538996915064;3123.422166899131;3157.2422618571377;3191.6010498687665;3249.252671885456;3305.1406634275263;430181;436591;436936;437533;441443.7927810373;59713.40286597165;60090.39909600848;60124.69937650284;60174.699126504085;60366.39633603608;63291;63689.681551591944;63950;64091.35908640947;64210;14485.85514144845;14873.256337183098;14873.256337183098;14911.179885106207;14929;10686.51910664022;11048.613298534512;11301.208915375844;12045.819312710317;12215.572454964211;17610.119494025246;19251;19364.225430982886;19929.402117936486;20117.79882201159;7371.078615173104;8324.958375208085;8451.915480845235;8453.70412035588;8474.872876906851;795.9044914610283;852.6972924611797;855.4140413816556;866.7183165471247;869.7303835810919;28592.42815143727;29385.559216611768;29514.114576562737;30367.088987330415;30380;841.6170642357713;1003.7992401519725;1055.7331202556963;1056.6354607660344;1140.1733743036398;13013.8938190253;15218.467353642569;15411.383544658313;15786.052836829827;15808;561893;639420;653134;654084;834025;41761;53782.19326710102;53806;53808.46191538113;54143.72928135334;1347.7439286535528;1352.9932350338186;1374.2510331868955;1374.3677908162158;1380.6203294094205;21151;28520;28732;28843.84624615076;29406.411871762873;46312;46957;46971.53028469672;47112.7644361776;47168;546047.5859551823;559475;559932;560399;562758.3724162705;22472;22811.657825132967;23018.53962920766;24527.632085518373;25547.36131596725;35826.13390928772;38777.806110969264;41445;41619.7919010403;42142.57857421387;24257.63613545763;35110.82444587761;35526.822365888;35663.96856267246;35811.92564223077;34021.31957360789;35234.8238258807;35336;36311;36330.636693632725;35017.824910875286;35348.646513534535;35639.64360356363;35739.46390804088;35750;26749.598756018288;29247;30020.849895751257;31885.68114318827;32015.67984320127;23465.88267058654;23943.760562394153;24222.878885606166;24493.51012979766;24629.63055554204 14:35:07 INFO - PROCESS | 1643 | |2;jquery.html;385.71264408016015;389.9337112690842;393.2920742663206;396.0751644909138;419.3856000958597;15969.680606387865;19296.807031929675;19997;20614;20694.379168624946;17501.124943752795;20140.496487587818;20937.895310523465;21633.026513806875;21670.808105554188;5458.727063646812;5794.884102317951;5830.32951210612;5866.911996320058;5877.67672777997;5649.293838270216;5763.740631671585;5859.355470898197;5861.648301101947;5866.501347385477;5784.710764461781;5854.970725146369;5867.911981320283;5873.70631468427;5883.823485295448;5602.663840169603;5787.189793428924;5859.824205273827;5865.8826823463505;5869.618474799146;5178.14560597501;5184.7407629618365;5186;5187.533122019036;5188.22176673502;23392;25527.61708574373;25639.846206920734;26016.479670406487;26409;2456.8648724320155;2766.9169924902285;2866.7816178124212;2996.6703662597097;3192.0264319382577;14280.143191408548;15447.382104715798;15880.808939329596;16027.519174424786;16615.584610384718;1553.487349174781;1614.9434769783118;1788.2578729827105;1825.3793710138484;1829.0734824281176;109531;132432.35135297338;138437.3078134613;141152;141794.58205417916;11298.209125361145;11759.2958218161;11802.46888890002;11826.290422574673;12010.389403999841;13792.724145517033;14316.713665726627;15400.383984640488;15439.845601544066;15458.613534661723;8059.838803223903;8392.706255281159;8496.447730897471;8538.530380829114;8635.784105397415;7257.49197556166;8204.261616454547;8227.42408031444;8231.17688231184;8283.875741863876;4614.74618895964;4704.6236301096515;4708.434987801417;4768.237082066853;4789.970156416387;1698.9745153822703;1973.8914359710066;2033.1562401603464;2034;2037.7860324665994;846.7417437681567;894.6242578117207;926.3284119013796;955.6225291010012;982.8722266105503;18072.728909066376;21451.78548214529;21621.35135945924;21813.127474900826;21903.342899713036;1003.6487229469627;1022.749426390539;1025.4206373399154;1031.9329243599143;1065.7761870007384;11123.666290011313;11345.943270283597;11359.602413915472;11411.885881141248;11424.200305978668;563599;563623;651394;674933;688781;129443;158726.20636896972;160404;162014;164730;895.6865097216053;1007.0734923869911;1007.09361574582;1049.9212559057949;1054.9894501054891;20098.39704808858;20257.898710506353;20491.38525844227;20495.692564611243;20525;58538.7073064632;60521;61750.69124654528;62037.37962620316;62163.37836621576;75402;88524;90592.64111038472;92429;94550.05449945413;8183.345332373515;8220.794480138044;8236.588170591567;8659.307255419677;8659.350548708999;9303.953480232556;12280.75438491243;12956.611301660965;13049.739005220032;13308.600741977756;10310.742231444274;11027.724306892393;11403.942980285046;11619.302841829518;11638;10646.361218326925;10923.945380273048;10953.616623418142;11099.389533575732;11196.66410007701;11116.22186446941;11297.039751620876;11582.247153934968;11585.420728963349;11638.53445862156;8175;8282.544460054754;8550.187732165434;8667.349948753743;8725.432846864933;9869.45717985489;11261.324320540794;11525.769484610093;11638.941805290919;11677.06583473337 14:35:07 INFO - PROCESS | 1643 | |3;mootools.html;1283.6854970532222;1389.4581113365787;1425.9857401425982;1426.7360538300416;1455.8908081893853;7475.813104672386;7748.41886858485;7995.32039776619;8448;8451.788705282363;7360.822268437051;7736.4913841800735;7949.165337639552;8127.390445716565;8275;2291.3698732848475;2330.4057465346314;2333.57995560799;2334.7898689117974;2345.824063195267;2067.2041264113273;2156.870587764731;2318.2233951626226;2351.0595761695286;2383.1182462488905;2049.549099198174;2214.9557008859815;2300.884955752214;2306.884655767213;2332.7200735911715;2005.358285348689;2240.271911628727;2307.561563302967;2307.665388518672;2329.9301020969397;2025.0785892418915;2271.1256166375897;2326.5579539887535;2359.7640235976437;2361.126383238213;8348.039975402846;8349.624266908004;8440.409171358007;8465.53439560824;8474.1949514796;5074.594032477393;5214.582833373359;5223.71269580173;5244.265802787613;5245.606579506552;2779.3051737065734;3402.8468718907707;3471.600765911902;3488.6162522122545;3502.5271588335504;1204.3857632607346;1207.6233094272536;1209.5826939705787;1243.5274595653684;1249.6875781054737;10390.636327728493;10395.896041039568;10446.216533759998;10461.058504734534;10466.895331046668;4365.825366985285;4570.108828778356;4657.60410365116;4657.976710116428;4722.126406614787;9398.624055037859;9487.90512094884;9494.430334179971;9505.857412138823;9516.666916657883;5131.204663277198;5213.061648903158;5215.087359712035;5215.217717342429;5247.501487358695;4600.746958917225;4703.270992996023;4731.101090792738;4750.311204875274;4761.6904901181315;3153.6057992750907;3183.2519357950864;3801.4487899255005;3900.4539364488996;3910.687145028391;1175.1773758369177;1218.3847157185742;1222.57821051737;1223.4188760338945;1228.7358217983176;712.9465290103263;752.889488005188;774.4269240761796;777.859985202669;802.8719648893315;4566.566176213254;5741.540676745851;5770.336411312669;5800.6809625471005;5974.790882319098;960.4669408478362;974.337450533644;974.6890432368454;974.7027156717128;994.6121012805012;3773.1510410157493;3773.8301776420126;3783.5270591176104;3869.9613003870163;3884.8446062157764;7576;9947.204223662235;10027.448490333101;10108.949455252676;10155.543000564992;10000.099991000845;10021.29850910444;10030.949845250727;10034.448105354275;10053.296269261082;7300.744473943387;7675.961620191975;7825.804354891059;7933.523988560705;7952.562609056442;5680.943190568041;5791.247137872049;5811.953848307346;5903.730697899972;5907.084401917709;8759.386842921189;8989.82020359576;9037.322200835095;9071.682491112779;9100.317476189444;9150.954245228997;9272.443653380818;9273.814523709352;9318;9376.34365594429;7080.645967701697;7193;7215.567065976058;7216;7232;7717.961410192913;7747.30274275318;7846.372290216883;7854.293113619801;7864.174261702439;7066.7173313066905;7085.50401471892;7097.361237488651;7220.0613920190035;7235.891461627974;7028.9648551758955;7037.120359955005;7061.329173728487;7066.823329416806;7105.822354440974;6336.778212762531;6350.396712312323;6353.745850166127;6418;6441.67791610427;4819.156647586588;4894.951050489592;4904.8773780655765;4929.9893521827225;5056.039352523009;4931.432885218246;4937.456879743154;5011.749412529286;5044.596432285482;5059.5952323814745 14:35:07 INFO - PROCESS | 1643 | |4;prototype.html;334.5550417944134;363.8090002748557;364.5079143156739;367.31129132875856;369.32782336148205;5424.3490781106275;5450.509454149126;5598.536643876691;5610;5612.550995920326;5212.192110222912;5433.212184233284;5435.287884316437;5439.918401223985;5495.230667706524;3542.1498840278405;3873.283442563121;4065.5200327800017;4116.34138537834;4172.7273181679575;3539.3806083935337;3617.421212605984;3736.0199094479967;4004.199160167978;4072.6538244249127;3344.3980083584943;3771.66055055045;3778.8299526521373;4101.282275601773;4158.981049642842;3888.4361767543546;4050.9594904050878;4122.031322639177;4134.979325103385;4144.171165766858;3129;3266.7223286020717;3521.7710848795004;3529.9410176946812;3535.9469607955903;5302.522772950453;5303.284056652341;5312.203169524602;5342.893142137135;5408.378036525811;3928.823202955874;4612.492625811158;4736.9526304736855;4765.809367625291;4775.9761201194115;5789.88420231593;5801.3328467225965;5830.15462757902;5847.561432892508;5858.238429004202;3470.514128022079;3927.8232479538487;3933.2920074386598;3944.5660977292473;3949.269385163754;5363.54409875161;5414.7834086636485;5795.942040579583;5896.292444906639;6128.540359473057;3295.3903527847424;3627.782333060025;3847.4033276190066;3923.941140882889;3934.370500719871;3510.982445087809;3963;3986.5614782373914;4002.3796311571755;4005.339119045325;4307.332363483665;4622.491525932145;4685.882852928704;4707.435107787088;4726.85819425411;5076.974615126901;5637.393342897337;5693.231413759089;5887;5896.616719913278;1175.7595736498076;1285.4087119924752;1293.9676508087373;1300.3888172558882;1301.8958483321312;716.638097760638;833.9457935234191;839.8824164616958;868.9695860644847;878.4641368765048;4370.912581748347;4479.977600111979;4530.773461326987;5195.19474481456;5225.850312931149;4704.882377940579;4924.75376231187;5132.409772876093;5170.819021334235;5595.964746521825;4694.662021323907;4993.3535226330105;5188.766505507261;5218.608604354688;5246.534128959459;2638.2744745195223;2814.943701125966;2974;2987.68629293921;3015.8841228745064;5595.776168953278;5964.880702385928;5980.312264089598;6006.399360064046;6017.729202185825;4871.5128487151715;5069.518395752398;5563.7774489019985;5840.3575606683235;5869.530437564985;5241.999999999924;6033.818985430444;6098.481629061491;6207.423919073534;6254.21822272216;5944.554158438048;5985.970070149621;5995.91006134917;6000;6000.279966404059;4701.764911754331;5301.416844147064;5637.52081073097;5880.353161152184;5930.703464826827;5389.407165211745;5650.242588678647;5710.5146062585145;6182.60891299454;6202.038684003986;3644.781313121221;3789.962100379071;3858.514471928384;4269.850555230552;4280.871573852789;4968.701877887338;5239.371275446971;5724.713764311851;5994.550408719277;5999.140266517394;5126.666766660155;5808.767649293981;5858.7070646468355;5860.472557469848;5862.618929769551;5116.28372027909;5395.649282796606;5459.5632349412745;5754.884902302014;5789.726260222744;4486.304622783474;5656.095024796013;5694.857628559319;5699.458551437607;5736.68448235351;4706.905861882811;4765.523447655207;5810.82567522975;5827.825165245049;5871.6770577618645;4594.2189827730035;5001.699898006132;5254.7898084076205;5496.532794712494;5638.7462564185535 14:35:07 INFO - PROCESS | 1643 | |5;yui.html;688.6487891175499;703.4302215205684;764.8737958236891;769.865273577124;819.5902048975512;11233.494492747826;12709.872901270985;12898.80651790224;15442.613934651625;15735.527934161993;14302.213378264218;14367.209803460806;14479.2760361982;14485.203313817736;14515.491957781453;671.8521925176453;694.7637803146916;696.5437638346891;840.7015509494133;872.8472517309477;860.724568138196;864.0797550608613;869.7695110795644;873.1225118755642;876.3033388456192;930.2557953637097;931.4923366765129;935.9578818953163;939.5443210043123;949.050949050949;912.1881525442361;933.6778811310087;934.0892629686069;934.8924873639551;935.3779736475236;674.2414783368711;694.2328726756962;695.1345574759406;695.3116414749412;699.6152116335995;14287.214203218819;14468.565943021726;14558;14877;14900.776488352683;13806.240656763874;14139.222342771143;14153.22157281349;14174.936879733958;14218.715625687531;11526.020288275507;11665.533378664843;11682.883171168265;11738.530458781639;11812.52749890012;3665.9083522911874;3679.742418030739;3692.464592634053;3709.0727318170457;3826.9858487500833;83062.3387532252;91263;92762.14475710448;94968.52515737446;96729.51635241919;10781.676549703521;10798.73003174927;10846.29499082557;10946.890531094587;11266.887331126747;22170.667439988414;22443.32670019902;22500.437489062577;22715.09139634429;22717.2048978285;7526.435517336222;7548.245175482518;7629.923700763033;7662.233776622294;7802.258785415376;4174.624283814472;4182.853600123981;4240.194363071007;4287.957120428819;4358.128374325148;3514.8242587870504;3606.765560238576;3607.5129857468905;3621.3300539400293;3631.2737452509605;631.5831551176202;636.920384951881;641.1120597971842;646.0922404022356;658.8996376052005;654.0842820051965;669.9229588597276;683.6513378177166;683.825624465768;697.5431092634333;9924.957879422556;10026.19790416765;10264.948675256575;10329.586816527404;10336.586536538605;648.2545073165898;667.1493845347221;677.7187467201155;679.7620832708611;703.7466512055656;4619.953800461953;4955.82654607087;4960.627952903546;4963.702177869267;4988.301637770715;68692;88017.55991220003;103522;105598;105649;90380;90766.54616726874;90896.545517272;91241;91721;65848;78743.60628196938;80605.79091313518;80695;81211.59394202991;7841;9663.371880827724;9691.321607487409;9692.273079519206;9720.416774993522;43980.12039759251;49387.765305867644;50836.98326033533;53266.93466130733;54988;48619.02761944812;61906.69046654918;62573.748525030154;71870.64064679643;73355;13089.477487354774;13129.803052954023;13141.277229752455;13208.66978325511;13492.865071349554;14494.63763405881;14743.262836858328;14755.188464634548;14806.481773137888;14813.407463701331;11784.292942423483;11893.82159267629;12314.815277770662;13330.133541319783;13607.387667555182;13526.79709804334;13546.254955977516;13728.313584320944;13746.106503077268;13887.652808679864;13414.798778018532;13439.664008399868;13444.932775336061;13695;13868.237246951514;8896.822063558822;11160.776784464428;11196.83204751913;11327.771585098208;11667.766644667228;10902.542563114897;10934.453277335942;11031.779364412827;11191.552337906392;11195.552177913118 14:35:07 INFO - PROCESS | 1643 | __end_tp_report 14:35:07 INFO - PROCESS | 1643 | __start_cc_report 14:35:07 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,376 14:35:07 INFO - PROCESS | 1643 | __end_cc_report 14:35:07 INFO - PROCESS | 1643 | __startTimestamp1483742107749__endTimestamp 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:35:07 INFO - PROCESS | 1643 | Number of tests: 6 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5568.62 Median:5784.77 stddev:783.02 (13.5%) stddev-sans-first:753.14 14:35:07 INFO - PROCESS | 1643 | Values: 2731.9 2956.5 3280.6 3309.9 3310.3 5496.7 5577.4 5578.6 5604.2 5647.9 5437.7 5492.2 5542.9 5552.8 5580.3 3675.7 5051.4 5113.6 5138.6 5171.7 5132.7 5161.1 5187.1 5202.2 5217.7 473.8 5123.1 5129.8 5205.1 5278.4 4349.8 5130.3 5141.4 5156.1 5177.1 5097.8 5103.3 5105.4 5127.3 5158.0 5392.9 5481.4 5520.4 5542.3 5692.7 6032.5 6083.0 6114.0 6137.6 6140.3 6175.6 6178.7 6199.3 6201.6 6202.6 5595.1 5711.3 5746.6 5756.5 5802.3 6151.7 6157.8 6166.7 6191.9 6221.5 6072.8 6097.1 6114.0 6121.3 6125.8 6015.7 6123.8 6131.4 6151.6 6193.8 5965.6 6016.8 6018.5 6187.7 6189.6 6103.4 6112.0 6127.2 6132.3 6133.0 4853.8 4891.7 4892.1 4988.7 5019.6 4339.3 4344.9 4372.5 4400.4 4421.2 4810.8 5738.5 5776.3 5781.4 5826.1 6050.8 6103.3 6115.5 6147.3 6209.3 5684.1 5687.6 5688.7 5690.1 5710.0 4385.9 4833.3 5419.8 5441.3 5443.8 6223.1 6225.7 6225.9 6226.2 6230.6 6000.2 6094.6 6138.4 6141.1 6152.7 5252.2 5338.7 6137.9 6151.2 6156.5 4899.6 6043.8 6048.9 6051.3 6067.8 5728.3 6068.6 6101.6 6110.1 6132.5 5864.9 5963.8 5970.0 5985.5 6001.5 5934.9 5951.6 5955.3 5975.0 6007.0 5644.7 5664.6 5664.7 5799.7 5815.1 5792.6 5968.8 5990.0 5994.6 5997.5 4952.6 5778.3 5784.8 5848.1 5863.6 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:67983.34 Median:35437.73 stddev:151253.08 (426.8%) stddev-sans-first:151592.37 14:35:07 INFO - PROCESS | 1643 | Values: 439.2 470.3 499.7 501.1 542.6 37875.6 40291.0 40417.8 40428.4 40473.8 32701.2 40957.8 41505.6 41641.8 41698.4 8303.4 8528.4 9125.2 9331.6 9370.2 9732.9 11040.3 11319.5 11362.7 11504.3 11358.4 11392.3 11410.1 11411.1 11427.0 11269.5 11311.4 11333.7 11342.5 11350.6 11253.2 11279.8 11300.4 11315.3 11316.2 39503.6 39638.6 39875.6 39955.6 39956.2 3925.5 3941.8 3944.4 3945.0 4054.8 29120.6 30565.8 30657.4 30662.4 30733.5 3123.4 3157.2 3191.6 3249.3 3305.1 430181.0 436591.0 436936.0 437533.0 441443.8 59713.4 60090.4 60124.7 60174.7 60366.4 63291.0 63689.7 63950.0 64091.4 64210.0 14485.9 14873.3 14873.3 14911.2 14929.0 10686.5 11048.6 11301.2 12045.8 12215.6 17610.1 19251.0 19364.2 19929.4 20117.8 7371.1 8325.0 8451.9 8453.7 8474.9 795.9 852.7 855.4 866.7 869.7 28592.4 29385.6 29514.1 30367.1 30380.0 841.6 1003.8 1055.7 1056.6 1140.2 13013.9 15218.5 15411.4 15786.1 15808.0 561893.0 639420.0 653134.0 654084.0 834025.0 41761.0 53782.2 53806.0 53808.5 54143.7 1347.7 1353.0 1374.3 1374.4 1380.6 21151.0 28520.0 28732.0 28843.8 29406.4 46312.0 46957.0 46971.5 47112.8 47168.0 546047.6 559475.0 559932.0 560399.0 562758.4 22472.0 22811.7 23018.5 24527.6 25547.4 35826.1 38777.8 41445.0 41619.8 42142.6 24257.6 35110.8 35526.8 35664.0 35811.9 34021.3 35234.8 35336.0 36311.0 36330.6 35017.8 35348.6 35639.6 35739.5 35750.0 26749.6 29247.0 30020.8 31885.7 32015.7 23465.9 23943.8 24222.9 24493.5 24629.6 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:37746.15 Median:21858.24 stddev:106271.64 (486.2%) stddev-sans-first:106532.74 14:35:07 INFO - PROCESS | 1643 | Values: 385.7 389.9 393.3 396.1 419.4 15969.7 19296.8 19997.0 20614.0 20694.4 17501.1 20140.5 20937.9 21633.0 21670.8 5458.7 5794.9 5830.3 5866.9 5877.7 5649.3 5763.7 5859.4 5861.6 5866.5 5784.7 5855.0 5867.9 5873.7 5883.8 5602.7 5787.2 5859.8 5865.9 5869.6 5178.1 5184.7 5186.0 5187.5 5188.2 23392.0 25527.6 25639.8 26016.5 26409.0 2456.9 2766.9 2866.8 2996.7 3192.0 14280.1 15447.4 15880.8 16027.5 16615.6 1553.5 1614.9 1788.3 1825.4 1829.1 109531.0 132432.4 138437.3 141152.0 141794.6 11298.2 11759.3 11802.5 11826.3 12010.4 13792.7 14316.7 15400.4 15439.8 15458.6 8059.8 8392.7 8496.4 8538.5 8635.8 7257.5 8204.3 8227.4 8231.2 8283.9 4614.7 4704.6 4708.4 4768.2 4790.0 1699.0 1973.9 2033.2 2034.0 2037.8 846.7 894.6 926.3 955.6 982.9 18072.7 21451.8 21621.4 21813.1 21903.3 1003.6 1022.7 1025.4 1031.9 1065.8 11123.7 11345.9 11359.6 11411.9 11424.2 563599.0 563623.0 651394.0 674933.0 688781.0 129443.0 158726.2 160404.0 162014.0 164730.0 895.7 1007.1 1007.1 1049.9 1055.0 20098.4 20257.9 20491.4 20495.7 20525.0 58538.7 60521.0 61750.7 62037.4 62163.4 75402.0 88524.0 90592.6 92429.0 94550.1 8183.3 8220.8 8236.6 8659.3 8659.4 9304.0 12280.8 12956.6 13049.7 13308.6 10310.7 11027.7 11403.9 11619.3 11638.0 10646.4 10923.9 10953.6 11099.4 11196.7 11116.2 11297.0 11582.2 11585.4 11638.5 8175.0 8282.5 8550.2 8667.3 8725.4 9869.5 11261.3 11525.8 11638.9 11677.1 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5390.88 Median:5172.13 stddev:2928.32 (56.6%) stddev-sans-first:2920.27 14:35:07 INFO - PROCESS | 1643 | Values: 1283.7 1389.5 1426.0 1426.7 1455.9 7475.8 7748.4 7995.3 8448.0 8451.8 7360.8 7736.5 7949.2 8127.4 8275.0 2291.4 2330.4 2333.6 2334.8 2345.8 2067.2 2156.9 2318.2 2351.1 2383.1 2049.5 2215.0 2300.9 2306.9 2332.7 2005.4 2240.3 2307.6 2307.7 2329.9 2025.1 2271.1 2326.6 2359.8 2361.1 8348.0 8349.6 8440.4 8465.5 8474.2 5074.6 5214.6 5223.7 5244.3 5245.6 2779.3 3402.8 3471.6 3488.6 3502.5 1204.4 1207.6 1209.6 1243.5 1249.7 10390.6 10395.9 10446.2 10461.1 10466.9 4365.8 4570.1 4657.6 4658.0 4722.1 9398.6 9487.9 9494.4 9505.9 9516.7 5131.2 5213.1 5215.1 5215.2 5247.5 4600.7 4703.3 4731.1 4750.3 4761.7 3153.6 3183.3 3801.4 3900.5 3910.7 1175.2 1218.4 1222.6 1223.4 1228.7 712.9 752.9 774.4 777.9 802.9 4566.6 5741.5 5770.3 5800.7 5974.8 960.5 974.3 974.7 974.7 994.6 3773.2 3773.8 3783.5 3870.0 3884.8 7576.0 9947.2 10027.4 10108.9 10155.5 10000.1 10021.3 10030.9 10034.4 10053.3 7300.7 7676.0 7825.8 7933.5 7952.6 5680.9 5791.2 5812.0 5903.7 5907.1 8759.4 8989.8 9037.3 9071.7 9100.3 9151.0 9272.4 9273.8 9318.0 9376.3 7080.6 7193.0 7215.6 7216.0 7232.0 7718.0 7747.3 7846.4 7854.3 7864.2 7066.7 7085.5 7097.4 7220.1 7235.9 7029.0 7037.1 7061.3 7066.8 7105.8 6336.8 6350.4 6353.7 6418.0 6441.7 4819.2 4895.0 4904.9 4930.0 5056.0 4931.4 4937.5 5011.7 5044.6 5059.6 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4579.36 Median:5179.79 stddev:1438.96 (27.8%) stddev-sans-first:1407.28 14:35:07 INFO - PROCESS | 1643 | Values: 334.6 363.8 364.5 367.3 369.3 5424.3 5450.5 5598.5 5610.0 5612.6 5212.2 5433.2 5435.3 5439.9 5495.2 3542.1 3873.3 4065.5 4116.3 4172.7 3539.4 3617.4 3736.0 4004.2 4072.7 3344.4 3771.7 3778.8 4101.3 4159.0 3888.4 4051.0 4122.0 4135.0 4144.2 3129.0 3266.7 3521.8 3529.9 3535.9 5302.5 5303.3 5312.2 5342.9 5408.4 3928.8 4612.5 4737.0 4765.8 4776.0 5789.9 5801.3 5830.2 5847.6 5858.2 3470.5 3927.8 3933.3 3944.6 3949.3 5363.5 5414.8 5795.9 5896.3 6128.5 3295.4 3627.8 3847.4 3923.9 3934.4 3511.0 3963.0 3986.6 4002.4 4005.3 4307.3 4622.5 4685.9 4707.4 4726.9 5077.0 5637.4 5693.2 5887.0 5896.6 1175.8 1285.4 1294.0 1300.4 1301.9 716.6 833.9 839.9 869.0 878.5 4370.9 4480.0 4530.8 5195.2 5225.9 4704.9 4924.8 5132.4 5170.8 5596.0 4694.7 4993.4 5188.8 5218.6 5246.5 2638.3 2814.9 2974.0 2987.7 3015.9 5595.8 5964.9 5980.3 6006.4 6017.7 4871.5 5069.5 5563.8 5840.4 5869.5 5242.0 6033.8 6098.5 6207.4 6254.2 5944.6 5986.0 5995.9 6000.0 6000.3 4701.8 5301.4 5637.5 5880.4 5930.7 5389.4 5650.2 5710.5 6182.6 6202.0 3644.8 3790.0 3858.5 4269.9 4280.9 4968.7 5239.4 5724.7 5994.6 5999.1 5126.7 5808.8 5858.7 5860.5 5862.6 5116.3 5395.6 5459.6 5754.9 5789.7 4486.3 5656.1 5694.9 5699.5 5736.7 4706.9 4765.5 5810.8 5827.8 5871.7 4594.2 5001.7 5254.8 5496.5 5638.7 14:35:07 INFO - PROCESS | 1643 | 14:35:07 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:19741.80 Median:24169.12 stddev:27752.39 (114.8%) stddev-sans-first:27793.37 14:35:07 INFO - PROCESS | 1643 | Values: 688.6 703.4 764.9 769.9 819.6 11233.5 12709.9 12898.8 15442.6 15735.5 14302.2 14367.2 14479.3 14485.2 14515.5 671.9 694.8 696.5 840.7 872.8 860.7 864.1 869.8 873.1 876.3 930.3 931.5 936.0 939.5 949.1 912.2 933.7 934.1 934.9 935.4 674.2 694.2 695.1 695.3 699.6 14287.2 14468.6 14558.0 14877.0 14900.8 13806.2 14139.2 14153.2 14174.9 14218.7 11526.0 11665.5 11682.9 11738.5 11812.5 3665.9 3679.7 3692.5 3709.1 3827.0 83062.3 91263.0 92762.1 94968.5 96729.5 10781.7 10798.7 10846.3 10946.9 11266.9 22170.7 22443.3 22500.4 22715.1 22717.2 7526.4 7548.2 7629.9 7662.2 7802.3 4174.6 4182.9 4240.2 4288.0 4358.1 3514.8 3606.8 3607.5 3621.3 3631.3 631.6 636.9 641.1 646.1 658.9 654.1 669.9 683.7 683.8 697.5 9925.0 10026.2 10264.9 10329.6 10336.6 648.3 667.1 677.7 679.8 703.7 4620.0 4955.8 4960.6 4963.7 4988.3 68692.0 88017.6 103522.0 105598.0 105649.0 90380.0 90766.5 90896.5 91241.0 91721.0 65848.0 78743.6 80605.8 80695.0 81211.6 7841.0 9663.4 9691.3 9692.3 9720.4 43980.1 49387.8 50837.0 53266.9 54988.0 48619.0 61906.7 62573.7 71870.6 73355.0 13089.5 13129.8 13141.3 13208.7 13492.9 14494.6 14743.3 14755.2 14806.5 14813.4 11784.3 11893.8 12314.8 13330.1 13607.4 13526.8 13546.3 13728.3 13746.1 13887.7 13414.8 13439.7 13444.9 13695.0 13868.2 8896.8 11160.8 11196.8 11327.8 11667.8 10902.5 10934.5 11031.8 11191.6 11195.6 14:35:07 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:35:07 INFO - PROCESS | 1643 | 14:35:08 INFO - TEST-INFO | 1643: exit 0 14:35:08 INFO - TEST-OK | dromaeo_css | took 1115379ms 14:35:08 INFO - TEST-START | kraken 14:35:08 INFO - operating with platform_type : mac_ 14:35:08 INFO - Initialising browser for kraken test... 14:35:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpXD9vnW/profile http://localhost:49240/getInfo.html) 14:35:08 INFO - PROCESS | 1656 | 1483742108907 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 14:35:11 INFO - PROCESS | 1656 | 2017-01-06 14:35:11.206 plugin-container[1657:10184] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 14:35:11 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:11 INFO - PROCESS | 1656 | 2017-01-06 14:35:11.209 plugin-container[1657:10184] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 14:35:11 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:11 INFO - PROCESS | 1656 | 2017-01-06 14:35:11.209 plugin-container[1657:10184] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:35:11 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 14:35:11 INFO - PROCESS | 1656 | colorDepth:24 14:35:11 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 14:35:11 INFO - PROCESS | 1656 | __metrics 14:35:11 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:35:12 INFO - TEST-INFO | 1656: exit 0 14:35:12 INFO - Browser initialized. 14:35:12 INFO - Running cycle 1/1 for kraken test... 14:35:12 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpXD9vnW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:14 INFO - PROCESS | 1658 | 2017-01-06 14:35:14.370 plugin-container[1659:10300] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 14:35:14 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:14 INFO - PROCESS | 1658 | 2017-01-06 14:35:14.374 plugin-container[1659:10300] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:35:14 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:14 INFO - PROCESS | 1658 | 2017-01-06 14:35:14.374 plugin-container[1659:10300] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:35:24 INFO - PROCESS | 1658 | RSS: Main: 233271296 14:35:24 INFO - PROCESS | 1658 | 14:35:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:28 INFO - PROCESS | 1658 | RSS: Main: 245940224 14:35:28 INFO - PROCESS | 1658 | 14:35:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:35:31 INFO - PROCESS | 1658 | RSS: Main: 253603840 14:35:31 INFO - PROCESS | 1658 | 14:35:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:35:35 INFO - PROCESS | 1658 | RSS: Main: 256176128 14:35:35 INFO - PROCESS | 1658 | 14:35:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:35:38 INFO - PROCESS | 1658 | RSS: Main: 257314816 14:35:38 INFO - PROCESS | 1658 | 14:35:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:40 INFO - PROCESS | 1658 | RSS: Main: 259010560 14:35:40 INFO - PROCESS | 1658 | 14:35:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:44 INFO - PROCESS | 1658 | RSS: Main: 265527296 14:35:44 INFO - PROCESS | 1658 | 14:35:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:48 INFO - PROCESS | 1658 | RSS: Main: 264056832 14:35:48 INFO - PROCESS | 1658 | 14:35:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:35:51 INFO - PROCESS | 1658 | RSS: Main: 264302592 14:35:51 INFO - PROCESS | 1658 | 14:35:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:54 INFO - PROCESS | 1658 | RSS: Main: 263131136 14:35:54 INFO - PROCESS | 1658 | 14:35:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:56 INFO - PROCESS | 1658 | RSS: Main: 263135232 14:35:56 INFO - PROCESS | 1658 | 14:35:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:59 INFO - PROCESS | 1658 | RSS: Main: 263213056 14:35:59 INFO - PROCESS | 1658 | 14:36:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:03 INFO - PROCESS | 1658 | RSS: Main: 263213056 14:36:03 INFO - PROCESS | 1658 | 14:36:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:36:07 INFO - PROCESS | 1658 | RSS: Main: 263233536 14:36:07 INFO - PROCESS | 1658 | 14:36:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:36:09 INFO - PROCESS | 1658 | RSS: Main: 265129984 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | __start_tp_report 14:36:09 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:36:09 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:36:09 INFO - PROCESS | 1658 | |i|pagename|runs| 14:36:09 INFO - PROCESS | 1658 | |0;ai-astar;107;126;110;152;175;175;120;119;119;118 14:36:09 INFO - PROCESS | 1658 | |1;audio-beat-detection;143;120;112;146;104;158;148;148;149;142 14:36:09 INFO - PROCESS | 1658 | |2;audio-dft;201;215;268;230;202;201;218;204;197;199 14:36:09 INFO - PROCESS | 1658 | |3;audio-fft;86;75;86;77;73;76;89;84;84;52 14:36:09 INFO - PROCESS | 1658 | |4;audio-oscillator;89;70;84;72;72;72;115;86;91;68 14:36:09 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;134;75;135;98;136;79;137;133;112;86 14:36:09 INFO - PROCESS | 1658 | |6;imaging-darkroom;97;96;96;107;100;131;156;95;98;97 14:36:09 INFO - PROCESS | 1658 | |7;imaging-desaturate;91;100;93;92;91;91;90;95;93;91 14:36:09 INFO - PROCESS | 1658 | |8;json-parse-financial;63;60;63;95;73;62;62;80;95;98 14:36:09 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;71;79;73;84;79;75;74;75;76;75 14:36:09 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;110;110;111;92;84;94;88;87;91;88 14:36:09 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;144;143;139;140;143;142;149;142;202;164 14:36:09 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;175;175;172;174;173;210;237;178;173;177 14:36:09 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;80;88;91;91;94;74;69;69;67 14:36:09 INFO - PROCESS | 1658 | __end_tp_report 14:36:09 INFO - PROCESS | 1658 | __start_cc_report 14:36:09 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,925 14:36:09 INFO - PROCESS | 1658 | __end_cc_report 14:36:09 INFO - PROCESS | 1658 | __startTimestamp1483742169201__endTimestamp 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:36:09 INFO - PROCESS | 1658 | Number of tests: 14 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:132.10 Median:123.00 stddev:25.65 (20.9%) stddev-sans-first:25.55 14:36:09 INFO - PROCESS | 1658 | Values: 107.0 126.0 110.0 152.0 175.0 175.0 120.0 119.0 119.0 118.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:147.00 stddev:18.17 (12.4%) stddev-sans-first:19.14 14:36:09 INFO - PROCESS | 1658 | Values: 143.0 120.0 112.0 146.0 104.0 158.0 148.0 148.0 149.0 142.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:213.50 Median:209.50 stddev:21.81 (10.4%) stddev-sans-first:22.66 14:36:09 INFO - PROCESS | 1658 | Values: 201.0 215.0 268.0 230.0 202.0 201.0 218.0 204.0 197.0 199.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:78.20 Median:84.00 stddev:10.73 (12.8%) stddev-sans-first:11.00 14:36:09 INFO - PROCESS | 1658 | Values: 86.0 75.0 86.0 77.0 73.0 76.0 89.0 84.0 84.0 52.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:81.90 Median:78.00 stddev:14.45 (18.5%) stddev-sans-first:15.10 14:36:09 INFO - PROCESS | 1658 | Values: 89.0 70.0 84.0 72.0 72.0 72.0 115.0 86.0 91.0 68.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:106.00 stddev:25.78 (24.3%) stddev-sans-first:26.15 14:36:09 INFO - PROCESS | 1658 | Values: 134.0 75.0 135.0 98.0 136.0 79.0 137.0 133.0 112.0 86.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:107.30 Median:96.00 stddev:20.25 (21.1%) stddev-sans-first:21.14 14:36:09 INFO - PROCESS | 1658 | Values: 97.0 96.0 96.0 107.0 100.0 131.0 156.0 95.0 98.0 97.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:91.50 stddev:2.95 (3.2%) stddev-sans-first:3.06 14:36:09 INFO - PROCESS | 1658 | Values: 91.0 100.0 93.0 92.0 91.0 91.0 90.0 95.0 93.0 91.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:75.10 Median:76.50 stddev:15.67 (20.5%) stddev-sans-first:15.99 14:36:09 INFO - PROCESS | 1658 | Values: 63.0 60.0 63.0 95.0 73.0 62.0 62.0 80.0 95.0 98.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:76.10 Median:75.50 stddev:3.70 (4.9%) stddev-sans-first:3.43 14:36:09 INFO - PROCESS | 1658 | Values: 71.0 79.0 73.0 84.0 79.0 75.0 74.0 75.0 76.0 75.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:95.50 Median:88.00 stddev:10.61 (12.1%) stddev-sans-first:9.87 14:36:09 INFO - PROCESS | 1658 | Values: 110.0 110.0 111.0 92.0 84.0 94.0 88.0 87.0 91.0 88.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:143.50 stddev:19.37 (13.5%) stddev-sans-first:20.39 14:36:09 INFO - PROCESS | 1658 | Values: 144.0 143.0 139.0 140.0 143.0 142.0 149.0 142.0 202.0 164.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:176.00 stddev:21.64 (12.3%) stddev-sans-first:22.69 14:36:09 INFO - PROCESS | 1658 | Values: 175.0 175.0 172.0 174.0 173.0 210.0 237.0 178.0 173.0 177.0 14:36:09 INFO - PROCESS | 1658 | 14:36:09 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.00 Median:84.00 stddev:11.10 (13.2%) stddev-sans-first:10.89 14:36:09 INFO - PROCESS | 1658 | Values: 67.0 80.0 88.0 91.0 91.0 94.0 74.0 69.0 69.0 67.0 14:36:09 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:36:09 INFO - PROCESS | 1658 | 14:36:10 INFO - TEST-INFO | 1658: exit 0 14:36:10 INFO - TEST-OK | kraken | took 61674ms 14:36:10 INFO - SUITE-END | took 1177s 14:36:10 INFO - Completed test suite (00:19:37) 14:36:10 INFO - javascript benchmark 14:36:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7238.162840783612, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2731.9317017074573, 2956.4973954427737, 3280.5735254416923, 3309.9338013239735, 3310.3213841162565, 5496.725163741817, 5577.44225577442, 5578.581606379517, 5604.215409842615, 5647.8588035299135, 5437.73193408084, 5492.176173573956, 5542.889142217154, 5552.805651802188, 5580.330360356763, 3675.705943524525, 5051.393832740058, 5113.5909127269915, 5138.563222126105, 5171.741412929338, 5132.666376685522, 5161.122609156434, 5187.0922588546855, 5202.167653175493, 5217.713025783581, 473.79280480245865, 5123.103456895065, 5129.820456284049, 5205.089109405858, 5278.3665960084845, 4349.804258808361, 5130.333056702642, 5141.357330333708, 5156.149235376196, 5177.094008548489, 5097.8215762448135, 5103.260027296058, 5105.438401775802, 5127.307813445212, 5157.9941911327305, 5392.865178370533, 5481.424450432687, 5520.420355862617, 5542.307211598551, 5692.658440493542, 6032.45707886288, 6083.0, 6114.023656277648, 6137.622145771035, 6140.324564297924, 6175.5985860919345, 6178.69106544671, 6199.287081985584, 6201.565890387675, 6202.596831205957, 5595.104783234663, 5711.343195532525, 5746.569007324468, 5756.539476841843, 5802.33273173582, 6151.692415379213, 6157.784477543264, 6166.691665416712, 6191.938080619227, 6221.5333849961435, 6072.848178795477, 6097.115918191837, 6113.993245360534, 6121.265448146251, 6125.816225513242, 6015.669138197353, 6123.755049798047, 6131.448169664663, 6151.630902145886, 6193.81418557444, 5965.55258355625, 6016.759329626853, 6018.458338749533, 6187.659678717624, 6189.597676151036, 6103.38966103395, 6111.96944015277, 6127.234095738033, 6132.2947860996555, 6133.018717005258, 4853.757312134379, 4891.730954797449, 4892.0705066037335, 4988.6507944444265, 5019.598432125495, 4339.305711086274, 4344.9348259776125, 4372.540883207217, 4400.383946247528, 4421.182081314967, 4810.7835147418455, 5738.483536481736, 5776.306843178845, 5781.392953739881, 5826.126081087786, 6050.757969681164, 6103.298120716086, 6115.480184184395, 6147.293061297919, 6209.2548894133, 5684.147377893267, 5687.60186786921, 5688.658680479184, 5690.061139911951, 5710.0, 4385.88160019193, 4833.299171620166, 5419.83740487786, 5441.319835020622, 5443.782248710087, 6223.066540019034, 6225.657588832658, 6225.875482490415, 6226.1905952225925, 6230.563860529719, 6000.21997140369, 6094.573379863367, 6138.355472675305, 6141.140240366263, 6152.723127459186, 5252.1596544552685, 5338.706371149624, 6137.938620613915, 6151.169592105188, 6156.476699480594, 4899.559039686303, 6043.758249669964, 6048.939510605013, 6051.33435322123, 6067.787627433018, 5728.312602487728, 6068.605540639845, 6101.610781564156, 6110.052941794029, 6132.540059495466, 5864.9413505864395, 5963.7912673056235, 5970.0, 5985.461308482258, 6001.519878409804, 5934.881302373842, 5951.613145145551, 5955.255593050869, 5975.014122669711, 6007.0, 5644.6613203207935, 5664.603477756682, 5664.745086471036, 5799.710014499343, 5815.127730840408, 5792.623479473821, 5968.76124954997, 5990.0, 5994.580379373402, 5997.460228579449, 4952.603791696728, 5778.335491418541, 5784.768609255751, 5848.093545500455, 5863.560232982629], "value": 5519.082377708443, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.2247682839788, 470.2757753060287, 499.74013512973255, 501.1080277106749, 542.5767901037192, 37875.62124378759, 40291.0, 40417.79791101044, 40428.393574096335, 40473.797631011876, 32701.18247043819, 40957.79521102398, 41505.58494415055, 41641.791791041076, 41698.37452438216, 8303.418760686754, 8528.445651032664, 9125.224355929753, 9331.626734930629, 9370.203532699728, 9732.902670973306, 11040.3375797452, 11319.547218111265, 11362.659120226364, 11504.25222360544, 11358.432078396088, 11392.25950313231, 11410.144239182053, 11411.087113030979, 11427.028702560292, 11269.54921803131, 11311.377874216914, 11333.716657083556, 11342.546298148065, 11350.602728904449, 11253.212275140744, 11279.774404511945, 11300.434978251136, 11315.321080735182, 11316.207865449422, 39503.60496395028, 39638.60361396407, 39875.601243987476, 39955.60044399548, 39956.200875982606, 3925.548561915388, 3941.783201923893, 3944.408338749182, 3945.0, 4054.7567145971334, 29120.625579906766, 30565.847170764227, 30657.38685226283, 30662.386752265054, 30733.538996915064, 3123.422166899131, 3157.2422618571377, 3191.6010498687665, 3249.252671885456, 3305.1406634275263, 430181.0, 436591.0, 436936.0, 437533.0, 441443.7927810373, 59713.40286597165, 60090.39909600848, 60124.69937650284, 60174.699126504085, 60366.39633603608, 63291.0, 63689.681551591944, 63950.0, 64091.35908640947, 64210.0, 14485.85514144845, 14873.256337183098, 14873.256337183098, 14911.179885106207, 14929.0, 10686.51910664022, 11048.613298534512, 11301.208915375844, 12045.819312710317, 12215.572454964211, 17610.119494025246, 19251.0, 19364.225430982886, 19929.402117936486, 20117.79882201159, 7371.078615173104, 8324.958375208085, 8451.915480845235, 8453.70412035588, 8474.872876906851, 795.9044914610283, 852.6972924611797, 855.4140413816556, 866.7183165471247, 869.7303835810919, 28592.42815143727, 29385.559216611768, 29514.114576562737, 30367.088987330415, 30380.0, 841.6170642357713, 1003.7992401519725, 1055.7331202556963, 1056.6354607660344, 1140.1733743036398, 13013.8938190253, 15218.467353642569, 15411.383544658313, 15786.052836829827, 15808.0, 561893.0, 639420.0, 653134.0, 654084.0, 834025.0, 41761.0, 53782.19326710102, 53806.0, 53808.46191538113, 54143.72928135334, 1347.7439286535528, 1352.9932350338186, 1374.2510331868955, 1374.3677908162158, 1380.6203294094205, 21151.0, 28520.0, 28732.0, 28843.84624615076, 29406.411871762873, 46312.0, 46957.0, 46971.53028469672, 47112.7644361776, 47168.0, 546047.5859551823, 559475.0, 559932.0, 560399.0, 562758.3724162705, 22472.0, 22811.657825132967, 23018.53962920766, 24527.632085518373, 25547.36131596725, 35826.13390928772, 38777.806110969264, 41445.0, 41619.7919010403, 42142.57857421387, 24257.63613545763, 35110.82444587761, 35526.822365888, 35663.96856267246, 35811.92564223077, 34021.31957360789, 35234.8238258807, 35336.0, 36311.0, 36330.636693632725, 35017.824910875286, 35348.646513534535, 35639.64360356363, 35739.46390804088, 35750.0, 26749.598756018288, 29247.0, 30020.849895751257, 31885.68114318827, 32015.67984320127, 23465.88267058654, 23943.760562394153, 24222.878885606166, 24493.51012979766, 24629.63055554204], "value": 19519.963305226353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.71264408016015, 389.9337112690842, 393.2920742663206, 396.0751644909138, 419.3856000958597, 15969.680606387865, 19296.807031929675, 19997.0, 20614.0, 20694.379168624946, 17501.124943752795, 20140.496487587818, 20937.895310523465, 21633.026513806875, 21670.808105554188, 5458.727063646812, 5794.884102317951, 5830.32951210612, 5866.911996320058, 5877.67672777997, 5649.293838270216, 5763.740631671585, 5859.355470898197, 5861.648301101947, 5866.501347385477, 5784.710764461781, 5854.970725146369, 5867.911981320283, 5873.70631468427, 5883.823485295448, 5602.663840169603, 5787.189793428924, 5859.824205273827, 5865.8826823463505, 5869.618474799146, 5178.14560597501, 5184.7407629618365, 5186.0, 5187.533122019036, 5188.22176673502, 23392.0, 25527.61708574373, 25639.846206920734, 26016.479670406487, 26409.0, 2456.8648724320155, 2766.9169924902285, 2866.7816178124212, 2996.6703662597097, 3192.0264319382577, 14280.143191408548, 15447.382104715798, 15880.808939329596, 16027.519174424786, 16615.584610384718, 1553.487349174781, 1614.9434769783118, 1788.2578729827105, 1825.3793710138484, 1829.0734824281176, 109531.0, 132432.35135297338, 138437.3078134613, 141152.0, 141794.58205417916, 11298.209125361145, 11759.2958218161, 11802.46888890002, 11826.290422574673, 12010.389403999841, 13792.724145517033, 14316.713665726627, 15400.383984640488, 15439.845601544066, 15458.613534661723, 8059.838803223903, 8392.706255281159, 8496.447730897471, 8538.530380829114, 8635.784105397415, 7257.49197556166, 8204.261616454547, 8227.42408031444, 8231.17688231184, 8283.875741863876, 4614.74618895964, 4704.6236301096515, 4708.434987801417, 4768.237082066853, 4789.970156416387, 1698.9745153822703, 1973.8914359710066, 2033.1562401603464, 2034.0, 2037.7860324665994, 846.7417437681567, 894.6242578117207, 926.3284119013796, 955.6225291010012, 982.8722266105503, 18072.728909066376, 21451.78548214529, 21621.35135945924, 21813.127474900826, 21903.342899713036, 1003.6487229469627, 1022.749426390539, 1025.4206373399154, 1031.9329243599143, 1065.7761870007384, 11123.666290011313, 11345.943270283597, 11359.602413915472, 11411.885881141248, 11424.200305978668, 563599.0, 563623.0, 651394.0, 674933.0, 688781.0, 129443.0, 158726.20636896972, 160404.0, 162014.0, 164730.0, 895.6865097216053, 1007.0734923869911, 1007.09361574582, 1049.9212559057949, 1054.9894501054891, 20098.39704808858, 20257.898710506353, 20491.38525844227, 20495.692564611243, 20525.0, 58538.7073064632, 60521.0, 61750.69124654528, 62037.37962620316, 62163.37836621576, 75402.0, 88524.0, 90592.64111038472, 92429.0, 94550.05449945413, 8183.345332373515, 8220.794480138044, 8236.588170591567, 8659.307255419677, 8659.350548708999, 9303.953480232556, 12280.75438491243, 12956.611301660965, 13049.739005220032, 13308.600741977756, 10310.742231444274, 11027.724306892393, 11403.942980285046, 11619.302841829518, 11638.0, 10646.361218326925, 10923.945380273048, 10953.616623418142, 11099.389533575732, 11196.66410007701, 11116.22186446941, 11297.039751620876, 11582.247153934968, 11585.420728963349, 11638.53445862156, 8175.0, 8282.544460054754, 8550.187732165434, 8667.349948753743, 8725.432846864933, 9869.45717985489, 11261.324320540794, 11525.769484610093, 11638.941805290919, 11677.06583473337], "value": 9959.263581240404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.6854970532222, 1389.4581113365787, 1425.9857401425982, 1426.7360538300416, 1455.8908081893853, 7475.813104672386, 7748.41886858485, 7995.32039776619, 8448.0, 8451.788705282363, 7360.822268437051, 7736.4913841800735, 7949.165337639552, 8127.390445716565, 8275.0, 2291.3698732848475, 2330.4057465346314, 2333.57995560799, 2334.7898689117974, 2345.824063195267, 2067.2041264113273, 2156.870587764731, 2318.2233951626226, 2351.0595761695286, 2383.1182462488905, 2049.549099198174, 2214.9557008859815, 2300.884955752214, 2306.884655767213, 2332.7200735911715, 2005.358285348689, 2240.271911628727, 2307.561563302967, 2307.665388518672, 2329.9301020969397, 2025.0785892418915, 2271.1256166375897, 2326.5579539887535, 2359.7640235976437, 2361.126383238213, 8348.039975402846, 8349.624266908004, 8440.409171358007, 8465.53439560824, 8474.1949514796, 5074.594032477393, 5214.582833373359, 5223.71269580173, 5244.265802787613, 5245.606579506552, 2779.3051737065734, 3402.8468718907707, 3471.600765911902, 3488.6162522122545, 3502.5271588335504, 1204.3857632607346, 1207.6233094272536, 1209.5826939705787, 1243.5274595653684, 1249.6875781054737, 10390.636327728493, 10395.896041039568, 10446.216533759998, 10461.058504734534, 10466.895331046668, 4365.825366985285, 4570.108828778356, 4657.60410365116, 4657.976710116428, 4722.126406614787, 9398.624055037859, 9487.90512094884, 9494.430334179971, 9505.857412138823, 9516.666916657883, 5131.204663277198, 5213.061648903158, 5215.087359712035, 5215.217717342429, 5247.501487358695, 4600.746958917225, 4703.270992996023, 4731.101090792738, 4750.311204875274, 4761.6904901181315, 3153.6057992750907, 3183.2519357950864, 3801.4487899255005, 3900.4539364488996, 3910.687145028391, 1175.1773758369177, 1218.3847157185742, 1222.57821051737, 1223.4188760338945, 1228.7358217983176, 712.9465290103263, 752.889488005188, 774.4269240761796, 777.859985202669, 802.8719648893315, 4566.566176213254, 5741.540676745851, 5770.336411312669, 5800.6809625471005, 5974.790882319098, 960.4669408478362, 974.337450533644, 974.6890432368454, 974.7027156717128, 994.6121012805012, 3773.1510410157493, 3773.8301776420126, 3783.5270591176104, 3869.9613003870163, 3884.8446062157764, 7576.0, 9947.204223662235, 10027.448490333101, 10108.949455252676, 10155.543000564992, 10000.099991000845, 10021.29850910444, 10030.949845250727, 10034.448105354275, 10053.296269261082, 7300.744473943387, 7675.961620191975, 7825.804354891059, 7933.523988560705, 7952.562609056442, 5680.943190568041, 5791.247137872049, 5811.953848307346, 5903.730697899972, 5907.084401917709, 8759.386842921189, 8989.82020359576, 9037.322200835095, 9071.682491112779, 9100.317476189444, 9150.954245228997, 9272.443653380818, 9273.814523709352, 9318.0, 9376.34365594429, 7080.645967701697, 7193.0, 7215.567065976058, 7216.0, 7232.0, 7717.961410192913, 7747.30274275318, 7846.372290216883, 7854.293113619801, 7864.174261702439, 7066.7173313066905, 7085.50401471892, 7097.361237488651, 7220.0613920190035, 7235.891461627974, 7028.9648551758955, 7037.120359955005, 7061.329173728487, 7066.823329416806, 7105.822354440974, 6336.778212762531, 6350.396712312323, 6353.745850166127, 6418.0, 6441.67791610427, 4819.156647586588, 4894.951050489592, 4904.8773780655765, 4929.9893521827225, 5056.039352523009, 4931.432885218246, 4937.456879743154, 5011.749412529286, 5044.596432285482, 5059.5952323814745], "value": 4372.044210574164, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5550417944134, 363.8090002748557, 364.5079143156739, 367.31129132875856, 369.32782336148205, 5424.3490781106275, 5450.509454149126, 5598.536643876691, 5610.0, 5612.550995920326, 5212.192110222912, 5433.212184233284, 5435.287884316437, 5439.918401223985, 5495.230667706524, 3542.1498840278405, 3873.283442563121, 4065.5200327800017, 4116.34138537834, 4172.7273181679575, 3539.3806083935337, 3617.421212605984, 3736.0199094479967, 4004.199160167978, 4072.6538244249127, 3344.3980083584943, 3771.66055055045, 3778.8299526521373, 4101.282275601773, 4158.981049642842, 3888.4361767543546, 4050.9594904050878, 4122.031322639177, 4134.979325103385, 4144.171165766858, 3129.0, 3266.7223286020717, 3521.7710848795004, 3529.9410176946812, 3535.9469607955903, 5302.522772950453, 5303.284056652341, 5312.203169524602, 5342.893142137135, 5408.378036525811, 3928.823202955874, 4612.492625811158, 4736.9526304736855, 4765.809367625291, 4775.9761201194115, 5789.88420231593, 5801.3328467225965, 5830.15462757902, 5847.561432892508, 5858.238429004202, 3470.514128022079, 3927.8232479538487, 3933.2920074386598, 3944.5660977292473, 3949.269385163754, 5363.54409875161, 5414.7834086636485, 5795.942040579583, 5896.292444906639, 6128.540359473057, 3295.3903527847424, 3627.782333060025, 3847.4033276190066, 3923.941140882889, 3934.370500719871, 3510.982445087809, 3963.0, 3986.5614782373914, 4002.3796311571755, 4005.339119045325, 4307.332363483665, 4622.491525932145, 4685.882852928704, 4707.435107787088, 4726.85819425411, 5076.974615126901, 5637.393342897337, 5693.231413759089, 5887.0, 5896.616719913278, 1175.7595736498076, 1285.4087119924752, 1293.9676508087373, 1300.3888172558882, 1301.8958483321312, 716.638097760638, 833.9457935234191, 839.8824164616958, 868.9695860644847, 878.4641368765048, 4370.912581748347, 4479.977600111979, 4530.773461326987, 5195.19474481456, 5225.850312931149, 4704.882377940579, 4924.75376231187, 5132.409772876093, 5170.819021334235, 5595.964746521825, 4694.662021323907, 4993.3535226330105, 5188.766505507261, 5218.608604354688, 5246.534128959459, 2638.2744745195223, 2814.943701125966, 2974.0, 2987.68629293921, 3015.8841228745064, 5595.776168953278, 5964.880702385928, 5980.312264089598, 6006.399360064046, 6017.729202185825, 4871.5128487151715, 5069.518395752398, 5563.7774489019985, 5840.3575606683235, 5869.530437564985, 5241.999999999924, 6033.818985430444, 6098.481629061491, 6207.423919073534, 6254.21822272216, 5944.554158438048, 5985.970070149621, 5995.91006134917, 6000.0, 6000.279966404059, 4701.764911754331, 5301.416844147064, 5637.52081073097, 5880.353161152184, 5930.703464826827, 5389.407165211745, 5650.242588678647, 5710.5146062585145, 6182.60891299454, 6202.038684003986, 3644.781313121221, 3789.962100379071, 3858.514471928384, 4269.850555230552, 4280.871573852789, 4968.701877887338, 5239.371275446971, 5724.713764311851, 5994.550408719277, 5999.140266517394, 5126.666766660155, 5808.767649293981, 5858.7070646468355, 5860.472557469848, 5862.618929769551, 5116.28372027909, 5395.649282796606, 5459.5632349412745, 5754.884902302014, 5789.726260222744, 4486.304622783474, 5656.095024796013, 5694.857628559319, 5699.458551437607, 5736.68448235351, 4706.905861882811, 4765.523447655207, 5810.82567522975, 5827.825165245049, 5871.6770577618645, 4594.2189827730035, 5001.699898006132, 5254.7898084076205, 5496.532794712494, 5638.7462564185535], "value": 4128.780576007121, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.6487891175499, 703.4302215205684, 764.8737958236891, 769.865273577124, 819.5902048975512, 11233.494492747826, 12709.872901270985, 12898.80651790224, 15442.613934651625, 15735.527934161993, 14302.213378264218, 14367.209803460806, 14479.2760361982, 14485.203313817736, 14515.491957781453, 671.8521925176453, 694.7637803146916, 696.5437638346891, 840.7015509494133, 872.8472517309477, 860.724568138196, 864.0797550608613, 869.7695110795644, 873.1225118755642, 876.3033388456192, 930.2557953637097, 931.4923366765129, 935.9578818953163, 939.5443210043123, 949.050949050949, 912.1881525442361, 933.6778811310087, 934.0892629686069, 934.8924873639551, 935.3779736475236, 674.2414783368711, 694.2328726756962, 695.1345574759406, 695.3116414749412, 699.6152116335995, 14287.214203218819, 14468.565943021726, 14558.0, 14877.0, 14900.776488352683, 13806.240656763874, 14139.222342771143, 14153.22157281349, 14174.936879733958, 14218.715625687531, 11526.020288275507, 11665.533378664843, 11682.883171168265, 11738.530458781639, 11812.52749890012, 3665.9083522911874, 3679.742418030739, 3692.464592634053, 3709.0727318170457, 3826.9858487500833, 83062.3387532252, 91263.0, 92762.14475710448, 94968.52515737446, 96729.51635241919, 10781.676549703521, 10798.73003174927, 10846.29499082557, 10946.890531094587, 11266.887331126747, 22170.667439988414, 22443.32670019902, 22500.437489062577, 22715.09139634429, 22717.2048978285, 7526.435517336222, 7548.245175482518, 7629.923700763033, 7662.233776622294, 7802.258785415376, 4174.624283814472, 4182.853600123981, 4240.194363071007, 4287.957120428819, 4358.128374325148, 3514.8242587870504, 3606.765560238576, 3607.5129857468905, 3621.3300539400293, 3631.2737452509605, 631.5831551176202, 636.920384951881, 641.1120597971842, 646.0922404022356, 658.8996376052005, 654.0842820051965, 669.9229588597276, 683.6513378177166, 683.825624465768, 697.5431092634333, 9924.957879422556, 10026.19790416765, 10264.948675256575, 10329.586816527404, 10336.586536538605, 648.2545073165898, 667.1493845347221, 677.7187467201155, 679.7620832708611, 703.7466512055656, 4619.953800461953, 4955.82654607087, 4960.627952903546, 4963.702177869267, 4988.301637770715, 68692.0, 88017.55991220003, 103522.0, 105598.0, 105649.0, 90380.0, 90766.54616726874, 90896.545517272, 91241.0, 91721.0, 65848.0, 78743.60628196938, 80605.79091313518, 80695.0, 81211.59394202991, 7841.0, 9663.371880827724, 9691.321607487409, 9692.273079519206, 9720.416774993522, 43980.12039759251, 49387.765305867644, 50836.98326033533, 53266.93466130733, 54988.0, 48619.02761944812, 61906.69046654918, 62573.748525030154, 71870.64064679643, 73355.0, 13089.477487354774, 13129.803052954023, 13141.277229752455, 13208.66978325511, 13492.865071349554, 14494.63763405881, 14743.262836858328, 14755.188464634548, 14806.481773137888, 14813.407463701331, 11784.292942423483, 11893.82159267629, 12314.815277770662, 13330.133541319783, 13607.387667555182, 13526.79709804334, 13546.254955977516, 13728.313584320944, 13746.106503077268, 13887.652808679864, 13414.798778018532, 13439.664008399868, 13444.932775336061, 13695.0, 13868.237246951514, 8896.822063558822, 11160.776784464428, 11196.83204751913, 11327.771585098208, 11667.766644667228, 10902.542563114897, 10934.453277335942, 11031.779364412827, 11191.552337906392, 11195.552177913118], "value": 7424.08782612248, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1616.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 126.0, 110.0, 152.0, 175.0, 175.0, 120.0, 119.0, 119.0, 118.0], "value": 132.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 112.0, 146.0, 104.0, 158.0, 148.0, 148.0, 149.0, 142.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 215.0, 268.0, 230.0, 202.0, 201.0, 218.0, 204.0, 197.0, 199.0], "value": 213.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 75.0, 86.0, 77.0, 73.0, 76.0, 89.0, 84.0, 84.0, 52.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 84.0, 72.0, 72.0, 72.0, 115.0, 86.0, 91.0, 68.0], "value": 81.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 75.0, 135.0, 98.0, 136.0, 79.0, 137.0, 133.0, 112.0, 86.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 107.0, 100.0, 131.0, 156.0, 95.0, 98.0, 97.0], "value": 107.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 100.0, 93.0, 92.0, 91.0, 91.0, 90.0, 95.0, 93.0, 91.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 63.0, 95.0, 73.0, 62.0, 62.0, 80.0, 95.0, 98.0], "value": 75.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 73.0, 84.0, 79.0, 75.0, 74.0, 75.0, 76.0, 75.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 92.0, 84.0, 94.0, 88.0, 87.0, 91.0, 88.0], "value": 95.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 139.0, 140.0, 143.0, 142.0, 149.0, 142.0, 202.0, 164.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 172.0, 174.0, 173.0, 210.0, 237.0, 178.0, 173.0, 177.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 80.0, 88.0, 91.0, 91.0, 94.0, 74.0, 69.0, 69.0, 67.0], "value": 79.0, "unit": "score"}]}]} 14:36:10 INFO - Return code: 0 14:36:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:36:10 ERROR - # TBPL SUCCESS # 14:36:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:36:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:36:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:36:10 INFO - 2017-01-06 14:36:10.499 screenresolution[1663:10677] starting screenresolution argv=screenresolution get 14:36:10 INFO - 2017-01-06 14:36:10.502 screenresolution[1663:10677] Display 0: 1600x1200x32@60 14:36:10 INFO - 2017-01-06 14:36:10.509 screenresolution[1664:10680] starting screenresolution argv=screenresolution list 14:36:10 INFO - Available Modes on Display 0 14:36:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:36:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:36:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:36:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:36:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:36:10 INFO - Intel Iris: 14:36:10 INFO - Chipset Model: Intel Iris 14:36:10 INFO - Type: GPU 14:36:10 INFO - Bus: Built-In 14:36:10 INFO - VRAM (Dynamic, Max): 1536 MB 14:36:10 INFO - Vendor: Intel (0x8086) 14:36:10 INFO - Device ID: 0x0a2e 14:36:10 INFO - Revision ID: 0x0009 14:36:10 INFO - Displays: 14:36:10 INFO - Display: 14:36:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:36:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:36:10 INFO - Display Serial Number: 1600x1200 60 14:36:10 INFO - Main Display: Yes 14:36:10 INFO - Mirror: Off 14:36:10 INFO - Online: Yes 14:36:10 INFO - Rotation: Supported 14:36:10 INFO - Return code: 0 14:36:10 INFO - Running post-action listener: _resource_record_post_action 14:36:10 INFO - [mozharness: 2017-01-06 22:36:10.744913Z] Finished run-tests step (success) 14:36:10 INFO - Running post-run listener: _resource_record_post_run 14:36:10 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 49724928; Write bytes: 562597888; Read time: 378; Write time: 1801 14:36:10 INFO - TinderboxPrint: CPU usage
54.6% 14:36:10 INFO - TinderboxPrint: I/O read bytes / time
49,724,928 / 378 14:36:10 INFO - TinderboxPrint: I/O write bytes / time
562,597,888 / 1,801 14:36:10 INFO - TinderboxPrint: CPU idle
2,177.5 (45.4%) 14:36:10 INFO - TinderboxPrint: CPU system
969.2 (20.2%) 14:36:10 INFO - TinderboxPrint: CPU user
1,651.0 (34.4%) 14:36:10 INFO - TinderboxPrint: Swap in / out
292,757,504 / 0 14:36:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 229413376; Write bytes: 221736960; Read time: 16528; Write time: 465 14:36:10 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 48803328; Write bytes: 310004224; Read time: 367; Write time: 1258 14:36:11 INFO - Running post-run listener: _upload_blobber_files 14:36:11 INFO - Blob upload gear active. 14:36:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:36:11 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 14:36:11 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:36:11 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:36:11 INFO - (blobuploader) - INFO - Open directory for files ... 14:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:12 INFO - (blobuploader) - INFO - Done attempting. 14:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:13 INFO - (blobuploader) - INFO - Done attempting. 14:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:14 INFO - (blobuploader) - INFO - Done attempting. 14:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:16 INFO - (blobuploader) - INFO - Done attempting. 14:36:16 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:16 INFO - Return code: 0 14:36:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6feb99861dbc09e3ffb3ee7de225fd8be3a5458ed90be21e6958f2f7f7cced5f9b5750c1808a92cb6b069b69cab833ff5a0d11aea837e955ea0b6e36fe0516b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/facaa359ef67c1b45c2c7cacbd6dc8197238854c56ab1ca42d299e809f6dd69a318e0587fc9b4454cdbabfc8ffcea9230319f5bd317490959f03e66662306f22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/73512acf558a455b61484b8c80c0f67ce3e5ed5c7dc5f1f26090527956e25aabd395e9e19503b64230652281f30c3bd66697ed26d2f5aa418808abe2c276de97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43e9ae592c2a3440e32feef5dff7e6da8e86adc08d4607189cefa550cfe971580e881b824b2710fb66d4251c66113c0ab14ed360b27be8e978242abd10842d71"} 14:36:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:16 INFO - Contents: 14:36:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6feb99861dbc09e3ffb3ee7de225fd8be3a5458ed90be21e6958f2f7f7cced5f9b5750c1808a92cb6b069b69cab833ff5a0d11aea837e955ea0b6e36fe0516b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/facaa359ef67c1b45c2c7cacbd6dc8197238854c56ab1ca42d299e809f6dd69a318e0587fc9b4454cdbabfc8ffcea9230319f5bd317490959f03e66662306f22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/73512acf558a455b61484b8c80c0f67ce3e5ed5c7dc5f1f26090527956e25aabd395e9e19503b64230652281f30c3bd66697ed26d2f5aa418808abe2c276de97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43e9ae592c2a3440e32feef5dff7e6da8e86adc08d4607189cefa550cfe971580e881b824b2710fb66d4251c66113c0ab14ed360b27be8e978242abd10842d71"} 14:36:16 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:16 INFO - Copying logs to upload dir... 14:36:16 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.219625 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-06 14:36:16.601001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 14:36:16.604138) ========= 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.zZKCIvMABT/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.H50GkPBWan/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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/Graphics/sha512/6feb99861dbc09e3ffb3ee7de225fd8be3a5458ed90be21e6958f2f7f7cced5f9b5750c1808a92cb6b069b69cab833ff5a0d11aea837e955ea0b6e36fe0516b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/facaa359ef67c1b45c2c7cacbd6dc8197238854c56ab1ca42d299e809f6dd69a318e0587fc9b4454cdbabfc8ffcea9230319f5bd317490959f03e66662306f22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/73512acf558a455b61484b8c80c0f67ce3e5ed5c7dc5f1f26090527956e25aabd395e9e19503b64230652281f30c3bd66697ed26d2f5aa418808abe2c276de97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43e9ae592c2a3440e32feef5dff7e6da8e86adc08d4607189cefa550cfe971580e881b824b2710fb66d4251c66113c0ab14ed360b27be8e978242abd10842d71"} build_url:https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011022 build_url: 'https://queue.taskcluster.net/v1/task/EDycKWu1RkqGyefTH6z7cg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6feb99861dbc09e3ffb3ee7de225fd8be3a5458ed90be21e6958f2f7f7cced5f9b5750c1808a92cb6b069b69cab833ff5a0d11aea837e955ea0b6e36fe0516b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/facaa359ef67c1b45c2c7cacbd6dc8197238854c56ab1ca42d299e809f6dd69a318e0587fc9b4454cdbabfc8ffcea9230319f5bd317490959f03e66662306f22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/73512acf558a455b61484b8c80c0f67ce3e5ed5c7dc5f1f26090527956e25aabd395e9e19503b64230652281f30c3bd66697ed26d2f5aa418808abe2c276de97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/43e9ae592c2a3440e32feef5dff7e6da8e86adc08d4607189cefa550cfe971580e881b824b2710fb66d4251c66113c0ab14ed360b27be8e978242abd10842d71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 14:36:16.638295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 14:36:16.638663) ========= 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.zZKCIvMABT/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.H50GkPBWan/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 14:36:16.688065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 14:36:16.688383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 14:36:16.688728) ========= ========= Total master_lag: 0.17 =========