builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1486438479.15 results: success (0) buildid: 20170206175856 builduid: a79239180cfa49528d8bc2b6b5e127e2 revision: fcc32735c01d504767a0dee94c6bc706b6a23b5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.153060) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.153510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.153787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.179760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.180053) ========= 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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:34:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.5M=0.001s 2017-02-06 19:34:39 (20.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124830 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.328638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.328950) ========= 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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.027508 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:39.377993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-06 19:34:39.378401) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fcc32735c01d504767a0dee94c6bc706b6a23b5e --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 fcc32735c01d504767a0dee94c6bc706b6a23b5e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cY1uCbjsET/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.NXpDX0Z2lq/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:34:39,476 truncating revision to first 12 chars 2017-02-06 19:34:39,477 Setting DEBUG logging. 2017-02-06 19:34:39,477 attempt 1/10 2017-02-06 19:34:39,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fcc32735c01d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 19:34:41,376 unpacking tar archive at: mozilla-aurora-fcc32735c01d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.183094 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-06 19:34:41.587515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:41.587837) ========= script_repo_revision: fcc32735c01d504767a0dee94c6bc706b6a23b5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:41.588217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:41.588564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 19:34:41.608063) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-06 19:34:41.608391) ========= /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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:34:41 INFO - MultiFileLogger online at 20170206 19:34:41 in /builds/slave/test 19:34:41 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 19:34:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:34:41 INFO - {'append_to_log': False, 19:34:41 INFO - 'base_work_dir': '/builds/slave/test', 19:34:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:34:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:34:41 INFO - 'branch': 'Mozilla-Aurora', 19:34:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:34:41 INFO - 'config_files': ('talos/mac_config.py',), 19:34:41 INFO - 'default_actions': ('clobber', 19:34:41 INFO - 'read-buildbot-config', 19:34:41 INFO - 'download-and-extract', 19:34:41 INFO - 'populate-webroot', 19:34:41 INFO - 'create-virtualenv', 19:34:41 INFO - 'install', 19:34:41 INFO - 'run-tests'), 19:34:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:34:41 INFO - 'download_minidump_stackwalk': True, 19:34:41 INFO - 'download_symbols': 'ondemand', 19:34:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:34:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:34:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:34:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:34:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:34:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:34:41 INFO - 'installer_path': 'installer.exe', 19:34:41 INFO - 'log_level': 'info', 19:34:41 INFO - 'log_name': 'talos', 19:34:41 INFO - 'log_to_console': True, 19:34:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:34:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:34:41 INFO - 'opt_config_files': (), 19:34:41 INFO - 'pip_index': False, 19:34:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:41 INFO - 'cmd': ('bash', 19:34:41 INFO - '-c', 19:34:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:41 INFO - 'enabled': True, 19:34:41 INFO - 'halt_on_failure': False, 19:34:41 INFO - 'name': 'check_screen_resolution'},), 19:34:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:41 INFO - 'cmd': ('bash', 19:34:41 INFO - '-c', 19:34:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:41 INFO - 'enabled': True, 19:34:41 INFO - 'halt_on_failure': False, 19:34:41 INFO - 'name': 'check_screen_resolution'},), 19:34:41 INFO - 'run_cmd_checks_enabled': True, 19:34:41 INFO - 'sps_profile': False, 19:34:41 INFO - 'sps_profile_interval': 0, 19:34:41 INFO - 'suite': 'dromaeojs-e10s', 19:34:41 INFO - 'system_bits': '32', 19:34:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:34:41 INFO - 'title': 't-yosemite-r7-0014', 19:34:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:34:41 INFO - 'use_talos_json': True, 19:34:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:34:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:34:41 INFO - 'work_dir': 'build'} 19:34:41 INFO - [mozharness: 2017-02-07 03:34:41.819026Z] Running clobber step. 19:34:41 INFO - Running pre-action listener: _resource_record_pre_action 19:34:41 INFO - Running main action method: clobber 19:34:41 INFO - rmtree: /builds/slave/test/build 19:34:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:34:44 INFO - Running post-action listener: _resource_record_post_action 19:34:44 INFO - [mozharness: 2017-02-07 03:34:44.359836Z] Finished clobber step (success) 19:34:44 INFO - [mozharness: 2017-02-07 03:34:44.359999Z] Running read-buildbot-config step. 19:34:44 INFO - Running pre-action listener: _resource_record_pre_action 19:34:44 INFO - Running main action method: read_buildbot_config 19:34:44 INFO - Using buildbot properties: 19:34:44 INFO - { 19:34:44 INFO - "project": "", 19:34:44 INFO - "product": "firefox", 19:34:44 INFO - "script_repo_revision": "production", 19:34:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:34:44 INFO - "repository": "", 19:34:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:34:44 INFO - "buildid": "20170206175856", 19:34:44 INFO - "pgo_build": "False", 19:34:44 INFO - "basedir": "/builds/slave/test", 19:34:44 INFO - "buildnumber": 48, 19:34:44 INFO - "slavename": "t-yosemite-r7-0014", 19:34:44 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:34:44 INFO - "platform": "yosemite_r7", 19:34:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:34:44 INFO - "branch": "mozilla-aurora", 19:34:44 INFO - "repo_path": "releases/mozilla-aurora", 19:34:44 INFO - "revision": "fcc32735c01d504767a0dee94c6bc706b6a23b5e", 19:34:44 INFO - "stage_platform": "macosx64", 19:34:44 INFO - "builduid": "a79239180cfa49528d8bc2b6b5e127e2", 19:34:44 INFO - "slavebuilddir": "test" 19:34:44 INFO - } 19:34:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 19:34:44 INFO - Running post-action listener: _resource_record_post_action 19:34:44 INFO - [mozharness: 2017-02-07 03:34:44.363288Z] Finished read-buildbot-config step (success) 19:34:44 INFO - [mozharness: 2017-02-07 03:34:44.363418Z] Running download-and-extract step. 19:34:44 INFO - Running pre-action listener: _resource_record_pre_action 19:34:44 INFO - Running main action method: download_and_extract 19:34:44 INFO - mkdir: /builds/slave/test/build/tests 19:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:44 INFO - trying https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 19:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/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 19:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/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 19:34:45 INFO - Downloaded 1199 bytes. 19:34:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 19:34:45 INFO - Using the following test package requirements: 19:34:45 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 19:34:45 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 19:34:45 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 19:34:45 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'jsshell-mac.zip'], 19:34:45 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 19:34:45 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 19:34:45 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 19:34:45 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 19:34:45 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 19:34:45 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:34:45 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 19:34:45 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:34:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 19:34:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:34:45 INFO - Fetch https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 19:34:46 INFO - Expected file size: 16356042 19:34:46 INFO - Obtained file size: 16356042 19:34:53 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 19:34:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 19:34:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:34:53 INFO - Fetch https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 19:34:53 INFO - Expected file size: 16356042 19:34:53 INFO - Obtained file size: 16356042 19:35:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 19:35:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:35:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 19:35:01 INFO - Expected file size: 14403485 19:35:01 INFO - Obtained file size: 14403485 19:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:01 INFO - trying https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:35:01 INFO - Downloading https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 19:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/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 19:35:03 INFO - Downloaded 73810492 bytes. 19:35:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:35:03 INFO - mkdir: /builds/slave/test/properties 19:35:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:35:03 INFO - Writing to file /builds/slave/test/properties/build_url 19:35:03 INFO - Contents: 19:35:03 INFO - build_url:https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:35:04 INFO - Running post-action listener: _resource_record_post_action 19:35:04 INFO - Running post-action listener: set_extra_try_arguments 19:35:04 INFO - [mozharness: 2017-02-07 03:35:04.261954Z] Finished download-and-extract step (success) 19:35:04 INFO - [mozharness: 2017-02-07 03:35:04.262107Z] Running populate-webroot step. 19:35:04 INFO - Running pre-action listener: _resource_record_pre_action 19:35:04 INFO - Running main action method: populate_webroot 19:35:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:35:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:35:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:35:04 INFO - '--tppagecycles', 19:35:04 INFO - '7'], 19:35:04 INFO - 'tests': ['tsvgm']}}, 19:35:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:35:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:35:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:35:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:35:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['damp', 'tps']}, 19:35:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'tests': ['damp', 'tps']}, 19:35:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['dromaeo_dom']}, 19:35:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:35:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['basic_compositor_video']}, 19:35:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:35:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['a11yr', 19:35:04 INFO - 'ts_paint', 19:35:04 INFO - 'tpaint', 19:35:04 INFO - 'sessionrestore', 19:35:04 INFO - 'sessionrestore_no_auto_restore', 19:35:04 INFO - 'tabpaint']}, 19:35:04 INFO - 'other-e10s': {'tests': ['a11yr', 19:35:04 INFO - 'ts_paint', 19:35:04 INFO - 'tpaint', 19:35:04 INFO - 'sessionrestore', 19:35:04 INFO - 'sessionrestore_no_auto_restore', 19:35:04 INFO - 'tabpaint']}, 19:35:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:35:04 INFO - 'ts_paint', 19:35:04 INFO - 'tpaint', 19:35:04 INFO - 'sessionrestore', 19:35:04 INFO - 'sessionrestore_no_auto_restore', 19:35:04 INFO - 'tabpaint']}, 19:35:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:35:04 INFO - 'ts_paint', 19:35:04 INFO - 'tpaint', 19:35:04 INFO - 'sessionrestore', 19:35:04 INFO - 'sessionrestore_no_auto_restore', 19:35:04 INFO - 'tabpaint']}, 19:35:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['a11yr', 19:35:04 INFO - 'ts_paint', 19:35:04 INFO - 'tpaint', 19:35:04 INFO - 'sessionrestore', 19:35:04 INFO - 'sessionrestore_no_auto_restore', 19:35:04 INFO - 'tabpaint']}, 19:35:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['a11yr', 19:35:04 INFO - 'ts_paint', 19:35:04 INFO - 'tpaint', 19:35:04 INFO - 'sessionrestore', 19:35:04 INFO - 'sessionrestore_no_auto_restore', 19:35:04 INFO - 'tabpaint']}, 19:35:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['tsvgx', 19:35:04 INFO - 'tsvgr_opacity', 19:35:04 INFO - 'tart', 19:35:04 INFO - 'tscrollx', 19:35:04 INFO - 'cart', 19:35:04 INFO - 'tsvg_static']}, 19:35:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:35:04 INFO - 'tsvgr_opacity', 19:35:04 INFO - 'tart', 19:35:04 INFO - 'tscrollx', 19:35:04 INFO - 'cart', 19:35:04 INFO - 'tsvg_static']}, 19:35:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'talos_options': ['--disable-e10s'], 19:35:04 INFO - 'tests': ['tp5o']}, 19:35:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:35:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'talos_options': ['--disable-e10s', 19:35:04 INFO - '--xperf_path', 19:35:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:04 INFO - 'tests': ['tp5n']}, 19:35:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:35:04 INFO - 'talos_options': ['--xperf_path', 19:35:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:04 INFO - 'tests': ['tp5n']}}, 19:35:04 INFO - 'talos.zip': {'path': '', 19:35:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:35:04 INFO - Running post-action listener: _resource_record_post_action 19:35:04 INFO - [mozharness: 2017-02-07 03:35:04.281374Z] Finished populate-webroot step (success) 19:35:04 INFO - [mozharness: 2017-02-07 03:35:04.281483Z] Running create-virtualenv step. 19:35:04 INFO - Running pre-action listener: _resource_record_pre_action 19:35:04 INFO - Running main action method: create_virtualenv 19:35:04 INFO - Creating virtualenv /builds/slave/test/build/venv 19:35:04 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 19:35:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:35:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:35:04 INFO - Using real prefix '/tools/python27' 19:35:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:35:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:35:07 INFO - Installing pip.................done. 19:35:07 INFO - Return code: 0 19:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:35:08 INFO - Reading from file tmpfile_stdout 19:35:08 INFO - Output received: 19:35:08 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) 19:35:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:35:08 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')]} 19:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:08 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')]} 19:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:08 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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35:08 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 19:35:08 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 19:35:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:08 INFO - 'HOME': '/Users/cltbld', 19:35:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:08 INFO - 'LOGNAME': 'cltbld', 19:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:08 INFO - 'MOZ_NO_REMOTE': '1', 19:35:08 INFO - 'NO_EM_RESTART': '1', 19:35:08 INFO - 'PAGER': '/bin/cat', 19:35:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:08 INFO - 'PWD': '/builds/slave/test', 19:35:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:08 INFO - 'SHELL': '/bin/bash', 19:35:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:08 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:08 INFO - 'USER': 'cltbld', 19:35:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:08 INFO - 'XPC_FLAGS': '0x0', 19:35:08 INFO - 'XPC_SERVICE_NAME': '0', 19:35:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:08 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 19:35:08 INFO - Cleaning up... 19:35:08 INFO - Return code: 0 19:35:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:35:08 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')]} 19:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:08 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')]} 19:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:08 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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35:08 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 19:35:08 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 19:35:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:08 INFO - 'HOME': '/Users/cltbld', 19:35:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:08 INFO - 'LOGNAME': 'cltbld', 19:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:08 INFO - 'MOZ_NO_REMOTE': '1', 19:35:08 INFO - 'NO_EM_RESTART': '1', 19:35:08 INFO - 'PAGER': '/bin/cat', 19:35:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:08 INFO - 'PWD': '/builds/slave/test', 19:35:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:08 INFO - 'SHELL': '/bin/bash', 19:35:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:08 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:08 INFO - 'USER': 'cltbld', 19:35:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:08 INFO - 'XPC_FLAGS': '0x0', 19:35:08 INFO - 'XPC_SERVICE_NAME': '0', 19:35:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:08 INFO - Downloading/unpacking psutil>=3.1.1 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:35:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:35:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:35:12 INFO - Installing collected packages: psutil 19:35:12 INFO - Running setup.py install for psutil 19:35:12 INFO - building 'psutil._psutil_osx' extension 19:35: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 19:35: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 19:35: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 19:35:13 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 19:35:13 INFO - building 'psutil._psutil_posix' extension 19:35:13 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 19:35:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:35:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:35:13 INFO - ^ 19:35:13 INFO - 1 warning generated. 19:35:13 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 19:35:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:35:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:35:13 INFO - Successfully installed psutil 19:35:13 INFO - Cleaning up... 19:35:13 INFO - Return code: 0 19:35:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35: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 19:35: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 19:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:13 INFO - 'HOME': '/Users/cltbld', 19:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:13 INFO - 'LOGNAME': 'cltbld', 19:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:13 INFO - 'MOZ_NO_REMOTE': '1', 19:35:13 INFO - 'NO_EM_RESTART': '1', 19:35:13 INFO - 'PAGER': '/bin/cat', 19:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:13 INFO - 'PWD': '/builds/slave/test', 19:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:13 INFO - 'SHELL': '/bin/bash', 19:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:13 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:13 INFO - 'USER': 'cltbld', 19:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:13 INFO - 'XPC_FLAGS': '0x0', 19:35:13 INFO - 'XPC_SERVICE_NAME': '0', 19:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:35:16 INFO - Installing collected packages: mozsystemmonitor 19:35:16 INFO - Running setup.py install for mozsystemmonitor 19:35:16 INFO - Successfully installed mozsystemmonitor 19:35:16 INFO - Cleaning up... 19:35:16 INFO - Return code: 0 19:35:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35: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 19:35: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 19:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:16 INFO - 'HOME': '/Users/cltbld', 19:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:16 INFO - 'LOGNAME': 'cltbld', 19:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:16 INFO - 'MOZ_NO_REMOTE': '1', 19:35:16 INFO - 'NO_EM_RESTART': '1', 19:35:16 INFO - 'PAGER': '/bin/cat', 19:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:16 INFO - 'PWD': '/builds/slave/test', 19:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:16 INFO - 'SHELL': '/bin/bash', 19:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:16 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:16 INFO - 'USER': 'cltbld', 19:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:16 INFO - 'XPC_FLAGS': '0x0', 19:35:16 INFO - 'XPC_SERVICE_NAME': '0', 19:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:35:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:35:19 INFO - warning: no files found matching '*.txt' 19:35:19 INFO - no previously-included directories found matching 'build' 19:35:19 INFO - no previously-included directories found matching 'dist' 19:35:19 INFO - no previously-included directories found matching '.git*' 19:35:19 INFO - Installing collected packages: jsonschema, functools32 19:35:20 INFO - Running setup.py install for functools32 19:35:20 INFO - warning: no files found matching '*.txt' 19:35:20 INFO - no previously-included directories found matching 'build' 19:35:20 INFO - no previously-included directories found matching 'dist' 19:35:20 INFO - no previously-included directories found matching '.git*' 19:35:20 INFO - Successfully installed jsonschema functools32 19:35:20 INFO - Cleaning up... 19:35:20 INFO - Return code: 0 19:35:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35: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 19:35: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 19:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:20 INFO - 'HOME': '/Users/cltbld', 19:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:20 INFO - 'LOGNAME': 'cltbld', 19:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:20 INFO - 'MOZ_NO_REMOTE': '1', 19:35:20 INFO - 'NO_EM_RESTART': '1', 19:35:20 INFO - 'PAGER': '/bin/cat', 19:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:20 INFO - 'PWD': '/builds/slave/test', 19:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:20 INFO - 'SHELL': '/bin/bash', 19:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:20 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:20 INFO - 'USER': 'cltbld', 19:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:20 INFO - 'XPC_FLAGS': '0x0', 19:35:20 INFO - 'XPC_SERVICE_NAME': '0', 19:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:35:20 INFO - Cleaning up... 19:35:20 INFO - Return code: 0 19:35:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35: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 19:35: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 19:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:20 INFO - 'HOME': '/Users/cltbld', 19:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:20 INFO - 'LOGNAME': 'cltbld', 19:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:20 INFO - 'MOZ_NO_REMOTE': '1', 19:35:20 INFO - 'NO_EM_RESTART': '1', 19:35:20 INFO - 'PAGER': '/bin/cat', 19:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:20 INFO - 'PWD': '/builds/slave/test', 19:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:20 INFO - 'SHELL': '/bin/bash', 19:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:20 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:20 INFO - 'USER': 'cltbld', 19:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:20 INFO - 'XPC_FLAGS': '0x0', 19:35:20 INFO - 'XPC_SERVICE_NAME': '0', 19:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:20 INFO - Downloading/unpacking blobuploader==1.2.4 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:35:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:35:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:24 INFO - Downloading docopt-0.6.1.tar.gz 19:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:35:24 INFO - Running setup.py install for blobuploader 19:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:35:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:35:24 INFO - Running setup.py install for requests 19:35:25 INFO - Running setup.py install for docopt 19:35:25 INFO - Successfully installed blobuploader requests docopt 19:35:25 INFO - Cleaning up... 19:35:25 INFO - Return code: 0 19:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35: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 19:35: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 19:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:25 INFO - 'HOME': '/Users/cltbld', 19:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:25 INFO - 'LOGNAME': 'cltbld', 19:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:25 INFO - 'MOZ_NO_REMOTE': '1', 19:35:25 INFO - 'NO_EM_RESTART': '1', 19:35:25 INFO - 'PAGER': '/bin/cat', 19:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:25 INFO - 'PWD': '/builds/slave/test', 19:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:25 INFO - 'SHELL': '/bin/bash', 19:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:25 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:25 INFO - 'USER': 'cltbld', 19:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:25 INFO - 'XPC_FLAGS': '0x0', 19:35:25 INFO - 'XPC_SERVICE_NAME': '0', 19:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:25 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-LvrAyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-5pVQzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-muzBFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-p9xmZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-hea1LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ueOmFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SkOw2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0txFfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Kv6KYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:26 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-TNw8Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Z_pga2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-YnxbVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-pfC9Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-zLszD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-cHWBLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-VuRwCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:27 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-YRrYaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:35:27 INFO - Running setup.py install for manifestparser 19:35:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:35:27 INFO - Running setup.py install for mozcrash 19:35:28 INFO - Running setup.py install for mozdebug 19:35:28 INFO - Running setup.py install for mozdevice 19:35:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Running setup.py install for mozfile 19:35:28 INFO - Running setup.py install for mozhttpd 19:35:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Running setup.py install for mozinfo 19:35:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Running setup.py install for mozInstall 19:35:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:35:28 INFO - Running setup.py install for mozleak 19:35:29 INFO - Running setup.py install for mozlog 19:35:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:35:29 INFO - Running setup.py install for moznetwork 19:35:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:35:29 INFO - Running setup.py install for mozprocess 19:35:29 INFO - Running setup.py install for mozprofile 19:35:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:35:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:35:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:35:29 INFO - Running setup.py install for mozrunner 19:35:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:35:29 INFO - Running setup.py install for mozscreenshot 19:35:30 INFO - Running setup.py install for moztest 19:35:30 INFO - Running setup.py install for mozversion 19:35:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:35:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:35:30 INFO - Cleaning up... 19:35:30 INFO - Return code: 0 19:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:31 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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35:31 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 19:35:31 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 19:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:31 INFO - 'HOME': '/Users/cltbld', 19:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:31 INFO - 'LOGNAME': 'cltbld', 19:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:31 INFO - 'MOZ_NO_REMOTE': '1', 19:35:31 INFO - 'NO_EM_RESTART': '1', 19:35:31 INFO - 'PAGER': '/bin/cat', 19:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:31 INFO - 'PWD': '/builds/slave/test', 19:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:31 INFO - 'SHELL': '/bin/bash', 19:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:31 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:31 INFO - 'USER': 'cltbld', 19:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:31 INFO - 'XPC_FLAGS': '0x0', 19:35:31 INFO - 'XPC_SERVICE_NAME': '0', 19:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:31 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-_15aJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:31 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)) 19:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:31 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Fa6Cwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:31 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)) 19:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:31 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-7kvhpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:31 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)) 19:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:31 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-A91zuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:31 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)) 19:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:31 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-V3xXVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:31 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)) 19:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:31 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-3a0xl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Pq5fg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-m3_Y2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-A5F3ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-wIKHhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-zSmy86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-90Z9ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-9YLxgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-7qHP3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:32 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)) 19:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:32 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jRWU5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:33 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)) 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:33 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-sfAsgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:33 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)) 19:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:33 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-w9bVc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:33 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)) 19:35:33 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)) 19:35:33 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)) 19:35:33 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)) 19:35:33 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)) 19:35:33 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)) 19:35:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:35:33 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 19:35:33 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 19:35:33 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 19:35:33 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 19:35:33 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 19:35:33 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 19:35:36 INFO - Downloading blessings-1.6.tar.gz 19:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:35:36 INFO - Installing collected packages: blessings 19:35:36 INFO - Running setup.py install for blessings 19:35:36 INFO - Successfully installed blessings 19:35:36 INFO - Cleaning up... 19:35:36 INFO - Return code: 0 19:35:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:36 INFO - Reading from file tmpfile_stdout 19:35:36 INFO - Current package versions: 19:35:36 INFO - blessings == 1.6 19:35:36 INFO - blobuploader == 1.2.4 19:35:36 INFO - docopt == 0.6.1 19:35:36 INFO - functools32 == 3.2.3-2 19:35:36 INFO - jsonschema == 2.5.1 19:35:36 INFO - manifestparser == 1.1 19:35:36 INFO - mozInstall == 1.12 19:35:36 INFO - mozcrash == 1.0 19:35:36 INFO - mozdebug == 0.1 19:35:36 INFO - mozdevice == 0.49 19:35:36 INFO - mozfile == 1.2 19:35:36 INFO - mozhttpd == 0.7 19:35:36 INFO - mozinfo == 0.9 19:35:36 INFO - mozleak == 0.1 19:35:36 INFO - mozlog == 3.4 19:35:36 INFO - moznetwork == 0.27 19:35:36 INFO - mozprocess == 0.24 19:35:36 INFO - mozprofile == 0.28 19:35:36 INFO - mozrunner == 6.13 19:35:36 INFO - mozscreenshot == 0.1 19:35:36 INFO - mozsystemmonitor == 0.3 19:35:36 INFO - moztest == 0.8 19:35:36 INFO - mozversion == 1.4 19:35:36 INFO - psutil == 3.1.1 19:35:36 INFO - requests == 1.2.3 19:35:36 INFO - wsgiref == 0.1.2 19:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:36 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')]} 19:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:36 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')]} 19:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:36 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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35:36 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 19:35:36 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 19:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:36 INFO - 'HOME': '/Users/cltbld', 19:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:36 INFO - 'LOGNAME': 'cltbld', 19:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:36 INFO - 'MOZ_NO_REMOTE': '1', 19:35:36 INFO - 'NO_EM_RESTART': '1', 19:35:36 INFO - 'PAGER': '/bin/cat', 19:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:36 INFO - 'PWD': '/builds/slave/test', 19:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:36 INFO - 'SHELL': '/bin/bash', 19:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:36 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:36 INFO - 'USER': 'cltbld', 19:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:36 INFO - 'XPC_FLAGS': '0x0', 19:35:36 INFO - 'XPC_SERVICE_NAME': '0', 19:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 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)) 19:35:37 INFO - Cleaning up... 19:35:37 INFO - Return code: 0 19:35:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:37 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 0x10250ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10250d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9102490a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, '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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 19:35:37 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 19:35:37 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 19:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:37 INFO - 'HOME': '/Users/cltbld', 19:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:37 INFO - 'LOGNAME': 'cltbld', 19:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:37 INFO - 'MOZ_NO_REMOTE': '1', 19:35:37 INFO - 'NO_EM_RESTART': '1', 19:35:37 INFO - 'PAGER': '/bin/cat', 19:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:37 INFO - 'PWD': '/builds/slave/test', 19:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:37 INFO - 'SHELL': '/bin/bash', 19:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:37 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:37 INFO - 'USER': 'cltbld', 19:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:37 INFO - 'XPC_FLAGS': '0x0', 19:35:37 INFO - 'XPC_SERVICE_NAME': '0', 19:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:35:37 INFO - Cleaning up... 19:35:37 INFO - Return code: 0 19:35:37 INFO - Running post-action listener: _resource_record_post_action 19:35:37 INFO - Running post-action listener: _start_resource_monitoring 19:35:37 INFO - Starting resource monitoring. 19:35:37 INFO - [mozharness: 2017-02-07 03:35:37.444569Z] Finished create-virtualenv step (success) 19:35:37 INFO - [mozharness: 2017-02-07 03:35:37.445505Z] Running install step. 19:35:37 INFO - Running pre-action listener: _resource_record_pre_action 19:35:37 INFO - Running main action method: install 19:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:37 INFO - Reading from file tmpfile_stdout 19:35:37 INFO - Detecting whether we're running mozinstall >=1.0... 19:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:35:37 INFO - Reading from file tmpfile_stdout 19:35:37 INFO - Output received: 19:35:37 INFO - Usage: mozinstall [options] installer 19:35:37 INFO - Options: 19:35:37 INFO - -h, --help show this help message and exit 19:35:37 INFO - -d DEST, --destination=DEST 19:35:37 INFO - Directory to install application into. [default: 19:35:37 INFO - "/builds/slave/test"] 19:35:37 INFO - --app=APP Application being installed. [default: firefox] 19:35:37 INFO - mkdir: /builds/slave/test/build/application 19:35:37 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'] 19:35:37 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 19:35:57 INFO - Reading from file tmpfile_stdout 19:35:57 INFO - Output received: 19:35:57 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:35:57 INFO - Running post-action listener: _resource_record_post_action 19:35:57 INFO - [mozharness: 2017-02-07 03:35:57.677075Z] Finished install step (success) 19:35:57 INFO - [mozharness: 2017-02-07 03:35:57.677247Z] Running run-tests step. 19:35:57 INFO - Running pre-action listener: _resource_record_pre_action 19:35:57 INFO - Running main action method: run_tests 19:35:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:35:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:35:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:35:57 INFO - 2017-02-06 19:35:57.692 screenresolution[1623:7321] starting screenresolution argv=screenresolution get 19:35:57 INFO - 2017-02-06 19:35:57.694 screenresolution[1623:7321] Display 0: 1600x1200x32@60 19:35:57 INFO - 2017-02-06 19:35:57.701 screenresolution[1624:7324] starting screenresolution argv=screenresolution list 19:35:57 INFO - Available Modes on Display 0 19:35:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:35:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:35:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:35:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:35:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:35:57 INFO - Intel Iris: 19:35:57 INFO - Chipset Model: Intel Iris 19:35:57 INFO - Type: GPU 19:35:57 INFO - Bus: Built-In 19:35:57 INFO - VRAM (Dynamic, Max): 1536 MB 19:35:57 INFO - Vendor: Intel (0x8086) 19:35:57 INFO - Device ID: 0x0a2e 19:35:57 INFO - Revision ID: 0x0009 19:35:57 INFO - Displays: 19:35:57 INFO - Display: 19:35:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:35:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:35:57 INFO - Display Serial Number: 1600x1200 60 19:35:57 INFO - Main Display: Yes 19:35:57 INFO - Mirror: Off 19:35:57 INFO - Online: Yes 19:35:57 INFO - Rotation: Supported 19:35:57 INFO - Return code: 0 19:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:35:57 INFO - Python 2.7.3 19:35:57 INFO - Return code: 0 19:35:57 INFO - grabbing minidump binary from tooltool 19:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:57 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 0x1022e8d30>, '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 0x10220fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022ddbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:35:57 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 19:35:57 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 19:35:57 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 19:35:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:35:58 INFO - Return code: 0 19:35:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:35:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:35:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:35:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:35:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:35:58 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/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 19:35:58 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/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 19:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cY1uCbjsET/Render', 19:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:58 INFO - 'HOME': '/Users/cltbld', 19:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:58 INFO - 'LOGNAME': 'cltbld', 19:35:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:35:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:58 INFO - 'MOZ_NO_REMOTE': '1', 19:35:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:35:58 INFO - 'NO_EM_RESTART': '1', 19:35:58 INFO - 'PAGER': '/bin/cat', 19:35:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:58 INFO - 'PWD': '/builds/slave/test', 19:35:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:58 INFO - 'SHELL': '/bin/bash', 19:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NXpDX0Z2lq/Listeners', 19:35:58 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 19:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:58 INFO - 'USER': 'cltbld', 19:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:58 INFO - 'XPC_FLAGS': '0x0', 19:35:58 INFO - 'XPC_SERVICE_NAME': '0', 19:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:58 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/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 19:35:58 INFO - mozversion application_buildid: 20170206175856 19:35:58 INFO - mozversion application_changeset: fcc32735c01d504767a0dee94c6bc706b6a23b5e 19:35:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:35:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:35:58 INFO - mozversion application_name: Firefox 19:35:58 INFO - mozversion application_remotingname: firefox-dev 19:35:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:35:58 INFO - mozversion application_vendor: Mozilla 19:35:58 INFO - mozversion application_version: 53.0a2 19:35:58 INFO - mozversion platform_buildid: 20170206175856 19:35:58 INFO - mozversion platform_changeset: fcc32735c01d504767a0dee94c6bc706b6a23b5e 19:35:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:35:58 INFO - mozversion platform_version: 53.0a2 19:35:58 INFO - using testdate: 1486438558 19:35:58 INFO - actual date: 1486438558 19:35:58 INFO - starting webserver on 'localhost:49241' 19:35:58 INFO - SUITE-START | Running 2 tests 19:35:58 INFO - TEST-START | dromaeo_css 19:35:58 INFO - operating with platform_type : mac_ 19:35:58 INFO - Initialising browser for dromaeo_css test... 19:35:58 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpwG6gWh/profile http://localhost:49241/getInfo.html) 19:36:01 INFO - PROCESS | 1634 | 2017-02-06 19:36:01.212 plugin-container[1636:7494] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b3f, name = 'com.apple.tsm.portname' 19:36:01 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:01 INFO - PROCESS | 1634 | 2017-02-06 19:36:01.214 plugin-container[1636:7494] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9503, name = 'com.apple.CFPasteboardClient' 19:36:01 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:01 INFO - PROCESS | 1634 | 2017-02-06 19:36:01.214 plugin-container[1636:7494] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:36:01 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 19:36:01 INFO - PROCESS | 1634 | colorDepth:24 19:36:01 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 19:36:01 INFO - PROCESS | 1634 | __metrics 19:36:01 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:36:01 INFO - PROCESS | 1634 | 1486438561379 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/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpwG6gWh/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpwG6gWh/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpwG6gWh/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpwG6gWh/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:36:01 INFO - TEST-INFO | 1634: exit 0 19:36:01 INFO - Browser initialized. 19:36:01 INFO - Running cycle 1/1 for dromaeo_css test... 19:36:01 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpwG6gWh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:36:04 INFO - PROCESS | 1637 | 2017-02-06 19:36:04.624 plugin-container[1638:7623] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 19:36:04 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:04 INFO - PROCESS | 1637 | 2017-02-06 19:36:04.625 plugin-container[1638:7623] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 19:36:04 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:04 INFO - PROCESS | 1637 | 2017-02-06 19:36:04.625 plugin-container[1638:7623] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:36:14 INFO - PROCESS | 1637 | RSS: Main: 218501120 19:36:14 INFO - PROCESS | 1637 | 19:39:16 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 19:39:18 INFO - PROCESS | 1637 | RSS: Main: 236056576 19:39:18 INFO - PROCESS | 1637 | 19:41:02 INFO - PROCESS | 1637 | ************************* 19:41:02 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 19:41:02 INFO - PROCESS | 1637 | 19:41:02 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:41:02 INFO - PROCESS | 1637 | Full stack: 19:41:02 INFO - PROCESS | 1637 | ************************* 19:42:20 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 19:42:21 INFO - PROCESS | 1637 | RSS: Main: 245530624 19:42:21 INFO - PROCESS | 1637 | 19:45:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 19:45:24 INFO - PROCESS | 1637 | RSS: Main: 253501440 19:45:24 INFO - PROCESS | 1637 | 19:48:26 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 19:48:26 INFO - PROCESS | 1637 | RSS: Main: 249958400 19:48:26 INFO - PROCESS | 1637 | 19:51:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 19:51:30 INFO - PROCESS | 1637 | RSS: Main: 254078976 19:51:30 INFO - PROCESS | 1637 | 19:54:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 19:54:32 INFO - PROCESS | 1637 | RSS: Main: 255401984 19:54:32 INFO - PROCESS | 1637 | 19:54:32 INFO - PROCESS | 1637 | __start_tp_report 19:54:32 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 19:54:32 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 19:54:32 INFO - PROCESS | 1637 | |i|pagename|runs| 19:54:32 INFO - PROCESS | 1637 | |0;dojo.html;3393.440082386406;3395.711364534014;3422.2813209226056;3427.246005878706;3433.467812489065;5674.460926212003;5690.715464226792;5723.713814309278;5813.186153938452;5825.155352473888;5709.857253568653;5778.59549831512;5780.4797568218855;5794.623349482281;5794.855128621776;4067.9389809152885;4947.084789313971;5229.477052294768;5310.8141215057485;5330.466953304658;5357.678539287655;5363.839084827461;5366.060939335601;5377.6097517182325;5413.53984911283;5210.426853046162;5214.957008598277;5333;5342.866428339284;5346.866328341784;5257.132573125449;5265.526102650741;5275.762590683428;5333.2266821310695;5375.381831089436;5222.660527065728;5268.578513718893;5305.973470132624;5322.2282768998275;5328.307320048408;5580.86047848807;5796.2464879565805;5828.417158284137;5838.267442844823;5939.287285525721;6125.509959203253;6198.938010619881;6240.219972503437;6241.28225254097;6325.399087086719;6315.684215789192;6321.399467050623;6322.589031712924;6343.8414039648915;6344.397282258178;4440.888977775549;4838.274258861164;5903.0260007099205;5910.911336329958;5921.792737254262;5191;6243.313235544087;6251.718672659741;6257.937420625826;6266.686665666698;6122.2959359674205;6212.968935155295;6220.160278362363;6226.128342032119;6227.532935029891;5574.247476590608;6242.750289988349;6280.780172693934;6280.90084235257;6327.96836015817;5032.924506132411;6129.540284478593;6135.84660383494;6162.445379915829;6274.811755647338;5313.256144139824;6284.183056202664;6285.434310911948;6301.558890877594;6302.684865756693;4925.9014819704125;4983.9252411213865;5009.423916249605;5009.599232061426;5011.55056358785;4373.365861949999;4376.693631445768;4399.472063352418;4470.1059788041875;4495.078508905666;5841.707914604252;5924.851878703067;5947.702614869239;5990.371011043865;5997.0404735242155;6111.419415155553;6247.327333300166;6292.2134733158355;6295.213098362705;6313.589616674902;4771.379720636295;5834.387389324144;5838.328592211865;5842.123681447817;5859.296884373817;5526.005319042531;5531.032069387841;5532.17017447378;5538.501534861882;5547.694876781816;6405.8718825624155;6408.29508754046;6428.807135785841;6431.517636177212;6441.484681225397;6173.722182501709;6176.598521096114;6219.004959206505;6226.159468471698;6271.404216599416;6336.271328797247;6339.683015849281;6343.746250150127;6373.107764912823;6381;6205.565610407409;6253.96873015632;6255.593386429868;6267.96866015667;6280.591761535486;5237.135872580981;6009.609375390585;6216.844578885383;6245.6252624842655;6286.025666021774;6119.99004232014;6196.938030619636;6198.380161983946;6200.937990620217;6211.937880621136;6163.044728067157;6182.876342473215;6216.409441103088;6218.720157592828;6246.9062964054665;4727.4799772025735;5518.365387980433;5790.971045144747;5860.648361098348;6118.959776837859;5972.104184372379;6126.632402055891;6130.63216207029;6195.752169913153;6206;5117.360329958755;5277.947220527899;6003.282112486877;6034.125051867542;6140.232470941132 19:54:32 INFO - PROCESS | 1637 | |1;ext.html;453.65295548905095;494.0884068892893;528.4240178205755;540.9540189083928;545.280230096273;38798.41802372963;41840;41886.371704424455;41979.99999999996;42011;34720.82639586798;42193.7890310548;42611.72164835052;42762.57237427625;42859.78570107145;8506.872396914052;8765.342599305077;9288.256939444846;9546.761330966712;9553.713388598318;10305.175585953106;11012.614558490455;11344.773104537904;11663.24188927717;11823.586174483895;10968;11508.539658413654;11513.712157196054;11573.305601663886;11594.826077608843;9487.905120948806;11491.770164596703;11518.020968217712;11578.594749183738;11579.305241685526;11441.313521188673;11463.598774042868;11503.309801411942;11536.538538458452;11541.711457213552;40905.79547102275;41221.58778412207;41560.79219603913;41673;41723.37414938778;4025.1547175092974;4026.838926442968;4113.876583702494;4117.670586353084;4157.646600039;30102.24744381386;30146.397072058437;30198.698013020028;30525.847370763004;31056.534151987737;3118.5010398336385;3348.1127501211954;3367.8652853885815;3372.5278461015478;3374.9493757593655;340809;342138.2893085568;342651.2867435672;343943;344610;64000;64193.71612567722;64246.35753642404;64530.677346613906;64533.70932581416;66905;67254;67393;67530;67698.66150669215;16755;17014.404495842587;17034;17044.744328835077;17068.975861448354;11126.666200014013;11360.659180224442;12913.483460661468;13070.738585228242;13234.139780914209;16635.08507032125;16744.832551674328;17335.65328693419;17419.912900435418;17458.738118928228;6182.845428864314;7300.488965772452;7394.630268486554;7400.444966627524;7528.698852045966;801.6112185590101;876.6975393489236;891.1355984694835;898.9910100898908;928.9256859451363;25988.8700556496;30586.08241752751;30669.386612268077;30877.919272825344;31257.687423125477;1053.7839742852698;1070.710908054821;1073.6403304892792;1101.6889901017764;1104.1553211792984;15483.5354939352;15800.60498487547;15830.52508424749;15894;15990.304674603163;621681;623620;626994;627014;629691;40593;60147.39852601506;60223;60536.09195862066;61442.692786536674;1451.4992327646944;1459.3214155417782;1466.6699992501601;1469.1846025455975;1470.2134358118356;28096.43807123805;30181;30295.545566816956;30489.54265685972;30626.540601890545;52306.47693523016;52366.21450678167;52606;52613.21080183724;52645.7367713159;439141;442744;444527;444883;445294;40365.59634403736;40810.79594602008;40837.59162408457;40852.38721419241;41211.38182927318;39210;40280.19439611133;45649;50635.74682126566;50908;38990.2201955965;39226.411603826535;39636.80181599074;39801.20397591974;41002.58997410107;39610;39955.40066899057;40610.058525939654;40746.59253407428;41362.58637413587;38329.61670383372;38935.415968759924;38963.80518097391;39001.804990974866;39076.413853791644;31867.840660796548;34666.65333346634;35418.29163416769;35660.64339356677;35663.28673426569;21009.264675736275;25911.870440647675;25965.870170649025;25972.74027259703;26518.337041574116 19:54:32 INFO - PROCESS | 1637 | |2;jquery.html;386.3104358719686;387.23714282862767;392.30366100172193;397.4812869205686;421.0001247038284;13560.186388816677;19776.208951641936;20111.79888201121;21126.943652817354;21132.260370887;19962.60074798503;20062.297819576317;21263;21271.36185914421;21490.677639835416;5398.460153984609;5734.225879506276;5769.5672824538115;5827.504662103705;5847.444492773201;5590.301212348457;5754.97122514389;5771.105478650816;5780.653160810344;5811.593188476808;5726.713664316789;5773.278340207474;5778.739956701958;5783.9710801445935;5788.305403351604;5555.30558680165;5710.400407957146;5766.769329226826;5775.075987841946;5776.653400795944;4270.295401258789;5086.54221120101;5107.565856902131;5130.871728206787;5148.588112950955;25117.874410628014;25772.355691107685;25887.835047422912;25964.740352596422;26018.349541261432;2753.6695596528343;2821.7601503872197;2826.646669166354;2828.3070647691447;2831.745142937125;15072.321745521369;15181;15437.922810385988;15483.5354939352;15503.612409689735;1820.7086866101492;1877.108373522566;1888.7827899791425;1890.5179179309189;1901.420066879601;123673;125298.37350813187;129429.05856412162;130810.3459482706;147646.99999999892;11841.763164736656;11931.761364772656;12079.97320227773;12151.270923744603;12284.754304913851;13854.515091971934;14342.641433964025;15497.457588984556;15509.379624814881;15528.844711552965;6477.578957367756;8377.748667539983;8409.621567029499;8448.535330556755;8556.18716221958;8102.230288122619;8118.472299300526;8122.593870306461;8137.104918458965;8224.38317126206;4260.233158031584;4493.348464472633;4693.718376897397;4759.714417134983;4899.583535399531;1688.4765722626025;2012.295696506211;2043.0806137238303;2055.5580550181785;2068.989655051715;1018.5874720738113;1047.910927571165;1050.4380156616173;1052.484282701486;1078.2613909472036;20825.895870520853;21202.04590793418;21258.893705531373;21402.25092121768;21408;1056.825623772069;1058.4284486377423;1079.4279032112993;1080.589376037101;1082.870055593318;9061.456312621263;10823.296485728402;11215.32708037504;11215.71960700989;11217.887821121847;569718;573410.1329493326;576272;786538;793201;155165;157445;164967;167125;167215;1006.8087063458066;1008.7629407089328;1037.9481025948671;1063.5798859450629;1068.6420049283577;18339;18754.531136721693;18972.861628302348;19002.52493687669;19030.904845476238;46883.53116468792;57523.424765751806;58866.7056664714;59049.40950590611;59109.40890591039;71023;84482;85106;86681;89658;8050.959745201237;8088;8283.792905177177;8501;8550.572471376281;9225.907740922505;12260.26438413698;12758.48966041385;12846.164999275017;12886.871131288568;9379.85930211061;10828.891711083104;11173.888261117285;11326.83009754871;11331.830022549833;11028.669139925814;11086.334819910831;11087.002169804757;11159.832602511131;11170.720731981766;11152.330860148417;11205.831912521156;11374.54501819918;11636.767264654829;11925.747796481592;8346.791330216793;8370.87443688333;8394.874076888973;8474.3644226682;8487.151284871463;9947.900520994697;10154;10169;10355.068043876086;10604.946975265075 19:54:32 INFO - PROCESS | 1637 | |3;mootools.html;1221.615191214768;1376.8898488120951;1441.48827166356;1447.8769304609107;1460.1093333066826;7540.39676825854;7780.377569794417;8128.796780080494;8569.828603427928;8584.141585841413;8059.838803223932;8253.546054966975;8322.958385208065;8386.538740369277;8409.78975525612;2288.7253529576474;2313.190383365817;2313.35226136682;2317.918872839451;2318.8724620145886;1867.9439616811517;2071.2543484345697;2160.7407111146604;2254.830887683422;2304.976950230493;2253.5154941687533;2326.336993956723;2328.4528135888054;2329.3827135809024;2332.370260029791;2286.2798218561265;2296.701428814252;2317.814574834026;2326.685897403846;2334.661474086248;2313.838031337807;2341;2343.9648405273933;2378.452955820154;2384.3562238195764;8441.451305665112;8531.488110713377;8534.914650853474;8555.443896146731;8564.871526927102;5083.847484575469;5192.636515443921;5228.372595288552;5238.240455133984;5239.502247286502;2991.7157870002534;3332.483465062919;3520.8591656333715;3523.066387407339;3566.7146628269675;1194.337142885698;1203.5787474383897;1255.8179064035755;1266.727653554481;1268.8287081244007;10747.570097196103;10911.290766100177;10918.181136414722;10931.672049838518;10955.452227388678;4601.125786100697;4690.624750019991;4769.117713223065;4773.09311230865;4779.259214821708;8742.213200811957;8819.338549608805;8907.153820387053;8925.018247992715;8926.464412135292;5219.086659834514;5222.582193424517;5229.901720638709;5232.529072383428;5241.42344342122;4669.673122881366;4814.879628009257;4851.932574833531;4858.8785280367565;4887.315775791392;3430.6740859618294;3662.754663414452;3697.556293244774;3751.681107105872;3805.543334799842;947.4930911962067;1001.9899801002042;1042.338115296792;1079.1798233342715;1158.2760774515928;766.3677466090497;774.4307933668749;794.674183584739;796.2634563029175;800.8158123631597;5468.671879687232;5496.148097044965;5585.469380408855;5599.188117722907;5691.089425691869;951.167728237792;952.8808898887639;997.1175509673991;1000.1148983149965;1032.9845052324222;3721.330160571069;3812.275667623143;3840.327942610032;3863.903402414906;3918.1967696622123;9794.559244834;10082.143017843418;10145.442000689885;10151.593936242616;10167.23745719074;9954.900450995397;10045;10074.899251007397;10095.596176153018;10118.291719579705;7673.808154796063;7691.269329413697;7877.724279650185;7900.486468379537;7910.920890791133;5409.1886217066185;5413.729313534229;5520.91718624229;5652.434756524479;5675.858103547444;9208.171264586219;9237.769055773659;9258.907410925805;9426.57580408897;9428.764280893032;9073.13805188506;9254.25965922738;9365.157135857806;9413.858792117986;9445.149936505748;7106.253843346374;7284.307990740871;7298.2701729826595;7306.671199796128;7306.890396644161;7699.88450173259;7826.726064587712;7862.331701805182;7909.485883417559;7947.205279472007;6584.637844918576;7148.678309475982;7228.31331023552;7286.417086633162;7327.670254838652;5930.229070221017;7075.646217689198;7116.252793456612;7198.064251647462;7215.422766178588;5345;6428.164338635947;6433.260175079926;6456.838579035561;6528.771492997722;4812.735299558418;4861.343718597944;4980.626453015966;4989.750512474289;5103.234514822658;4988.875278117931;5026.095302845523;5031.622628302819;5037.546620804145;5108.055009823194 19:54:33 INFO - PROCESS | 1637 | |4;prototype.html;305.31456879305955;318.8373929296058;356.7046058612825;357.4887910288288;359.7463788029439;4461.8215271389145;4569.291759777231;5458.263134476844;5501.807436739715;5623.465770751777;5290.550303224221;5438.91841622376;5457.426970168135;5468.808591699291;5521.668699878011;3593.8382772775158;4186.769727664977;4213.705040647148;4323.437953066097;4330.501992270882;3310.5034244863223;4033.616806403387;4255.382969469425;4280.97859510702;4316.07204451043;3677.2829298286847;3919.6668283195963;4051.534073581546;4224.408582798411;4263.211305908401;4214.346776249687;4236.915261694764;4261.339492378686;4267.274563324242;4273.7008409411355;3641.617630148849;3781.3760729479604;3807.5430948286107;3808.990617486368;3815.5993620669983;4645.303204519315;4737.928931066037;5068.087744206042;5282.920756188661;5339.038972984861;4501.324801279801;4575.428071491064;4902.632302577321;4904.6321525885705;4905.656604037718;4501;5716.198727845977;5743;5777.508911742507;5862.824115276549;3481.4603736420895;3932.4494570760116;4102.671786257092;4112.239235741397;4120.423140760296;6026;6033.818985430444;6042.486388656926;6073.635581865102;6153.261608606951;3888.494495715539;4071.8371265149653;4205.684573656988;4236.322188449833;4252.85115020979;3445;3982.5021872265966;4061.7156799024374;4094.467719196485;4328.415663885398;4564.7717614119165;4727.172744769651;4732.674851041714;4744.478107408182;4793.784279707352;4448.110377924363;5824.970875145597;5915.319738230159;5940.495057920125;5957.195778569924;1246.9189502682298;1247.1564832182637;1288.8014146843338;1320.3728229091296;1321.0158431968052;863.8165712973141;888.6756333938196;893.3523195683208;893.5755516129786;895.1853813030111;5196.948030519722;5229.294045303911;5253.816116435906;5272.499112584298;5275.683458992473;5661.264035675335;5757.827265182052;5768.798092066758;5780.94219057804;5810.302763668303;4728;4866.902661946741;5039.77321020555;5156.896862062813;5252.789888404497;2504.749525047481;2599.77810429098;2910.476114299404;2960.6003189569565;3022.9848850755607;4799.0401919616215;4909.165441874889;5108.66793658411;5529.529989950819;5651.265335506358;4700.88247793801;4888.802243450306;5700.344460387026;6135.5398345124295;6145.108959200891;5028.485757121439;6244.344343843922;6260.937390626126;6263.248410190807;6276.748930042839;5602.926917040721;5970.552208584287;6019.849503762441;6037.78867739627;6099.512039036955;5278.785879247871;5497.587680923867;5868.530517558671;5871.266091738533;5874.206982057368;5461.5357694596405;6150.507959363151;6159.81520554384;6167.167432396569;6172.012478003498;3735.477033215406;3752.0057184846582;3960.663208706877;3997.480327557399;4001.3597824347967;5594.244776955222;5974.878917984053;5985.760569577168;6025;6041.546883983807;4678.742669153093;5600.215969764155;5731.799387021434;5790.826275211751;5814.505767009682;4625.190591646516;5529.419410961791;5836.970815145897;5844.970775146267;5899.321578018411;4843.564079232886;5125.333706618265;5367.954123124251;5526.55787536988;5756.683382414008;4955.603551715782;5623.903338848885;5829.621074630305;5901.852453688521;5912.852178695567;4412.3160910059;4933.703977761345;5012.874678133076;5593.965116453469;5784.855378615568 19:54:33 INFO - PROCESS | 1637 | |5;yui.html;696.4741620076841;707.7876637008897;720.1825927572205;788.1724189600922;818.67662273402;14963.476278330261;15812.209389530506;15850;15850.524484265461;15904.045757254558;11684.532618695262;14455.92772036141;14472.059316144443;14479.2760361982;14540.491082812103;670.9530332876701;691.7440546997593;853.4452605806244;860.1269711243093;870.9477431354107;863.1799790199304;870.0690261420283;877.33322674767;878.7583414560983;885.3802338363139;921.617528725578;934.9252059835197;938.3947353956694;939.2204470289644;942.7124726958275;915.3455279475174;934.3086116273943;935.2097477631459;938.6761567259284;940.4733349324332;703.1070540413697;703.595432626242;704.1936982155403;704.3871831506622;706.2407911495163;15222.314995825214;15476.993995390263;15597.376104955789;15876.444324448705;16133.83866161335;14472.348744306531;14532.200728959902;14813.407463701438;14976.850231497654;14978.70042599142;11574.826377604342;11903.047756179485;11940.223885447418;11974.820377694341;12581.937090314581;3692.7511741755866;3703.3889408247605;3835.390373746775;3876.7092468065007;3963.128111815396;110115;115375.84624153735;116064.41967790191;117124;118077;10252.692419227435;10565.683029509128;10850.67447976562;10863.728406789736;10904.836427453594;18642.533936651693;21434.24980125688;21680.566388672454;21701.891490542446;21775.67336489954;6348.523860710465;7504.249575042561;7649.235076492418;7684;7854.096778870503;4274.957250427456;4303.397524346594;4309.202797482476;4353.4122893408985;4400.779961001937;3514.139035936212;3563.6080031196548;3595.173110184672;3602.819859007039;3611;562.4122791682702;659.5317324699517;660.3759447322234;661.9007148927699;678.7590405406108;638.8466767975652;645.8256270806855;664.1764212376618;665.0987911380107;676.0467740485891;9113.134252246025;9731.367461115005;9818;9835.803283934425;10212.131968782589;644.7421031587403;658;671.6775947545206;672.4452326830384;688.8828899087167;4524.864254072318;4742.359781429532;4765.69023013503;4769.260764581495;4783.043391321749;99416.50291748495;102215;104199.95800041902;105253;106627;58210.417895821345;65785.6710716453;82358.35283294301;89622.55188724014;91482.1703565925;79391;79429.20570794218;81569;82299.17700822915;85289.57355213184;9102.681406150752;9153.221976132103;9239.86140207884;9248.676296329597;9273.25813934897;54213.728931355094;54581;54761.72619136879;55155.72422137864;55207.72396138154;43921.78039109784;63606.68196658987;63908;64246.35753642591;67137;13121.606351809462;13388.062835601415;13470.326483675974;13471.3937872794;13614.978876584493;12281.209171512262;14692.779608305671;14828.925855370655;15002.549923502313;15475.922620386826;10650.627228046982;13647.11293765902;13737.450501979809;14124.576262712135;14423.78364324557;13528.188308701509;13741;14100.153990760587;14301.713965720835;14530.128192308495;13272.402741876831;13334.666633333856;13786.65533361674;13870.237136957565;14293.499727509903;10913;11102.389368584805;11416.885831141582;11615.825762613398;12209.633710988684;9568;11104.888951110708;11180.04969577595;11257.268277561932;11258.043066339125 19:54:33 INFO - PROCESS | 1637 | __end_tp_report 19:54:33 INFO - PROCESS | 1637 | __start_cc_report 19:54:33 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,371 19:54:33 INFO - PROCESS | 1637 | __end_cc_report 19:54:33 INFO - PROCESS | 1637 | __startTimestamp1486439672989__endTimestamp 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | ------- Summary: start ------- 19:54:33 INFO - PROCESS | 1637 | Number of tests: 6 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5733.22 Median:5939.29 stddev:670.83 (11.3%) stddev-sans-first:647.29 19:54:33 INFO - PROCESS | 1637 | Values: 3393.4 3395.7 3422.3 3427.2 3433.5 5674.5 5690.7 5723.7 5813.2 5825.2 5709.9 5778.6 5780.5 5794.6 5794.9 4067.9 4947.1 5229.5 5310.8 5330.5 5357.7 5363.8 5366.1 5377.6 5413.5 5210.4 5215.0 5333.0 5342.9 5346.9 5257.1 5265.5 5275.8 5333.2 5375.4 5222.7 5268.6 5306.0 5322.2 5328.3 5580.9 5796.2 5828.4 5838.3 5939.3 6125.5 6198.9 6240.2 6241.3 6325.4 6315.7 6321.4 6322.6 6343.8 6344.4 4440.9 4838.3 5903.0 5910.9 5921.8 5191.0 6243.3 6251.7 6257.9 6266.7 6122.3 6213.0 6220.2 6226.1 6227.5 5574.2 6242.8 6280.8 6280.9 6328.0 5032.9 6129.5 6135.8 6162.4 6274.8 5313.3 6284.2 6285.4 6301.6 6302.7 4925.9 4983.9 5009.4 5009.6 5011.6 4373.4 4376.7 4399.5 4470.1 4495.1 5841.7 5924.9 5947.7 5990.4 5997.0 6111.4 6247.3 6292.2 6295.2 6313.6 4771.4 5834.4 5838.3 5842.1 5859.3 5526.0 5531.0 5532.2 5538.5 5547.7 6405.9 6408.3 6428.8 6431.5 6441.5 6173.7 6176.6 6219.0 6226.2 6271.4 6336.3 6339.7 6343.7 6373.1 6381.0 6205.6 6254.0 6255.6 6268.0 6280.6 5237.1 6009.6 6216.8 6245.6 6286.0 6120.0 6196.9 6198.4 6200.9 6211.9 6163.0 6182.9 6216.4 6218.7 6246.9 4727.5 5518.4 5791.0 5860.6 6119.0 5972.1 6126.6 6130.6 6195.8 6206.0 5117.4 5277.9 6003.3 6034.1 6140.2 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:62965.86 Median:39039.11 stddev:129187.21 (330.9%) stddev-sans-first:129464.35 19:54:33 INFO - PROCESS | 1637 | Values: 453.7 494.1 528.4 541.0 545.3 38798.4 41840.0 41886.4 41980.0 42011.0 34720.8 42193.8 42611.7 42762.6 42859.8 8506.9 8765.3 9288.3 9546.8 9553.7 10305.2 11012.6 11344.8 11663.2 11823.6 10968.0 11508.5 11513.7 11573.3 11594.8 9487.9 11491.8 11518.0 11578.6 11579.3 11441.3 11463.6 11503.3 11536.5 11541.7 40905.8 41221.6 41560.8 41673.0 41723.4 4025.2 4026.8 4113.9 4117.7 4157.6 30102.2 30146.4 30198.7 30525.8 31056.5 3118.5 3348.1 3367.9 3372.5 3374.9 340809.0 342138.3 342651.3 343943.0 344610.0 64000.0 64193.7 64246.4 64530.7 64533.7 66905.0 67254.0 67393.0 67530.0 67698.7 16755.0 17014.4 17034.0 17044.7 17069.0 11126.7 11360.7 12913.5 13070.7 13234.1 16635.1 16744.8 17335.7 17419.9 17458.7 6182.8 7300.5 7394.6 7400.4 7528.7 801.6 876.7 891.1 899.0 928.9 25988.9 30586.1 30669.4 30877.9 31257.7 1053.8 1070.7 1073.6 1101.7 1104.2 15483.5 15800.6 15830.5 15894.0 15990.3 621681.0 623620.0 626994.0 627014.0 629691.0 40593.0 60147.4 60223.0 60536.1 61442.7 1451.5 1459.3 1466.7 1469.2 1470.2 28096.4 30181.0 30295.5 30489.5 30626.5 52306.5 52366.2 52606.0 52613.2 52645.7 439141.0 442744.0 444527.0 444883.0 445294.0 40365.6 40810.8 40837.6 40852.4 41211.4 39210.0 40280.2 45649.0 50635.7 50908.0 38990.2 39226.4 39636.8 39801.2 41002.6 39610.0 39955.4 40610.1 40746.6 41362.6 38329.6 38935.4 38963.8 39001.8 39076.4 31867.8 34666.7 35418.3 35660.6 35663.3 21009.3 25911.9 25965.9 25972.7 26518.3 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:38425.02 Median:21260.95 stddev:112302.00 (528.2%) stddev-sans-first:112580.72 19:54:33 INFO - PROCESS | 1637 | Values: 386.3 387.2 392.3 397.5 421.0 13560.2 19776.2 20111.8 21126.9 21132.3 19962.6 20062.3 21263.0 21271.4 21490.7 5398.5 5734.2 5769.6 5827.5 5847.4 5590.3 5755.0 5771.1 5780.7 5811.6 5726.7 5773.3 5778.7 5784.0 5788.3 5555.3 5710.4 5766.8 5775.1 5776.7 4270.3 5086.5 5107.6 5130.9 5148.6 25117.9 25772.4 25887.8 25964.7 26018.3 2753.7 2821.8 2826.6 2828.3 2831.7 15072.3 15181.0 15437.9 15483.5 15503.6 1820.7 1877.1 1888.8 1890.5 1901.4 123673.0 125298.4 129429.1 130810.3 147647.0 11841.8 11931.8 12080.0 12151.3 12284.8 13854.5 14342.6 15497.5 15509.4 15528.8 6477.6 8377.7 8409.6 8448.5 8556.2 8102.2 8118.5 8122.6 8137.1 8224.4 4260.2 4493.3 4693.7 4759.7 4899.6 1688.5 2012.3 2043.1 2055.6 2069.0 1018.6 1047.9 1050.4 1052.5 1078.3 20825.9 21202.0 21258.9 21402.3 21408.0 1056.8 1058.4 1079.4 1080.6 1082.9 9061.5 10823.3 11215.3 11215.7 11217.9 569718.0 573410.1 576272.0 786538.0 793201.0 155165.0 157445.0 164967.0 167125.0 167215.0 1006.8 1008.8 1037.9 1063.6 1068.6 18339.0 18754.5 18972.9 19002.5 19030.9 46883.5 57523.4 58866.7 59049.4 59109.4 71023.0 84482.0 85106.0 86681.0 89658.0 8051.0 8088.0 8283.8 8501.0 8550.6 9225.9 12260.3 12758.5 12846.2 12886.9 9379.9 10828.9 11173.9 11326.8 11331.8 11028.7 11086.3 11087.0 11159.8 11170.7 11152.3 11205.8 11374.5 11636.8 11925.7 8346.8 8370.9 8394.9 8474.4 8487.2 9947.9 10154.0 10169.0 10355.1 10604.9 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5428.61 Median:5205.86 stddev:2972.47 (57.1%) stddev-sans-first:2963.99 19:54:33 INFO - PROCESS | 1637 | Values: 1221.6 1376.9 1441.5 1447.9 1460.1 7540.4 7780.4 8128.8 8569.8 8584.1 8059.8 8253.5 8323.0 8386.5 8409.8 2288.7 2313.2 2313.4 2317.9 2318.9 1867.9 2071.3 2160.7 2254.8 2305.0 2253.5 2326.3 2328.5 2329.4 2332.4 2286.3 2296.7 2317.8 2326.7 2334.7 2313.8 2341.0 2344.0 2378.5 2384.4 8441.5 8531.5 8534.9 8555.4 8564.9 5083.8 5192.6 5228.4 5238.2 5239.5 2991.7 3332.5 3520.9 3523.1 3566.7 1194.3 1203.6 1255.8 1266.7 1268.8 10747.6 10911.3 10918.2 10931.7 10955.5 4601.1 4690.6 4769.1 4773.1 4779.3 8742.2 8819.3 8907.2 8925.0 8926.5 5219.1 5222.6 5229.9 5232.5 5241.4 4669.7 4814.9 4851.9 4858.9 4887.3 3430.7 3662.8 3697.6 3751.7 3805.5 947.5 1002.0 1042.3 1079.2 1158.3 766.4 774.4 794.7 796.3 800.8 5468.7 5496.1 5585.5 5599.2 5691.1 951.2 952.9 997.1 1000.1 1033.0 3721.3 3812.3 3840.3 3863.9 3918.2 9794.6 10082.1 10145.4 10151.6 10167.2 9954.9 10045.0 10074.9 10095.6 10118.3 7673.8 7691.3 7877.7 7900.5 7910.9 5409.2 5413.7 5520.9 5652.4 5675.9 9208.2 9237.8 9258.9 9426.6 9428.8 9073.1 9254.3 9365.2 9413.9 9445.1 7106.3 7284.3 7298.3 7306.7 7306.9 7699.9 7826.7 7862.3 7909.5 7947.2 6584.6 7148.7 7228.3 7286.4 7327.7 5930.2 7075.6 7116.3 7198.1 7215.4 5345.0 6428.2 6433.3 6456.8 6528.8 4812.7 4861.3 4980.6 4989.8 5103.2 4988.9 5026.1 5031.6 5037.5 5108.1 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4645.13 Median:5053.93 stddev:1431.56 (28.3%) stddev-sans-first:1398.03 19:54:33 INFO - PROCESS | 1637 | Values: 305.3 318.8 356.7 357.5 359.7 4461.8 4569.3 5458.3 5501.8 5623.5 5290.6 5438.9 5457.4 5468.8 5521.7 3593.8 4186.8 4213.7 4323.4 4330.5 3310.5 4033.6 4255.4 4281.0 4316.1 3677.3 3919.7 4051.5 4224.4 4263.2 4214.3 4236.9 4261.3 4267.3 4273.7 3641.6 3781.4 3807.5 3809.0 3815.6 4645.3 4737.9 5068.1 5282.9 5339.0 4501.3 4575.4 4902.6 4904.6 4905.7 4501.0 5716.2 5743.0 5777.5 5862.8 3481.5 3932.4 4102.7 4112.2 4120.4 6026.0 6033.8 6042.5 6073.6 6153.3 3888.5 4071.8 4205.7 4236.3 4252.9 3445.0 3982.5 4061.7 4094.5 4328.4 4564.8 4727.2 4732.7 4744.5 4793.8 4448.1 5825.0 5915.3 5940.5 5957.2 1246.9 1247.2 1288.8 1320.4 1321.0 863.8 888.7 893.4 893.6 895.2 5196.9 5229.3 5253.8 5272.5 5275.7 5661.3 5757.8 5768.8 5780.9 5810.3 4728.0 4866.9 5039.8 5156.9 5252.8 2504.7 2599.8 2910.5 2960.6 3023.0 4799.0 4909.2 5108.7 5529.5 5651.3 4700.9 4888.8 5700.3 6135.5 6145.1 5028.5 6244.3 6260.9 6263.2 6276.7 5602.9 5970.6 6019.8 6037.8 6099.5 5278.8 5497.6 5868.5 5871.3 5874.2 5461.5 6150.5 6159.8 6167.2 6172.0 3735.5 3752.0 3960.7 3997.5 4001.4 5594.2 5974.9 5985.8 6025.0 6041.5 4678.7 5600.2 5731.8 5790.8 5814.5 4625.2 5529.4 5837.0 5845.0 5899.3 4843.6 5125.3 5368.0 5526.6 5756.7 4955.6 5623.9 5829.6 5901.9 5912.9 4412.3 4933.7 5012.9 5594.0 5784.9 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20502.33 Median:4306.30 stddev:29715.53 (690.0%) stddev-sans-first:29761.67 19:54:33 INFO - PROCESS | 1637 | Values: 696.5 707.8 720.2 788.2 818.7 14963.5 15812.2 15850.0 15850.5 15904.0 11684.5 14455.9 14472.1 14479.3 14540.5 671.0 691.7 853.4 860.1 870.9 863.2 870.1 877.3 878.8 885.4 921.6 934.9 938.4 939.2 942.7 915.3 934.3 935.2 938.7 940.5 703.1 703.6 704.2 704.4 706.2 15222.3 15477.0 15597.4 15876.4 16133.8 14472.3 14532.2 14813.4 14976.9 14978.7 11574.8 11903.0 11940.2 11974.8 12581.9 3692.8 3703.4 3835.4 3876.7 3963.1 110115.0 115375.8 116064.4 117124.0 118077.0 10252.7 10565.7 10850.7 10863.7 10904.8 18642.5 21434.2 21680.6 21701.9 21775.7 6348.5 7504.2 7649.2 7684.0 7854.1 4275.0 4303.4 4309.2 4353.4 4400.8 3514.1 3563.6 3595.2 3602.8 3611.0 562.4 659.5 660.4 661.9 678.8 638.8 645.8 664.2 665.1 676.0 9113.1 9731.4 9818.0 9835.8 10212.1 644.7 658.0 671.7 672.4 688.9 4524.9 4742.4 4765.7 4769.3 4783.0 99416.5 102215.0 104200.0 105253.0 106627.0 58210.4 65785.7 82358.4 89622.6 91482.2 79391.0 79429.2 81569.0 82299.2 85289.6 9102.7 9153.2 9239.9 9248.7 9273.3 54213.7 54581.0 54761.7 55155.7 55207.7 43921.8 63606.7 63908.0 64246.4 67137.0 13121.6 13388.1 13470.3 13471.4 13615.0 12281.2 14692.8 14828.9 15002.5 15475.9 10650.6 13647.1 13737.5 14124.6 14423.8 13528.2 13741.0 14100.2 14301.7 14530.1 13272.4 13334.7 13786.7 13870.2 14293.5 10913.0 11102.4 11416.9 11615.8 12209.6 9568.0 11104.9 11180.0 11257.3 11258.0 19:54:33 INFO - PROCESS | 1637 | -------- Summary: end -------- 19:54:33 INFO - PROCESS | 1637 | 19:54:33 INFO - TEST-INFO | 1637: exit 0 19:54:33 INFO - TEST-OK | dromaeo_css | took 1115356ms 19:54:33 INFO - TEST-START | kraken 19:54:33 INFO - operating with platform_type : mac_ 19:54:33 INFO - Initialising browser for kraken test... 19:54:33 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmptmzGKE/profile http://localhost:49241/getInfo.html) 19:54:36 INFO - PROCESS | 1649 | 2017-02-06 19:54:36.484 plugin-container[1650:9843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 19:54:36 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:54:36 INFO - PROCESS | 1649 | 2017-02-06 19:54:36.487 plugin-container[1650:9843] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 19:54:36 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:54:36 INFO - PROCESS | 1649 | 2017-02-06 19:54:36.487 plugin-container[1650:9843] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:54:36 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 19:54:36 INFO - PROCESS | 1649 | colorDepth:24 19:54:36 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 19:54:36 INFO - PROCESS | 1649 | __metrics 19:54:36 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:54:36 INFO - PROCESS | 1649 | 1486439676672 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/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmptmzGKE/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmptmzGKE/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmptmzGKE/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmptmzGKE/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:54:37 INFO - TEST-INFO | 1649: exit 0 19:54:37 INFO - Browser initialized. 19:54:37 INFO - Running cycle 1/1 for kraken test... 19:54:37 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmptmzGKE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:54:39 INFO - PROCESS | 1651 | 2017-02-06 19:54:39.922 plugin-container[1652:9970] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 19:54:39 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:54:39 INFO - PROCESS | 1651 | 2017-02-06 19:54:39.923 plugin-container[1652:9970] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 19:54:39 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:54:39 INFO - PROCESS | 1651 | 2017-02-06 19:54:39.923 plugin-container[1652:9970] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:54:49 INFO - PROCESS | 1651 | RSS: Main: 218791936 19:54:49 INFO - PROCESS | 1651 | 19:54:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 19:54:53 INFO - PROCESS | 1651 | RSS: Main: 233132032 19:54:53 INFO - PROCESS | 1651 | 19:54:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 19:54:56 INFO - PROCESS | 1651 | RSS: Main: 241033216 19:54:56 INFO - PROCESS | 1651 | 19:55:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 19:55:00 INFO - PROCESS | 1651 | RSS: Main: 244654080 19:55:00 INFO - PROCESS | 1651 | 19:55:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 19:55:03 INFO - PROCESS | 1651 | RSS: Main: 245596160 19:55:03 INFO - PROCESS | 1651 | 19:55:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:55:06 INFO - PROCESS | 1651 | RSS: Main: 246824960 19:55:06 INFO - PROCESS | 1651 | 19:55:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 19:55:09 INFO - PROCESS | 1651 | RSS: Main: 250200064 19:55:09 INFO - PROCESS | 1651 | 19:55:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 19:55:13 INFO - PROCESS | 1651 | RSS: Main: 249180160 19:55:13 INFO - PROCESS | 1651 | 19:55:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 19:55:17 INFO - PROCESS | 1651 | RSS: Main: 249405440 19:55:17 INFO - PROCESS | 1651 | 19:55:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:55:19 INFO - PROCESS | 1651 | RSS: Main: 248868864 19:55:19 INFO - PROCESS | 1651 | 19:55:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:55:22 INFO - PROCESS | 1651 | RSS: Main: 248844288 19:55:22 INFO - PROCESS | 1651 | 19:55:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:55:25 INFO - PROCESS | 1651 | RSS: Main: 248905728 19:55:25 INFO - PROCESS | 1651 | 19:55:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:55:28 INFO - PROCESS | 1651 | RSS: Main: 249249792 19:55:28 INFO - PROCESS | 1651 | 19:55:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:55:32 INFO - PROCESS | 1651 | RSS: Main: 249040896 19:55:32 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 19:55:34 INFO - PROCESS | 1651 | RSS: Main: 251109376 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | __start_tp_report 19:55:34 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 19:55:34 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 19:55:34 INFO - PROCESS | 1651 | |i|pagename|runs| 19:55:34 INFO - PROCESS | 1651 | |0;ai-astar;106;122;167;118;119;119;117;117;119;117 19:55:34 INFO - PROCESS | 1651 | |1;audio-beat-detection;146;136;146;181;142;112;110;116;121;140 19:55:34 INFO - PROCESS | 1651 | |2;audio-dft;198;203;197;198;200;199;197;199;199;241 19:55:34 INFO - PROCESS | 1651 | |3;audio-fft;82;60;60;85;60;61;59;54;94;87 19:55:34 INFO - PROCESS | 1651 | |4;audio-oscillator;102;106;118;105;78;73;80;70;70;82 19:55:34 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;132;133;90;86;100;89;138;87;89;86 19:55:34 INFO - PROCESS | 1651 | |6;imaging-darkroom;98;97;96;122;164;97;125;92;93;96 19:55:34 INFO - PROCESS | 1651 | |7;imaging-desaturate;139;146;94;93;86;125;128;139;155;91 19:55:34 INFO - PROCESS | 1651 | |8;json-parse-financial;59;49;48;96;98;99;101;64;62;63 19:55:34 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;69;77;101;80;67;100;104;65;103;60 19:55:34 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;97;77;87;98;108;81;84;96;78;98 19:55:34 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;141;178;149;150;153;155;165;185;144 19:55:34 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;171;171;168;169;210;174;172;193;240;168 19:55:34 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;68;65;68;66;76;66;66;66;65;67 19:55:34 INFO - PROCESS | 1651 | __end_tp_report 19:55:34 INFO - PROCESS | 1651 | __start_cc_report 19:55:34 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,940 19:55:34 INFO - PROCESS | 1651 | __end_cc_report 19:55:34 INFO - PROCESS | 1651 | __startTimestamp1486439734510__endTimestamp 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | ------- Summary: start ------- 19:55:34 INFO - PROCESS | 1651 | Number of tests: 14 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:122.10 Median:119.00 stddev:16.33 (13.7%) stddev-sans-first:16.24 19:55:34 INFO - PROCESS | 1651 | Values: 106.0 122.0 167.0 118.0 119.0 119.0 117.0 117.0 119.0 117.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:141.00 stddev:21.46 (15.2%) stddev-sans-first:22.39 19:55:34 INFO - PROCESS | 1651 | Values: 146.0 136.0 146.0 181.0 142.0 112.0 110.0 116.0 121.0 140.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:203.10 Median:199.00 stddev:13.43 (6.7%) stddev-sans-first:14.12 19:55:34 INFO - PROCESS | 1651 | Values: 198.0 203.0 197.0 198.0 200.0 199.0 197.0 199.0 199.0 241.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:70.20 Median:71.50 stddev:14.88 (20.8%) stddev-sans-first:15.15 19:55:34 INFO - PROCESS | 1651 | Values: 82.0 60.0 60.0 85.0 60.0 61.0 59.0 54.0 94.0 87.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:71.50 stddev:17.58 (24.6%) stddev-sans-first:17.94 19:55:34 INFO - PROCESS | 1651 | Values: 102.0 106.0 118.0 105.0 78.0 73.0 80.0 70.0 70.0 82.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:86.50 stddev:22.04 (25.5%) stddev-sans-first:20.72 19:55:34 INFO - PROCESS | 1651 | Values: 132.0 133.0 90.0 86.0 100.0 89.0 138.0 87.0 89.0 86.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:96.00 stddev:22.93 (23.9%) stddev-sans-first:24.03 19:55:34 INFO - PROCESS | 1651 | Values: 98.0 97.0 96.0 122.0 164.0 97.0 125.0 92.0 93.0 96.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:119.60 Median:120.50 stddev:26.06 (21.6%) stddev-sans-first:26.68 19:55:34 INFO - PROCESS | 1651 | Values: 139.0 146.0 94.0 93.0 86.0 125.0 128.0 139.0 155.0 91.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:73.90 Median:63.50 stddev:21.87 (34.4%) stddev-sans-first:22.52 19:55:34 INFO - PROCESS | 1651 | Values: 59.0 49.0 48.0 96.0 98.0 99.0 101.0 64.0 62.0 63.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:66.00 stddev:17.65 (26.7%) stddev-sans-first:18.02 19:55:34 INFO - PROCESS | 1651 | Values: 69.0 77.0 101.0 80.0 67.0 100.0 104.0 65.0 103.0 60.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:91.50 stddev:10.41 (11.4%) stddev-sans-first:10.76 19:55:34 INFO - PROCESS | 1651 | Values: 97.0 77.0 87.0 98.0 108.0 81.0 84.0 96.0 78.0 98.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:154.00 stddev:15.49 (10.1%) stddev-sans-first:15.17 19:55:34 INFO - PROCESS | 1651 | Values: 139.0 141.0 178.0 149.0 150.0 153.0 155.0 165.0 185.0 144.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:173.00 stddev:24.06 (13.9%) stddev-sans-first:25.08 19:55:34 INFO - PROCESS | 1651 | Values: 171.0 171.0 168.0 169.0 210.0 174.0 172.0 193.0 240.0 168.0 19:55:34 INFO - PROCESS | 1651 | 19:55:34 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:3.23 (4.9%) stddev-sans-first:3.42 19:55:34 INFO - PROCESS | 1651 | Values: 68.0 65.0 68.0 66.0 76.0 66.0 66.0 66.0 65.0 67.0 19:55:34 INFO - PROCESS | 1651 | -------- Summary: end -------- 19:55:34 INFO - PROCESS | 1651 | 19:55:35 INFO - TEST-INFO | 1651: exit 0 19:55:35 INFO - TEST-OK | kraken | took 61781ms 19:55:35 INFO - SUITE-END | took 1177s 19:55:35 INFO - Completed test suite (00:19:37) 19:55:35 INFO - javascript benchmark 19:55:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7363.231953337218, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.440082386406, 3395.711364534014, 3422.2813209226056, 3427.246005878706, 3433.467812489065, 5674.460926212003, 5690.715464226792, 5723.713814309278, 5813.186153938452, 5825.155352473888, 5709.857253568653, 5778.59549831512, 5780.4797568218855, 5794.623349482281, 5794.855128621776, 4067.9389809152885, 4947.084789313971, 5229.477052294768, 5310.8141215057485, 5330.466953304658, 5357.678539287655, 5363.839084827461, 5366.060939335601, 5377.6097517182325, 5413.53984911283, 5210.426853046162, 5214.957008598277, 5333.0, 5342.866428339284, 5346.866328341784, 5257.132573125449, 5265.526102650741, 5275.762590683428, 5333.2266821310695, 5375.381831089436, 5222.660527065728, 5268.578513718893, 5305.973470132624, 5322.2282768998275, 5328.307320048408, 5580.86047848807, 5796.2464879565805, 5828.417158284137, 5838.267442844823, 5939.287285525721, 6125.509959203253, 6198.938010619881, 6240.219972503437, 6241.28225254097, 6325.399087086719, 6315.684215789192, 6321.399467050623, 6322.589031712924, 6343.8414039648915, 6344.397282258178, 4440.888977775549, 4838.274258861164, 5903.0260007099205, 5910.911336329958, 5921.792737254262, 5191.0, 6243.313235544087, 6251.718672659741, 6257.937420625826, 6266.686665666698, 6122.2959359674205, 6212.968935155295, 6220.160278362363, 6226.128342032119, 6227.532935029891, 5574.247476590608, 6242.750289988349, 6280.780172693934, 6280.90084235257, 6327.96836015817, 5032.924506132411, 6129.540284478593, 6135.84660383494, 6162.445379915829, 6274.811755647338, 5313.256144139824, 6284.183056202664, 6285.434310911948, 6301.558890877594, 6302.684865756693, 4925.9014819704125, 4983.9252411213865, 5009.423916249605, 5009.599232061426, 5011.55056358785, 4373.365861949999, 4376.693631445768, 4399.472063352418, 4470.1059788041875, 4495.078508905666, 5841.707914604252, 5924.851878703067, 5947.702614869239, 5990.371011043865, 5997.0404735242155, 6111.419415155553, 6247.327333300166, 6292.2134733158355, 6295.213098362705, 6313.589616674902, 4771.379720636295, 5834.387389324144, 5838.328592211865, 5842.123681447817, 5859.296884373817, 5526.005319042531, 5531.032069387841, 5532.17017447378, 5538.501534861882, 5547.694876781816, 6405.8718825624155, 6408.29508754046, 6428.807135785841, 6431.517636177212, 6441.484681225397, 6173.722182501709, 6176.598521096114, 6219.004959206505, 6226.159468471698, 6271.404216599416, 6336.271328797247, 6339.683015849281, 6343.746250150127, 6373.107764912823, 6381.0, 6205.565610407409, 6253.96873015632, 6255.593386429868, 6267.96866015667, 6280.591761535486, 5237.135872580981, 6009.609375390585, 6216.844578885383, 6245.6252624842655, 6286.025666021774, 6119.99004232014, 6196.938030619636, 6198.380161983946, 6200.937990620217, 6211.937880621136, 6163.044728067157, 6182.876342473215, 6216.409441103088, 6218.720157592828, 6246.9062964054665, 4727.4799772025735, 5518.365387980433, 5790.971045144747, 5860.648361098348, 6118.959776837859, 5972.104184372379, 6126.632402055891, 6130.63216207029, 6195.752169913153, 6206.0, 5117.360329958755, 5277.947220527899, 6003.282112486877, 6034.125051867542, 6140.232470941132], "value": 5693.536042464885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.65295548905095, 494.0884068892893, 528.4240178205755, 540.9540189083928, 545.280230096273, 38798.41802372963, 41840.0, 41886.371704424455, 41979.99999999996, 42011.0, 34720.82639586798, 42193.7890310548, 42611.72164835052, 42762.57237427625, 42859.78570107145, 8506.872396914052, 8765.342599305077, 9288.256939444846, 9546.761330966712, 9553.713388598318, 10305.175585953106, 11012.614558490455, 11344.773104537904, 11663.24188927717, 11823.586174483895, 10968.0, 11508.539658413654, 11513.712157196054, 11573.305601663886, 11594.826077608843, 9487.905120948806, 11491.770164596703, 11518.020968217712, 11578.594749183738, 11579.305241685526, 11441.313521188673, 11463.598774042868, 11503.309801411942, 11536.538538458452, 11541.711457213552, 40905.79547102275, 41221.58778412207, 41560.79219603913, 41673.0, 41723.37414938778, 4025.1547175092974, 4026.838926442968, 4113.876583702494, 4117.670586353084, 4157.646600039, 30102.24744381386, 30146.397072058437, 30198.698013020028, 30525.847370763004, 31056.534151987737, 3118.5010398336385, 3348.1127501211954, 3367.8652853885815, 3372.5278461015478, 3374.9493757593655, 340809.0, 342138.2893085568, 342651.2867435672, 343943.0, 344610.0, 64000.0, 64193.71612567722, 64246.35753642404, 64530.677346613906, 64533.70932581416, 66905.0, 67254.0, 67393.0, 67530.0, 67698.66150669215, 16755.0, 17014.404495842587, 17034.0, 17044.744328835077, 17068.975861448354, 11126.666200014013, 11360.659180224442, 12913.483460661468, 13070.738585228242, 13234.139780914209, 16635.08507032125, 16744.832551674328, 17335.65328693419, 17419.912900435418, 17458.738118928228, 6182.845428864314, 7300.488965772452, 7394.630268486554, 7400.444966627524, 7528.698852045966, 801.6112185590101, 876.6975393489236, 891.1355984694835, 898.9910100898908, 928.9256859451363, 25988.8700556496, 30586.08241752751, 30669.386612268077, 30877.919272825344, 31257.687423125477, 1053.7839742852698, 1070.710908054821, 1073.6403304892792, 1101.6889901017764, 1104.1553211792984, 15483.5354939352, 15800.60498487547, 15830.52508424749, 15894.0, 15990.304674603163, 621681.0, 623620.0, 626994.0, 627014.0, 629691.0, 40593.0, 60147.39852601506, 60223.0, 60536.09195862066, 61442.692786536674, 1451.4992327646944, 1459.3214155417782, 1466.6699992501601, 1469.1846025455975, 1470.2134358118356, 28096.43807123805, 30181.0, 30295.545566816956, 30489.54265685972, 30626.540601890545, 52306.47693523016, 52366.21450678167, 52606.0, 52613.21080183724, 52645.7367713159, 439141.0, 442744.0, 444527.0, 444883.0, 445294.0, 40365.59634403736, 40810.79594602008, 40837.59162408457, 40852.38721419241, 41211.38182927318, 39210.0, 40280.19439611133, 45649.0, 50635.74682126566, 50908.0, 38990.2201955965, 39226.411603826535, 39636.80181599074, 39801.20397591974, 41002.58997410107, 39610.0, 39955.40066899057, 40610.058525939654, 40746.59253407428, 41362.58637413587, 38329.61670383372, 38935.415968759924, 38963.80518097391, 39001.804990974866, 39076.413853791644, 31867.840660796548, 34666.65333346634, 35418.29163416769, 35660.64339356677, 35663.28673426569, 21009.264675736275, 25911.870440647675, 25965.870170649025, 25972.74027259703, 26518.337041574116], "value": 20394.47517712685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3104358719686, 387.23714282862767, 392.30366100172193, 397.4812869205686, 421.0001247038284, 13560.186388816677, 19776.208951641936, 20111.79888201121, 21126.943652817354, 21132.260370887, 19962.60074798503, 20062.297819576317, 21263.0, 21271.36185914421, 21490.677639835416, 5398.460153984609, 5734.225879506276, 5769.5672824538115, 5827.504662103705, 5847.444492773201, 5590.301212348457, 5754.97122514389, 5771.105478650816, 5780.653160810344, 5811.593188476808, 5726.713664316789, 5773.278340207474, 5778.739956701958, 5783.9710801445935, 5788.305403351604, 5555.30558680165, 5710.400407957146, 5766.769329226826, 5775.075987841946, 5776.653400795944, 4270.295401258789, 5086.54221120101, 5107.565856902131, 5130.871728206787, 5148.588112950955, 25117.874410628014, 25772.355691107685, 25887.835047422912, 25964.740352596422, 26018.349541261432, 2753.6695596528343, 2821.7601503872197, 2826.646669166354, 2828.3070647691447, 2831.745142937125, 15072.321745521369, 15181.0, 15437.922810385988, 15483.5354939352, 15503.612409689735, 1820.7086866101492, 1877.108373522566, 1888.7827899791425, 1890.5179179309189, 1901.420066879601, 123673.0, 125298.37350813187, 129429.05856412162, 130810.3459482706, 147646.99999999892, 11841.763164736656, 11931.761364772656, 12079.97320227773, 12151.270923744603, 12284.754304913851, 13854.515091971934, 14342.641433964025, 15497.457588984556, 15509.379624814881, 15528.844711552965, 6477.578957367756, 8377.748667539983, 8409.621567029499, 8448.535330556755, 8556.18716221958, 8102.230288122619, 8118.472299300526, 8122.593870306461, 8137.104918458965, 8224.38317126206, 4260.233158031584, 4493.348464472633, 4693.718376897397, 4759.714417134983, 4899.583535399531, 1688.4765722626025, 2012.295696506211, 2043.0806137238303, 2055.5580550181785, 2068.989655051715, 1018.5874720738113, 1047.910927571165, 1050.4380156616173, 1052.484282701486, 1078.2613909472036, 20825.895870520853, 21202.04590793418, 21258.893705531373, 21402.25092121768, 21408.0, 1056.825623772069, 1058.4284486377423, 1079.4279032112993, 1080.589376037101, 1082.870055593318, 9061.456312621263, 10823.296485728402, 11215.32708037504, 11215.71960700989, 11217.887821121847, 569718.0, 573410.1329493326, 576272.0, 786538.0, 793201.0, 155165.0, 157445.0, 164967.0, 167125.0, 167215.0, 1006.8087063458066, 1008.7629407089328, 1037.9481025948671, 1063.5798859450629, 1068.6420049283577, 18339.0, 18754.531136721693, 18972.861628302348, 19002.52493687669, 19030.904845476238, 46883.53116468792, 57523.424765751806, 58866.7056664714, 59049.40950590611, 59109.40890591039, 71023.0, 84482.0, 85106.0, 86681.0, 89658.0, 8050.959745201237, 8088.0, 8283.792905177177, 8501.0, 8550.572471376281, 9225.907740922505, 12260.26438413698, 12758.48966041385, 12846.164999275017, 12886.871131288568, 9379.85930211061, 10828.891711083104, 11173.888261117285, 11326.83009754871, 11331.830022549833, 11028.669139925814, 11086.334819910831, 11087.002169804757, 11159.832602511131, 11170.720731981766, 11152.330860148417, 11205.831912521156, 11374.54501819918, 11636.767264654829, 11925.747796481592, 8346.791330216793, 8370.87443688333, 8394.874076888973, 8474.3644226682, 8487.151284871463, 9947.900520994697, 10154.0, 10169.0, 10355.068043876086, 10604.946975265075], "value": 9918.110608556322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.615191214768, 1376.8898488120951, 1441.48827166356, 1447.8769304609107, 1460.1093333066826, 7540.39676825854, 7780.377569794417, 8128.796780080494, 8569.828603427928, 8584.141585841413, 8059.838803223932, 8253.546054966975, 8322.958385208065, 8386.538740369277, 8409.78975525612, 2288.7253529576474, 2313.190383365817, 2313.35226136682, 2317.918872839451, 2318.8724620145886, 1867.9439616811517, 2071.2543484345697, 2160.7407111146604, 2254.830887683422, 2304.976950230493, 2253.5154941687533, 2326.336993956723, 2328.4528135888054, 2329.3827135809024, 2332.370260029791, 2286.2798218561265, 2296.701428814252, 2317.814574834026, 2326.685897403846, 2334.661474086248, 2313.838031337807, 2341.0, 2343.9648405273933, 2378.452955820154, 2384.3562238195764, 8441.451305665112, 8531.488110713377, 8534.914650853474, 8555.443896146731, 8564.871526927102, 5083.847484575469, 5192.636515443921, 5228.372595288552, 5238.240455133984, 5239.502247286502, 2991.7157870002534, 3332.483465062919, 3520.8591656333715, 3523.066387407339, 3566.7146628269675, 1194.337142885698, 1203.5787474383897, 1255.8179064035755, 1266.727653554481, 1268.8287081244007, 10747.570097196103, 10911.290766100177, 10918.181136414722, 10931.672049838518, 10955.452227388678, 4601.125786100697, 4690.624750019991, 4769.117713223065, 4773.09311230865, 4779.259214821708, 8742.213200811957, 8819.338549608805, 8907.153820387053, 8925.018247992715, 8926.464412135292, 5219.086659834514, 5222.582193424517, 5229.901720638709, 5232.529072383428, 5241.42344342122, 4669.673122881366, 4814.879628009257, 4851.932574833531, 4858.8785280367565, 4887.315775791392, 3430.6740859618294, 3662.754663414452, 3697.556293244774, 3751.681107105872, 3805.543334799842, 947.4930911962067, 1001.9899801002042, 1042.338115296792, 1079.1798233342715, 1158.2760774515928, 766.3677466090497, 774.4307933668749, 794.674183584739, 796.2634563029175, 800.8158123631597, 5468.671879687232, 5496.148097044965, 5585.469380408855, 5599.188117722907, 5691.089425691869, 951.167728237792, 952.8808898887639, 997.1175509673991, 1000.1148983149965, 1032.9845052324222, 3721.330160571069, 3812.275667623143, 3840.327942610032, 3863.903402414906, 3918.1967696622123, 9794.559244834, 10082.143017843418, 10145.442000689885, 10151.593936242616, 10167.23745719074, 9954.900450995397, 10045.0, 10074.899251007397, 10095.596176153018, 10118.291719579705, 7673.808154796063, 7691.269329413697, 7877.724279650185, 7900.486468379537, 7910.920890791133, 5409.1886217066185, 5413.729313534229, 5520.91718624229, 5652.434756524479, 5675.858103547444, 9208.171264586219, 9237.769055773659, 9258.907410925805, 9426.57580408897, 9428.764280893032, 9073.13805188506, 9254.25965922738, 9365.157135857806, 9413.858792117986, 9445.149936505748, 7106.253843346374, 7284.307990740871, 7298.2701729826595, 7306.671199796128, 7306.890396644161, 7699.88450173259, 7826.726064587712, 7862.331701805182, 7909.485883417559, 7947.205279472007, 6584.637844918576, 7148.678309475982, 7228.31331023552, 7286.417086633162, 7327.670254838652, 5930.229070221017, 7075.646217689198, 7116.252793456612, 7198.064251647462, 7215.422766178588, 5345.0, 6428.164338635947, 6433.260175079926, 6456.838579035561, 6528.771492997722, 4812.735299558418, 4861.343718597944, 4980.626453015966, 4989.750512474289, 5103.234514822658, 4988.875278117931, 5026.095302845523, 5031.622628302819, 5037.546620804145, 5108.055009823194], "value": 4386.178911216181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.31456879305955, 318.8373929296058, 356.7046058612825, 357.4887910288288, 359.7463788029439, 4461.8215271389145, 4569.291759777231, 5458.263134476844, 5501.807436739715, 5623.465770751777, 5290.550303224221, 5438.91841622376, 5457.426970168135, 5468.808591699291, 5521.668699878011, 3593.8382772775158, 4186.769727664977, 4213.705040647148, 4323.437953066097, 4330.501992270882, 3310.5034244863223, 4033.616806403387, 4255.382969469425, 4280.97859510702, 4316.07204451043, 3677.2829298286847, 3919.6668283195963, 4051.534073581546, 4224.408582798411, 4263.211305908401, 4214.346776249687, 4236.915261694764, 4261.339492378686, 4267.274563324242, 4273.7008409411355, 3641.617630148849, 3781.3760729479604, 3807.5430948286107, 3808.990617486368, 3815.5993620669983, 4645.303204519315, 4737.928931066037, 5068.087744206042, 5282.920756188661, 5339.038972984861, 4501.324801279801, 4575.428071491064, 4902.632302577321, 4904.6321525885705, 4905.656604037718, 4501.0, 5716.198727845977, 5743.0, 5777.508911742507, 5862.824115276549, 3481.4603736420895, 3932.4494570760116, 4102.671786257092, 4112.239235741397, 4120.423140760296, 6026.0, 6033.818985430444, 6042.486388656926, 6073.635581865102, 6153.261608606951, 3888.494495715539, 4071.8371265149653, 4205.684573656988, 4236.322188449833, 4252.85115020979, 3445.0, 3982.5021872265966, 4061.7156799024374, 4094.467719196485, 4328.415663885398, 4564.7717614119165, 4727.172744769651, 4732.674851041714, 4744.478107408182, 4793.784279707352, 4448.110377924363, 5824.970875145597, 5915.319738230159, 5940.495057920125, 5957.195778569924, 1246.9189502682298, 1247.1564832182637, 1288.8014146843338, 1320.3728229091296, 1321.0158431968052, 863.8165712973141, 888.6756333938196, 893.3523195683208, 893.5755516129786, 895.1853813030111, 5196.948030519722, 5229.294045303911, 5253.816116435906, 5272.499112584298, 5275.683458992473, 5661.264035675335, 5757.827265182052, 5768.798092066758, 5780.94219057804, 5810.302763668303, 4728.0, 4866.902661946741, 5039.77321020555, 5156.896862062813, 5252.789888404497, 2504.749525047481, 2599.77810429098, 2910.476114299404, 2960.6003189569565, 3022.9848850755607, 4799.0401919616215, 4909.165441874889, 5108.66793658411, 5529.529989950819, 5651.265335506358, 4700.88247793801, 4888.802243450306, 5700.344460387026, 6135.5398345124295, 6145.108959200891, 5028.485757121439, 6244.344343843922, 6260.937390626126, 6263.248410190807, 6276.748930042839, 5602.926917040721, 5970.552208584287, 6019.849503762441, 6037.78867739627, 6099.512039036955, 5278.785879247871, 5497.587680923867, 5868.530517558671, 5871.266091738533, 5874.206982057368, 5461.5357694596405, 6150.507959363151, 6159.81520554384, 6167.167432396569, 6172.012478003498, 3735.477033215406, 3752.0057184846582, 3960.663208706877, 3997.480327557399, 4001.3597824347967, 5594.244776955222, 5974.878917984053, 5985.760569577168, 6025.0, 6041.546883983807, 4678.742669153093, 5600.215969764155, 5731.799387021434, 5790.826275211751, 5814.505767009682, 4625.190591646516, 5529.419410961791, 5836.970815145897, 5844.970775146267, 5899.321578018411, 4843.564079232886, 5125.333706618265, 5367.954123124251, 5526.55787536988, 5756.683382414008, 4955.603551715782, 5623.903338848885, 5829.621074630305, 5901.852453688521, 5912.852178695567, 4412.3160910059, 4933.703977761345, 5012.874678133076, 5593.965116453469, 5784.855378615568], "value": 4193.8109721731425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.4741620076841, 707.7876637008897, 720.1825927572205, 788.1724189600922, 818.67662273402, 14963.476278330261, 15812.209389530506, 15850.0, 15850.524484265461, 15904.045757254558, 11684.532618695262, 14455.92772036141, 14472.059316144443, 14479.2760361982, 14540.491082812103, 670.9530332876701, 691.7440546997593, 853.4452605806244, 860.1269711243093, 870.9477431354107, 863.1799790199304, 870.0690261420283, 877.33322674767, 878.7583414560983, 885.3802338363139, 921.617528725578, 934.9252059835197, 938.3947353956694, 939.2204470289644, 942.7124726958275, 915.3455279475174, 934.3086116273943, 935.2097477631459, 938.6761567259284, 940.4733349324332, 703.1070540413697, 703.595432626242, 704.1936982155403, 704.3871831506622, 706.2407911495163, 15222.314995825214, 15476.993995390263, 15597.376104955789, 15876.444324448705, 16133.83866161335, 14472.348744306531, 14532.200728959902, 14813.407463701438, 14976.850231497654, 14978.70042599142, 11574.826377604342, 11903.047756179485, 11940.223885447418, 11974.820377694341, 12581.937090314581, 3692.7511741755866, 3703.3889408247605, 3835.390373746775, 3876.7092468065007, 3963.128111815396, 110115.0, 115375.84624153735, 116064.41967790191, 117124.0, 118077.0, 10252.692419227435, 10565.683029509128, 10850.67447976562, 10863.728406789736, 10904.836427453594, 18642.533936651693, 21434.24980125688, 21680.566388672454, 21701.891490542446, 21775.67336489954, 6348.523860710465, 7504.249575042561, 7649.235076492418, 7684.0, 7854.096778870503, 4274.957250427456, 4303.397524346594, 4309.202797482476, 4353.4122893408985, 4400.779961001937, 3514.139035936212, 3563.6080031196548, 3595.173110184672, 3602.819859007039, 3611.0, 562.4122791682702, 659.5317324699517, 660.3759447322234, 661.9007148927699, 678.7590405406108, 638.8466767975652, 645.8256270806855, 664.1764212376618, 665.0987911380107, 676.0467740485891, 9113.134252246025, 9731.367461115005, 9818.0, 9835.803283934425, 10212.131968782589, 644.7421031587403, 658.0, 671.6775947545206, 672.4452326830384, 688.8828899087167, 4524.864254072318, 4742.359781429532, 4765.69023013503, 4769.260764581495, 4783.043391321749, 99416.50291748495, 102215.0, 104199.95800041902, 105253.0, 106627.0, 58210.417895821345, 65785.6710716453, 82358.35283294301, 89622.55188724014, 91482.1703565925, 79391.0, 79429.20570794218, 81569.0, 82299.17700822915, 85289.57355213184, 9102.681406150752, 9153.221976132103, 9239.86140207884, 9248.676296329597, 9273.25813934897, 54213.728931355094, 54581.0, 54761.72619136879, 55155.72422137864, 55207.72396138154, 43921.78039109784, 63606.68196658987, 63908.0, 64246.35753642591, 67137.0, 13121.606351809462, 13388.062835601415, 13470.326483675974, 13471.3937872794, 13614.978876584493, 12281.209171512262, 14692.779608305671, 14828.925855370655, 15002.549923502313, 15475.922620386826, 10650.627228046982, 13647.11293765902, 13737.450501979809, 14124.576262712135, 14423.78364324557, 13528.188308701509, 13741.0, 14100.153990760587, 14301.713965720835, 14530.128192308495, 13272.402741876831, 13334.666633333856, 13786.65533361674, 13870.237136957565, 14293.499727509903, 10913.0, 11102.389368584805, 11416.885831141582, 11615.825762613398, 12209.633710988684, 9568.0, 11104.888951110708, 11180.04969577595, 11257.268277561932, 11258.043066339125], "value": 7522.1913280225845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 167.0, 118.0, 119.0, 119.0, 117.0, 117.0, 119.0, 117.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 136.0, 146.0, 181.0, 142.0, 112.0, 110.0, 116.0, 121.0, 140.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 203.0, 197.0, 198.0, 200.0, 199.0, 197.0, 199.0, 199.0, 241.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 85.0, 60.0, 61.0, 59.0, 54.0, 94.0, 87.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 118.0, 105.0, 78.0, 73.0, 80.0, 70.0, 70.0, 82.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 90.0, 86.0, 100.0, 89.0, 138.0, 87.0, 89.0, 86.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 96.0, 122.0, 164.0, 97.0, 125.0, 92.0, 93.0, 96.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 94.0, 93.0, 86.0, 125.0, 128.0, 139.0, 155.0, 91.0], "value": 119.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 49.0, 48.0, 96.0, 98.0, 99.0, 101.0, 64.0, 62.0, 63.0], "value": 73.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 101.0, 80.0, 67.0, 100.0, 104.0, 65.0, 103.0, 60.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 77.0, 87.0, 98.0, 108.0, 81.0, 84.0, 96.0, 78.0, 98.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 178.0, 149.0, 150.0, 153.0, 155.0, 165.0, 185.0, 144.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 168.0, 169.0, 210.0, 174.0, 172.0, 193.0, 240.0, 168.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 66.0, 76.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 67.3, "unit": "score"}]}]} 19:55:35 INFO - Return code: 0 19:55:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:55:35 ERROR - # TBPL SUCCESS # 19:55:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:55:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:55:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:55:35 INFO - 2017-02-06 19:55:35.852 screenresolution[1656:10365] starting screenresolution argv=screenresolution get 19:55:35 INFO - 2017-02-06 19:55:35.855 screenresolution[1656:10365] Display 0: 1600x1200x32@60 19:55:35 INFO - 2017-02-06 19:55:35.861 screenresolution[1657:10368] starting screenresolution argv=screenresolution list 19:55:35 INFO - Available Modes on Display 0 19:55:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:55:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:55:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:55:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:55:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:55:36 INFO - Intel Iris: 19:55:36 INFO - Chipset Model: Intel Iris 19:55:36 INFO - Type: GPU 19:55:36 INFO - Bus: Built-In 19:55:36 INFO - VRAM (Dynamic, Max): 1536 MB 19:55:36 INFO - Vendor: Intel (0x8086) 19:55:36 INFO - Device ID: 0x0a2e 19:55:36 INFO - Revision ID: 0x0009 19:55:36 INFO - Displays: 19:55:36 INFO - Display: 19:55:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:55:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:55:36 INFO - Display Serial Number: 1600x1200 60 19:55:36 INFO - Main Display: Yes 19:55:36 INFO - Mirror: Off 19:55:36 INFO - Online: Yes 19:55:36 INFO - Rotation: Supported 19:55:36 INFO - Return code: 0 19:55:36 INFO - Running post-action listener: _resource_record_post_action 19:55:36 INFO - [mozharness: 2017-02-07 03:55:36.098315Z] Finished run-tests step (success) 19:55:36 INFO - Running post-run listener: _resource_record_post_run 19:55:36 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40856064; Write bytes: 510808064; Read time: 409; Write time: 1853 19:55:36 INFO - TinderboxPrint: CPU usage
54.2% 19:55:36 INFO - TinderboxPrint: I/O read bytes / time
40,856,064 / 409 19:55:36 INFO - TinderboxPrint: I/O write bytes / time
510,808,064 / 1,853 19:55:36 INFO - TinderboxPrint: CPU idle
2,193.9 (45.8%) 19:55:36 INFO - TinderboxPrint: CPU system
970.6 (20.2%) 19:55:36 INFO - TinderboxPrint: CPU user
1,629.2 (34.0%) 19:55:36 INFO - TinderboxPrint: Swap in / out
248,049,664 / 0 19:55:36 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207544832; Write bytes: 198774784; Read time: 15985; Write time: 384 19:55:36 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36121088; Write bytes: 300937216; Read time: 370; Write time: 1431 19:55:36 INFO - Running post-run listener: _upload_blobber_files 19:55:36 INFO - Blob upload gear active. 19:55:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:55:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:55:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:55:36 INFO - (blobuploader) - INFO - Open directory for files ... 19:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:38 INFO - (blobuploader) - INFO - Done attempting. 19:55:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:55:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:39 INFO - (blobuploader) - INFO - Done attempting. 19:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:55:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:40 INFO - (blobuploader) - INFO - Done attempting. 19:55:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:55:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:55:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:42 INFO - (blobuploader) - INFO - Done attempting. 19:55:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:55:42 INFO - Return code: 0 19:55:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:55:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:55:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6036fa51a2d46b8a6bd654c6ab88bceff57f57cb0e8d9a3eb8eb5c5a25afcf6a73cf7e9bc100263c406485b929a8b82d98f91a3c39ebfe2c1285332423d13ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611f7b62200c93e9afded677ca2291decc40a232c67666326542c15da52378c753f38277459b9e1f2c492a5d292f07581f23d0ae63908feff0208249c01011a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01167edbf31e274f914482c3967c87580f73acab6f5f6ecf08b4ebaececa9a4e37388978d7be59c196c1b3297bf76f22edce39c7710bfbc651b74aca89512818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f56975ce7f3164f0bdcedce664928e7e33198fa67f96e22fcdb35b88072464cad3a9ff39af36e870afae8825fe1db5295363ab2443ec645fc2c366472c1da99"} 19:55:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:55:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:55:42 INFO - Contents: 19:55:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6036fa51a2d46b8a6bd654c6ab88bceff57f57cb0e8d9a3eb8eb5c5a25afcf6a73cf7e9bc100263c406485b929a8b82d98f91a3c39ebfe2c1285332423d13ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611f7b62200c93e9afded677ca2291decc40a232c67666326542c15da52378c753f38277459b9e1f2c492a5d292f07581f23d0ae63908feff0208249c01011a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01167edbf31e274f914482c3967c87580f73acab6f5f6ecf08b4ebaececa9a4e37388978d7be59c196c1b3297bf76f22edce39c7710bfbc651b74aca89512818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f56975ce7f3164f0bdcedce664928e7e33198fa67f96e22fcdb35b88072464cad3a9ff39af36e870afae8825fe1db5295363ab2443ec645fc2c366472c1da99"} 19:55:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:55:42 INFO - Copying logs to upload dir... 19:55:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:55:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.131874 ========= master_lag: 1.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-06 19:55:43.792508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 19:55:43.796393) ========= 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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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/6036fa51a2d46b8a6bd654c6ab88bceff57f57cb0e8d9a3eb8eb5c5a25afcf6a73cf7e9bc100263c406485b929a8b82d98f91a3c39ebfe2c1285332423d13ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611f7b62200c93e9afded677ca2291decc40a232c67666326542c15da52378c753f38277459b9e1f2c492a5d292f07581f23d0ae63908feff0208249c01011a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01167edbf31e274f914482c3967c87580f73acab6f5f6ecf08b4ebaececa9a4e37388978d7be59c196c1b3297bf76f22edce39c7710bfbc651b74aca89512818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f56975ce7f3164f0bdcedce664928e7e33198fa67f96e22fcdb35b88072464cad3a9ff39af36e870afae8825fe1db5295363ab2443ec645fc2c366472c1da99"} build_url:https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/fAFwArKzRt-HAWXidBS4kw/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/6036fa51a2d46b8a6bd654c6ab88bceff57f57cb0e8d9a3eb8eb5c5a25afcf6a73cf7e9bc100263c406485b929a8b82d98f91a3c39ebfe2c1285332423d13ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611f7b62200c93e9afded677ca2291decc40a232c67666326542c15da52378c753f38277459b9e1f2c492a5d292f07581f23d0ae63908feff0208249c01011a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01167edbf31e274f914482c3967c87580f73acab6f5f6ecf08b4ebaececa9a4e37388978d7be59c196c1b3297bf76f22edce39c7710bfbc651b74aca89512818", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f56975ce7f3164f0bdcedce664928e7e33198fa67f96e22fcdb35b88072464cad3a9ff39af36e870afae8825fe1db5295363ab2443ec645fc2c366472c1da99"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 19:55:43.834152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-02-06 19:55:43.836937) ========= 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.cY1uCbjsET/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.NXpDX0Z2lq/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005224 ========= master_lag: 2.94 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-02-06 19:55:46.786848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 19:55:46.787224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 19:55:46.792963) ========= ========= Total master_lag: 4.09 =========