builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0326 starttime: 1486431998.96 results: success (0) buildid: 20170206161456 builduid: 970c752b235d41f6bfbd807960660d88 revision: 295a39d8aa6b0255a5467970303f1bb8ff0bd7ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:38.963637) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:38.964427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:38.964721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:38.992342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:38.992699) ========= 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.vl49NBwlhx/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.T6aAwuAZNg/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-06 17:46:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2017-02-06 17:46:39 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.215657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.215986) ========= 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.vl49NBwlhx/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.T6aAwuAZNg/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.024706 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.264129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.264540) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 295a39d8aa6b0255a5467970303f1bb8ff0bd7ed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 295a39d8aa6b0255a5467970303f1bb8ff0bd7ed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vl49NBwlhx/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.T6aAwuAZNg/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-06 17:46:39,374 truncating revision to first 12 chars 2017-02-06 17:46:39,374 Setting DEBUG logging. 2017-02-06 17:46:39,374 attempt 1/10 2017-02-06 17:46:39,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/295a39d8aa6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 17:46:39,685 unpacking tar archive at: mozilla-aurora-295a39d8aa6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590778 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.882046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.882371) ========= script_repo_revision: 295a39d8aa6b0255a5467970303f1bb8ff0bd7ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.882763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.883035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 17:46:39.902967) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-06 17:46:40.004992) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vl49NBwlhx/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.T6aAwuAZNg/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:46:40 INFO - MultiFileLogger online at 20170206 17:46:40 in /builds/slave/test 17:46:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:46:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:46:40 INFO - {'append_to_log': False, 17:46:40 INFO - 'base_work_dir': '/builds/slave/test', 17:46:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:46:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:46:40 INFO - 'branch': 'Mozilla-Aurora', 17:46:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:46:40 INFO - 'config_files': ('talos/mac_config.py',), 17:46:40 INFO - 'default_actions': ('clobber', 17:46:40 INFO - 'read-buildbot-config', 17:46:40 INFO - 'download-and-extract', 17:46:40 INFO - 'populate-webroot', 17:46:40 INFO - 'create-virtualenv', 17:46:40 INFO - 'install', 17:46:40 INFO - 'run-tests'), 17:46:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:46:40 INFO - 'download_minidump_stackwalk': True, 17:46:40 INFO - 'download_symbols': 'ondemand', 17:46:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:46:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:46:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:46:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:46:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:46:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:46:40 INFO - 'installer_path': 'installer.exe', 17:46:40 INFO - 'log_level': 'info', 17:46:40 INFO - 'log_name': 'talos', 17:46:40 INFO - 'log_to_console': True, 17:46:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:46:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:46:40 INFO - 'opt_config_files': (), 17:46:40 INFO - 'pip_index': False, 17:46:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:46:40 INFO - 'cmd': ('bash', 17:46:40 INFO - '-c', 17:46:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:46:40 INFO - 'enabled': True, 17:46:40 INFO - 'halt_on_failure': False, 17:46:40 INFO - 'name': 'check_screen_resolution'},), 17:46:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:46:40 INFO - 'cmd': ('bash', 17:46:40 INFO - '-c', 17:46:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:46:40 INFO - 'enabled': True, 17:46:40 INFO - 'halt_on_failure': False, 17:46:40 INFO - 'name': 'check_screen_resolution'},), 17:46:40 INFO - 'run_cmd_checks_enabled': True, 17:46:40 INFO - 'sps_profile': False, 17:46:40 INFO - 'sps_profile_interval': 0, 17:46:40 INFO - 'suite': 'dromaeojs-e10s', 17:46:40 INFO - 'system_bits': '32', 17:46:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:46:40 INFO - 'title': 't-yosemite-r7-0326', 17:46:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:46:40 INFO - 'use_talos_json': True, 17:46:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:46:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:46:40 INFO - 'work_dir': 'build'} 17:46:40 INFO - [mozharness: 2017-02-07 01:46:40.222897Z] Running clobber step. 17:46:40 INFO - Running pre-action listener: _resource_record_pre_action 17:46:40 INFO - Running main action method: clobber 17:46:40 INFO - rmtree: /builds/slave/test/build 17:46:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:46:42 INFO - Running post-action listener: _resource_record_post_action 17:46:42 INFO - [mozharness: 2017-02-07 01:46:42.570312Z] Finished clobber step (success) 17:46:42 INFO - [mozharness: 2017-02-07 01:46:42.570451Z] Running read-buildbot-config step. 17:46:42 INFO - Running pre-action listener: _resource_record_pre_action 17:46:42 INFO - Running main action method: read_buildbot_config 17:46:42 INFO - Using buildbot properties: 17:46:42 INFO - { 17:46:42 INFO - "project": "", 17:46:42 INFO - "product": "firefox", 17:46:42 INFO - "script_repo_revision": "production", 17:46:42 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 17:46:42 INFO - "repository": "", 17:46:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 17:46:42 INFO - "buildid": "20170206161456", 17:46:42 INFO - "pgo_build": "False", 17:46:42 INFO - "basedir": "/builds/slave/test", 17:46:42 INFO - "buildnumber": 85, 17:46:42 INFO - "slavename": "t-yosemite-r7-0326", 17:46:42 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:46:42 INFO - "platform": "yosemite_r7", 17:46:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:46:42 INFO - "branch": "mozilla-aurora", 17:46:42 INFO - "repo_path": "releases/mozilla-aurora", 17:46:42 INFO - "revision": "295a39d8aa6b0255a5467970303f1bb8ff0bd7ed", 17:46:42 INFO - "stage_platform": "macosx64", 17:46:42 INFO - "builduid": "970c752b235d41f6bfbd807960660d88", 17:46:42 INFO - "slavebuilddir": "test" 17:46:42 INFO - } 17:46:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 17:46:42 INFO - Running post-action listener: _resource_record_post_action 17:46:42 INFO - [mozharness: 2017-02-07 01:46:42.573729Z] Finished read-buildbot-config step (success) 17:46:42 INFO - [mozharness: 2017-02-07 01:46:42.573865Z] Running download-and-extract step. 17:46:42 INFO - Running pre-action listener: _resource_record_pre_action 17:46:42 INFO - Running main action method: download_and_extract 17:46:42 INFO - mkdir: /builds/slave/test/build/tests 17:46: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')]} 17:46:42 INFO - trying https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 17:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 17:46:44 INFO - Downloaded 1199 bytes. 17:46:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:46:44 INFO - Using the following test package requirements: 17:46:44 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:46:44 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 17:46:44 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 17:46:44 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'jsshell-mac.zip'], 17:46:44 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 17:46:44 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:46:44 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 17:46:44 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 17:46:44 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 17:46:44 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:46:44 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 17:46:44 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:46:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:46:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:46:44 INFO - Expected file size: 16356095 17:46:44 INFO - Obtained file size: 16356095 17:46:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:46:52 INFO - Expected file size: 16356095 17:46:52 INFO - Obtained file size: 16356095 17:46:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 17:46:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 17:47:00 INFO - Expected file size: 14403485 17:47:00 INFO - Obtained file size: 14403485 17:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:00 INFO - trying https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:47:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 17:47:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 17:47:03 INFO - Downloaded 73812936 bytes. 17:47:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:47:03 INFO - mkdir: /builds/slave/test/properties 17:47:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:47:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:47:03 INFO - Contents: 17:47:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:47:03 INFO - Running post-action listener: _resource_record_post_action 17:47:03 INFO - Running post-action listener: set_extra_try_arguments 17:47:03 INFO - [mozharness: 2017-02-07 01:47:03.641651Z] Finished download-and-extract step (success) 17:47:03 INFO - [mozharness: 2017-02-07 01:47:03.641794Z] Running populate-webroot step. 17:47:03 INFO - Running pre-action listener: _resource_record_pre_action 17:47:03 INFO - Running main action method: populate_webroot 17:47:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:47:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:47:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:47:03 INFO - '--tppagecycles', 17:47:03 INFO - '7'], 17:47:03 INFO - 'tests': ['tsvgm']}}, 17:47:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:47:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:47:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:47:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:47:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['damp', 'tps']}, 17:47:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'tests': ['damp', 'tps']}, 17:47:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['dromaeo_dom']}, 17:47:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:47:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['basic_compositor_video']}, 17:47:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:47:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['a11yr', 17:47:03 INFO - 'ts_paint', 17:47:03 INFO - 'tpaint', 17:47:03 INFO - 'sessionrestore', 17:47:03 INFO - 'sessionrestore_no_auto_restore', 17:47:03 INFO - 'tabpaint']}, 17:47:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:47:03 INFO - 'ts_paint', 17:47:03 INFO - 'tpaint', 17:47:03 INFO - 'sessionrestore', 17:47:03 INFO - 'sessionrestore_no_auto_restore', 17:47:03 INFO - 'tabpaint']}, 17:47:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:47:03 INFO - 'ts_paint', 17:47:03 INFO - 'tpaint', 17:47:03 INFO - 'sessionrestore', 17:47:03 INFO - 'sessionrestore_no_auto_restore', 17:47:03 INFO - 'tabpaint']}, 17:47:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:47:03 INFO - 'ts_paint', 17:47:03 INFO - 'tpaint', 17:47:03 INFO - 'sessionrestore', 17:47:03 INFO - 'sessionrestore_no_auto_restore', 17:47:03 INFO - 'tabpaint']}, 17:47:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['a11yr', 17:47:03 INFO - 'ts_paint', 17:47:03 INFO - 'tpaint', 17:47:03 INFO - 'sessionrestore', 17:47:03 INFO - 'sessionrestore_no_auto_restore', 17:47:03 INFO - 'tabpaint']}, 17:47:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['a11yr', 17:47:03 INFO - 'ts_paint', 17:47:03 INFO - 'tpaint', 17:47:03 INFO - 'sessionrestore', 17:47:03 INFO - 'sessionrestore_no_auto_restore', 17:47:03 INFO - 'tabpaint']}, 17:47:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['tsvgx', 17:47:03 INFO - 'tsvgr_opacity', 17:47:03 INFO - 'tart', 17:47:03 INFO - 'tscrollx', 17:47:03 INFO - 'cart', 17:47:03 INFO - 'tsvg_static']}, 17:47:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:47:03 INFO - 'tsvgr_opacity', 17:47:03 INFO - 'tart', 17:47:03 INFO - 'tscrollx', 17:47:03 INFO - 'cart', 17:47:03 INFO - 'tsvg_static']}, 17:47:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'talos_options': ['--disable-e10s'], 17:47:03 INFO - 'tests': ['tp5o']}, 17:47:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:47:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'talos_options': ['--disable-e10s', 17:47:03 INFO - '--xperf_path', 17:47:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:03 INFO - 'tests': ['tp5n']}, 17:47:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:47:03 INFO - 'talos_options': ['--xperf_path', 17:47:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:03 INFO - 'tests': ['tp5n']}}, 17:47:03 INFO - 'talos.zip': {'path': '', 17:47:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:47:03 INFO - Running post-action listener: _resource_record_post_action 17:47:03 INFO - [mozharness: 2017-02-07 01:47:03.660367Z] Finished populate-webroot step (success) 17:47:03 INFO - [mozharness: 2017-02-07 01:47:03.660504Z] Running create-virtualenv step. 17:47:03 INFO - Running pre-action listener: _resource_record_pre_action 17:47:03 INFO - Running main action method: create_virtualenv 17:47:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:47:03 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 17:47:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:47:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:47:03 INFO - Using real prefix '/tools/python27' 17:47:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:47:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:47:07 INFO - Installing pip.................done. 17:47:07 INFO - Return code: 0 17:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:47:07 INFO - Reading from file tmpfile_stdout 17:47:07 INFO - Output received: 17:47:07 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) 17:47:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:07 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:07 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 17:47:07 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 17:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:07 INFO - 'HOME': '/Users/cltbld', 17:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:07 INFO - 'LOGNAME': 'cltbld', 17:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:07 INFO - 'MOZ_NO_REMOTE': '1', 17:47:07 INFO - 'NO_EM_RESTART': '1', 17:47:07 INFO - 'PAGER': '/bin/cat', 17:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:07 INFO - 'PWD': '/builds/slave/test', 17:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:07 INFO - 'SHELL': '/bin/bash', 17:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:07 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:07 INFO - 'USER': 'cltbld', 17:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:07 INFO - 'XPC_FLAGS': '0x0', 17:47:07 INFO - 'XPC_SERVICE_NAME': '0', 17:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:07 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 17:47:07 INFO - Cleaning up... 17:47:07 INFO - Return code: 0 17:47:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:07 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:07 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 17:47:07 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 17:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:07 INFO - 'HOME': '/Users/cltbld', 17:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:07 INFO - 'LOGNAME': 'cltbld', 17:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:07 INFO - 'MOZ_NO_REMOTE': '1', 17:47:07 INFO - 'NO_EM_RESTART': '1', 17:47:07 INFO - 'PAGER': '/bin/cat', 17:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:07 INFO - 'PWD': '/builds/slave/test', 17:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:07 INFO - 'SHELL': '/bin/bash', 17:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:07 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:07 INFO - 'USER': 'cltbld', 17:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:07 INFO - 'XPC_FLAGS': '0x0', 17:47:07 INFO - 'XPC_SERVICE_NAME': '0', 17:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:08 INFO - Downloading/unpacking psutil>=3.1.1 17:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:11 INFO - Installing collected packages: psutil 17:47:11 INFO - Running setup.py install for psutil 17:47:12 INFO - building 'psutil._psutil_osx' extension 17:47:12 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 17:47:12 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 17:47:12 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 17:47:12 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 17:47:12 INFO - building 'psutil._psutil_posix' extension 17:47:12 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 17:47:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:47:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:47:12 INFO - ^ 17:47:12 INFO - 1 warning generated. 17:47:12 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 17:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:13 INFO - Successfully installed psutil 17:47:13 INFO - Cleaning up... 17:47:13 INFO - Return code: 0 17:47:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:47:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:13 INFO - 'HOME': '/Users/cltbld', 17:47:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:13 INFO - 'LOGNAME': 'cltbld', 17:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:13 INFO - 'MOZ_NO_REMOTE': '1', 17:47:13 INFO - 'NO_EM_RESTART': '1', 17:47:13 INFO - 'PAGER': '/bin/cat', 17:47:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:13 INFO - 'PWD': '/builds/slave/test', 17:47:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:13 INFO - 'SHELL': '/bin/bash', 17:47:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:13 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:13 INFO - 'USER': 'cltbld', 17:47:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:13 INFO - 'XPC_FLAGS': '0x0', 17:47:13 INFO - 'XPC_SERVICE_NAME': '0', 17:47:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:47:13 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 17:47:13 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 17:47:13 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 17:47:13 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 17:47:13 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 17:47:13 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 17:47:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:47:16 INFO - Installing collected packages: mozsystemmonitor 17:47:16 INFO - Running setup.py install for mozsystemmonitor 17:47:16 INFO - Successfully installed mozsystemmonitor 17:47:16 INFO - Cleaning up... 17:47:16 INFO - Return code: 0 17:47:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:47:16 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')]} 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:16 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')]} 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:16 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:16 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 17:47:16 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 17:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:16 INFO - 'HOME': '/Users/cltbld', 17:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:16 INFO - 'LOGNAME': 'cltbld', 17:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:16 INFO - 'MOZ_NO_REMOTE': '1', 17:47:16 INFO - 'NO_EM_RESTART': '1', 17:47:16 INFO - 'PAGER': '/bin/cat', 17:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:16 INFO - 'PWD': '/builds/slave/test', 17:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:16 INFO - 'SHELL': '/bin/bash', 17:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:16 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:16 INFO - 'USER': 'cltbld', 17:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:16 INFO - 'XPC_FLAGS': '0x0', 17:47:16 INFO - 'XPC_SERVICE_NAME': '0', 17:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:16 INFO - Downloading/unpacking jsonschema==2.5.1 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:47:19 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 17:47:19 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 17:47:19 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 17:47:19 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 17:47:19 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 17:47:19 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 17:47:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:19 INFO - warning: no files found matching '*.txt' 17:47:19 INFO - no previously-included directories found matching 'build' 17:47:19 INFO - no previously-included directories found matching 'dist' 17:47:19 INFO - no previously-included directories found matching '.git*' 17:47:19 INFO - Installing collected packages: jsonschema, functools32 17:47:19 INFO - Running setup.py install for functools32 17:47:20 INFO - warning: no files found matching '*.txt' 17:47:20 INFO - no previously-included directories found matching 'build' 17:47:20 INFO - no previously-included directories found matching 'dist' 17:47:20 INFO - no previously-included directories found matching '.git*' 17:47:20 INFO - Successfully installed jsonschema functools32 17:47:20 INFO - Cleaning up... 17:47:20 INFO - Return code: 0 17:47:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:20 INFO - 'HOME': '/Users/cltbld', 17:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:20 INFO - 'LOGNAME': 'cltbld', 17:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:20 INFO - 'MOZ_NO_REMOTE': '1', 17:47:20 INFO - 'NO_EM_RESTART': '1', 17:47:20 INFO - 'PAGER': '/bin/cat', 17:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:20 INFO - 'PWD': '/builds/slave/test', 17:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:20 INFO - 'SHELL': '/bin/bash', 17:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:20 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:20 INFO - 'USER': 'cltbld', 17:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:20 INFO - 'XPC_FLAGS': '0x0', 17:47:20 INFO - 'XPC_SERVICE_NAME': '0', 17:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:47:20 INFO - Cleaning up... 17:47:20 INFO - Return code: 0 17:47:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:20 INFO - 'HOME': '/Users/cltbld', 17:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:20 INFO - 'LOGNAME': 'cltbld', 17:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:20 INFO - 'MOZ_NO_REMOTE': '1', 17:47:20 INFO - 'NO_EM_RESTART': '1', 17:47:20 INFO - 'PAGER': '/bin/cat', 17:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:20 INFO - 'PWD': '/builds/slave/test', 17:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:20 INFO - 'SHELL': '/bin/bash', 17:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:20 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:20 INFO - 'USER': 'cltbld', 17:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:20 INFO - 'XPC_FLAGS': '0x0', 17:47:20 INFO - 'XPC_SERVICE_NAME': '0', 17:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:23 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 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 17:47:24 INFO - Downloading docopt-0.6.1.tar.gz 17:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:24 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:24 INFO - Running setup.py install for blobuploader 17:47:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:24 INFO - Running setup.py install for requests 17:47:25 INFO - Running setup.py install for docopt 17:47:25 INFO - Successfully installed blobuploader requests docopt 17:47:25 INFO - Cleaning up... 17:47:25 INFO - Return code: 0 17:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:25 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')]} 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:25 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')]} 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:25 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:25 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 17:47:25 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 17:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:25 INFO - 'HOME': '/Users/cltbld', 17:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:25 INFO - 'LOGNAME': 'cltbld', 17:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:25 INFO - 'MOZ_NO_REMOTE': '1', 17:47:25 INFO - 'NO_EM_RESTART': '1', 17:47:25 INFO - 'PAGER': '/bin/cat', 17:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:25 INFO - 'PWD': '/builds/slave/test', 17:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:25 INFO - 'SHELL': '/bin/bash', 17:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:25 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:25 INFO - 'USER': 'cltbld', 17:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:25 INFO - 'XPC_FLAGS': '0x0', 17:47:25 INFO - 'XPC_SERVICE_NAME': '0', 17:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:25 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-aP6Xce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:25 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-cxUkuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:25 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-od7O_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-yeVege-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-iYsSpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-IEwqLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-hbT3Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-vph6Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-jtQ9cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-P9t33u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-08ynRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:26 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-MoDgHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:27 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-k1nr1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:27 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ZZ2itl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:27 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-4IjOgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:27 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-3AEVSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:27 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-c0IJEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:27 INFO - Running setup.py install for manifestparser 17:47:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:27 INFO - Running setup.py install for mozcrash 17:47:27 INFO - Running setup.py install for mozdebug 17:47:27 INFO - Running setup.py install for mozdevice 17:47:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Running setup.py install for mozfile 17:47:28 INFO - Running setup.py install for mozhttpd 17:47:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Running setup.py install for mozinfo 17:47:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Running setup.py install for mozInstall 17:47:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:28 INFO - Running setup.py install for mozleak 17:47:28 INFO - Running setup.py install for mozlog 17:47:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:29 INFO - Running setup.py install for moznetwork 17:47:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:29 INFO - Running setup.py install for mozprocess 17:47:29 INFO - Running setup.py install for mozprofile 17:47:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:29 INFO - Running setup.py install for mozrunner 17:47:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:29 INFO - Running setup.py install for mozscreenshot 17:47:29 INFO - Running setup.py install for moztest 17:47:29 INFO - Running setup.py install for mozversion 17:47:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:30 INFO - Cleaning up... 17:47:30 INFO - Return code: 0 17:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:30 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:30 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 17:47:30 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 17:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:30 INFO - 'HOME': '/Users/cltbld', 17:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:30 INFO - 'LOGNAME': 'cltbld', 17:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:30 INFO - 'MOZ_NO_REMOTE': '1', 17:47:30 INFO - 'NO_EM_RESTART': '1', 17:47:30 INFO - 'PAGER': '/bin/cat', 17:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:30 INFO - 'PWD': '/builds/slave/test', 17:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:30 INFO - 'SHELL': '/bin/bash', 17:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:30 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:30 INFO - 'USER': 'cltbld', 17:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:30 INFO - 'XPC_FLAGS': '0x0', 17:47:30 INFO - 'XPC_SERVICE_NAME': '0', 17:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-MfAj7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:30 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)) 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ZPkKUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:30 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)) 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-JBU2dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:30 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)) 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-a8V8wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:30 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)) 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-C2wFjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:30 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)) 17:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-xpUC_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-c4WXxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-7VilKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Mgwz15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Ej2Ww_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-9jzBhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-nV7xiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-dbrzSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-LmvffW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:31 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)) 17:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:31 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-PdvFbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:32 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)) 17:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:32 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-RYaiAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:32 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)) 17:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:32 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-7P5tc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:32 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)) 17:47:32 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)) 17:47:32 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)) 17:47:32 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)) 17:47:32 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)) 17:47:32 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)) 17:47:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47:32 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 17:47:32 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 17:47:32 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 17:47:32 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 17:47:32 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 17:47:32 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 17:47:34 INFO - Downloading blessings-1.6.tar.gz 17:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:34 INFO - Installing collected packages: blessings 17:47:34 INFO - Running setup.py install for blessings 17:47:35 INFO - Successfully installed blessings 17:47:35 INFO - Cleaning up... 17:47:35 INFO - Return code: 0 17:47:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:35 INFO - Reading from file tmpfile_stdout 17:47:35 INFO - Current package versions: 17:47:35 INFO - blessings == 1.6 17:47:35 INFO - blobuploader == 1.2.4 17:47:35 INFO - docopt == 0.6.1 17:47:35 INFO - functools32 == 3.2.3-2 17:47:35 INFO - jsonschema == 2.5.1 17:47:35 INFO - manifestparser == 1.1 17:47:35 INFO - mozInstall == 1.12 17:47:35 INFO - mozcrash == 1.0 17:47:35 INFO - mozdebug == 0.1 17:47:35 INFO - mozdevice == 0.49 17:47:35 INFO - mozfile == 1.2 17:47:35 INFO - mozhttpd == 0.7 17:47:35 INFO - mozinfo == 0.9 17:47:35 INFO - mozleak == 0.1 17:47:35 INFO - mozlog == 3.4 17:47:35 INFO - moznetwork == 0.27 17:47:35 INFO - mozprocess == 0.24 17:47:35 INFO - mozprofile == 0.28 17:47:35 INFO - mozrunner == 6.13 17:47:35 INFO - mozscreenshot == 0.1 17:47:35 INFO - mozsystemmonitor == 0.3 17:47:35 INFO - moztest == 0.8 17:47:35 INFO - mozversion == 1.4 17:47:35 INFO - psutil == 3.1.1 17:47:35 INFO - requests == 1.2.3 17:47:35 INFO - wsgiref == 0.1.2 17:47:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:35 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:35 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 17:47:35 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 17:47:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:35 INFO - 'HOME': '/Users/cltbld', 17:47:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:35 INFO - 'LOGNAME': 'cltbld', 17:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:35 INFO - 'MOZ_NO_REMOTE': '1', 17:47:35 INFO - 'NO_EM_RESTART': '1', 17:47:35 INFO - 'PAGER': '/bin/cat', 17:47:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:35 INFO - 'PWD': '/builds/slave/test', 17:47:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:35 INFO - 'SHELL': '/bin/bash', 17:47:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:35 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:35 INFO - 'USER': 'cltbld', 17:47:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:35 INFO - 'XPC_FLAGS': '0x0', 17:47:35 INFO - 'XPC_SERVICE_NAME': '0', 17:47:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 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)) 17:47:35 INFO - Cleaning up... 17:47:35 INFO - Return code: 0 17:47:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47: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')]} 17:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:35 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 0x10f270b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f273768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1a1dc74c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, '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.vl49NBwlhx/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.T6aAwuAZNg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 17:47:35 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 17:47:35 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 17:47:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:35 INFO - 'HOME': '/Users/cltbld', 17:47:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:35 INFO - 'LOGNAME': 'cltbld', 17:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:35 INFO - 'MOZ_NO_REMOTE': '1', 17:47:35 INFO - 'NO_EM_RESTART': '1', 17:47:35 INFO - 'PAGER': '/bin/cat', 17:47:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:35 INFO - 'PWD': '/builds/slave/test', 17:47:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:35 INFO - 'SHELL': '/bin/bash', 17:47:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:35 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:35 INFO - 'USER': 'cltbld', 17:47:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:35 INFO - 'XPC_FLAGS': '0x0', 17:47:35 INFO - 'XPC_SERVICE_NAME': '0', 17:47:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:47:35 INFO - Cleaning up... 17:47:35 INFO - Return code: 0 17:47:35 INFO - Running post-action listener: _resource_record_post_action 17:47:35 INFO - Running post-action listener: _start_resource_monitoring 17:47:35 INFO - Starting resource monitoring. 17:47:35 INFO - [mozharness: 2017-02-07 01:47:35.980627Z] Finished create-virtualenv step (success) 17:47:35 INFO - [mozharness: 2017-02-07 01:47:35.981562Z] Running install step. 17:47:35 INFO - Running pre-action listener: _resource_record_pre_action 17:47:35 INFO - Running main action method: install 17:47:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:36 INFO - Reading from file tmpfile_stdout 17:47:36 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:36 INFO - Reading from file tmpfile_stdout 17:47:36 INFO - Output received: 17:47:36 INFO - Usage: mozinstall [options] installer 17:47:36 INFO - Options: 17:47:36 INFO - -h, --help show this help message and exit 17:47:36 INFO - -d DEST, --destination=DEST 17:47:36 INFO - Directory to install application into. [default: 17:47:36 INFO - "/builds/slave/test"] 17:47:36 INFO - --app=APP Application being installed. [default: firefox] 17:47:36 INFO - mkdir: /builds/slave/test/build/application 17:47:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:47:56 INFO - Reading from file tmpfile_stdout 17:47:56 INFO - Output received: 17:47:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:47:56 INFO - Running post-action listener: _resource_record_post_action 17:47:56 INFO - [mozharness: 2017-02-07 01:47:56.389829Z] Finished install step (success) 17:47:56 INFO - [mozharness: 2017-02-07 01:47:56.389993Z] Running run-tests step. 17:47:56 INFO - Running pre-action listener: _resource_record_pre_action 17:47:56 INFO - Running main action method: run_tests 17:47:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:47:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:47:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:47:56 INFO - 2017-02-06 17:47:56.404 screenresolution[1635:8002] starting screenresolution argv=screenresolution get 17:47:56 INFO - 2017-02-06 17:47:56.407 screenresolution[1635:8002] Display 0: 1600x1200x32@60 17:47:56 INFO - 2017-02-06 17:47:56.413 screenresolution[1636:8005] starting screenresolution argv=screenresolution list 17:47:56 INFO - Available Modes on Display 0 17:47:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:47:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:47:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:47:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:47:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:47:56 INFO - Intel Iris: 17:47:56 INFO - Chipset Model: Intel Iris 17:47:56 INFO - Type: GPU 17:47:56 INFO - Bus: Built-In 17:47:56 INFO - VRAM (Dynamic, Max): 1536 MB 17:47:56 INFO - Vendor: Intel (0x8086) 17:47:56 INFO - Device ID: 0x0a2e 17:47:56 INFO - Revision ID: 0x0009 17:47:56 INFO - Displays: 17:47:56 INFO - Display: 17:47:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:47:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:47:56 INFO - Display Serial Number: 1600x1200 60 17:47:56 INFO - Main Display: Yes 17:47:56 INFO - Mirror: Off 17:47:56 INFO - Online: Yes 17:47:56 INFO - Rotation: Supported 17:47:56 INFO - Return code: 0 17:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:56 INFO - Python 2.7.3 17:47:56 INFO - Return code: 0 17:47:56 INFO - grabbing minidump binary from tooltool 17:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:56 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 0x10f04ed30>, '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 0x10ef75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f043be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:56 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 17:47:56 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 17:47:56 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 17:47:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:56 INFO - Return code: 0 17:47:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:47:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:47:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 17:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0326 --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 17:47:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vl49NBwlhx/Render', 17:47:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:47:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:47:56 INFO - 'HOME': '/Users/cltbld', 17:47:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:47:56 INFO - 'LOGNAME': 'cltbld', 17:47:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:56 INFO - 'MOZ_NO_REMOTE': '1', 17:47:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:56 INFO - 'NO_EM_RESTART': '1', 17:47:56 INFO - 'PAGER': '/bin/cat', 17:47:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:56 INFO - 'PWD': '/builds/slave/test', 17:47:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:47:56 INFO - 'SHELL': '/bin/bash', 17:47:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T6aAwuAZNg/Listeners', 17:47:56 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 17:47:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:47:56 INFO - 'USER': 'cltbld', 17:47:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:47:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:56 INFO - 'XPC_FLAGS': '0x0', 17:47:56 INFO - 'XPC_SERVICE_NAME': '0', 17:47:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:47:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 17:47:56 INFO - mozversion application_buildid: 20170206161456 17:47:56 INFO - mozversion application_changeset: 295a39d8aa6b0255a5467970303f1bb8ff0bd7ed 17:47:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:47:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:47:57 INFO - mozversion application_name: Firefox 17:47:57 INFO - mozversion application_remotingname: firefox-dev 17:47:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:47:57 INFO - mozversion application_vendor: Mozilla 17:47:57 INFO - mozversion application_version: 53.0a2 17:47:57 INFO - mozversion platform_buildid: 20170206161456 17:47:57 INFO - mozversion platform_changeset: 295a39d8aa6b0255a5467970303f1bb8ff0bd7ed 17:47:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:47:57 INFO - mozversion platform_version: 53.0a2 17:47:57 INFO - using testdate: 1486432076 17:47:57 INFO - actual date: 1486432076 17:47:57 INFO - starting webserver on 'localhost:49240' 17:47:57 INFO - SUITE-START | Running 2 tests 17:47:57 INFO - TEST-START | dromaeo_css 17:47:57 INFO - operating with platform_type : mac_ 17:47:57 INFO - Initialising browser for dromaeo_css test... 17:47:57 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp2q5gWv/profile http://localhost:49240/getInfo.html) 17:47:59 INFO - PROCESS | 1646 | 2017-02-06 17:47:59.859 plugin-container[1648:8191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 17:47:59 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:47:59 INFO - PROCESS | 1646 | 2017-02-06 17:47:59.862 plugin-container[1648:8191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9213, name = 'com.apple.CFPasteboardClient' 17:47:59 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:47:59 INFO - PROCESS | 1646 | 2017-02-06 17:47:59.862 plugin-container[1648:8191] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:47:59 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 17:47:59 INFO - PROCESS | 1646 | colorDepth:24 17:47:59 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 17:47:59 INFO - PROCESS | 1646 | __metrics 17:48:00 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 17:48:00 INFO - PROCESS | 1646 | 1486432080014 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp2q5gWv/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp2q5gWv/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp2q5gWv/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp2q5gWv/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:48:00 INFO - TEST-INFO | 1646: exit 0 17:48:00 INFO - Browser initialized. 17:48:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:48:00 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp2q5gWv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:03 INFO - PROCESS | 1650 | 2017-02-06 17:48:03.245 plugin-container[1651:8334] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 17:48:03 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:48:03 INFO - PROCESS | 1650 | 2017-02-06 17:48:03.247 plugin-container[1651:8334] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b13, name = 'com.apple.CFPasteboardClient' 17:48:03 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:48:03 INFO - PROCESS | 1650 | 2017-02-06 17:48:03.248 plugin-container[1651:8334] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:48:12 INFO - PROCESS | 1650 | RSS: Main: 218628096 17:48:12 INFO - PROCESS | 1650 | 17:51:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 17:51:16 INFO - PROCESS | 1650 | RSS: Main: 239345664 17:51:16 INFO - PROCESS | 1650 | 17:53:01 INFO - PROCESS | 1650 | ************************* 17:53:01 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 17:53:01 INFO - PROCESS | 1650 | 17:53:01 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:53:01 INFO - PROCESS | 1650 | Full stack: 17:53:01 INFO - PROCESS | 1650 | ************************* 17:54:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 17:54:19 INFO - PROCESS | 1650 | RSS: Main: 247967744 17:54:19 INFO - PROCESS | 1650 | 17:57:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 17:57:22 INFO - PROCESS | 1650 | RSS: Main: 254332928 17:57:22 INFO - PROCESS | 1650 | 18:00:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 18:00:25 INFO - PROCESS | 1650 | RSS: Main: 250720256 18:00:25 INFO - PROCESS | 1650 | 18:03:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 18:03:28 INFO - PROCESS | 1650 | RSS: Main: 254701568 18:03:28 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 18:06:31 INFO - PROCESS | 1650 | RSS: Main: 256045056 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | __start_tp_report 18:06:31 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 18:06:31 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 18:06:31 INFO - PROCESS | 1650 | |i|pagename|runs| 18:06:31 INFO - PROCESS | 1650 | |0;dojo.html;3359.0258824940765;3368.7641865069454;3415.316936612678;3415.8121303328317;3418.0942050356643;5650.7174641267875;5673.092305231164;5687.061634830253;5696.7721291148355;5722.656640601567;4622.653301002421;5730.3123625164935;5735.655860648364;5743.597948143632;5756.712164391784;5185.170372740362;5201.713905735183;5210.452902445246;5227.085260079471;5277.788888444457;5278.445763194867;5300.708461034642;5307.230451584518;5313.920291195615;5362.91955620666;5124.2057481090305;5142.665726727751;5285.709285989269;5300.893982120355;5351.518363347298;3920.588338224474;5236.921446178291;5240.580753539708;5247.632665713401;5337.839864804062;5179.637425380225;5229.660072095302;5230.006298803215;5257.815976440845;5308.814191503279;5373.9731301343245;5442.863928401822;5753.626014309057;5789.8552536186935;5829;5844.503217226541;5941.643501389931;6135.263289243823;6190.907136392958;6259.217597800275;6253.781117660906;6288.276848162474;6294.024426213944;6316.368363163693;6336.3346848580695;4840.733759643218;5833.82498525045;5835.328937172195;5847.649141051551;5861.17943487912;6176.8764624707255;6219.378062193744;6239.812805615838;6241.500679945593;6278.843028924313;6129.632222066691;6215.223097112861;6236.656983865931;6243.7814676486105;6246.3441338659695;6212.06818977148;6297.685115744194;6312.242530896322;6318.178636777189;6328.208973878265;6004.7598096076545;6074.787382441594;6211;6243.43809057187;6333;6288.151099601587;6289.496840252768;6291.874162516724;6298.118263443122;6310.0850376695125;4977.850664480072;4986.326845875833;4987.60099192071;4996.7001979881325;5029.723365214948;4337.652987760972;4374.890627734332;4462.48681401643;4471.8434854779925;4482.103579284156;5198.636095473281;5675.5459563234845;5742.224799651994;5743.597948143673;5881.147233651097;6269.68651567429;6285.654289014056;6307.432331090224;6317.431431171217;6324.114623952651;5712.514436272963;5777;5808.680522571215;5809.128630705343;5809.24479817621;5471.206675032098;5486.506214440639;5488.7530061147345;5495.807646732425;5519.227308176858;6328.11406403104;6360.077788720517;6360.840978975562;6376.617402955652;6388.105665206967;6129.695011270178;6213.751449942132;6231.22109736283;6233.657148856856;6291.653959032297;6035.939640603538;6254.718537665907;6266.592671476339;6269.0909818075215;6323.9683801580695;6191.349908259568;6205.968970155121;6213.596116252429;6238.189035425366;6276.027215781562;5463.371712252982;6014.879702406015;6154.323024467394;6195.721192546436;6293.748250069946;5975.55183361241;5995.890760209375;6132.324915438508;6138.7869253627705;6144.631322120687;4998.925016124834;5992.910106348496;6079.483243924316;6121.785737499166;6133.478654314434;5078.035173317058;5325.973370133124;5519.558435325244;5938.970305148447;5945.970270148621;4992.675476094042;4998.600111991104;6090.634561926298;6196.81409557714;6209.627422354673;5912.438318359749;5977.731002104829;6003.519718422428;6015.368386319374;6041.003234466264 18:06:31 INFO - PROCESS | 1650 | |1;ext.html;454.8635409377187;455.44663234170474;456.5571395746125;460.723565860484;471.99700636148185;28283;40014.399784003224;40026;40055.998600034975;40203.39694904579;39674.00814979627;40204.79897600515;40249.396259056135;40278.798606007;40401.59598404015;8502;8707.042225355206;9204.677836275714;9466.148046675798;9474.526273686322;11277.492512836941;11593.942030289836;11618.535258589647;11677.883221167764;11736.941315293412;11433.485493152828;11441.141914356456;11492.195546311761;11501.942490287536;11529.135314851419;11492.310461372344;11524.827127593093;11529.365884876328;11533.365664888386;11540.596079137275;11306.717332066683;11327.716807079807;11382.94308528452;11416.31502109876;11421;39704.20591588152;40022.199556008716;40068.59931400678;40104;40130.99672508211;3898.0823227193832;3919.627635374635;4011.939820902689;4019.919601607981;4080.204360149772;25610.84751186201;29466.410671786445;29721.851390742908;29961.850190749126;31465.21336966571;3231.3052693670975;3265.673432656739;3276.8033917965;3379.9831000845084;3415.1803567143957;475146;475247;475397;477001;479046.9999999965;64980;65141;65161;65192.67403662951;65199.34800651933;67848;67938;68142.65928670423;68386.63226735537;68758;16658.16709164537;17250.396236131674;17281.39515116965;17294;17350.47948561545;12574.30841303737;12845.421956012002;12883.420246088948;13182.60452186436;13324;18402;18595.90702046508;18607.06964651762;18630.347937822113;19009.334673286645;8004.199580041949;8021.3181879539725;8085.474444161111;8090.878636820453;8143.144969778206;737.9003834482384;846.2383854530848;850.1328644782287;868.2142660891903;884.2307192742227;30421.543676844864;30434;30436.934707285138;30698.925537606523;30721.69278307188;1014.7310962594918;1051.447989805343;1066.1151244467073;1093.9617113400993;1201.954299759215;12020.278783273032;13270.606586308299;14883.925580372246;15610.45363412275;16431.931924424873;635561;640491;648661;649621.7518912376;654322;60869.39130608726;61389.38610613926;61428;61769.382306177264;62346.688266558376;1418.432626949208;1435.5693292012354;1439.8920080993967;1450.0502171078172;1453.0192120318743;25065;25442;30040.248993774458;30059.549106762977;30934.381312374077;42240.577594224895;42441.151176976906;42628;42669.35995960125;42755.57244427516;550882;550975;552921.470785287;553641;554711;22482.437939051655;25260.87369563214;26206;26874.731252688005;26973;35586.11034724153;42742.14515709731;42992.785036074616;43441.565584345015;44305.55694443014;34687.653123468444;34940.82529587336;35382;35462.82268588641;35565.110872228404;35113.47329790004;35273;35887.64112358948;36026.4596031065;36136.63863361333;34028.1492962668;34191.14522136867;34505.309893802485;34834.9549513515;35085.947421577395;27072.458550829266;30321;31833.522497163023;32009;32188.517172241965;19747.605047899247;22854.20010299698;23918;24272.87863560671;24374.903129359576 18:06:31 INFO - PROCESS | 1650 | |2;jquery.html;379.3778203745857;384.49630983411714;393.86017963622913;396.3737295073783;413.6959334888856;11980.520779168823;16023.439179628715;19753;21212.681809772865;21262.57474850504;20350.89824550879;20617.38147855563;20998.475038124016;21153.15387384503;21351.039203235854;5751.942480575182;5754.367019627837;5970.373110823366;6011.819645410645;6050.183225264599;4848.466668666444;5842.6786526741225;5896.027155519334;5961.403859614025;5966.79116230932;5646.265985421889;5869.354371019184;5901.114832775075;5909.113632955048;5918.05311150216;5637.577181711388;5911.113333000063;5912.054071348585;5964.254468191476;5970.373110823344;4457.442819647544;5148.819791307324;5150.4334523202415;5175.689458632494;5179.326687530634;24764.761761912014;25020.74896255198;25455.490890182093;25477.49045019108;25599.61600575993;3042.893498727556;3097.9070627880974;3123.87504499822;3158.147300228948;3194.2014496375905;14911.850881491155;15396.692066158614;15484.916055876092;15617.765733514007;15844.287007084593;1634.961799257468;1850.703887378013;1853.8794978326366;1871.3543827379533;1896.0804010055112;115545;122969;125251;125743.99999999908;126440.36779816043;11507;11746.647600571825;11788.23376480526;11918.344491052902;12064.879351206375;14489.420423183166;14616.853831461549;14630;14664.706705866036;14678.706425871424;7147.82130446743;8878.156575125482;8928.508932008672;8986.550672466481;8988;8708.608112634947;8751.949766028118;8778.429402088845;8868.290536757044;8880.777980550409;5943.702814859326;7222.422206223489;7287.963560182271;7332.340089391981;7373.631318434057;1932.6811076172555;1955.0127185771094;1966.223341779989;1972.112549352797;1974.220183027696;995.9004099590128;1054.1566746602687;1071.83580387685;1078.7141407527013;1080.8162612355918;20290;21837.45406364822;22073.99811843879;22093.005814738375;22311.44221394478;1078.9568417263222;1101.3777215873006;1102.4322473925934;1125.5272785430138;1138.3966497756203;11101.722456938642;11449.828252576219;11784.991378664205;11879.58421455245;11935.522579096913;764432;766626;804103;810558;821430;101817;118142.81857181319;129555;155540;158145.41854581537;1071.325065208929;1106.3472551194834;1129.5820546397722;1147.0307590086531;1153.5212886652114;19279.80720192836;19605.8039419604;19782.802171978095;19801.702974455682;19868.801311987274;57964;58747.825043499746;59497.702511487165;61376.69311653413;61496;73486.16284592928;86174.56912715397;86663.56668216619;88609.11390886009;90738;7851.568163751049;8091.514509129235;8116.594170291343;8270.2556769891;8343.54110523927;10132.746681333025;12328.753424931272;12385.380730963596;12461;12857;10808.243422960317;11009.2843965142;11047.354373057033;11059.50232239535;11063.280886742335;9300.93039300462;9491.050894910453;10491.475426228506;10650.307729997525;10965.56137754481;10693.251472396858;10828.837567436653;11146.386948717574;11195.216334856808;11255.268407553483;7462.701491940262;7947.284744373034;8146.674133034612;8374.455660382057;8430.903982482238;10736.89263107359;10791.460426978463;10969.122470202525;10996.780064398827;11071.667849964513 18:06:31 INFO - PROCESS | 1650 | |3;mootools.html;1312.3635037007052;1443.5380678182978;1448.9058211216263;1455.4251070827024;1471.8454562270965;7508.9624551877305;7698.7690369288875;8083.232092951168;8560.828783424327;8570.10013948535;8005.479643823148;8234.300084492825;8256.95871520643;8386.20331068549;8429.91570084299;2285.0631241191113;2306.7577904320055;2307.8114770893003;2308.7922087012166;2330.685357476736;2070.2960993262286;2143.721316228888;2318.038014224095;2350.0482304666552;2366.183666635008;2211.834112441565;2276.3284830974903;2286.0398632574274;2292.518571100071;2294.300238427279;2296.1504243429954;2300.919467818627;2306.5156317173414;2315.154968436517;2320.825938054653;2264.9320520384413;2296.127471560796;2335.556244313575;2343.4610039690965;2354.093673935547;8407.663693452254;8422.747317580483;8435.83128337436;8439;8460.365472589581;4187.309093999486;5194.402643695986;5202.323697919246;5215.452377500384;5222.00781851447;2929.2091135393325;3312.983667096859;3363.848626811775;3389.5254664347012;3467.791932484059;1132.5526417065296;1162.4943149729895;1203.4404002139047;1211.0553768060927;1226.2764968668528;8897.288216942628;9252.907470925273;10354.275200735952;10740;10834.837477437844;4338.934915976263;4604.930926036112;4669.509701481364;4734.573888350065;4752.358431611758;9402.529873506433;9490.145886870216;9495.14543691071;9515.429074255568;9550.952245238868;4523.660725445605;4956.587372598792;5177.068127737043;5181.4300426953005;5221.921671174935;4409.713368631029;4681.133990211822;4703.600193983481;4726.3146843708155;4803.735794531264;3778.112143646241;3794.6395092466173;3840.327942610088;3867.361885288896;3910.061585219584;1089.9945500272447;1146.9426528673532;1186.9821952670716;1274.6813296675832;1279.7504486625205;663.8240866170469;666.9362367024588;786.3159051625008;823.6129019360891;852.8635418333037;5447.319085114361;5493.697846618475;5538.833834984957;5631.986242476311;5733.140028995601;954.1365064616533;984.670135504614;1010.5907107621425;1020.6733845169623;1035.3839465518004;3518.894433167009;3706.6108058653454;3708.9072773180346;3838;3960.5643379228263;9731.659391921248;10067.446290454096;10102.949485252526;10112.544935477921;10112.848307275397;9434.339596228197;9898.356606820678;9912.157466615274;10073.445960472245;10122.987701229818;7708.884366734504;7876.881846772303;7884.093329267093;7897.368210543258;7917.881231781528;5701.030824759718;5723.313202415737;5729.455701708331;5756;5951.375105613848;7043.612601306772;9203.125703058198;9327.347085703936;9357.438553686801;9375.296852735935;8916.375853690179;9265.53672316368;9293.117153870371;9391.859122113037;9400;7085.6811443486195;7209.387202087882;7212.4230061596;7223.241559636373;7224.060872086595;7746.806329841799;7748.302652761278;7760.961195193988;7793.922060779547;7828.373730101692;6403.358746653127;7032.734636467358;7088.04311417952;7111.217766045627;7204.963975180301;6890.483213758888;6984.895226571707;7042.154941407064;7083.256258093033;7118.394936430462;6326.683665816783;6335.144755458138;6398.232212134573;6398.424141827258;6428.646424446701;4843.370361853077;4898.2652602109965;4951;4988.80044798204;5108.719020453911;4925.876853078558;4954.157793175097;4958.181899986462;4967.677100988424;5025.773840177274 18:06:31 INFO - PROCESS | 1650 | |4;prototype.html;356.3870143353432;359.1828589957847;369.62298455575325;371.2611902314395;373.5051057349012;4185.8744237672845;4553.418558100762;5285.471452854713;5351.849352389236;5436.836894893149;4875.536824001723;5277.226782850261;5336.733163341827;5417.783288668448;5417.891642167164;3770.4155855842387;4014.799260037001;4253.808578613962;4254.766117825842;4278.122984788127;3532.24056827782;3658.8170591470453;4082.5100987881347;4270.508891477489;4288.571142885702;4169.14532520834;4179.916401671965;4195.28680124378;4197.958020419787;4217.725847819897;4214.536400995888;4229.513605935326;4239.385289133058;4249.936250956238;4271.081717430736;3319.96680033199;3765.6987441004653;3780.584135745066;3781.2248489059675;3784.678302344304;5081.644284900059;5236.743181636418;5272.92090618641;5292.682439053669;5311.787528498855;4443.622292105175;4824;4837.443693975203;4889.975550122226;4898.265260210961;5525.972370138164;5721.970045391828;5757.884842303172;5767.856518197593;5772.220750198711;3348.5144654025275;3618.294432585647;3967.6429121378924;4130.318497447947;4140.171965606861;5298.417174110845;6070.716808103592;6072.635641861459;6096.908546371808;6107.908381374283;3386.508956201337;4196.328587425997;4206.284931561642;4224.73258022592;4231.682623803165;3588.4079126944284;3653.6529029742665;4093.9151124951914;4197.5172855122055;4218.7679677618025;4291.935620965688;4472.686911916135;4757.976210118927;4845.200541910545;4911.140550403665;4935.777889994959;5789.739461724233;5802.680852553066;5814.796482123105;5830.912536311958;1184.9348285844362;1262.0156278103095;1368.8288963879515;1373.3751143229806;1387.7710177820547;811.926926576611;838.4550042472441;930.8091841172543;980.3921568627354;992.5682328187262;4634.837780677727;4666.9863917031325;5034.924476132861;5121.487851214849;5129.717865517432;5030.320906677552;5043.049201941744;5091.854332775096;5504.862378440571;5529.834104976857;3994.560598334181;4238.87283381499;4431.379606855043;5209.869753256199;5245.606579506552;2456.9017239310583;2518.5214809186195;2705.376773935662;2967.629046369204;2985.7611391088662;4808.663393562417;5121.795128194905;5144;5484.808031718951;5956.702164891738;5067.670601410897;5392.811251606175;5592.762894842096;5630.943690563124;5864.296284445809;5001.424836143818;5299.549538289289;5919.319278283053;5979.521638269015;6001.489873360813;5734.684592347461;5749.3326935188325;5750.447379207674;5796.304443466811;5811.94188058114;5297.682139071668;5525.066226820581;5624.946894383603;5639.661620302795;5678.3248941561515;5263.710495922761;5820.275023984738;5875.354900627831;5877.472686744741;5884.705764711662;3487.3199726053176;3708.851645934132;3743.9891229368463;3794.4118661607495;3829.9425508616837;5197.792088316425;5363.222332761649;5413.458654134555;5871.7651293947765;5895.587308888336;4845.248986407112;5112.846614601568;5568.6658800472105;5722.7710891563875;5725.65646061221;4868.9756551217015;5231.241469986907;5263.815766448156;5716.199732037601;5723;4702.647301452474;5389.326334208224;5441.993231252231;5453.590980676386;5668.716564171693;4925.9014819704125;5326.9200961984825;5744.454276843693;5771.307443106854;5791.015527360275;5124.385073791169;5408.269883565826;5611.8776244752025;5651.378348381757;5714.771409143587 18:06:31 INFO - PROCESS | 1650 | |5;yui.html;698.4586945117536;700.0968750312095;771.6643260181821;793.6745934166993;840.4285086141422;14863.108213507197;15624.76562851558;15710.214489275519;15724.449644262453;15731.60670983226;14440.494582689582;14577.635559111028;14588.343524541395;14596.562103136923;14599.489017884376;655.4461480049374;670.430134385773;839.7858546070773;846.6697987784753;854.4232642966005;853.9701110461135;863.313665635821;866.5493943149559;867.2108381372952;867.652938824469;923.8383282925495;923.9260859131253;924.2236521322088;924.4360939826701;927.7309580221728;917.0737555069361;918.4581097152678;919.4804935211585;920.8342498350295;921.5530467723149;679.6262055869302;680.680080362229;686.5091459606356;686.5297271369128;687.0038444255849;14704.191269480174;15015.399384024626;15103.697926041528;15124.168170750605;15142.545723628198;14299.356528956221;14561.635959101108;14741.926290368587;14751.041182323115;14860;11192.992630663279;11243.943780281128;11261;11360.318380897173;11491.221085320696;3690.837386223331;3744.54683654622;3754.1177823211524;3778.079988882163;3905.7656540607654;102940.48529757303;103173.48413257886;103273.48363258211;104001;104455;9309.394889332172;10952.945235273774;10985.121190304757;11082.667519974413;11167;22366.66450003251;22544.323670289916;22608.9825957829;22903;23113.76886231116;7667;7709.344705699966;7739.496932699357;7819.100803407681;7963.442559020813;4041.2119636671155;4171.374293855946;4235.322348424237;4238.512571054368;4302.268614335508;3415.9316813663586;3481.9825900870333;3488.3720930232294;3509.8771542996383;3519.964800352015;618.8762247550508;619.102301662591;620.4230066038627;628.745358129958;629.0375725140542;604.4106995679177;609.5215256024;640.9775657852047;643.6845945486677;651.2835880531378;7869.567173805382;9356.578953947088;9708.368956017835;9911.702648920544;10256.846147307797;609.2901769438643;628.5914155798675;634.946029587481;639.9616023038633;648.8280605639509;4617.676762626651;4763.356946812136;4788.377510923628;4811.446683631427;4827.42070951488;91662.54168729113;95816.52091739497;97730.02269977352;98443.50778246207;99532;63498;84795.57602212073;85743.14256857477;86107.56946215229;86721;58285;58517.41482585205;76231.85652215221;76953.84569231466;78264;9172.357934944757;9220.723378298662;9248.722538323862;9278;9296.767580810263;49589;49687.503124969735;49873.501264988336;50211;51967.2204916919;55780;64461;64554.67722661357;65800.36798528006;66187.66906165631;10682.946585267335;10716;10923.729952179103;11086.22396432242;11335.603253886075;12016.63950081499;12042.819357709817;12069;12193.146479746332;12568.270835293186;11238.66284011481;11380.829287560859;11694.29834209916;11705.473253703774;12116;10982.725431864268;11300.830487542858;11596.420178991186;11671.12466565028;11691.590794322157;10955.45222738844;11285.21003529745;11316.377599231791;11692.415379231175;11848.644540663794;9408.529573521433;9546.42721436716;9568.359986677448;9766.218702503924;9907.256955728206;7392.4086073115095;9066.456012639263;9459.810803784023;9645.251103435487;9744.025597440199 18:06:31 INFO - PROCESS | 1650 | __end_tp_report 18:06:31 INFO - PROCESS | 1650 | __start_cc_report 18:06:31 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,383 18:06:31 INFO - PROCESS | 1650 | __end_cc_report 18:06:31 INFO - PROCESS | 1650 | __startTimestamp1486433191287__endTimestamp 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | ------- Summary: start ------- 18:06:31 INFO - PROCESS | 1650 | Number of tests: 6 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5708.29 Median:5881.15 stddev:661.44 (11.2%) stddev-sans-first:637.28 18:06:31 INFO - PROCESS | 1650 | Values: 3359.0 3368.8 3415.3 3415.8 3418.1 5650.7 5673.1 5687.1 5696.8 5722.7 4622.7 5730.3 5735.7 5743.6 5756.7 5185.2 5201.7 5210.5 5227.1 5277.8 5278.4 5300.7 5307.2 5313.9 5362.9 5124.2 5142.7 5285.7 5300.9 5351.5 3920.6 5236.9 5240.6 5247.6 5337.8 5179.6 5229.7 5230.0 5257.8 5308.8 5374.0 5442.9 5753.6 5789.9 5829.0 5844.5 5941.6 6135.3 6190.9 6259.2 6253.8 6288.3 6294.0 6316.4 6336.3 4840.7 5833.8 5835.3 5847.6 5861.2 6176.9 6219.4 6239.8 6241.5 6278.8 6129.6 6215.2 6236.7 6243.8 6246.3 6212.1 6297.7 6312.2 6318.2 6328.2 6004.8 6074.8 6211.0 6243.4 6333.0 6288.2 6289.5 6291.9 6298.1 6310.1 4977.9 4986.3 4987.6 4996.7 5029.7 4337.7 4374.9 4462.5 4471.8 4482.1 5198.6 5675.5 5742.2 5743.6 5881.1 6269.7 6285.7 6307.4 6317.4 6324.1 5712.5 5777.0 5808.7 5809.1 5809.2 5471.2 5486.5 5488.8 5495.8 5519.2 6328.1 6360.1 6360.8 6376.6 6388.1 6129.7 6213.8 6231.2 6233.7 6291.7 6035.9 6254.7 6266.6 6269.1 6324.0 6191.3 6206.0 6213.6 6238.2 6276.0 5463.4 6014.9 6154.3 6195.7 6293.7 5975.6 5995.9 6132.3 6138.8 6144.6 4998.9 5992.9 6079.5 6121.8 6133.5 5078.0 5326.0 5519.6 5939.0 5946.0 4992.7 4998.6 6090.6 6196.8 6209.6 5912.4 5977.7 6003.5 6015.4 6041.0 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:68947.69 Median:34887.89 stddev:150352.12 (431.0%) stddev-sans-first:150685.95 18:06:31 INFO - PROCESS | 1650 | Values: 454.9 455.4 456.6 460.7 472.0 28283.0 40014.4 40026.0 40056.0 40203.4 39674.0 40204.8 40249.4 40278.8 40401.6 8502.0 8707.0 9204.7 9466.1 9474.5 11277.5 11593.9 11618.5 11677.9 11736.9 11433.5 11441.1 11492.2 11501.9 11529.1 11492.3 11524.8 11529.4 11533.4 11540.6 11306.7 11327.7 11382.9 11416.3 11421.0 39704.2 40022.2 40068.6 40104.0 40131.0 3898.1 3919.6 4011.9 4019.9 4080.2 25610.8 29466.4 29721.9 29961.9 31465.2 3231.3 3265.7 3276.8 3380.0 3415.2 475146.0 475247.0 475397.0 477001.0 479047.0 64980.0 65141.0 65161.0 65192.7 65199.3 67848.0 67938.0 68142.7 68386.6 68758.0 16658.2 17250.4 17281.4 17294.0 17350.5 12574.3 12845.4 12883.4 13182.6 13324.0 18402.0 18595.9 18607.1 18630.3 19009.3 8004.2 8021.3 8085.5 8090.9 8143.1 737.9 846.2 850.1 868.2 884.2 30421.5 30434.0 30436.9 30698.9 30721.7 1014.7 1051.4 1066.1 1094.0 1202.0 12020.3 13270.6 14883.9 15610.5 16431.9 635561.0 640491.0 648661.0 649621.8 654322.0 60869.4 61389.4 61428.0 61769.4 62346.7 1418.4 1435.6 1439.9 1450.1 1453.0 25065.0 25442.0 30040.2 30059.5 30934.4 42240.6 42441.2 42628.0 42669.4 42755.6 550882.0 550975.0 552921.5 553641.0 554711.0 22482.4 25260.9 26206.0 26874.7 26973.0 35586.1 42742.1 42992.8 43441.6 44305.6 34687.7 34940.8 35382.0 35462.8 35565.1 35113.5 35273.0 35887.6 36026.5 36136.6 34028.1 34191.1 34505.3 34835.0 35085.9 27072.5 30321.0 31833.5 32009.0 32188.5 19747.6 22854.2 23918.0 24272.9 24374.9 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:41333.96 Median:21237.63 stddev:131261.63 (618.1%) stddev-sans-first:131593.82 18:06:31 INFO - PROCESS | 1650 | Values: 379.4 384.5 393.9 396.4 413.7 11980.5 16023.4 19753.0 21212.7 21262.6 20350.9 20617.4 20998.5 21153.2 21351.0 5751.9 5754.4 5970.4 6011.8 6050.2 4848.5 5842.7 5896.0 5961.4 5966.8 5646.3 5869.4 5901.1 5909.1 5918.1 5637.6 5911.1 5912.1 5964.3 5970.4 4457.4 5148.8 5150.4 5175.7 5179.3 24764.8 25020.7 25455.5 25477.5 25599.6 3042.9 3097.9 3123.9 3158.1 3194.2 14911.9 15396.7 15484.9 15617.8 15844.3 1635.0 1850.7 1853.9 1871.4 1896.1 115545.0 122969.0 125251.0 125744.0 126440.4 11507.0 11746.6 11788.2 11918.3 12064.9 14489.4 14616.9 14630.0 14664.7 14678.7 7147.8 8878.2 8928.5 8986.6 8988.0 8708.6 8751.9 8778.4 8868.3 8880.8 5943.7 7222.4 7288.0 7332.3 7373.6 1932.7 1955.0 1966.2 1972.1 1974.2 995.9 1054.2 1071.8 1078.7 1080.8 20290.0 21837.5 22074.0 22093.0 22311.4 1079.0 1101.4 1102.4 1125.5 1138.4 11101.7 11449.8 11785.0 11879.6 11935.5 764432.0 766626.0 804103.0 810558.0 821430.0 101817.0 118142.8 129555.0 155540.0 158145.4 1071.3 1106.3 1129.6 1147.0 1153.5 19279.8 19605.8 19782.8 19801.7 19868.8 57964.0 58747.8 59497.7 61376.7 61496.0 73486.2 86174.6 86663.6 88609.1 90738.0 7851.6 8091.5 8116.6 8270.3 8343.5 10132.7 12328.8 12385.4 12461.0 12857.0 10808.2 11009.3 11047.4 11059.5 11063.3 9300.9 9491.1 10491.5 10650.3 10965.6 10693.3 10828.8 11146.4 11195.2 11255.3 7462.7 7947.3 8146.7 8374.5 8430.9 10736.9 10791.5 10969.1 10996.8 11071.7 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5388.28 Median:5179.25 stddev:2924.93 (56.5%) stddev-sans-first:2917.09 18:06:31 INFO - PROCESS | 1650 | Values: 1312.4 1443.5 1448.9 1455.4 1471.8 7509.0 7698.8 8083.2 8560.8 8570.1 8005.5 8234.3 8257.0 8386.2 8429.9 2285.1 2306.8 2307.8 2308.8 2330.7 2070.3 2143.7 2318.0 2350.0 2366.2 2211.8 2276.3 2286.0 2292.5 2294.3 2296.2 2300.9 2306.5 2315.2 2320.8 2264.9 2296.1 2335.6 2343.5 2354.1 8407.7 8422.7 8435.8 8439.0 8460.4 4187.3 5194.4 5202.3 5215.5 5222.0 2929.2 3313.0 3363.8 3389.5 3467.8 1132.6 1162.5 1203.4 1211.1 1226.3 8897.3 9252.9 10354.3 10740.0 10834.8 4338.9 4604.9 4669.5 4734.6 4752.4 9402.5 9490.1 9495.1 9515.4 9551.0 4523.7 4956.6 5177.1 5181.4 5221.9 4409.7 4681.1 4703.6 4726.3 4803.7 3778.1 3794.6 3840.3 3867.4 3910.1 1090.0 1146.9 1187.0 1274.7 1279.8 663.8 666.9 786.3 823.6 852.9 5447.3 5493.7 5538.8 5632.0 5733.1 954.1 984.7 1010.6 1020.7 1035.4 3518.9 3706.6 3708.9 3838.0 3960.6 9731.7 10067.4 10102.9 10112.5 10112.8 9434.3 9898.4 9912.2 10073.4 10123.0 7708.9 7876.9 7884.1 7897.4 7917.9 5701.0 5723.3 5729.5 5756.0 5951.4 7043.6 9203.1 9327.3 9357.4 9375.3 8916.4 9265.5 9293.1 9391.9 9400.0 7085.7 7209.4 7212.4 7223.2 7224.1 7746.8 7748.3 7761.0 7793.9 7828.4 6403.4 7032.7 7088.0 7111.2 7205.0 6890.5 6984.9 7042.2 7083.3 7118.4 6326.7 6335.1 6398.2 6398.4 6428.6 4843.4 4898.3 4951.0 4988.8 5108.7 4925.9 4954.2 4958.2 4967.7 5025.8 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4561.04 Median:5102.35 stddev:1378.85 (27.0%) stddev-sans-first:1346.12 18:06:31 INFO - PROCESS | 1650 | Values: 356.4 359.2 369.6 371.3 373.5 4185.9 4553.4 5285.5 5351.8 5436.8 4875.5 5277.2 5336.7 5417.8 5417.9 3770.4 4014.8 4253.8 4254.8 4278.1 3532.2 3658.8 4082.5 4270.5 4288.6 4169.1 4179.9 4195.3 4198.0 4217.7 4214.5 4229.5 4239.4 4249.9 4271.1 3320.0 3765.7 3780.6 3781.2 3784.7 5081.6 5236.7 5272.9 5292.7 5311.8 4443.6 4824.0 4837.4 4890.0 4898.3 5526.0 5722.0 5757.9 5767.9 5772.2 3348.5 3618.3 3967.6 4130.3 4140.2 5298.4 6070.7 6072.6 6096.9 6107.9 3386.5 4196.3 4206.3 4224.7 4231.7 3588.4 3653.7 4093.9 4197.5 4218.8 4291.9 4472.7 4758.0 4845.2 4911.1 4935.8 5789.7 5802.7 5814.8 5830.9 1184.9 1262.0 1368.8 1373.4 1387.8 811.9 838.5 930.8 980.4 992.6 4634.8 4667.0 5034.9 5121.5 5129.7 5030.3 5043.0 5091.9 5504.9 5529.8 3994.6 4238.9 4431.4 5209.9 5245.6 2456.9 2518.5 2705.4 2967.6 2985.8 4808.7 5121.8 5144.0 5484.8 5956.7 5067.7 5392.8 5592.8 5630.9 5864.3 5001.4 5299.5 5919.3 5979.5 6001.5 5734.7 5749.3 5750.4 5796.3 5811.9 5297.7 5525.1 5624.9 5639.7 5678.3 5263.7 5820.3 5875.4 5877.5 5884.7 3487.3 3708.9 3744.0 3794.4 3829.9 5197.8 5363.2 5413.5 5871.8 5895.6 4845.2 5112.8 5568.7 5722.8 5725.7 4869.0 5231.2 5263.8 5716.2 5723.0 4702.6 5389.3 5442.0 5453.6 5668.7 4925.9 5326.9 5744.5 5771.3 5791.0 5124.4 5408.3 5611.9 5651.4 5714.8 18:06:31 INFO - PROCESS | 1650 | 18:06:31 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:19308.78 Median:57032.50 stddev:27788.99 (48.7%) stddev-sans-first:27831.81 18:06:31 INFO - PROCESS | 1650 | Values: 698.5 700.1 771.7 793.7 840.4 14863.1 15624.8 15710.2 15724.4 15731.6 14440.5 14577.6 14588.3 14596.6 14599.5 655.4 670.4 839.8 846.7 854.4 854.0 863.3 866.5 867.2 867.7 923.8 923.9 924.2 924.4 927.7 917.1 918.5 919.5 920.8 921.6 679.6 680.7 686.5 686.5 687.0 14704.2 15015.4 15103.7 15124.2 15142.5 14299.4 14561.6 14741.9 14751.0 14860.0 11193.0 11243.9 11261.0 11360.3 11491.2 3690.8 3744.5 3754.1 3778.1 3905.8 102940.5 103173.5 103273.5 104001.0 104455.0 9309.4 10952.9 10985.1 11082.7 11167.0 22366.7 22544.3 22609.0 22903.0 23113.8 7667.0 7709.3 7739.5 7819.1 7963.4 4041.2 4171.4 4235.3 4238.5 4302.3 3415.9 3482.0 3488.4 3509.9 3520.0 618.9 619.1 620.4 628.7 629.0 604.4 609.5 641.0 643.7 651.3 7869.6 9356.6 9708.4 9911.7 10256.8 609.3 628.6 634.9 640.0 648.8 4617.7 4763.4 4788.4 4811.4 4827.4 91662.5 95816.5 97730.0 98443.5 99532.0 63498.0 84795.6 85743.1 86107.6 86721.0 58285.0 58517.4 76231.9 76953.8 78264.0 9172.4 9220.7 9248.7 9278.0 9296.8 49589.0 49687.5 49873.5 50211.0 51967.2 55780.0 64461.0 64554.7 65800.4 66187.7 10682.9 10716.0 10923.7 11086.2 11335.6 12016.6 12042.8 12069.0 12193.1 12568.3 11238.7 11380.8 11694.3 11705.5 12116.0 10982.7 11300.8 11596.4 11671.1 11691.6 10955.5 11285.2 11316.4 11692.4 11848.6 9408.5 9546.4 9568.4 9766.2 9907.3 7392.4 9066.5 9459.8 9645.3 9744.0 18:06:31 INFO - PROCESS | 1650 | -------- Summary: end -------- 18:06:31 INFO - PROCESS | 1650 | 18:06:32 INFO - TEST-INFO | 1650: exit 0 18:06:32 INFO - TEST-OK | dromaeo_css | took 1115062ms 18:06:32 INFO - TEST-START | kraken 18:06:32 INFO - operating with platform_type : mac_ 18:06:32 INFO - Initialising browser for kraken test... 18:06:32 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpxSDtbz/profile http://localhost:49240/getInfo.html) 18:06:34 INFO - PROCESS | 1657 | 2017-02-06 18:06:34.704 plugin-container[1658:10500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 18:06:34 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:06:34 INFO - PROCESS | 1657 | 2017-02-06 18:06:34.707 plugin-container[1658:10500] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 18:06:34 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:06:34 INFO - PROCESS | 1657 | 2017-02-06 18:06:34.707 plugin-container[1658:10500] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:06:34 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 18:06:34 INFO - PROCESS | 1657 | colorDepth:24 18:06:34 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 18:06:34 INFO - PROCESS | 1657 | __metrics 18:06:34 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 18:06:34 INFO - PROCESS | 1657 | 1486433194878 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpxSDtbz/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpxSDtbz/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpxSDtbz/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpxSDtbz/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:06:35 INFO - TEST-INFO | 1657: exit 0 18:06:35 INFO - Browser initialized. 18:06:35 INFO - Running cycle 1/1 for kraken test... 18:06:35 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpxSDtbz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:38 INFO - PROCESS | 1659 | 2017-02-06 18:06:38.228 plugin-container[1660:10627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a53, name = 'com.apple.tsm.portname' 18:06:38 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:06:38 INFO - PROCESS | 1659 | 2017-02-06 18:06:38.229 plugin-container[1660:10627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.CFPasteboardClient' 18:06:38 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:06:38 INFO - PROCESS | 1659 | 2017-02-06 18:06:38.229 plugin-container[1660:10627] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:06:47 INFO - PROCESS | 1659 | RSS: Main: 219029504 18:06:47 INFO - PROCESS | 1659 | 18:06:50 INFO - PROCESS | 1659 | 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) 18:06:52 INFO - PROCESS | 1659 | RSS: Main: 233451520 18:06:52 INFO - PROCESS | 1659 | 18:06:54 INFO - PROCESS | 1659 | 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) 18:06:55 INFO - PROCESS | 1659 | RSS: Main: 241369088 18:06:55 INFO - PROCESS | 1659 | 18:06:58 INFO - PROCESS | 1659 | 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) 18:06:59 INFO - PROCESS | 1659 | RSS: Main: 245100544 18:06:59 INFO - PROCESS | 1659 | 18:07:01 INFO - PROCESS | 1659 | 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) 18:07:01 INFO - PROCESS | 1659 | RSS: Main: 246435840 18:07:01 INFO - PROCESS | 1659 | 18:07:03 INFO - PROCESS | 1659 | 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) 18:07:04 INFO - PROCESS | 1659 | RSS: Main: 246501376 18:07:04 INFO - PROCESS | 1659 | 18:07:07 INFO - PROCESS | 1659 | 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) 18:07:07 INFO - PROCESS | 1659 | RSS: Main: 250097664 18:07:07 INFO - PROCESS | 1659 | 18:07:10 INFO - PROCESS | 1659 | 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) 18:07:11 INFO - PROCESS | 1659 | RSS: Main: 249556992 18:07:11 INFO - PROCESS | 1659 | 18:07:14 INFO - PROCESS | 1659 | 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) 18:07:15 INFO - PROCESS | 1659 | RSS: Main: 249954304 18:07:15 INFO - PROCESS | 1659 | 18:07:16 INFO - PROCESS | 1659 | 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) 18:07:17 INFO - PROCESS | 1659 | RSS: Main: 249196544 18:07:17 INFO - PROCESS | 1659 | 18:07:19 INFO - PROCESS | 1659 | 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) 18:07:19 INFO - PROCESS | 1659 | RSS: Main: 249262080 18:07:19 INFO - PROCESS | 1659 | 18:07:22 INFO - PROCESS | 1659 | 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) 18:07:22 INFO - PROCESS | 1659 | RSS: Main: 249262080 18:07:22 INFO - PROCESS | 1659 | 18:07:25 INFO - PROCESS | 1659 | 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) 18:07:26 INFO - PROCESS | 1659 | RSS: Main: 249839616 18:07:26 INFO - PROCESS | 1659 | 18:07:29 INFO - PROCESS | 1659 | 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) 18:07:29 INFO - PROCESS | 1659 | RSS: Main: 249651200 18:07:29 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | 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) 18:07:31 INFO - PROCESS | 1659 | RSS: Main: 251703296 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | __start_tp_report 18:07:31 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 18:07:31 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 18:07:31 INFO - PROCESS | 1659 | |i|pagename|runs| 18:07:31 INFO - PROCESS | 1659 | |0;ai-astar;134;118;119;122;177;163;180;140;148;174 18:07:31 INFO - PROCESS | 1659 | |1;audio-beat-detection;169;137;108;142;108;152;102;117;163;142 18:07:31 INFO - PROCESS | 1659 | |2;audio-dft;197;254;198;197;195;198;192;193;196;196 18:07:31 INFO - PROCESS | 1659 | |3;audio-fft;80;60;61;97;80;65;58;58;88;87 18:07:31 INFO - PROCESS | 1659 | |4;audio-oscillator;83;70;84;70;59;59;103;91;60;84 18:07:31 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;93;90;95;91;106;72;137;124;92;95 18:07:31 INFO - PROCESS | 1659 | |6;imaging-darkroom;96;98;95;96;103;152;115;96;97;115 18:07:31 INFO - PROCESS | 1659 | |7;imaging-desaturate;92;96;114;114;92;93;91;91;94;92 18:07:31 INFO - PROCESS | 1659 | |8;json-parse-financial;56;58;57;62;60;61;60;61;62;60 18:07:31 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;69;73;71;78;76;73;72;70;69;70 18:07:31 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;86;85;84;86;86;88;107;114;86;85 18:07:31 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;137;142;136;154;156;159;163;163;267;166 18:07:31 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;170;173;171;181;171;173;170;171;175;172 18:07:31 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;69;66;66;66;70;66;69;67;67;66 18:07:31 INFO - PROCESS | 1659 | __end_tp_report 18:07:31 INFO - PROCESS | 1659 | __start_cc_report 18:07:31 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,942 18:07:31 INFO - PROCESS | 1659 | __end_cc_report 18:07:31 INFO - PROCESS | 1659 | __startTimestamp1486433251908__endTimestamp 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | ------- Summary: start ------- 18:07:31 INFO - PROCESS | 1659 | Number of tests: 14 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:147.50 Median:155.50 stddev:24.59 (15.8%) stddev-sans-first:25.59 18:07:31 INFO - PROCESS | 1659 | Values: 134.0 118.0 119.0 122.0 177.0 163.0 180.0 140.0 148.0 174.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:142.00 stddev:24.02 (16.9%) stddev-sans-first:21.88 18:07:31 INFO - PROCESS | 1659 | Values: 169.0 137.0 108.0 142.0 108.0 152.0 102.0 117.0 163.0 142.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:201.60 Median:197.00 stddev:18.52 (9.4%) stddev-sans-first:19.57 18:07:31 INFO - PROCESS | 1659 | Values: 197.0 254.0 198.0 197.0 195.0 198.0 192.0 193.0 196.0 196.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:73.40 Median:80.00 stddev:14.61 (18.3%) stddev-sans-first:15.30 18:07:31 INFO - PROCESS | 1659 | Values: 80.0 60.0 61.0 97.0 80.0 65.0 58.0 58.0 88.0 87.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:76.50 stddev:15.04 (19.7%) stddev-sans-first:15.76 18:07:31 INFO - PROCESS | 1659 | Values: 83.0 70.0 84.0 70.0 59.0 59.0 103.0 91.0 60.0 84.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:91.50 stddev:18.58 (20.3%) stddev-sans-first:19.56 18:07:31 INFO - PROCESS | 1659 | Values: 93.0 90.0 95.0 91.0 106.0 72.0 137.0 124.0 92.0 95.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:96.00 stddev:17.80 (18.5%) stddev-sans-first:18.49 18:07:31 INFO - PROCESS | 1659 | Values: 96.0 98.0 95.0 96.0 103.0 152.0 115.0 96.0 97.0 115.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:92.00 stddev:9.13 (9.9%) stddev-sans-first:9.51 18:07:31 INFO - PROCESS | 1659 | Values: 92.0 96.0 114.0 114.0 92.0 93.0 91.0 91.0 94.0 92.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.50 stddev:2.06 (3.4%) stddev-sans-first:1.69 18:07:31 INFO - PROCESS | 1659 | Values: 56.0 58.0 57.0 62.0 60.0 61.0 60.0 61.0 62.0 60.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.50 stddev:3.00 (4.1%) stddev-sans-first:2.96 18:07:31 INFO - PROCESS | 1659 | Values: 69.0 73.0 71.0 78.0 76.0 73.0 72.0 70.0 69.0 70.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:86.00 stddev:10.61 (12.3%) stddev-sans-first:11.12 18:07:31 INFO - PROCESS | 1659 | Values: 86.0 85.0 84.0 86.0 86.0 88.0 107.0 114.0 86.0 85.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:164.30 Median:161.00 stddev:37.71 (23.4%) stddev-sans-first:38.68 18:07:31 INFO - PROCESS | 1659 | Values: 137.0 142.0 136.0 154.0 156.0 159.0 163.0 163.0 267.0 166.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.50 stddev:3.30 (1.9%) stddev-sans-first:3.35 18:07:31 INFO - PROCESS | 1659 | Values: 170.0 173.0 171.0 181.0 171.0 173.0 170.0 171.0 175.0 172.0 18:07:31 INFO - PROCESS | 1659 | 18:07:31 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.50 18:07:31 INFO - PROCESS | 1659 | Values: 69.0 66.0 66.0 66.0 70.0 66.0 69.0 67.0 67.0 66.0 18:07:31 INFO - PROCESS | 1659 | -------- Summary: end -------- 18:07:31 INFO - PROCESS | 1659 | 18:07:32 INFO - TEST-INFO | 1659: exit 0 18:07:32 INFO - TEST-OK | kraken | took 60697ms 18:07:32 INFO - SUITE-END | took 1175s 18:07:33 INFO - Completed test suite (00:19:36) 18:07:33 INFO - javascript benchmark 18:07:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7274.095036758754, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.0258824940765, 3368.7641865069454, 3415.316936612678, 3415.8121303328317, 3418.0942050356643, 5650.7174641267875, 5673.092305231164, 5687.061634830253, 5696.7721291148355, 5722.656640601567, 4622.653301002421, 5730.3123625164935, 5735.655860648364, 5743.597948143632, 5756.712164391784, 5185.170372740362, 5201.713905735183, 5210.452902445246, 5227.085260079471, 5277.788888444457, 5278.445763194867, 5300.708461034642, 5307.230451584518, 5313.920291195615, 5362.91955620666, 5124.2057481090305, 5142.665726727751, 5285.709285989269, 5300.893982120355, 5351.518363347298, 3920.588338224474, 5236.921446178291, 5240.580753539708, 5247.632665713401, 5337.839864804062, 5179.637425380225, 5229.660072095302, 5230.006298803215, 5257.815976440845, 5308.814191503279, 5373.9731301343245, 5442.863928401822, 5753.626014309057, 5789.8552536186935, 5829.0, 5844.503217226541, 5941.643501389931, 6135.263289243823, 6190.907136392958, 6259.217597800275, 6253.781117660906, 6288.276848162474, 6294.024426213944, 6316.368363163693, 6336.3346848580695, 4840.733759643218, 5833.82498525045, 5835.328937172195, 5847.649141051551, 5861.17943487912, 6176.8764624707255, 6219.378062193744, 6239.812805615838, 6241.500679945593, 6278.843028924313, 6129.632222066691, 6215.223097112861, 6236.656983865931, 6243.7814676486105, 6246.3441338659695, 6212.06818977148, 6297.685115744194, 6312.242530896322, 6318.178636777189, 6328.208973878265, 6004.7598096076545, 6074.787382441594, 6211.0, 6243.43809057187, 6333.0, 6288.151099601587, 6289.496840252768, 6291.874162516724, 6298.118263443122, 6310.0850376695125, 4977.850664480072, 4986.326845875833, 4987.60099192071, 4996.7001979881325, 5029.723365214948, 4337.652987760972, 4374.890627734332, 4462.48681401643, 4471.8434854779925, 4482.103579284156, 5198.636095473281, 5675.5459563234845, 5742.224799651994, 5743.597948143673, 5881.147233651097, 6269.68651567429, 6285.654289014056, 6307.432331090224, 6317.431431171217, 6324.114623952651, 5712.514436272963, 5777.0, 5808.680522571215, 5809.128630705343, 5809.24479817621, 5471.206675032098, 5486.506214440639, 5488.7530061147345, 5495.807646732425, 5519.227308176858, 6328.11406403104, 6360.077788720517, 6360.840978975562, 6376.617402955652, 6388.105665206967, 6129.695011270178, 6213.751449942132, 6231.22109736283, 6233.657148856856, 6291.653959032297, 6035.939640603538, 6254.718537665907, 6266.592671476339, 6269.0909818075215, 6323.9683801580695, 6191.349908259568, 6205.968970155121, 6213.596116252429, 6238.189035425366, 6276.027215781562, 5463.371712252982, 6014.879702406015, 6154.323024467394, 6195.721192546436, 6293.748250069946, 5975.55183361241, 5995.890760209375, 6132.324915438508, 6138.7869253627705, 6144.631322120687, 4998.925016124834, 5992.910106348496, 6079.483243924316, 6121.785737499166, 6133.478654314434, 5078.035173317058, 5325.973370133124, 5519.558435325244, 5938.970305148447, 5945.970270148621, 4992.675476094042, 4998.600111991104, 6090.634561926298, 6196.81409557714, 6209.627422354673, 5912.438318359749, 5977.731002104829, 6003.519718422428, 6015.368386319374, 6041.003234466264], "value": 5668.317263598835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.8635409377187, 455.44663234170474, 456.5571395746125, 460.723565860484, 471.99700636148185, 28283.0, 40014.399784003224, 40026.0, 40055.998600034975, 40203.39694904579, 39674.00814979627, 40204.79897600515, 40249.396259056135, 40278.798606007, 40401.59598404015, 8502.0, 8707.042225355206, 9204.677836275714, 9466.148046675798, 9474.526273686322, 11277.492512836941, 11593.942030289836, 11618.535258589647, 11677.883221167764, 11736.941315293412, 11433.485493152828, 11441.141914356456, 11492.195546311761, 11501.942490287536, 11529.135314851419, 11492.310461372344, 11524.827127593093, 11529.365884876328, 11533.365664888386, 11540.596079137275, 11306.717332066683, 11327.716807079807, 11382.94308528452, 11416.31502109876, 11421.0, 39704.20591588152, 40022.199556008716, 40068.59931400678, 40104.0, 40130.99672508211, 3898.0823227193832, 3919.627635374635, 4011.939820902689, 4019.919601607981, 4080.204360149772, 25610.84751186201, 29466.410671786445, 29721.851390742908, 29961.850190749126, 31465.21336966571, 3231.3052693670975, 3265.673432656739, 3276.8033917965, 3379.9831000845084, 3415.1803567143957, 475146.0, 475247.0, 475397.0, 477001.0, 479046.9999999965, 64980.0, 65141.0, 65161.0, 65192.67403662951, 65199.34800651933, 67848.0, 67938.0, 68142.65928670423, 68386.63226735537, 68758.0, 16658.16709164537, 17250.396236131674, 17281.39515116965, 17294.0, 17350.47948561545, 12574.30841303737, 12845.421956012002, 12883.420246088948, 13182.60452186436, 13324.0, 18402.0, 18595.90702046508, 18607.06964651762, 18630.347937822113, 19009.334673286645, 8004.199580041949, 8021.3181879539725, 8085.474444161111, 8090.878636820453, 8143.144969778206, 737.9003834482384, 846.2383854530848, 850.1328644782287, 868.2142660891903, 884.2307192742227, 30421.543676844864, 30434.0, 30436.934707285138, 30698.925537606523, 30721.69278307188, 1014.7310962594918, 1051.447989805343, 1066.1151244467073, 1093.9617113400993, 1201.954299759215, 12020.278783273032, 13270.606586308299, 14883.925580372246, 15610.45363412275, 16431.931924424873, 635561.0, 640491.0, 648661.0, 649621.7518912376, 654322.0, 60869.39130608726, 61389.38610613926, 61428.0, 61769.382306177264, 62346.688266558376, 1418.432626949208, 1435.5693292012354, 1439.8920080993967, 1450.0502171078172, 1453.0192120318743, 25065.0, 25442.0, 30040.248993774458, 30059.549106762977, 30934.381312374077, 42240.577594224895, 42441.151176976906, 42628.0, 42669.35995960125, 42755.57244427516, 550882.0, 550975.0, 552921.470785287, 553641.0, 554711.0, 22482.437939051655, 25260.87369563214, 26206.0, 26874.731252688005, 26973.0, 35586.11034724153, 42742.14515709731, 42992.785036074616, 43441.565584345015, 44305.55694443014, 34687.653123468444, 34940.82529587336, 35382.0, 35462.82268588641, 35565.110872228404, 35113.47329790004, 35273.0, 35887.64112358948, 36026.4596031065, 36136.63863361333, 34028.1492962668, 34191.14522136867, 34505.309893802485, 34834.9549513515, 35085.947421577395, 27072.458550829266, 30321.0, 31833.522497163023, 32009.0, 32188.517172241965, 19747.605047899247, 22854.20010299698, 23918.0, 24272.87863560671, 24374.903129359576], "value": 19930.748856409853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3778203745857, 384.49630983411714, 393.86017963622913, 396.3737295073783, 413.6959334888856, 11980.520779168823, 16023.439179628715, 19753.0, 21212.681809772865, 21262.57474850504, 20350.89824550879, 20617.38147855563, 20998.475038124016, 21153.15387384503, 21351.039203235854, 5751.942480575182, 5754.367019627837, 5970.373110823366, 6011.819645410645, 6050.183225264599, 4848.466668666444, 5842.6786526741225, 5896.027155519334, 5961.403859614025, 5966.79116230932, 5646.265985421889, 5869.354371019184, 5901.114832775075, 5909.113632955048, 5918.05311150216, 5637.577181711388, 5911.113333000063, 5912.054071348585, 5964.254468191476, 5970.373110823344, 4457.442819647544, 5148.819791307324, 5150.4334523202415, 5175.689458632494, 5179.326687530634, 24764.761761912014, 25020.74896255198, 25455.490890182093, 25477.49045019108, 25599.61600575993, 3042.893498727556, 3097.9070627880974, 3123.87504499822, 3158.147300228948, 3194.2014496375905, 14911.850881491155, 15396.692066158614, 15484.916055876092, 15617.765733514007, 15844.287007084593, 1634.961799257468, 1850.703887378013, 1853.8794978326366, 1871.3543827379533, 1896.0804010055112, 115545.0, 122969.0, 125251.0, 125743.99999999908, 126440.36779816043, 11507.0, 11746.647600571825, 11788.23376480526, 11918.344491052902, 12064.879351206375, 14489.420423183166, 14616.853831461549, 14630.0, 14664.706705866036, 14678.706425871424, 7147.82130446743, 8878.156575125482, 8928.508932008672, 8986.550672466481, 8988.0, 8708.608112634947, 8751.949766028118, 8778.429402088845, 8868.290536757044, 8880.777980550409, 5943.702814859326, 7222.422206223489, 7287.963560182271, 7332.340089391981, 7373.631318434057, 1932.6811076172555, 1955.0127185771094, 1966.223341779989, 1972.112549352797, 1974.220183027696, 995.9004099590128, 1054.1566746602687, 1071.83580387685, 1078.7141407527013, 1080.8162612355918, 20290.0, 21837.45406364822, 22073.99811843879, 22093.005814738375, 22311.44221394478, 1078.9568417263222, 1101.3777215873006, 1102.4322473925934, 1125.5272785430138, 1138.3966497756203, 11101.722456938642, 11449.828252576219, 11784.991378664205, 11879.58421455245, 11935.522579096913, 764432.0, 766626.0, 804103.0, 810558.0, 821430.0, 101817.0, 118142.81857181319, 129555.0, 155540.0, 158145.41854581537, 1071.325065208929, 1106.3472551194834, 1129.5820546397722, 1147.0307590086531, 1153.5212886652114, 19279.80720192836, 19605.8039419604, 19782.802171978095, 19801.702974455682, 19868.801311987274, 57964.0, 58747.825043499746, 59497.702511487165, 61376.69311653413, 61496.0, 73486.16284592928, 86174.56912715397, 86663.56668216619, 88609.11390886009, 90738.0, 7851.568163751049, 8091.514509129235, 8116.594170291343, 8270.2556769891, 8343.54110523927, 10132.746681333025, 12328.753424931272, 12385.380730963596, 12461.0, 12857.0, 10808.243422960317, 11009.2843965142, 11047.354373057033, 11059.50232239535, 11063.280886742335, 9300.93039300462, 9491.050894910453, 10491.475426228506, 10650.307729997525, 10965.56137754481, 10693.251472396858, 10828.837567436653, 11146.386948717574, 11195.216334856808, 11255.268407553483, 7462.701491940262, 7947.284744373034, 8146.674133034612, 8374.455660382057, 8430.903982482238, 10736.89263107359, 10791.460426978463, 10969.122470202525, 10996.780064398827, 11071.667849964513], "value": 10129.511372378654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.3635037007052, 1443.5380678182978, 1448.9058211216263, 1455.4251070827024, 1471.8454562270965, 7508.9624551877305, 7698.7690369288875, 8083.232092951168, 8560.828783424327, 8570.10013948535, 8005.479643823148, 8234.300084492825, 8256.95871520643, 8386.20331068549, 8429.91570084299, 2285.0631241191113, 2306.7577904320055, 2307.8114770893003, 2308.7922087012166, 2330.685357476736, 2070.2960993262286, 2143.721316228888, 2318.038014224095, 2350.0482304666552, 2366.183666635008, 2211.834112441565, 2276.3284830974903, 2286.0398632574274, 2292.518571100071, 2294.300238427279, 2296.1504243429954, 2300.919467818627, 2306.5156317173414, 2315.154968436517, 2320.825938054653, 2264.9320520384413, 2296.127471560796, 2335.556244313575, 2343.4610039690965, 2354.093673935547, 8407.663693452254, 8422.747317580483, 8435.83128337436, 8439.0, 8460.365472589581, 4187.309093999486, 5194.402643695986, 5202.323697919246, 5215.452377500384, 5222.00781851447, 2929.2091135393325, 3312.983667096859, 3363.848626811775, 3389.5254664347012, 3467.791932484059, 1132.5526417065296, 1162.4943149729895, 1203.4404002139047, 1211.0553768060927, 1226.2764968668528, 8897.288216942628, 9252.907470925273, 10354.275200735952, 10740.0, 10834.837477437844, 4338.934915976263, 4604.930926036112, 4669.509701481364, 4734.573888350065, 4752.358431611758, 9402.529873506433, 9490.145886870216, 9495.14543691071, 9515.429074255568, 9550.952245238868, 4523.660725445605, 4956.587372598792, 5177.068127737043, 5181.4300426953005, 5221.921671174935, 4409.713368631029, 4681.133990211822, 4703.600193983481, 4726.3146843708155, 4803.735794531264, 3778.112143646241, 3794.6395092466173, 3840.327942610088, 3867.361885288896, 3910.061585219584, 1089.9945500272447, 1146.9426528673532, 1186.9821952670716, 1274.6813296675832, 1279.7504486625205, 663.8240866170469, 666.9362367024588, 786.3159051625008, 823.6129019360891, 852.8635418333037, 5447.319085114361, 5493.697846618475, 5538.833834984957, 5631.986242476311, 5733.140028995601, 954.1365064616533, 984.670135504614, 1010.5907107621425, 1020.6733845169623, 1035.3839465518004, 3518.894433167009, 3706.6108058653454, 3708.9072773180346, 3838.0, 3960.5643379228263, 9731.659391921248, 10067.446290454096, 10102.949485252526, 10112.544935477921, 10112.848307275397, 9434.339596228197, 9898.356606820678, 9912.157466615274, 10073.445960472245, 10122.987701229818, 7708.884366734504, 7876.881846772303, 7884.093329267093, 7897.368210543258, 7917.881231781528, 5701.030824759718, 5723.313202415737, 5729.455701708331, 5756.0, 5951.375105613848, 7043.612601306772, 9203.125703058198, 9327.347085703936, 9357.438553686801, 9375.296852735935, 8916.375853690179, 9265.53672316368, 9293.117153870371, 9391.859122113037, 9400.0, 7085.6811443486195, 7209.387202087882, 7212.4230061596, 7223.241559636373, 7224.060872086595, 7746.806329841799, 7748.302652761278, 7760.961195193988, 7793.922060779547, 7828.373730101692, 6403.358746653127, 7032.734636467358, 7088.04311417952, 7111.217766045627, 7204.963975180301, 6890.483213758888, 6984.895226571707, 7042.154941407064, 7083.256258093033, 7118.394936430462, 6326.683665816783, 6335.144755458138, 6398.232212134573, 6398.424141827258, 6428.646424446701, 4843.370361853077, 4898.2652602109965, 4951.0, 4988.80044798204, 5108.719020453911, 4925.876853078558, 4954.157793175097, 4958.181899986462, 4967.677100988424, 5025.773840177274], "value": 4373.804269253384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.3870143353432, 359.1828589957847, 369.62298455575325, 371.2611902314395, 373.5051057349012, 4185.8744237672845, 4553.418558100762, 5285.471452854713, 5351.849352389236, 5436.836894893149, 4875.536824001723, 5277.226782850261, 5336.733163341827, 5417.783288668448, 5417.891642167164, 3770.4155855842387, 4014.799260037001, 4253.808578613962, 4254.766117825842, 4278.122984788127, 3532.24056827782, 3658.8170591470453, 4082.5100987881347, 4270.508891477489, 4288.571142885702, 4169.14532520834, 4179.916401671965, 4195.28680124378, 4197.958020419787, 4217.725847819897, 4214.536400995888, 4229.513605935326, 4239.385289133058, 4249.936250956238, 4271.081717430736, 3319.96680033199, 3765.6987441004653, 3780.584135745066, 3781.2248489059675, 3784.678302344304, 5081.644284900059, 5236.743181636418, 5272.92090618641, 5292.682439053669, 5311.787528498855, 4443.622292105175, 4824.0, 4837.443693975203, 4889.975550122226, 4898.265260210961, 5525.972370138164, 5721.970045391828, 5757.884842303172, 5767.856518197593, 5772.220750198711, 3348.5144654025275, 3618.294432585647, 3967.6429121378924, 4130.318497447947, 4140.171965606861, 5298.417174110845, 6070.716808103592, 6072.635641861459, 6096.908546371808, 6107.908381374283, 3386.508956201337, 4196.328587425997, 4206.284931561642, 4224.73258022592, 4231.682623803165, 3588.4079126944284, 3653.6529029742665, 4093.9151124951914, 4197.5172855122055, 4218.7679677618025, 4291.935620965688, 4472.686911916135, 4757.976210118927, 4845.200541910545, 4911.140550403665, 4935.777889994959, 5789.739461724233, 5802.680852553066, 5814.796482123105, 5830.912536311958, 1184.9348285844362, 1262.0156278103095, 1368.8288963879515, 1373.3751143229806, 1387.7710177820547, 811.926926576611, 838.4550042472441, 930.8091841172543, 980.3921568627354, 992.5682328187262, 4634.837780677727, 4666.9863917031325, 5034.924476132861, 5121.487851214849, 5129.717865517432, 5030.320906677552, 5043.049201941744, 5091.854332775096, 5504.862378440571, 5529.834104976857, 3994.560598334181, 4238.87283381499, 4431.379606855043, 5209.869753256199, 5245.606579506552, 2456.9017239310583, 2518.5214809186195, 2705.376773935662, 2967.629046369204, 2985.7611391088662, 4808.663393562417, 5121.795128194905, 5144.0, 5484.808031718951, 5956.702164891738, 5067.670601410897, 5392.811251606175, 5592.762894842096, 5630.943690563124, 5864.296284445809, 5001.424836143818, 5299.549538289289, 5919.319278283053, 5979.521638269015, 6001.489873360813, 5734.684592347461, 5749.3326935188325, 5750.447379207674, 5796.304443466811, 5811.94188058114, 5297.682139071668, 5525.066226820581, 5624.946894383603, 5639.661620302795, 5678.3248941561515, 5263.710495922761, 5820.275023984738, 5875.354900627831, 5877.472686744741, 5884.705764711662, 3487.3199726053176, 3708.851645934132, 3743.9891229368463, 3794.4118661607495, 3829.9425508616837, 5197.792088316425, 5363.222332761649, 5413.458654134555, 5871.7651293947765, 5895.587308888336, 4845.248986407112, 5112.846614601568, 5568.6658800472105, 5722.7710891563875, 5725.65646061221, 4868.9756551217015, 5231.241469986907, 5263.815766448156, 5716.199732037601, 5723.0, 4702.647301452474, 5389.326334208224, 5441.993231252231, 5453.590980676386, 5668.716564171693, 4925.9014819704125, 5326.9200961984825, 5744.454276843693, 5771.307443106854, 5791.015527360275, 5124.385073791169, 5408.269883565826, 5611.8776244752025, 5651.378348381757, 5714.771409143587], "value": 4137.430026417885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4586945117536, 700.0968750312095, 771.6643260181821, 793.6745934166993, 840.4285086141422, 14863.108213507197, 15624.76562851558, 15710.214489275519, 15724.449644262453, 15731.60670983226, 14440.494582689582, 14577.635559111028, 14588.343524541395, 14596.562103136923, 14599.489017884376, 655.4461480049374, 670.430134385773, 839.7858546070773, 846.6697987784753, 854.4232642966005, 853.9701110461135, 863.313665635821, 866.5493943149559, 867.2108381372952, 867.652938824469, 923.8383282925495, 923.9260859131253, 924.2236521322088, 924.4360939826701, 927.7309580221728, 917.0737555069361, 918.4581097152678, 919.4804935211585, 920.8342498350295, 921.5530467723149, 679.6262055869302, 680.680080362229, 686.5091459606356, 686.5297271369128, 687.0038444255849, 14704.191269480174, 15015.399384024626, 15103.697926041528, 15124.168170750605, 15142.545723628198, 14299.356528956221, 14561.635959101108, 14741.926290368587, 14751.041182323115, 14860.0, 11192.992630663279, 11243.943780281128, 11261.0, 11360.318380897173, 11491.221085320696, 3690.837386223331, 3744.54683654622, 3754.1177823211524, 3778.079988882163, 3905.7656540607654, 102940.48529757303, 103173.48413257886, 103273.48363258211, 104001.0, 104455.0, 9309.394889332172, 10952.945235273774, 10985.121190304757, 11082.667519974413, 11167.0, 22366.66450003251, 22544.323670289916, 22608.9825957829, 22903.0, 23113.76886231116, 7667.0, 7709.344705699966, 7739.496932699357, 7819.100803407681, 7963.442559020813, 4041.2119636671155, 4171.374293855946, 4235.322348424237, 4238.512571054368, 4302.268614335508, 3415.9316813663586, 3481.9825900870333, 3488.3720930232294, 3509.8771542996383, 3519.964800352015, 618.8762247550508, 619.102301662591, 620.4230066038627, 628.745358129958, 629.0375725140542, 604.4106995679177, 609.5215256024, 640.9775657852047, 643.6845945486677, 651.2835880531378, 7869.567173805382, 9356.578953947088, 9708.368956017835, 9911.702648920544, 10256.846147307797, 609.2901769438643, 628.5914155798675, 634.946029587481, 639.9616023038633, 648.8280605639509, 4617.676762626651, 4763.356946812136, 4788.377510923628, 4811.446683631427, 4827.42070951488, 91662.54168729113, 95816.52091739497, 97730.02269977352, 98443.50778246207, 99532.0, 63498.0, 84795.57602212073, 85743.14256857477, 86107.56946215229, 86721.0, 58285.0, 58517.41482585205, 76231.85652215221, 76953.84569231466, 78264.0, 9172.357934944757, 9220.723378298662, 9248.722538323862, 9278.0, 9296.767580810263, 49589.0, 49687.503124969735, 49873.501264988336, 50211.0, 51967.2204916919, 55780.0, 64461.0, 64554.67722661357, 65800.36798528006, 66187.66906165631, 10682.946585267335, 10716.0, 10923.729952179103, 11086.22396432242, 11335.603253886075, 12016.63950081499, 12042.819357709817, 12069.0, 12193.146479746332, 12568.270835293186, 11238.66284011481, 11380.829287560859, 11694.29834209916, 11705.473253703774, 12116.0, 10982.725431864268, 11300.830487542858, 11596.420178991186, 11671.12466565028, 11691.590794322157, 10955.45222738844, 11285.21003529745, 11316.377599231791, 11692.415379231175, 11848.644540663794, 9408.529573521433, 9546.42721436716, 9568.359986677448, 9766.218702503924, 9907.256955728206, 7392.4086073115095, 9066.456012639263, 9459.810803784023, 9645.251103435487, 9744.025597440199], "value": 7152.692137923293, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 118.0, 119.0, 122.0, 177.0, 163.0, 180.0, 140.0, 148.0, 174.0], "value": 147.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 137.0, 108.0, 142.0, 108.0, 152.0, 102.0, 117.0, 163.0, 142.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 254.0, 198.0, 197.0, 195.0, 198.0, 192.0, 193.0, 196.0, 196.0], "value": 201.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 61.0, 97.0, 80.0, 65.0, 58.0, 58.0, 88.0, 87.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 84.0, 70.0, 59.0, 59.0, 103.0, 91.0, 60.0, 84.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 95.0, 91.0, 106.0, 72.0, 137.0, 124.0, 92.0, 95.0], "value": 99.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 96.0, 103.0, 152.0, 115.0, 96.0, 97.0, 115.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 114.0, 114.0, 92.0, 93.0, 91.0, 91.0, 94.0, 92.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 62.0, 60.0, 61.0, 60.0, 61.0, 62.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 71.0, 78.0, 76.0, 73.0, 72.0, 70.0, 69.0, 70.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 86.0, 86.0, 88.0, 107.0, 114.0, 86.0, 85.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 136.0, 154.0, 156.0, 159.0, 163.0, 163.0, 267.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 171.0, 181.0, 171.0, 173.0, 170.0, 171.0, 175.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 66.0, 70.0, 66.0, 69.0, 67.0, 67.0, 66.0], "value": 67.2, "unit": "score"}]}]} 18:07:33 INFO - Return code: 0 18:07:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:07:33 ERROR - # TBPL SUCCESS # 18:07:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:07:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:07:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:07:33 INFO - 2017-02-06 18:07:33.248 screenresolution[1664:11012] starting screenresolution argv=screenresolution get 18:07:33 INFO - 2017-02-06 18:07:33.251 screenresolution[1664:11012] Display 0: 1600x1200x32@60 18:07:33 INFO - 2017-02-06 18:07:33.257 screenresolution[1665:11015] starting screenresolution argv=screenresolution list 18:07:33 INFO - Available Modes on Display 0 18:07:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:07:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:07:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:07:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:07:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:07:33 INFO - Intel Iris: 18:07:33 INFO - Chipset Model: Intel Iris 18:07:33 INFO - Type: GPU 18:07:33 INFO - Bus: Built-In 18:07:33 INFO - VRAM (Dynamic, Max): 1536 MB 18:07:33 INFO - Vendor: Intel (0x8086) 18:07:33 INFO - Device ID: 0x0a2e 18:07:33 INFO - Revision ID: 0x0009 18:07:33 INFO - Displays: 18:07:33 INFO - Display: 18:07:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:07:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:07:33 INFO - Display Serial Number: 1600x1200 60 18:07:33 INFO - Main Display: Yes 18:07:33 INFO - Mirror: Off 18:07:33 INFO - Online: Yes 18:07:33 INFO - Rotation: Supported 18:07:33 INFO - Return code: 0 18:07:33 INFO - Running post-action listener: _resource_record_post_action 18:07:33 INFO - [mozharness: 2017-02-07 02:07:33.492157Z] Finished run-tests step (success) 18:07:33 INFO - Running post-run listener: _resource_record_post_run 18:07:33 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 33452544; Write bytes: 511715840; Read time: 197; Write time: 1584 18:07:33 INFO - TinderboxPrint: CPU usage
54.2% 18:07:33 INFO - TinderboxPrint: I/O read bytes / time
33,452,544 / 197 18:07:33 INFO - TinderboxPrint: I/O write bytes / time
511,715,840 / 1,584 18:07:33 INFO - TinderboxPrint: CPU idle
2,193.1 (45.8%) 18:07:33 INFO - TinderboxPrint: CPU system
962.0 (20.1%) 18:07:33 INFO - TinderboxPrint: CPU user
1,634.6 (34.1%) 18:07:33 INFO - TinderboxPrint: Swap in / out
237,268,992 / 0 18:07:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203289088; Write bytes: 201242112; Read time: 15606; Write time: 422 18:07:33 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31429120; Write bytes: 299602944; Read time: 180; Write time: 1126 18:07:33 INFO - Running post-run listener: _upload_blobber_files 18:07:33 INFO - Blob upload gear active. 18:07:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:33 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 18:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:07:34 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:35 INFO - (blobuploader) - INFO - Done attempting. 18:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:36 INFO - (blobuploader) - INFO - Done attempting. 18:07:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:07:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:36 INFO - (blobuploader) - INFO - Done attempting. 18:07:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:07:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:39 INFO - (blobuploader) - INFO - Done attempting. 18:07:39 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:39 INFO - Return code: 0 18:07:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31dc65ef449dc6dac3d9a06d9b1bc99fcb742622e0087853b9d0f71564d2da22c5bab1989cad83d0a5591f8fba6d2998d06170ef4094ff334f3c8086348d2d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685fe86c943b12701fe15ed344b7ba877c2320d678b381e7741b1c9db657d1408b3a7b5e80cb23f47b31caabe564a240f5e2f01bd082ff945e73554cd145fb3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75636d484300a4b0187cecbcd9c9763de32a3f3f9836f9d02d3d63ecdbb4aa56bedbf32a5d854c98426dbe2dd5cbf6d2fc4837aee34a66da7197e514781d5b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/524bccc64acaee00ab5f4d3eb547f1d2681097911cf5df3930d03d42a83153a123cb7e87ec942dc8d96d5fbc9846d2bdf2d8b58c6bc118939ec0ee63c89891b5"} 18:07:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:39 INFO - Contents: 18:07:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31dc65ef449dc6dac3d9a06d9b1bc99fcb742622e0087853b9d0f71564d2da22c5bab1989cad83d0a5591f8fba6d2998d06170ef4094ff334f3c8086348d2d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685fe86c943b12701fe15ed344b7ba877c2320d678b381e7741b1c9db657d1408b3a7b5e80cb23f47b31caabe564a240f5e2f01bd082ff945e73554cd145fb3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75636d484300a4b0187cecbcd9c9763de32a3f3f9836f9d02d3d63ecdbb4aa56bedbf32a5d854c98426dbe2dd5cbf6d2fc4837aee34a66da7197e514781d5b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/524bccc64acaee00ab5f4d3eb547f1d2681097911cf5df3930d03d42a83153a123cb7e87ec942dc8d96d5fbc9846d2bdf2d8b58c6bc118939ec0ee63c89891b5"} 18:07:39 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:39 INFO - Copying logs to upload dir... 18:07:39 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.087305 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-06 18:07:39.134928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 18:07:39.138673) ========= 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.vl49NBwlhx/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.T6aAwuAZNg/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31dc65ef449dc6dac3d9a06d9b1bc99fcb742622e0087853b9d0f71564d2da22c5bab1989cad83d0a5591f8fba6d2998d06170ef4094ff334f3c8086348d2d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685fe86c943b12701fe15ed344b7ba877c2320d678b381e7741b1c9db657d1408b3a7b5e80cb23f47b31caabe564a240f5e2f01bd082ff945e73554cd145fb3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75636d484300a4b0187cecbcd9c9763de32a3f3f9836f9d02d3d63ecdbb4aa56bedbf32a5d854c98426dbe2dd5cbf6d2fc4837aee34a66da7197e514781d5b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/524bccc64acaee00ab5f4d3eb547f1d2681097911cf5df3930d03d42a83153a123cb7e87ec942dc8d96d5fbc9846d2bdf2d8b58c6bc118939ec0ee63c89891b5"} build_url:https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/ATUCYR_oR7qiLI5W3qwGag/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31dc65ef449dc6dac3d9a06d9b1bc99fcb742622e0087853b9d0f71564d2da22c5bab1989cad83d0a5591f8fba6d2998d06170ef4094ff334f3c8086348d2d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/685fe86c943b12701fe15ed344b7ba877c2320d678b381e7741b1c9db657d1408b3a7b5e80cb23f47b31caabe564a240f5e2f01bd082ff945e73554cd145fb3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75636d484300a4b0187cecbcd9c9763de32a3f3f9836f9d02d3d63ecdbb4aa56bedbf32a5d854c98426dbe2dd5cbf6d2fc4837aee34a66da7197e514781d5b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/524bccc64acaee00ab5f4d3eb547f1d2681097911cf5df3930d03d42a83153a123cb7e87ec942dc8d96d5fbc9846d2bdf2d8b58c6bc118939ec0ee63c89891b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 18:07:39.172865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:07:39.173197) ========= 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.vl49NBwlhx/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.T6aAwuAZNg/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.005133 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:07:39.222192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 18:07:39.222550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 18:07:39.222867) ========= ========= Total master_lag: 0.18 =========