builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0252 starttime: 1486486172.88 results: success (0) buildid: 20170207072756 builduid: d53d0f91353448a08f10ca46c03c9da5 revision: 9b8c5ed2e94a4311c450017696923fb52021880a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:32.884079) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:32.884563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:32.884840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:32.918182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:32.918539) ========= 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.TDPxWtjKik/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.Qse0HmXARz/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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-07 08:49:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.01M=0.001s 2017-02-07 08:49:33 (8.01 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:33.054584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:33.054893) ========= 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.TDPxWtjKik/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.Qse0HmXARz/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.020180 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:33.103262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 08:49:33.103620) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9b8c5ed2e94a4311c450017696923fb52021880a --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 9b8c5ed2e94a4311c450017696923fb52021880a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TDPxWtjKik/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.Qse0HmXARz/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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-07 08:49:33,195 truncating revision to first 12 chars 2017-02-07 08:49:33,196 Setting DEBUG logging. 2017-02-07 08:49:33,196 attempt 1/10 2017-02-07 08:49:33,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9b8c5ed2e94a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 08:49:33,998 unpacking tar archive at: mozilla-aurora-9b8c5ed2e94a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051360 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 08:49:34.178777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:34.179120) ========= script_repo_revision: 9b8c5ed2e94a4311c450017696923fb52021880a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:34.179522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:34.179819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 08:49:34.199388) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-07 08:49:34.199752) ========= /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.TDPxWtjKik/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.Qse0HmXARz/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:49:34 INFO - MultiFileLogger online at 20170207 08:49:34 in /builds/slave/test 08:49:34 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 08:49:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:34 INFO - {'append_to_log': False, 08:49:34 INFO - 'base_work_dir': '/builds/slave/test', 08:49:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:49:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:34 INFO - 'branch': 'Mozilla-Aurora', 08:49:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:34 INFO - 'config_files': ('talos/mac_config.py',), 08:49:34 INFO - 'default_actions': ('clobber', 08:49:34 INFO - 'read-buildbot-config', 08:49:34 INFO - 'download-and-extract', 08:49:34 INFO - 'populate-webroot', 08:49:34 INFO - 'create-virtualenv', 08:49:34 INFO - 'install', 08:49:34 INFO - 'run-tests'), 08:49:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:34 INFO - 'download_minidump_stackwalk': True, 08:49:34 INFO - 'download_symbols': 'ondemand', 08:49:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:34 INFO - 'installer_path': 'installer.exe', 08:49:34 INFO - 'log_level': 'info', 08:49:34 INFO - 'log_name': 'talos', 08:49:34 INFO - 'log_to_console': True, 08:49:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:34 INFO - 'opt_config_files': (), 08:49:34 INFO - 'pip_index': False, 08:49:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:34 INFO - 'cmd': ('bash', 08:49:34 INFO - '-c', 08:49:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:34 INFO - 'enabled': True, 08:49:34 INFO - 'halt_on_failure': False, 08:49:34 INFO - 'name': 'check_screen_resolution'},), 08:49:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:34 INFO - 'cmd': ('bash', 08:49:34 INFO - '-c', 08:49:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:34 INFO - 'enabled': True, 08:49:34 INFO - 'halt_on_failure': False, 08:49:34 INFO - 'name': 'check_screen_resolution'},), 08:49:34 INFO - 'run_cmd_checks_enabled': True, 08:49:34 INFO - 'sps_profile': False, 08:49:34 INFO - 'sps_profile_interval': 0, 08:49:34 INFO - 'suite': 'dromaeojs-e10s', 08:49:34 INFO - 'system_bits': '32', 08:49:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:34 INFO - 'title': 't-yosemite-r7-0252', 08:49:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:34 INFO - 'use_talos_json': True, 08:49:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:34 INFO - 'work_dir': 'build'} 08:49:34 INFO - [mozharness: 2017-02-07 16:49:34.407381Z] Running clobber step. 08:49:34 INFO - Running pre-action listener: _resource_record_pre_action 08:49:34 INFO - Running main action method: clobber 08:49:34 INFO - rmtree: /builds/slave/test/build 08:49:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:36 INFO - Running post-action listener: _resource_record_post_action 08:49:36 INFO - [mozharness: 2017-02-07 16:49:36.219327Z] Finished clobber step (success) 08:49:36 INFO - [mozharness: 2017-02-07 16:49:36.219508Z] Running read-buildbot-config step. 08:49:36 INFO - Running pre-action listener: _resource_record_pre_action 08:49:36 INFO - Running main action method: read_buildbot_config 08:49:36 INFO - Using buildbot properties: 08:49:36 INFO - { 08:49:36 INFO - "project": "", 08:49:36 INFO - "product": "firefox", 08:49:36 INFO - "script_repo_revision": "production", 08:49:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:49:36 INFO - "repository": "", 08:49:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:49:36 INFO - "buildid": "20170207072756", 08:49:36 INFO - "pgo_build": "False", 08:49:36 INFO - "basedir": "/builds/slave/test", 08:49:36 INFO - "buildnumber": 87, 08:49:36 INFO - "slavename": "t-yosemite-r7-0252", 08:49:36 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:49:36 INFO - "platform": "yosemite_r7", 08:49:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:49:36 INFO - "branch": "mozilla-aurora", 08:49:36 INFO - "repo_path": "releases/mozilla-aurora", 08:49:36 INFO - "revision": "9b8c5ed2e94a4311c450017696923fb52021880a", 08:49:36 INFO - "stage_platform": "macosx64", 08:49:36 INFO - "builduid": "d53d0f91353448a08f10ca46c03c9da5", 08:49:36 INFO - "slavebuilddir": "test" 08:49:36 INFO - } 08:49:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:49:36 INFO - Running post-action listener: _resource_record_post_action 08:49:36 INFO - [mozharness: 2017-02-07 16:49:36.223038Z] Finished read-buildbot-config step (success) 08:49:36 INFO - [mozharness: 2017-02-07 16:49:36.223177Z] Running download-and-extract step. 08:49:36 INFO - Running pre-action listener: _resource_record_pre_action 08:49:36 INFO - Running main action method: download_and_extract 08:49:36 INFO - mkdir: /builds/slave/test/build/tests 08:49: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')]} 08:49:36 INFO - trying https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:49:36 INFO - Downloading https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/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 08:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/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 08:49:36 INFO - Downloaded 1199 bytes. 08:49:36 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:49:36 INFO - Using the following test package requirements: 08:49:36 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:49:36 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:49:36 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:49:36 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'jsshell-mac.zip'], 08:49:36 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:49:36 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:49:36 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:49:36 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:49:36 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:49:36 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:49:36 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:49:36 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:49:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:49:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:49:36 INFO - Fetch https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:49:37 INFO - Expected file size: 16356899 08:49:37 INFO - Obtained file size: 16356899 08:49:44 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 08:49:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:49:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:49:44 INFO - Fetch https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:49:45 INFO - Expected file size: 16356899 08:49:45 INFO - Obtained file size: 16356899 08:49:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:49:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:49:51 INFO - Fetch https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:49:53 INFO - Expected file size: 14403485 08:49:53 INFO - Obtained file size: 14403485 08:49:53 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')]} 08:49:53 INFO - trying https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:49:53 INFO - Downloading https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/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 08:49:55 INFO - Downloaded 73817520 bytes. 08:49:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:49:55 INFO - mkdir: /builds/slave/test/properties 08:49:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:55 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:55 INFO - Contents: 08:49:55 INFO - build_url:https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - Running post-action listener: set_extra_try_arguments 08:49:56 INFO - [mozharness: 2017-02-07 16:49:56.090095Z] Finished download-and-extract step (success) 08:49:56 INFO - [mozharness: 2017-02-07 16:49:56.090231Z] Running populate-webroot step. 08:49:56 INFO - Running pre-action listener: _resource_record_pre_action 08:49:56 INFO - Running main action method: populate_webroot 08:49:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:56 INFO - '--tppagecycles', 08:49:56 INFO - '7'], 08:49:56 INFO - 'tests': ['tsvgm']}}, 08:49:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['damp', 'tps']}, 08:49:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'tests': ['damp', 'tps']}, 08:49:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['dromaeo_dom']}, 08:49:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['basic_compositor_video']}, 08:49:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:49:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['a11yr', 08:49:56 INFO - 'ts_paint', 08:49:56 INFO - 'tpaint', 08:49:56 INFO - 'sessionrestore', 08:49:56 INFO - 'sessionrestore_no_auto_restore', 08:49:56 INFO - 'tabpaint']}, 08:49:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:56 INFO - 'ts_paint', 08:49:56 INFO - 'tpaint', 08:49:56 INFO - 'sessionrestore', 08:49:56 INFO - 'sessionrestore_no_auto_restore', 08:49:56 INFO - 'tabpaint']}, 08:49:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:56 INFO - 'ts_paint', 08:49:56 INFO - 'tpaint', 08:49:56 INFO - 'sessionrestore', 08:49:56 INFO - 'sessionrestore_no_auto_restore', 08:49:56 INFO - 'tabpaint']}, 08:49:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:56 INFO - 'ts_paint', 08:49:56 INFO - 'tpaint', 08:49:56 INFO - 'sessionrestore', 08:49:56 INFO - 'sessionrestore_no_auto_restore', 08:49:56 INFO - 'tabpaint']}, 08:49:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['a11yr', 08:49:56 INFO - 'ts_paint', 08:49:56 INFO - 'tpaint', 08:49:56 INFO - 'sessionrestore', 08:49:56 INFO - 'sessionrestore_no_auto_restore', 08:49:56 INFO - 'tabpaint']}, 08:49:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['a11yr', 08:49:56 INFO - 'ts_paint', 08:49:56 INFO - 'tpaint', 08:49:56 INFO - 'sessionrestore', 08:49:56 INFO - 'sessionrestore_no_auto_restore', 08:49:56 INFO - 'tabpaint']}, 08:49:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['tsvgx', 08:49:56 INFO - 'tsvgr_opacity', 08:49:56 INFO - 'tart', 08:49:56 INFO - 'tscrollx', 08:49:56 INFO - 'cart', 08:49:56 INFO - 'tsvg_static']}, 08:49:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:56 INFO - 'tsvgr_opacity', 08:49:56 INFO - 'tart', 08:49:56 INFO - 'tscrollx', 08:49:56 INFO - 'cart', 08:49:56 INFO - 'tsvg_static']}, 08:49:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'talos_options': ['--disable-e10s'], 08:49:56 INFO - 'tests': ['tp5o']}, 08:49:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:49:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'talos_options': ['--disable-e10s', 08:49:56 INFO - '--xperf_path', 08:49:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:56 INFO - 'tests': ['tp5n']}, 08:49:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:49:56 INFO - 'talos_options': ['--xperf_path', 08:49:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:56 INFO - 'tests': ['tp5n']}}, 08:49:56 INFO - 'talos.zip': {'path': '', 08:49:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - [mozharness: 2017-02-07 16:49:56.109352Z] Finished populate-webroot step (success) 08:49:56 INFO - [mozharness: 2017-02-07 16:49:56.109499Z] Running create-virtualenv step. 08:49:56 INFO - Running pre-action listener: _resource_record_pre_action 08:49:56 INFO - Running main action method: create_virtualenv 08:49:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:56 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 08:49:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:56 INFO - Using real prefix '/tools/python27' 08:49:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:59 INFO - Installing pip.................done. 08:49:59 INFO - Return code: 0 08:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:50:00 INFO - Reading from file tmpfile_stdout 08:50:00 INFO - Output received: 08:50:00 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) 08:50:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:00 INFO - 'HOME': '/Users/cltbld', 08:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:00 INFO - 'LOGNAME': 'cltbld', 08:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:00 INFO - 'MOZ_NO_REMOTE': '1', 08:50:00 INFO - 'NO_EM_RESTART': '1', 08:50:00 INFO - 'PAGER': '/bin/cat', 08:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:00 INFO - 'PWD': '/builds/slave/test', 08:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:00 INFO - 'SHELL': '/bin/bash', 08:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:00 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:00 INFO - 'USER': 'cltbld', 08:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:00 INFO - 'XPC_FLAGS': '0x0', 08:50:00 INFO - 'XPC_SERVICE_NAME': '0', 08:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:00 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 08:50:00 INFO - Cleaning up... 08:50:00 INFO - Return code: 0 08:50:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:00 INFO - 'HOME': '/Users/cltbld', 08:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:00 INFO - 'LOGNAME': 'cltbld', 08:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:00 INFO - 'MOZ_NO_REMOTE': '1', 08:50:00 INFO - 'NO_EM_RESTART': '1', 08:50:00 INFO - 'PAGER': '/bin/cat', 08:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:00 INFO - 'PWD': '/builds/slave/test', 08:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:00 INFO - 'SHELL': '/bin/bash', 08:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:00 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:00 INFO - 'USER': 'cltbld', 08:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:00 INFO - 'XPC_FLAGS': '0x0', 08:50:00 INFO - 'XPC_SERVICE_NAME': '0', 08:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:00 INFO - Downloading/unpacking psutil>=3.1.1 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:04 INFO - Installing collected packages: psutil 08:50:04 INFO - Running setup.py install for psutil 08:50:04 INFO - building 'psutil._psutil_osx' extension 08:50:04 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 08:50:04 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 08:50:04 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 08:50:04 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 08:50:04 INFO - building 'psutil._psutil_posix' extension 08:50:04 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 08:50:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:50:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:50:05 INFO - ^ 08:50:05 INFO - 1 warning generated. 08:50:05 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 08:50:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:05 INFO - Successfully installed psutil 08:50:05 INFO - Cleaning up... 08:50:05 INFO - Return code: 0 08:50:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50:05 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')]} 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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')]} 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:05 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 08:50:05 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 08:50:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:05 INFO - 'HOME': '/Users/cltbld', 08:50:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:05 INFO - 'LOGNAME': 'cltbld', 08:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:05 INFO - 'MOZ_NO_REMOTE': '1', 08:50:05 INFO - 'NO_EM_RESTART': '1', 08:50:05 INFO - 'PAGER': '/bin/cat', 08:50:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:05 INFO - 'PWD': '/builds/slave/test', 08:50:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:05 INFO - 'SHELL': '/bin/bash', 08:50:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:05 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:05 INFO - 'USER': 'cltbld', 08:50:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:05 INFO - 'XPC_FLAGS': '0x0', 08:50:05 INFO - 'XPC_SERVICE_NAME': '0', 08:50:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50:05 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 08:50:05 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 08:50:05 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 08:50:05 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 08:50:05 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 08:50:05 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 08:50:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:08 INFO - Installing collected packages: mozsystemmonitor 08:50:08 INFO - Running setup.py install for mozsystemmonitor 08:50:08 INFO - Successfully installed mozsystemmonitor 08:50:08 INFO - Cleaning up... 08:50:08 INFO - Return code: 0 08:50:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', '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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:50: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 jsonschema==2.5.1 08:50:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:08 INFO - 'HOME': '/Users/cltbld', 08:50:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:08 INFO - 'LOGNAME': 'cltbld', 08:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:08 INFO - 'MOZ_NO_REMOTE': '1', 08:50:08 INFO - 'NO_EM_RESTART': '1', 08:50:08 INFO - 'PAGER': '/bin/cat', 08:50:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:08 INFO - 'PWD': '/builds/slave/test', 08:50:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:08 INFO - 'SHELL': '/bin/bash', 08:50:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:08 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:08 INFO - 'USER': 'cltbld', 08:50:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:08 INFO - 'XPC_FLAGS': '0x0', 08:50:08 INFO - 'XPC_SERVICE_NAME': '0', 08:50:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:50:11 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 08:50:11 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 08:50:11 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 08:50:11 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 08:50:11 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 08:50:11 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 08:50:11 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:11 INFO - warning: no files found matching '*.txt' 08:50:11 INFO - no previously-included directories found matching 'build' 08:50:11 INFO - no previously-included directories found matching 'dist' 08:50:11 INFO - no previously-included directories found matching '.git*' 08:50:11 INFO - Installing collected packages: jsonschema, functools32 08:50:11 INFO - Running setup.py install for functools32 08:50:12 INFO - warning: no files found matching '*.txt' 08:50:12 INFO - no previously-included directories found matching 'build' 08:50:12 INFO - no previously-included directories found matching 'dist' 08:50:12 INFO - no previously-included directories found matching '.git*' 08:50:12 INFO - Successfully installed jsonschema functools32 08:50:12 INFO - Cleaning up... 08:50:12 INFO - Return code: 0 08:50:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:50:12 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')]} 08:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:12 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')]} 08:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:12 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:12 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 08:50:12 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 08:50:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:12 INFO - 'HOME': '/Users/cltbld', 08:50:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:12 INFO - 'LOGNAME': 'cltbld', 08:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:12 INFO - 'MOZ_NO_REMOTE': '1', 08:50:12 INFO - 'NO_EM_RESTART': '1', 08:50:12 INFO - 'PAGER': '/bin/cat', 08:50:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:12 INFO - 'PWD': '/builds/slave/test', 08:50:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:12 INFO - 'SHELL': '/bin/bash', 08:50:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:12 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:12 INFO - 'USER': 'cltbld', 08:50:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:12 INFO - 'XPC_FLAGS': '0x0', 08:50:12 INFO - 'XPC_SERVICE_NAME': '0', 08:50:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:50:12 INFO - Cleaning up... 08:50:12 INFO - Return code: 0 08:50:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:12 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')]} 08:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:12 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')]} 08:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:12 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:12 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 08:50:12 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 08:50:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:12 INFO - 'HOME': '/Users/cltbld', 08:50:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:12 INFO - 'LOGNAME': 'cltbld', 08:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:12 INFO - 'MOZ_NO_REMOTE': '1', 08:50:12 INFO - 'NO_EM_RESTART': '1', 08:50:12 INFO - 'PAGER': '/bin/cat', 08:50:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:12 INFO - 'PWD': '/builds/slave/test', 08:50:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:12 INFO - 'SHELL': '/bin/bash', 08:50:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:12 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:12 INFO - 'USER': 'cltbld', 08:50:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:12 INFO - 'XPC_FLAGS': '0x0', 08:50:12 INFO - 'XPC_SERVICE_NAME': '0', 08:50:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:12 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 08:50:12 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 08:50:12 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 08:50:12 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 08:50:12 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 08:50:12 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 08:50:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:16 INFO - Downloading docopt-0.6.1.tar.gz 08:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:16 INFO - Running setup.py install for blobuploader 08:50:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:16 INFO - Running setup.py install for requests 08:50:17 INFO - Running setup.py install for docopt 08:50:17 INFO - Successfully installed blobuploader requests docopt 08:50:17 INFO - Cleaning up... 08:50:17 INFO - Return code: 0 08:50:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:17 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')]} 08:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:17 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')]} 08:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:17 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:17 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 08:50:17 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 08:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:17 INFO - 'HOME': '/Users/cltbld', 08:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:17 INFO - 'LOGNAME': 'cltbld', 08:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:17 INFO - 'MOZ_NO_REMOTE': '1', 08:50:17 INFO - 'NO_EM_RESTART': '1', 08:50:17 INFO - 'PAGER': '/bin/cat', 08:50:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:17 INFO - 'PWD': '/builds/slave/test', 08:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:17 INFO - 'SHELL': '/bin/bash', 08:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:17 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:17 INFO - 'USER': 'cltbld', 08:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:17 INFO - 'XPC_FLAGS': '0x0', 08:50:17 INFO - 'XPC_SERVICE_NAME': '0', 08:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:17 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-lNIeiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:17 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-F8P3Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-TLqOik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-CWgrBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-6BCX4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-vkAaoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-kXQeRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-McwslJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-XTNB_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-hSp5IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:18 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-4Icnxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:19 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-uz9CNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:19 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-BWaAWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:19 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-cPVYat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:19 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-QNrmyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:19 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-vVleFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:19 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-FnWJYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:19 INFO - Running setup.py install for manifestparser 08:50:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:19 INFO - Running setup.py install for mozcrash 08:50:19 INFO - Running setup.py install for mozdebug 08:50:20 INFO - Running setup.py install for mozdevice 08:50:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Running setup.py install for mozfile 08:50:20 INFO - Running setup.py install for mozhttpd 08:50:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Running setup.py install for mozinfo 08:50:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Running setup.py install for mozInstall 08:50:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:20 INFO - Running setup.py install for mozleak 08:50:20 INFO - Running setup.py install for mozlog 08:50:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:21 INFO - Running setup.py install for moznetwork 08:50:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:21 INFO - Running setup.py install for mozprocess 08:50:21 INFO - Running setup.py install for mozprofile 08:50:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:21 INFO - Running setup.py install for mozrunner 08:50:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:21 INFO - Running setup.py install for mozscreenshot 08:50:21 INFO - Running setup.py install for moztest 08:50:22 INFO - Running setup.py install for mozversion 08:50:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:22 INFO - Cleaning up... 08:50:22 INFO - Return code: 0 08:50:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:22 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')]} 08:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:22 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')]} 08:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:22 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:22 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 08:50:22 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 08:50:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:22 INFO - 'HOME': '/Users/cltbld', 08:50:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:22 INFO - 'LOGNAME': 'cltbld', 08:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:22 INFO - 'MOZ_NO_REMOTE': '1', 08:50:22 INFO - 'NO_EM_RESTART': '1', 08:50:22 INFO - 'PAGER': '/bin/cat', 08:50:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:22 INFO - 'PWD': '/builds/slave/test', 08:50:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:22 INFO - 'SHELL': '/bin/bash', 08:50:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:22 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:22 INFO - 'USER': 'cltbld', 08:50:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:22 INFO - 'XPC_FLAGS': '0x0', 08:50:22 INFO - 'XPC_SERVICE_NAME': '0', 08:50:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:22 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-TlWdaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:22 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)) 08:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:22 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-mVxcJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:22 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)) 08:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:22 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-RPrKo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:22 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)) 08:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:22 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-XpD6P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:22 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)) 08:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:22 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-HkY3zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-7yCOLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-epqDqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-xoEpyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-_qkcEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-mbBAEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-MkqUQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-FtP_Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-oqf6X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:23 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)) 08:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:23 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-BIukdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:24 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)) 08:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:24 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-P9sOO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:24 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)) 08:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:24 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-DefiDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:24 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)) 08:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:24 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-rWQdlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:24 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)) 08:50:24 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)) 08:50:24 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)) 08:50:24 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)) 08:50:24 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)) 08:50:24 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)) 08:50:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:26 INFO - Downloading blessings-1.6.tar.gz 08:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:27 INFO - Installing collected packages: blessings 08:50:27 INFO - Running setup.py install for blessings 08:50:27 INFO - Successfully installed blessings 08:50:27 INFO - Cleaning up... 08:50:27 INFO - Return code: 0 08:50:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:27 INFO - Reading from file tmpfile_stdout 08:50:27 INFO - Current package versions: 08:50:27 INFO - blessings == 1.6 08:50:27 INFO - blobuploader == 1.2.4 08:50:27 INFO - docopt == 0.6.1 08:50:27 INFO - functools32 == 3.2.3-2 08:50:27 INFO - jsonschema == 2.5.1 08:50:27 INFO - manifestparser == 1.1 08:50:27 INFO - mozInstall == 1.12 08:50:27 INFO - mozcrash == 1.0 08:50:27 INFO - mozdebug == 0.1 08:50:27 INFO - mozdevice == 0.49 08:50:27 INFO - mozfile == 1.2 08:50:27 INFO - mozhttpd == 0.7 08:50:27 INFO - mozinfo == 0.9 08:50:27 INFO - mozleak == 0.1 08:50:27 INFO - mozlog == 3.4 08:50:27 INFO - moznetwork == 0.27 08:50:27 INFO - mozprocess == 0.24 08:50:27 INFO - mozprofile == 0.28 08:50:27 INFO - mozrunner == 6.13 08:50:27 INFO - mozscreenshot == 0.1 08:50:27 INFO - mozsystemmonitor == 0.3 08:50:27 INFO - moztest == 0.8 08:50:27 INFO - mozversion == 1.4 08:50:27 INFO - psutil == 3.1.1 08:50:27 INFO - requests == 1.2.3 08:50:27 INFO - wsgiref == 0.1.2 08:50:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:28 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')]} 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:28 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:28 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 08:50:28 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 08:50:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:28 INFO - 'HOME': '/Users/cltbld', 08:50:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:28 INFO - 'LOGNAME': 'cltbld', 08:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:28 INFO - 'MOZ_NO_REMOTE': '1', 08:50:28 INFO - 'NO_EM_RESTART': '1', 08:50:28 INFO - 'PAGER': '/bin/cat', 08:50:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:28 INFO - 'PWD': '/builds/slave/test', 08:50:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:28 INFO - 'SHELL': '/bin/bash', 08:50:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:28 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:28 INFO - 'USER': 'cltbld', 08:50:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:28 INFO - 'XPC_FLAGS': '0x0', 08:50:28 INFO - 'XPC_SERVICE_NAME': '0', 08:50:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 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)) 08:50:28 INFO - Cleaning up... 08:50:28 INFO - Return code: 0 08:50:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:28 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')]} 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:28 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')]} 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:29 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 0x10dd39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf4b4b9c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, '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.TDPxWtjKik/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.Qse0HmXARz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 08:50:29 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 08:50:29 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 08:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:29 INFO - 'HOME': '/Users/cltbld', 08:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:29 INFO - 'LOGNAME': 'cltbld', 08:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:29 INFO - 'MOZ_NO_REMOTE': '1', 08:50:29 INFO - 'NO_EM_RESTART': '1', 08:50:29 INFO - 'PAGER': '/bin/cat', 08:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:29 INFO - 'PWD': '/builds/slave/test', 08:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:29 INFO - 'SHELL': '/bin/bash', 08:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:29 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:29 INFO - 'USER': 'cltbld', 08:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:29 INFO - 'XPC_FLAGS': '0x0', 08:50:29 INFO - 'XPC_SERVICE_NAME': '0', 08:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:29 INFO - Cleaning up... 08:50:29 INFO - Return code: 0 08:50:29 INFO - Running post-action listener: _resource_record_post_action 08:50:29 INFO - Running post-action listener: _start_resource_monitoring 08:50:29 INFO - Starting resource monitoring. 08:50:29 INFO - [mozharness: 2017-02-07 16:50:29.516918Z] Finished create-virtualenv step (success) 08:50:29 INFO - [mozharness: 2017-02-07 16:50:29.517987Z] Running install step. 08:50:29 INFO - Running pre-action listener: _resource_record_pre_action 08:50:29 INFO - Running main action method: install 08:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:29 INFO - Reading from file tmpfile_stdout 08:50:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:29 INFO - Reading from file tmpfile_stdout 08:50:29 INFO - Output received: 08:50:29 INFO - Usage: mozinstall [options] installer 08:50:29 INFO - Options: 08:50:29 INFO - -h, --help show this help message and exit 08:50:29 INFO - -d DEST, --destination=DEST 08:50:29 INFO - Directory to install application into. [default: 08:50:29 INFO - "/builds/slave/test"] 08:50:29 INFO - --app=APP Application being installed. [default: firefox] 08:50:29 INFO - mkdir: /builds/slave/test/build/application 08:50:29 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'] 08:50:29 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 08:50:49 INFO - Reading from file tmpfile_stdout 08:50:49 INFO - Output received: 08:50:49 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:50:49 INFO - Running post-action listener: _resource_record_post_action 08:50:49 INFO - [mozharness: 2017-02-07 16:50:49.775361Z] Finished install step (success) 08:50:49 INFO - [mozharness: 2017-02-07 16:50:49.775535Z] Running run-tests step. 08:50:49 INFO - Running pre-action listener: _resource_record_pre_action 08:50:49 INFO - Running main action method: run_tests 08:50:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:49 INFO - 2017-02-07 08:50:49.790 screenresolution[2180:23107] starting screenresolution argv=screenresolution get 08:50:49 INFO - 2017-02-07 08:50:49.793 screenresolution[2180:23107] Display 0: 1600x1200x32@60 08:50:49 INFO - 2017-02-07 08:50:49.798 screenresolution[2181:23110] starting screenresolution argv=screenresolution list 08:50:49 INFO - Available Modes on Display 0 08:50:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:50 INFO - Intel Iris: 08:50:50 INFO - Chipset Model: Intel Iris 08:50:50 INFO - Type: GPU 08:50:50 INFO - Bus: Built-In 08:50:50 INFO - VRAM (Dynamic, Max): 1536 MB 08:50:50 INFO - Vendor: Intel (0x8086) 08:50:50 INFO - Device ID: 0x0a2e 08:50:50 INFO - Revision ID: 0x0009 08:50:50 INFO - Displays: 08:50:50 INFO - Display: 08:50:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:50 INFO - Display Serial Number: 1600x1200 60 08:50:50 INFO - Main Display: Yes 08:50:50 INFO - Mirror: Off 08:50:50 INFO - Online: Yes 08:50:50 INFO - Rotation: Supported 08:50:50 INFO - Return code: 0 08:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:50 INFO - Python 2.7.3 08:50:50 INFO - Return code: 0 08:50:50 INFO - grabbing minidump binary from tooltool 08:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:50 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 0x10db17d30>, '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 0x10da3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db0cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:50 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 08:50:50 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 08:50:50 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 08:50:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:50 INFO - Return code: 0 08:50:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:50 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/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 08:50:50 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/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0252 --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 08:50:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TDPxWtjKik/Render', 08:50:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:50 INFO - 'HOME': '/Users/cltbld', 08:50:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:50 INFO - 'LOGNAME': 'cltbld', 08:50:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:50 INFO - 'MOZ_NO_REMOTE': '1', 08:50:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:50 INFO - 'NO_EM_RESTART': '1', 08:50:50 INFO - 'PAGER': '/bin/cat', 08:50:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:50 INFO - 'PWD': '/builds/slave/test', 08:50:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:50 INFO - 'SHELL': '/bin/bash', 08:50:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qse0HmXARz/Listeners', 08:50:50 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 08:50:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:50 INFO - 'USER': 'cltbld', 08:50:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:50 INFO - 'XPC_FLAGS': '0x0', 08:50:50 INFO - 'XPC_SERVICE_NAME': '0', 08:50:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:50 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/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 08:50:50 INFO - mozversion application_buildid: 20170207072756 08:50:50 INFO - mozversion application_changeset: 9b8c5ed2e94a4311c450017696923fb52021880a 08:50:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:50:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:50 INFO - mozversion application_name: Firefox 08:50:50 INFO - mozversion application_remotingname: firefox-dev 08:50:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:50 INFO - mozversion application_vendor: Mozilla 08:50:50 INFO - mozversion application_version: 53.0a2 08:50:50 INFO - mozversion platform_buildid: 20170207072756 08:50:50 INFO - mozversion platform_changeset: 9b8c5ed2e94a4311c450017696923fb52021880a 08:50:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:50 INFO - mozversion platform_version: 53.0a2 08:50:50 INFO - using testdate: 1486486250 08:50:50 INFO - actual date: 1486486250 08:50:50 INFO - starting webserver on 'localhost:55996' 08:50:50 INFO - SUITE-START | Running 2 tests 08:50:50 INFO - TEST-START | dromaeo_css 08:50:50 INFO - operating with platform_type : mac_ 08:50:50 INFO - Initialising browser for dromaeo_css test... 08:50:50 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpcEn8qD/profile http://localhost:55996/getInfo.html) 08:50:53 INFO - PROCESS | 2191 | 2017-02-07 08:50:53.386 plugin-container[2193:23281] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904b, name = 'com.apple.tsm.portname' 08:50:53 INFO - PROCESS | 2191 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:50:53 INFO - PROCESS | 2191 | 2017-02-07 08:50:53.391 plugin-container[2193:23281] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 08:50:53 INFO - PROCESS | 2191 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:50:53 INFO - PROCESS | 2191 | 2017-02-07 08:50:53.391 plugin-container[2193:23281] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:50:53 INFO - PROCESS | 2191 | __metrics Screen width/height:1600/1200 08:50:53 INFO - PROCESS | 2191 | colorDepth:24 08:50:53 INFO - PROCESS | 2191 | Browser inner width/height: 1024/689 08:50:53 INFO - PROCESS | 2191 | __metrics 08:50:53 ERROR - PROCESS | 2191 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:50:53 INFO - PROCESS | 2191 | 1486486253543 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/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpcEn8qD/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpcEn8qD/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpcEn8qD/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpcEn8qD/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:50:54 INFO - TEST-INFO | 2191: exit 0 08:50:54 INFO - Browser initialized. 08:50:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:54 INFO - TEST-INFO | started process 2194 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpcEn8qD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:56 INFO - PROCESS | 2194 | 2017-02-07 08:50:56.694 plugin-container[2195:23403] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 08:50:56 INFO - PROCESS | 2194 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:50:56 INFO - PROCESS | 2194 | 2017-02-07 08:50:56.695 plugin-container[2195:23403] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 08:50:56 INFO - PROCESS | 2194 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:50:56 INFO - PROCESS | 2194 | 2017-02-07 08:50:56.695 plugin-container[2195:23403] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:51:06 INFO - PROCESS | 2194 | RSS: Main: 219070464 08:51:06 INFO - PROCESS | 2194 | 08:54:08 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:55996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55996/tests/dromaeo/cssquery-ext.html) 08:54:10 INFO - PROCESS | 2194 | RSS: Main: 240406528 08:54:10 INFO - PROCESS | 2194 | 08:55:54 INFO - PROCESS | 2194 | ************************* 08:55:54 INFO - PROCESS | 2194 | A coding exception was thrown and uncaught in a Task. 08:55:54 INFO - PROCESS | 2194 | 08:55:54 ERROR - PROCESS | 2194 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:55:54 INFO - PROCESS | 2194 | Full stack: 08:55:54 INFO - PROCESS | 2194 | ************************* 08:57:12 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:55996/tests/dromaeo/cssquery-ext.html (next: http://localhost:55996/tests/dromaeo/cssquery-jquery.html) 08:57:13 INFO - PROCESS | 2194 | RSS: Main: 246190080 08:57:13 INFO - PROCESS | 2194 | 09:00:15 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:55996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55996/tests/dromaeo/cssquery-mootools.html) 09:00:16 INFO - PROCESS | 2194 | RSS: Main: 253456384 09:00:16 INFO - PROCESS | 2194 | 09:03:17 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:55996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55996/tests/dromaeo/cssquery-prototype.html) 09:03:18 INFO - PROCESS | 2194 | RSS: Main: 250396672 09:03:18 INFO - PROCESS | 2194 | 09:06:21 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:55996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55996/tests/dromaeo/cssquery-yui.html) 09:06:22 INFO - PROCESS | 2194 | RSS: Main: 254427136 09:06:22 INFO - PROCESS | 2194 | 09:09:24 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:55996/tests/dromaeo/cssquery-yui.html (next: http://localhost:55996/tests/dromaeo/cssquery-dojo.html) 09:09:24 INFO - PROCESS | 2194 | RSS: Main: 255639552 09:09:24 INFO - PROCESS | 2194 | 09:09:24 INFO - PROCESS | 2194 | __start_tp_report 09:09:24 INFO - PROCESS | 2194 | _x_x_mozilla_page_load 09:09:25 INFO - PROCESS | 2194 | _x_x_mozilla_page_load_details 09:09:25 INFO - PROCESS | 2194 | |i|pagename|runs| 09:09:25 INFO - PROCESS | 2194 | |0;dojo.html;2818.1122946271935;3374.645662205469;3388.7289016878653;3409.7954122752635;3420.5040269160972;4525.456945166577;5734.713264336782;5809.854753631162;5813.970930145343;5836.182934389183;5760.56795740319;5868.149118377833;5868.882622347551;5870.823875283738;5892.351841297454;3917.7257591968573;4422.982713975787;4447.444069491314;5272.789088436468;5300.09898317285;4395.582419670126;5170.379554453452;5316.229146773716;5364.624476286662;5409.702466364349;5201.063808514466;5208.76560554774;5332.066888294552;5334.439883812202;5345.7594408251725;5241.8951620967555;5251.291075704788;5275.709835959021;5345.064613692627;5354.089804733205;4489;4624.976875115636;4901.901961960776;5089.134847076006;5246.213068039787;4310.741355518679;5540.2243685884005;5740.08158694611;5917.20117784098;5929.733162007677;5060.924086138711;6125.693326622233;6152.046432802923;6210.161628180228;6259.217597800275;6224.688765561749;6234.750609975596;6241.906371404432;6247.156633854417;6250.43746062852;5913.994620914455;5927.229460170151;5967.104934259809;5979.5640191425855;6020.036794112921;6113.4154954094565;6124.846878828065;6193.349698281706;6214;6215.192025036717;6015.127806468037;6101.450869421773;6102.206713127265;6108.633481991006;6134.846628834315;5187.948120518822;6103.206583144251;6177.907331390033;6182.845428864314;6197.380261973766;6096;6104.236970378703;6114.875284800388;6143.6928153593035;6143.6928153593035;6155;6162.599431036968;6166.9383306167265;6167.938320616826;6245.781397651061;4338.132373525307;5039.3448851649055;5047.217681259411;5052.722100284446;5068.239764035424;4428.158649856517;4437.733735975852;4453.732776033448;4518.480374756879;4530.524294948983;5905;5907.675077870758;5989.101634754822;5995.250593675791;6026.517878569792;6190.3190649028575;6193.287771906288;6206.317305096436;6210.347913469111;6226.315105338409;5773.134029895549;5859.003969325225;5934.0802175661975;5961.7615295387695;6000.0999850022845;5518.33779946409;5519.337679478488;5536.031194540939;5538.6122971391615;5556.861078473071;6341.492680585542;6351.9047214290895;6356.046593011085;6361.173047503702;6368.745250189941;6085.117657939485;6124.3809352984035;6129.908051379144;6150.723217455135;6196.938030619816;6377.426031657174;6378.872422551616;6382.457491113121;6395.776147834804;6403.423691867754;6140.815775526741;6179.876402472015;6182.876342473035;6197.1324014638885;6205.782797602063;6078.179445774941;6137.96931015342;6202.4417802398;6203.4416902479;6226.533010024357;6116.17431646722;6163.568550201443;6172.351903050115;6182.041783523561;6190.41191086846;6083.847903802441;6152.78465253714;6162.383761623802;6168.25980882297;6181.011038233861;4752.310914917249;4901.877453063702;5840.737166827588;6025.698715064317;6060.060690592965;5127.717975511383;6009.639421634716;6120.663363515049;6127.264728232641;6194.845128871634;4958.57852082577;6014.218151640259;6055.939440605537;6062.120992455981;6087.8128764890425 09:09:25 INFO - PROCESS | 2194 | |1;ext.html;451.25768111456654;490.5192910947272;493.8098831949698;530.1279395394577;559.0858945623904;31078;41107.17785644285;41210.58789412105;41353.58646413535;41382.7930860346;41940.95147621311;42249;42445.575544244624;42449.575504244945;42513.7874310628;9051.275897928183;9250;9300.116488933574;9455.432674039545;9476.005019472925;11105;11186.496607652634;11203.551857925673;11230.438478076105;11233.66299011031;11171.83242251367;11187.608433704821;11192.44037798111;11220.775584488305;11222.326660400402;11086.334819910831;11144;11149.665510034712;11149.665510034712;11157.442127893573;11029.062529684987;11086.501107450184;11092.001719845171;11105.167112466517;11118.833217501744;35038;35368;35375.82312088449;35464.46803297952;35560.822195889115;3933.9016524586827;3944.704147188944;3954.8813535593977;3963.1083006323634;3996.460477835484;27682.169534913784;28073;29179.270518237;29306.560401593993;29446.11661650154;3145.653978062411;3189.744820414361;3383.8308084595674;3388.932221355584;3394.1853955050856;464028;464587;465421;466957;468982;57261.42738572561;57627.711861440424;57674.711626441596;57743.422565773806;57789.71105144447;59496.40503594995;59729.80540389255;59992.70003649954;59993.40006599965;60002.699986499785;15473.148976806384;15744.842551574338;15965.962212456154;15975.760363594556;16020.919895400448;11258.09935205198;11440.084793216523;12274.38628068593;12501.624951251477;12507.812382814265;17595.91202044007;17711.82288177102;17713.29146834138;17843.197056132507;17874.910625446788;8011.759647210593;8189.918100819034;8210.671573137128;8211.917880821115;8244.29923456501;857.8069934264865;868.7741187291224;878.4539210988706;898.2230370729403;909.2453263791037;25888.8705556471;29288.853555732512;30215.395692086036;30495;30891.073267802003;1057.3285963413289;1063.3726101600093;1081.086481922774;1114.543037354697;1205.9638210853689;12669.683257918441;15751.763723544156;15883.52349429519;15898.966567173096;16155.11146886909;582097;584062;585557;588348;588535;61135.38864611386;61650.075248871304;61747.6912615443;61955.690221548604;61971.69014154901;1424.3732757586629;1441.099312929419;1464.3849583175092;1466.8679818816145;1470.1913947328926;29290.853545732134;29581.85209073941;29876;30222.979971948083;30531.54202686917;50496.24255636095;50745.23882141845;50840;51024.48975510346;51031;531205;534487;535521;535562;537225;23222;24211.273661790176;24498.142565010137;24901.630410327605;26451.338716532242;45798;47183.29225061558;47292;47709;48123.55629331126;31684.36631267408;38706;38890;38955.80522097485;39825.80087099546;32720.018399448054;36460.270794583426;38580.614193858826;39198.516585948964;39993;28524.57213141763;36464.635353646125;37652.81173594115;37720;38294.2341153181;24929.626055609544;31593.684063159075;34193.31613367768;34436.65563344335;34683;25173.622395664446;25235.74764252334;25306.36734081589;25770;25774.355641109123 09:09:25 INFO - PROCESS | 2194 | |2;jquery.html;330.950357446383;387.6549870615153;400.7916380742111;405.98376064957404;416.5522063781434;16181.757273640906;19080.90459547702;21310.573788524238;21561.99999999998;22160.556788864214;18495.537611559717;19929.50176245591;21184.046717897694;21785.782142178614;21789.782102178975;5603.971980140093;5776.249087618604;5856;6041.3052498962525;6143.293521245069;3933.3903244996927;4127.463429754128;4547.204239258133;6054.6367217966845;6102.542309326796;5771.249737534135;6031.607945483552;6097.390260973912;6099.054646529773;6112.724927378256;6081.54388420868;6104.725287362057;6380.234371875358;6606.1412016438035;6671.699773510204;5973.283206015306;5977.312609049972;5978.432048955342;5994.6403215807195;6000.459958603703;13294;13334.333283335794;13490.662733431645;13578.728425431535;13646.317684115853;2625.960610590843;2673.8930442782266;2674.8930042798265;2682.4769170011855;2737.2472570043196;10087.2434567407;10131.240156988255;10193.476175247848;10467.89847796872;10555.366677999267;1800.5048611631776;1824.6806808808406;1852.3424184414607;1860.5720684242565;1863.3757691173473;109010.45494772555;131261;140571;140754.29622851923;141728;11909.821352679717;12027.458764355624;12326.691832704075;12335.876641233473;12338.753224935452;15636.2963666633;15777.68444631101;15814.367425302858;15828.92085539588;15844.970076945192;8713.607887644945;8876.644934202559;8905.376623636414;8910.910890891138;8993.595288212045;8639.222469977733;8665.913340866511;8678.088800675965;8787.297016238686;8869.822603547893;4812.1578723723205;4838.250071238964;4842.322074909515;4844.612431005511;4895.583875370562;1689.6451745133413;2016.1935225909754;2063.690446433047;2072.958540829175;2074.854760166804;905.764501229685;981.9656312029044;1015.7714514234239;1059.86751656043;1089.743910181107;19946;21314.254001109886;21426.678599821014;21638.567228655338;21738;915.4781774388667;974.2254907348674;1002.8595996560488;1002.9648962286285;1009.4649835587151;6660.800175994728;6772.322767723188;6998.6150761708595;7001.824954376181;7029.0862187915245;624441;730375;760577;761610;780300;106649.93350066555;109035.36446953301;131869;155619;159366;938.6104766521953;1074.0977578833817;1099.1536516882115;1106.7841770854607;1108.684025052856;12112.333821639895;12130.211536250115;12335.753284934071;12553.054276587143;12554.246745195318;58555;59546.51133721518;59768;61034.253458595354;61827.6908615454;88995.55502222448;91752;92270.53864730902;92443;94311.05688943023;12484.12611117213;12513.812292815797;13029;13401.53094641683;13450.394732237268;13989.790153147915;14013.369398377301;14393.568192954228;14444.783328250294;14577.344019518934;5745.2818397700285;7288.234735352712;8135.877961830459;11058.447077645924;11784.932479034098;8731.214190722865;11640.592579259684;11721.824172637247;11922;12246.326452045223;10447.94776026115;12052.939735301268;12094.818577721517;12154.331511766937;12223.44994475233;11580.478878450322;13272.27002514871;13400.731985360044;13728.93135534316;13784.172949623055;11867.881321186678;12062.819057714318;12175.817362739388;12224.388780561114;12265.38673066361 09:09:25 INFO - PROCESS | 2194 | |3;mootools.html;1118.9328640281583;1187.2223693480773;1193.206517665752;1265.4621785741058;1267.4613289352023;7323.633818309077;7572.318491335779;7889.763307100789;8338.166183381667;8352.373571982103;7830.8042298942555;8130.715424960127;8147.022357317115;8222.588870556463;8241.217084376989;2274.3404412720292;2310.7111611048617;2315.513742114158;2322.814174866007;2328.0687724910085;2085.1138266236862;2287.256641591481;2329.26628112145;2334.9066037358484;2348.812095032402;2072.5958438104576;2243.663450482424;2313.410080429488;2325.5930212212793;2327.453048533593;2167.219800871685;2178.6514157734764;2187.147012665062;2201.042546492281;2201.2625770366785;2266.8299877509253;2296.724393072842;2315.0045480443405;2317.4438134847514;2322.0247496051697;8140.837183256302;8166.632501537445;8253.422260441772;8255.587220638945;8261.297789687884;4580.862574122782;4995.500449955011;5030.496950304977;5180.585553155738;5181.300524429192;3436.329915666446;3445.13871532117;3503.667151620592;3519.454484554898;3574.8391322390553;1151.6257216404701;1189.2745425290566;1204.7831390349734;1242.2298175131477;1254;10479.84280235797;10510.159187265;10636.095931845724;10662.946685266601;10694.572217111307;4058.8985275367763;4143.254214241466;4227.97886010568;4455.2426087564545;4538.205813982606;8460.365472589581;8550.657973680984;8560.743177704679;8565.18630730092;8569.442986205877;5082.593392528589;5083.974580127149;5088.0587091388215;5090.261912022736;5098.515641014098;4591.9540804591525;4636.809858838488;4654.976725116353;4671.089137618132;4728.17256980034;3298.1365528476335;3661.212839239576;3673.045008297808;3714.665680088751;3746.7002639788752;1056.3186744549723;1166.381817636654;1176.611718133014;1178.7112157521462;1182.9231099978647;784.6625950841079;877.7805548612847;899.9775005624912;901.3330135699536;942.6794889737522;4721.220998535272;5385.973070134624;5491.341039075257;5494.09347457665;5569.136783798518;925.842606756853;970.7573106723319;973.956171972263;978.5792109393029;994.3089552760762;3569.446735755962;3646.4348026056005;3733.0853940784136;3758.642928921748;3809.8095095245126;9504.382215155993;9753;9824.95087524572;9835.950820245853;9836.852447213298;9744.366616169926;9747;9749.463779492196;9816.803663926681;9882.80234395308;7188.928110718826;7650.923490765021;7726.884096738553;7752.418568607377;7766.611669416507;4823.686460380064;5360.919586206288;5485.232067510472;5669.801556945487;5785.3636100028125;7252.347288743827;8366.205210504992;9130.726078217664;9141.268698504236;9271.072892710676;7690;9084.818303634023;9187.586558605013;9229.723108306762;9368.297377696836;5303.4696530346655;7084.25615310385;7089.432845372461;7189.604571748604;7196.316349946746;7236.878283866009;7573.697052117854;7760.262775036363;7777.883331749915;7786.649600767866;6337.2395312562785;7015.789526314219;7029.3673569379;7057.682404291922;7157.534760240567;6906.171259448898;6963.373296403348;6963.9303606963285;6982.441404687715;7047.436205103477;6330.841728956629;6337.397947195009;6350.7777227796805;6406.487481001602;6416.647084410402;4233.936490952699;4904.411470623548;4961.454240033666;4995.975020124876;5042.294078828893;4888.584470320063;4902.313676085422;5011.2232603944985;5093.516115968977;5107.310513080686 09:09:25 INFO - PROCESS | 2194 | |4;prototype.html;313.4984025559105;355.8078637535729;364.84129403709386;368.1752873563216;372.5027088836403;4970.6520543561965;5154.4072431670365;5296.9735151324285;5316.946830531693;5445.1832225166245;5128.307678463407;5266.394364648067;5332.706701131446;5338.626296159261;5373.119408207125;4221.24017676818;4221.641160501361;4222.662187025038;4223.324268117102;4241.557870324089;3992.141689536749;4177.791110444466;4256.638185754199;4257.723247988886;4274.487061552618;3615.7107431405557;4162.8126734296875;4166.145940082276;4192.7484350938885;4192.958070419288;4185.121124563845;4186.120914607936;4188.246115699173;4209.431726716915;4216.388623649554;3173.397434295689;3733.2346868891814;3739.5325584301963;3772.2078363543687;3789.886303410902;4549.656926682761;4874.926876096862;5203.947960520384;5216.9739151304;5242.816501422432;3479.599846017715;4520.660950428731;4631.698939568917;4659.394278743742;4692.788824502872;5595.936772013345;5616.887662246773;5674.773009079632;5679.841660169151;5690.2887139107615;3621.619729928372;3807.7905715185652;3873.573906870242;3891.9416208756893;3902.902427439337;5010.924836127461;5939.227900372967;5949.405059494059;5972.850678733023;5998.730057147439;3917.373220284741;3926.6845606721495;3932.488776459042;3938.03518138058;3947.131631041166;3839.6928245740273;3939.7242193046786;3983.820728067244;3994.484853329052;4024.436578878959;4034.919301613951;4611.5619016193405;4633.698809577367;4636.4899861015265;4637.188492013884;4750.097481478508;5676.829695109153;5708.80019199326;5728.1407788831175;5750.338711048199;1100.9174311926638;1213.9863214216227;1221.908356873238;1225.6200577820905;1249.5126900508808;723.1719680965265;851.6295411496019;873.6199753107419;874.0865795243985;876.4741155306765;4304.945288404361;4583.816647334136;5007.874803129878;5034.896559304156;5035.370578677665;4773.71357718538;5287.471252874759;5308.23030660552;5511.397982684503;5547.5007249346945;4314.50383205929;4460.565364669186;4571.634269258451;4630.513796051433;4764.2615394613895;2686.8849427487767;2733.152722655983;2748.7526122649056;2888.5412866502284;2922.4885645012037;5159.297431847556;5709.714514274269;5721.313442386857;5725.51333136688;5753.827385178452;4776.880577985578;5522.834314970557;5616.118600268874;5629.043062679354;5757.424257574209;5471.589630777628;5701.572382071361;5704.657720536781;5721.5708821838525;5740.6268592541355;4541.682082254342;5118.820841270538;5151.871203219949;5454.063807348334;5493.610279528418;4667.883302917454;4902.63230257725;4906.411230652202;5147.613928955268;5185.470286265636;5140.922886156785;5265.368155821173;5685.147227915846;5727.226824378656;5757.568182386254;3172.6510083891217;3328.983355083209;3459.41189997696;3471.531343268626;3739.738218324691;4986.850394488171;5043.621728370314;5163.263470360715;5218.608604354765;5476.342838859203;4311.504177019683;5415.323084614423;5449.99175152598;5461.42655021233;5606.803761868315;4806.639502037431;5142.460041695717;5587.323802859045;5592.804251851166;5624.634398764068;4850.587700045395;4890.731009794496;5251.474852514718;5485;5505.971715556348;4549.363089167586;5256.185291279858;5588.30146231721;5649.519790817826;5677.240055582783;4433.689641725048;5386.353637563518;5407.026735187546;5503.944960550503;5517.393086760373 09:09:25 INFO - PROCESS | 2194 | |5;yui.html;697.4873468001022;714.1929619529931;734.537241537831;745.3157941621876;751.2640986071345;14900.701985960275;15699.450519231828;15705.371785128582;15727.370905163809;15770.684586308282;13500.459981600725;14305.213213273291;14490;14491.855081449183;14515.927420362883;633.4837107757163;705.4532737128715;876.2157868707535;877.4691311756392;879.2745984562729;860.2515811244195;867.9262262707678;876.4346996187455;876.9079246679103;878.4860856399014;918.2516249256868;919.3197034194682;921.272194965976;923.9769005774842;924.6301479408223;907.3285768531273;911.3438324406417;912.899581046081;913.1051569461898;916.3677062826662;674.6660403100448;680.0309558878578;686.2519853359862;688.0607970120799;689.5207830557764;12077.57728479499;12728;13551.661208469866;13710.862891371158;13914.234717090556;11841.171118021743;12019.579314723942;12062.095342849234;12083.637490875288;12315.322657253848;10574.78850422995;10817.513211905483;10858.782824343549;10947;11271.380074095921;3566.5720113586535;3587.8744243951337;3644.908877278063;3647.708183345326;3726.8322925468146;108011.37982930183;108272;108781;110089;111062.44468777685;9321.673741419017;10200.38797672142;10572.52423640938;10724.892751072546;11050.115990720724;21200.893995529925;21467.141314347562;21676.783232167476;21700.565988680137;21766.782332176794;7452.614865535399;7550.35821955129;7620.428467864932;7780.105287891852;7802.804929876685;4227.852025179104;4247.256730072225;4319.4816622005565;4354.085642015149;4375.496817865923;3436.1581412554083;3517.4547945068557;3533.717302615785;3536.717062634983;3543.7696549724187;624.65643895858;632.8544434780026;637.7704026550438;653.7842511971133;656.4617014048434;653.2128784814288;656.7734131724548;657.1555551116792;662.3826000988631;683.5795985468901;9472.668456604124;9670.70987870365;9688.370255933483;9756.170725488271;9923.866368730613;648.9001143062463;679.1951537428164;679.7790718016664;682.1234713393266;682.4301708073814;4471.321421794303;4837.080954618682;5349.537395333488;5503.284573005483;5580.135079062752;91906.54046729724;104453.43319850208;106480;107410.46294768476;108060;67069;69185.65407172932;69362;73721.6313918427;77556;70125.99999999898;71251;72307.91538126933;79291.60354198192;80793.19206807857;8929.821403572023;10026.849597256192;10504.961675677161;10675.199360048182;10729.731756706145;46635;48855;49243;49258.872286072394;52880.471195289094;64156;65510.672446637465;68384;69556.6522167386;70664.29335706578;12843.29361885068;12851.971842252784;13112.344382781013;13233.139845909986;13424;13924.443022278996;14499.565013049625;14500.492482763053;14596.927015364856;14943.839812716187;13284.933575332061;13576.389062492013;13596.11625244356;13644.454221831016;14231.928840355731;11053.28153670009;12884.680757463371;13319;13573.52492662752;13598.660033499242;10439.425831579336;10825.927784097375;13165.341732913124;13398.129121607064;14031.01782875189;9970.877825544227;10674.199435042248;10714;11043;11310.377929213972;9984.650537231162;10376.68869933873;10465.005824446665;10512.369257844553;10664.786704266027 09:09:25 INFO - PROCESS | 2194 | __end_tp_report 09:09:25 INFO - PROCESS | 2194 | __start_cc_report 09:09:25 INFO - PROCESS | 2194 | _x_x_mozilla_cycle_collect,379 09:09:25 INFO - PROCESS | 2194 | __end_cc_report 09:09:25 INFO - PROCESS | 2194 | __startTimestamp1486487364997__endTimestamp 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | ------- Summary: start ------- 09:09:25 INFO - PROCESS | 2194 | Number of tests: 6 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | [#0] dojo.html Cycles:165 Average:5694.61 Median:6015.13 stddev:710.44 (11.8%) stddev-sans-first:675.83 09:09:25 INFO - PROCESS | 2194 | Values: 2818.1 3374.6 3388.7 3409.8 3420.5 4525.5 5734.7 5809.9 5814.0 5836.2 5760.6 5868.1 5868.9 5870.8 5892.4 3917.7 4423.0 4447.4 5272.8 5300.1 4395.6 5170.4 5316.2 5364.6 5409.7 5201.1 5208.8 5332.1 5334.4 5345.8 5241.9 5251.3 5275.7 5345.1 5354.1 4489.0 4625.0 4901.9 5089.1 5246.2 4310.7 5540.2 5740.1 5917.2 5929.7 5060.9 6125.7 6152.0 6210.2 6259.2 6224.7 6234.8 6241.9 6247.2 6250.4 5914.0 5927.2 5967.1 5979.6 6020.0 6113.4 6124.8 6193.3 6214.0 6215.2 6015.1 6101.5 6102.2 6108.6 6134.8 5187.9 6103.2 6177.9 6182.8 6197.4 6096.0 6104.2 6114.9 6143.7 6143.7 6155.0 6162.6 6166.9 6167.9 6245.8 4338.1 5039.3 5047.2 5052.7 5068.2 4428.2 4437.7 4453.7 4518.5 4530.5 5905.0 5907.7 5989.1 5995.3 6026.5 6190.3 6193.3 6206.3 6210.3 6226.3 5773.1 5859.0 5934.1 5961.8 6000.1 5518.3 5519.3 5536.0 5538.6 5556.9 6341.5 6351.9 6356.0 6361.2 6368.7 6085.1 6124.4 6129.9 6150.7 6196.9 6377.4 6378.9 6382.5 6395.8 6403.4 6140.8 6179.9 6182.9 6197.1 6205.8 6078.2 6138.0 6202.4 6203.4 6226.5 6116.2 6163.6 6172.4 6182.0 6190.4 6083.8 6152.8 6162.4 6168.3 6181.0 4752.3 4901.9 5840.7 6025.7 6060.1 5127.7 6009.6 6120.7 6127.3 6194.8 4958.6 6014.2 6055.9 6062.1 6087.8 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | [#1] ext.html Cycles:180 Average:66543.92 Median:35371.91 stddev:141576.69 (400.3%) stddev-sans-first:141886.88 09:09:25 INFO - PROCESS | 2194 | Values: 451.3 490.5 493.8 530.1 559.1 31078.0 41107.2 41210.6 41353.6 41382.8 41941.0 42249.0 42445.6 42449.6 42513.8 9051.3 9250.0 9300.1 9455.4 9476.0 11105.0 11186.5 11203.6 11230.4 11233.7 11171.8 11187.6 11192.4 11220.8 11222.3 11086.3 11144.0 11149.7 11149.7 11157.4 11029.1 11086.5 11092.0 11105.2 11118.8 35038.0 35368.0 35375.8 35464.5 35560.8 3933.9 3944.7 3954.9 3963.1 3996.5 27682.2 28073.0 29179.3 29306.6 29446.1 3145.7 3189.7 3383.8 3388.9 3394.2 464028.0 464587.0 465421.0 466957.0 468982.0 57261.4 57627.7 57674.7 57743.4 57789.7 59496.4 59729.8 59992.7 59993.4 60002.7 15473.1 15744.8 15966.0 15975.8 16020.9 11258.1 11440.1 12274.4 12501.6 12507.8 17595.9 17711.8 17713.3 17843.2 17874.9 8011.8 8189.9 8210.7 8211.9 8244.3 857.8 868.8 878.5 898.2 909.2 25888.9 29288.9 30215.4 30495.0 30891.1 1057.3 1063.4 1081.1 1114.5 1206.0 12669.7 15751.8 15883.5 15899.0 16155.1 582097.0 584062.0 585557.0 588348.0 588535.0 61135.4 61650.1 61747.7 61955.7 61971.7 1424.4 1441.1 1464.4 1466.9 1470.2 29290.9 29581.9 29876.0 30223.0 30531.5 50496.2 50745.2 50840.0 51024.5 51031.0 531205.0 534487.0 535521.0 535562.0 537225.0 23222.0 24211.3 24498.1 24901.6 26451.3 45798.0 47183.3 47292.0 47709.0 48123.6 31684.4 38706.0 38890.0 38955.8 39825.8 32720.0 36460.3 38580.6 39198.5 39993.0 28524.6 36464.6 37652.8 37720.0 38294.2 24929.6 31593.7 34193.3 34436.7 34683.0 25173.6 25235.7 25306.4 25770.0 25774.4 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | [#2] jquery.html Cycles:180 Average:39655.40 Median:11629.45 stddev:122018.62 (1049.2%) stddev-sans-first:122325.19 09:09:25 INFO - PROCESS | 2194 | Values: 331.0 387.7 400.8 406.0 416.6 16181.8 19080.9 21310.6 21562.0 22160.6 18495.5 19929.5 21184.0 21785.8 21789.8 5604.0 5776.2 5856.0 6041.3 6143.3 3933.4 4127.5 4547.2 6054.6 6102.5 5771.2 6031.6 6097.4 6099.1 6112.7 6081.5 6104.7 6380.2 6606.1 6671.7 5973.3 5977.3 5978.4 5994.6 6000.5 13294.0 13334.3 13490.7 13578.7 13646.3 2626.0 2673.9 2674.9 2682.5 2737.2 10087.2 10131.2 10193.5 10467.9 10555.4 1800.5 1824.7 1852.3 1860.6 1863.4 109010.5 131261.0 140571.0 140754.3 141728.0 11909.8 12027.5 12326.7 12335.9 12338.8 15636.3 15777.7 15814.4 15828.9 15845.0 8713.6 8876.6 8905.4 8910.9 8993.6 8639.2 8665.9 8678.1 8787.3 8869.8 4812.2 4838.3 4842.3 4844.6 4895.6 1689.6 2016.2 2063.7 2073.0 2074.9 905.8 982.0 1015.8 1059.9 1089.7 19946.0 21314.3 21426.7 21638.6 21738.0 915.5 974.2 1002.9 1003.0 1009.5 6660.8 6772.3 6998.6 7001.8 7029.1 624441.0 730375.0 760577.0 761610.0 780300.0 106649.9 109035.4 131869.0 155619.0 159366.0 938.6 1074.1 1099.2 1106.8 1108.7 12112.3 12130.2 12335.8 12553.1 12554.2 58555.0 59546.5 59768.0 61034.3 61827.7 88995.6 91752.0 92270.5 92443.0 94311.1 12484.1 12513.8 13029.0 13401.5 13450.4 13989.8 14013.4 14393.6 14444.8 14577.3 5745.3 7288.2 8135.9 11058.4 11784.9 8731.2 11640.6 11721.8 11922.0 12246.3 10447.9 12052.9 12094.8 12154.3 12223.4 11580.5 13272.3 13400.7 13728.9 13784.2 11867.9 12062.8 12175.8 12224.4 12265.4 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | [#3] mootools.html Cycles:180 Average:5275.09 Median:5180.94 stddev:2861.89 (55.2%) stddev-sans-first:2852.87 09:09:25 INFO - PROCESS | 2194 | Values: 1118.9 1187.2 1193.2 1265.5 1267.5 7323.6 7572.3 7889.8 8338.2 8352.4 7830.8 8130.7 8147.0 8222.6 8241.2 2274.3 2310.7 2315.5 2322.8 2328.1 2085.1 2287.3 2329.3 2334.9 2348.8 2072.6 2243.7 2313.4 2325.6 2327.5 2167.2 2178.7 2187.1 2201.0 2201.3 2266.8 2296.7 2315.0 2317.4 2322.0 8140.8 8166.6 8253.4 8255.6 8261.3 4580.9 4995.5 5030.5 5180.6 5181.3 3436.3 3445.1 3503.7 3519.5 3574.8 1151.6 1189.3 1204.8 1242.2 1254.0 10479.8 10510.2 10636.1 10662.9 10694.6 4058.9 4143.3 4228.0 4455.2 4538.2 8460.4 8550.7 8560.7 8565.2 8569.4 5082.6 5084.0 5088.1 5090.3 5098.5 4592.0 4636.8 4655.0 4671.1 4728.2 3298.1 3661.2 3673.0 3714.7 3746.7 1056.3 1166.4 1176.6 1178.7 1182.9 784.7 877.8 900.0 901.3 942.7 4721.2 5386.0 5491.3 5494.1 5569.1 925.8 970.8 974.0 978.6 994.3 3569.4 3646.4 3733.1 3758.6 3809.8 9504.4 9753.0 9825.0 9836.0 9836.9 9744.4 9747.0 9749.5 9816.8 9882.8 7188.9 7650.9 7726.9 7752.4 7766.6 4823.7 5360.9 5485.2 5669.8 5785.4 7252.3 8366.2 9130.7 9141.3 9271.1 7690.0 9084.8 9187.6 9229.7 9368.3 5303.5 7084.3 7089.4 7189.6 7196.3 7236.9 7573.7 7760.3 7777.9 7786.6 6337.2 7015.8 7029.4 7057.7 7157.5 6906.2 6963.4 6963.9 6982.4 7047.4 6330.8 6337.4 6350.8 6406.5 6416.6 4233.9 4904.4 4961.5 4996.0 5042.3 4888.6 4902.3 5011.2 5093.5 5107.3 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | [#4] prototype.html Cycles:180 Average:4461.78 Median:4904.52 stddev:1345.26 (27.4%) stddev-sans-first:1312.51 09:09:25 INFO - PROCESS | 2194 | Values: 313.5 355.8 364.8 368.2 372.5 4970.7 5154.4 5297.0 5316.9 5445.2 5128.3 5266.4 5332.7 5338.6 5373.1 4221.2 4221.6 4222.7 4223.3 4241.6 3992.1 4177.8 4256.6 4257.7 4274.5 3615.7 4162.8 4166.1 4192.7 4193.0 4185.1 4186.1 4188.2 4209.4 4216.4 3173.4 3733.2 3739.5 3772.2 3789.9 4549.7 4874.9 5203.9 5217.0 5242.8 3479.6 4520.7 4631.7 4659.4 4692.8 5595.9 5616.9 5674.8 5679.8 5690.3 3621.6 3807.8 3873.6 3891.9 3902.9 5010.9 5939.2 5949.4 5972.9 5998.7 3917.4 3926.7 3932.5 3938.0 3947.1 3839.7 3939.7 3983.8 3994.5 4024.4 4034.9 4611.6 4633.7 4636.5 4637.2 4750.1 5676.8 5708.8 5728.1 5750.3 1100.9 1214.0 1221.9 1225.6 1249.5 723.2 851.6 873.6 874.1 876.5 4304.9 4583.8 5007.9 5034.9 5035.4 4773.7 5287.5 5308.2 5511.4 5547.5 4314.5 4460.6 4571.6 4630.5 4764.3 2686.9 2733.2 2748.8 2888.5 2922.5 5159.3 5709.7 5721.3 5725.5 5753.8 4776.9 5522.8 5616.1 5629.0 5757.4 5471.6 5701.6 5704.7 5721.6 5740.6 4541.7 5118.8 5151.9 5454.1 5493.6 4667.9 4902.6 4906.4 5147.6 5185.5 5140.9 5265.4 5685.1 5727.2 5757.6 3172.7 3329.0 3459.4 3471.5 3739.7 4986.9 5043.6 5163.3 5218.6 5476.3 4311.5 5415.3 5450.0 5461.4 5606.8 4806.6 5142.5 5587.3 5592.8 5624.6 4850.6 4890.7 5251.5 5485.0 5506.0 4549.4 5256.2 5588.3 5649.5 5677.2 4433.7 5386.4 5407.0 5503.9 5517.4 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - PROCESS | 2194 | [#5] yui.html Cycles:180 Average:19795.61 Median:4237.55 stddev:28587.07 (674.6%) stddev-sans-first:28631.30 09:09:25 INFO - PROCESS | 2194 | Values: 697.5 714.2 734.5 745.3 751.3 14900.7 15699.5 15705.4 15727.4 15770.7 13500.5 14305.2 14490.0 14491.9 14515.9 633.5 705.5 876.2 877.5 879.3 860.3 867.9 876.4 876.9 878.5 918.3 919.3 921.3 924.0 924.6 907.3 911.3 912.9 913.1 916.4 674.7 680.0 686.3 688.1 689.5 12077.6 12728.0 13551.7 13710.9 13914.2 11841.2 12019.6 12062.1 12083.6 12315.3 10574.8 10817.5 10858.8 10947.0 11271.4 3566.6 3587.9 3644.9 3647.7 3726.8 108011.4 108272.0 108781.0 110089.0 111062.4 9321.7 10200.4 10572.5 10724.9 11050.1 21200.9 21467.1 21676.8 21700.6 21766.8 7452.6 7550.4 7620.4 7780.1 7802.8 4227.9 4247.3 4319.5 4354.1 4375.5 3436.2 3517.5 3533.7 3536.7 3543.8 624.7 632.9 637.8 653.8 656.5 653.2 656.8 657.2 662.4 683.6 9472.7 9670.7 9688.4 9756.2 9923.9 648.9 679.2 679.8 682.1 682.4 4471.3 4837.1 5349.5 5503.3 5580.1 91906.5 104453.4 106480.0 107410.5 108060.0 67069.0 69185.7 69362.0 73721.6 77556.0 70126.0 71251.0 72307.9 79291.6 80793.2 8929.8 10026.8 10505.0 10675.2 10729.7 46635.0 48855.0 49243.0 49258.9 52880.5 64156.0 65510.7 68384.0 69556.7 70664.3 12843.3 12852.0 13112.3 13233.1 13424.0 13924.4 14499.6 14500.5 14596.9 14943.8 13284.9 13576.4 13596.1 13644.5 14231.9 11053.3 12884.7 13319.0 13573.5 13598.7 10439.4 10825.9 13165.3 13398.1 14031.0 9970.9 10674.2 10714.0 11043.0 11310.4 9984.7 10376.7 10465.0 10512.4 10664.8 09:09:25 INFO - PROCESS | 2194 | -------- Summary: end -------- 09:09:25 INFO - PROCESS | 2194 | 09:09:25 INFO - TEST-INFO | 2194: exit 0 09:09:25 INFO - TEST-OK | dromaeo_css | took 1115238ms 09:09:25 INFO - TEST-START | kraken 09:09:25 INFO - operating with platform_type : mac_ 09:09:25 INFO - Initialising browser for kraken test... 09:09:25 INFO - TEST-INFO | started process 2198 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3CywoT/profile http://localhost:55996/getInfo.html) 09:09:28 INFO - PROCESS | 2198 | 2017-02-07 09:09:28.253 plugin-container[2199:25321] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 09:09:28 INFO - PROCESS | 2198 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:09:28 INFO - PROCESS | 2198 | 2017-02-07 09:09:28.256 plugin-container[2199:25321] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 09:09:28 INFO - PROCESS | 2198 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:09:28 INFO - PROCESS | 2198 | 2017-02-07 09:09:28.256 plugin-container[2199:25321] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:09:28 INFO - PROCESS | 2198 | __metrics Screen width/height:1600/1200 09:09:28 INFO - PROCESS | 2198 | colorDepth:24 09:09:28 INFO - PROCESS | 2198 | Browser inner width/height: 1024/689 09:09:28 INFO - PROCESS | 2198 | __metrics 09:09:28 ERROR - PROCESS | 2198 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:09:28 INFO - PROCESS | 2198 | 1486487368416 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/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3CywoT/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3CywoT/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3CywoT/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3CywoT/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:09:29 INFO - TEST-INFO | 2198: exit 0 09:09:29 INFO - Browser initialized. 09:09:29 INFO - Running cycle 1/1 for kraken test... 09:09:29 INFO - TEST-INFO | started process 2200 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3CywoT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:31 INFO - PROCESS | 2200 | 2017-02-07 09:09:31.647 plugin-container[2201:25449] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 09:09:31 INFO - PROCESS | 2200 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:09:31 INFO - PROCESS | 2200 | 2017-02-07 09:09:31.647 plugin-container[2201:25449] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 09:09:31 INFO - PROCESS | 2200 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:09:31 INFO - PROCESS | 2200 | 2017-02-07 09:09:31.648 plugin-container[2201:25449] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:09:41 INFO - PROCESS | 2200 | RSS: Main: 218660864 09:09:41 INFO - PROCESS | 2200 | 09:09:44 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55996/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:45 INFO - PROCESS | 2200 | RSS: Main: 233197568 09:09:45 INFO - PROCESS | 2200 | 09:09:48 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55996/tests/kraken/driver.html?testName=audio-dft) 09:09:48 INFO - PROCESS | 2200 | RSS: Main: 241000448 09:09:48 INFO - PROCESS | 2200 | 09:09:51 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55996/tests/kraken/driver.html?testName=audio-fft) 09:09:52 INFO - PROCESS | 2200 | RSS: Main: 244580352 09:09:52 INFO - PROCESS | 2200 | 09:09:54 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55996/tests/kraken/driver.html?testName=audio-oscillator) 09:09:55 INFO - PROCESS | 2200 | RSS: Main: 245792768 09:09:55 INFO - PROCESS | 2200 | 09:09:57 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:57 INFO - PROCESS | 2200 | RSS: Main: 246452224 09:09:57 INFO - PROCESS | 2200 | 09:10:00 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55996/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:01 INFO - PROCESS | 2200 | RSS: Main: 250224640 09:10:01 INFO - PROCESS | 2200 | 09:10:04 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55996/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:04 INFO - PROCESS | 2200 | RSS: Main: 249475072 09:10:04 INFO - PROCESS | 2200 | 09:10:07 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55996/tests/kraken/driver.html?testName=json-parse-financial) 09:10:08 INFO - PROCESS | 2200 | RSS: Main: 249593856 09:10:08 INFO - PROCESS | 2200 | 09:10:10 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:10 INFO - PROCESS | 2200 | RSS: Main: 248856576 09:10:10 INFO - PROCESS | 2200 | 09:10:12 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:13 INFO - PROCESS | 2200 | RSS: Main: 248942592 09:10:13 INFO - PROCESS | 2200 | 09:10:15 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:16 INFO - PROCESS | 2200 | RSS: Main: 248979456 09:10:16 INFO - PROCESS | 2200 | 09:10:19 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:20 INFO - PROCESS | 2200 | RSS: Main: 249421824 09:10:20 INFO - PROCESS | 2200 | 09:10:23 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:23 INFO - PROCESS | 2200 | RSS: Main: 249290752 09:10:23 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | Cycle 1(1): loaded http://localhost:55996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55996/tests/kraken/driver.html?testName=ai-astar) 09:10:25 INFO - PROCESS | 2200 | RSS: Main: 251273216 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | __start_tp_report 09:10:25 INFO - PROCESS | 2200 | _x_x_mozilla_page_load 09:10:25 INFO - PROCESS | 2200 | _x_x_mozilla_page_load_details 09:10:25 INFO - PROCESS | 2200 | |i|pagename|runs| 09:10:25 INFO - PROCESS | 2200 | |0;ai-astar;123;172;159;117;120;119;119;133;171;159 09:10:25 INFO - PROCESS | 2200 | |1;audio-beat-detection;152;114;115;151;114;115;97;132;165;145 09:10:25 INFO - PROCESS | 2200 | |2;audio-dft;197;199;194;197;190;200;196;196;201;197 09:10:25 INFO - PROCESS | 2200 | |3;audio-fft;83;62;62;92;64;61;76;81;73;60 09:10:25 INFO - PROCESS | 2200 | |4;audio-oscillator;90;72;87;73;72;72;82;70;70;84 09:10:25 INFO - PROCESS | 2200 | |5;imaging-gaussian-blur;90;88;92;89;90;88;91;87;91;89 09:10:25 INFO - PROCESS | 2200 | |6;imaging-darkroom;96;97;97;97;99;109;121;96;96;97 09:10:25 INFO - PROCESS | 2200 | |7;imaging-desaturate;145;145;93;95;77;150;148;95;95;94 09:10:25 INFO - PROCESS | 2200 | |8;json-parse-financial;61;61;60;62;63;65;62;64;63;62 09:10:25 INFO - PROCESS | 2200 | |9;json-stringify-tinderbox;70;72;76;77;75;71;73;73;104;62 09:10:25 INFO - PROCESS | 2200 | |10;stanford-crypto-aes;87;87;85;77;102;79;101;104;106;104 09:10:25 INFO - PROCESS | 2200 | |11;stanford-crypto-ccm;142;173;147;125;149;152;170;160;202;183 09:10:25 INFO - PROCESS | 2200 | |12;stanford-crypto-pbkdf2;189;166;161;217;164;215;231;170;176;173 09:10:25 INFO - PROCESS | 2200 | |13;stanford-crypto-sha256-iterative;68;68;67;68;63;82;85;84;73;68 09:10:25 INFO - PROCESS | 2200 | __end_tp_report 09:10:25 INFO - PROCESS | 2200 | __start_cc_report 09:10:25 INFO - PROCESS | 2200 | _x_x_mozilla_cycle_collect,940 09:10:25 INFO - PROCESS | 2200 | __end_cc_report 09:10:25 INFO - PROCESS | 2200 | __startTimestamp1486487425880__endTimestamp 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | ------- Summary: start ------- 09:10:25 INFO - PROCESS | 2200 | Number of tests: 14 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#0] ai-astar Cycles:10 Average:139.20 Median:146.00 stddev:23.21 (15.9%) stddev-sans-first:23.87 09:10:25 INFO - PROCESS | 2200 | Values: 123.0 172.0 159.0 117.0 120.0 119.0 119.0 133.0 171.0 159.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:148.00 stddev:22.19 (15.0%) stddev-sans-first:22.06 09:10:25 INFO - PROCESS | 2200 | Values: 152.0 114.0 115.0 151.0 114.0 115.0 97.0 132.0 165.0 145.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#2] audio-dft Cycles:10 Average:196.70 Median:197.00 stddev:3.13 (1.6%) stddev-sans-first:3.32 09:10:25 INFO - PROCESS | 2200 | Values: 197.0 199.0 194.0 197.0 190.0 200.0 196.0 196.0 201.0 197.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#3] audio-fft Cycles:10 Average:71.40 Median:74.50 stddev:11.28 (15.1%) stddev-sans-first:11.15 09:10:25 INFO - PROCESS | 2200 | Values: 83.0 62.0 62.0 92.0 64.0 61.0 76.0 81.0 73.0 60.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:7.69 (9.9%) stddev-sans-first:6.61 09:10:25 INFO - PROCESS | 2200 | Values: 90.0 72.0 87.0 73.0 72.0 72.0 82.0 70.0 70.0 84.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:90.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 09:10:25 INFO - PROCESS | 2200 | Values: 90.0 88.0 92.0 89.0 90.0 88.0 91.0 87.0 91.0 89.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:97.00 stddev:8.20 (8.4%) stddev-sans-first:8.53 09:10:25 INFO - PROCESS | 2200 | Values: 96.0 97.0 97.0 97.0 99.0 109.0 121.0 96.0 96.0 97.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#7] imaging-desaturate Cycles:10 Average:113.70 Median:93.50 stddev:29.19 (31.2%) stddev-sans-first:28.67 09:10:25 INFO - PROCESS | 2200 | Values: 145.0 145.0 93.0 95.0 77.0 150.0 148.0 95.0 95.0 94.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.50 stddev:1.49 (2.4%) stddev-sans-first:1.51 09:10:25 INFO - PROCESS | 2200 | Values: 61.0 61.0 60.0 62.0 63.0 65.0 62.0 64.0 63.0 62.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#9] json-stringify-tinderbox Cycles:10 Average:75.30 Median:73.00 stddev:10.91 (15.0%) stddev-sans-first:11.41 09:10:25 INFO - PROCESS | 2200 | Values: 70.0 72.0 76.0 77.0 75.0 71.0 73.0 73.0 104.0 62.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:78.00 stddev:11.27 (14.5%) stddev-sans-first:11.73 09:10:25 INFO - PROCESS | 2200 | Values: 87.0 87.0 85.0 77.0 102.0 79.0 101.0 104.0 106.0 104.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#11] stanford-crypto-ccm Cycles:10 Average:160.30 Median:165.00 stddev:22.27 (13.5%) stddev-sans-first:22.62 09:10:25 INFO - PROCESS | 2200 | Values: 142.0 173.0 147.0 125.0 149.0 152.0 170.0 160.0 202.0 183.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:182.50 stddev:25.54 (14.0%) stddev-sans-first:27.07 09:10:25 INFO - PROCESS | 2200 | Values: 189.0 166.0 161.0 217.0 164.0 215.0 231.0 170.0 176.0 173.0 09:10:25 INFO - PROCESS | 2200 | 09:10:25 INFO - PROCESS | 2200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:70.50 stddev:8.03 (11.4%) stddev-sans-first:8.34 09:10:25 INFO - PROCESS | 2200 | Values: 68.0 68.0 67.0 68.0 63.0 82.0 85.0 84.0 73.0 68.0 09:10:25 INFO - PROCESS | 2200 | -------- Summary: end -------- 09:10:25 INFO - PROCESS | 2200 | 09:10:26 INFO - TEST-INFO | 2200: exit 0 09:10:26 INFO - TEST-OK | kraken | took 61263ms 09:10:26 INFO - SUITE-END | took 1176s 09:10:27 INFO - Completed test suite (00:19:36) 09:10:27 INFO - javascript benchmark 09:10:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7211.678724367879, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2818.1122946271935, 3374.645662205469, 3388.7289016878653, 3409.7954122752635, 3420.5040269160972, 4525.456945166577, 5734.713264336782, 5809.854753631162, 5813.970930145343, 5836.182934389183, 5760.56795740319, 5868.149118377833, 5868.882622347551, 5870.823875283738, 5892.351841297454, 3917.7257591968573, 4422.982713975787, 4447.444069491314, 5272.789088436468, 5300.09898317285, 4395.582419670126, 5170.379554453452, 5316.229146773716, 5364.624476286662, 5409.702466364349, 5201.063808514466, 5208.76560554774, 5332.066888294552, 5334.439883812202, 5345.7594408251725, 5241.8951620967555, 5251.291075704788, 5275.709835959021, 5345.064613692627, 5354.089804733205, 4489.0, 4624.976875115636, 4901.901961960776, 5089.134847076006, 5246.213068039787, 4310.741355518679, 5540.2243685884005, 5740.08158694611, 5917.20117784098, 5929.733162007677, 5060.924086138711, 6125.693326622233, 6152.046432802923, 6210.161628180228, 6259.217597800275, 6224.688765561749, 6234.750609975596, 6241.906371404432, 6247.156633854417, 6250.43746062852, 5913.994620914455, 5927.229460170151, 5967.104934259809, 5979.5640191425855, 6020.036794112921, 6113.4154954094565, 6124.846878828065, 6193.349698281706, 6214.0, 6215.192025036717, 6015.127806468037, 6101.450869421773, 6102.206713127265, 6108.633481991006, 6134.846628834315, 5187.948120518822, 6103.206583144251, 6177.907331390033, 6182.845428864314, 6197.380261973766, 6096.0, 6104.236970378703, 6114.875284800388, 6143.6928153593035, 6143.6928153593035, 6155.0, 6162.599431036968, 6166.9383306167265, 6167.938320616826, 6245.781397651061, 4338.132373525307, 5039.3448851649055, 5047.217681259411, 5052.722100284446, 5068.239764035424, 4428.158649856517, 4437.733735975852, 4453.732776033448, 4518.480374756879, 4530.524294948983, 5905.0, 5907.675077870758, 5989.101634754822, 5995.250593675791, 6026.517878569792, 6190.3190649028575, 6193.287771906288, 6206.317305096436, 6210.347913469111, 6226.315105338409, 5773.134029895549, 5859.003969325225, 5934.0802175661975, 5961.7615295387695, 6000.0999850022845, 5518.33779946409, 5519.337679478488, 5536.031194540939, 5538.6122971391615, 5556.861078473071, 6341.492680585542, 6351.9047214290895, 6356.046593011085, 6361.173047503702, 6368.745250189941, 6085.117657939485, 6124.3809352984035, 6129.908051379144, 6150.723217455135, 6196.938030619816, 6377.426031657174, 6378.872422551616, 6382.457491113121, 6395.776147834804, 6403.423691867754, 6140.815775526741, 6179.876402472015, 6182.876342473035, 6197.1324014638885, 6205.782797602063, 6078.179445774941, 6137.96931015342, 6202.4417802398, 6203.4416902479, 6226.533010024357, 6116.17431646722, 6163.568550201443, 6172.351903050115, 6182.041783523561, 6190.41191086846, 6083.847903802441, 6152.78465253714, 6162.383761623802, 6168.25980882297, 6181.011038233861, 4752.310914917249, 4901.877453063702, 5840.737166827588, 6025.698715064317, 6060.060690592965, 5127.717975511383, 6009.639421634716, 6120.663363515049, 6127.264728232641, 6194.845128871634, 4958.57852082577, 6014.218151640259, 6055.939440605537, 6062.120992455981, 6087.8128764890425], "value": 5649.497165417937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.25768111456654, 490.5192910947272, 493.8098831949698, 530.1279395394577, 559.0858945623904, 31078.0, 41107.17785644285, 41210.58789412105, 41353.58646413535, 41382.7930860346, 41940.95147621311, 42249.0, 42445.575544244624, 42449.575504244945, 42513.7874310628, 9051.275897928183, 9250.0, 9300.116488933574, 9455.432674039545, 9476.005019472925, 11105.0, 11186.496607652634, 11203.551857925673, 11230.438478076105, 11233.66299011031, 11171.83242251367, 11187.608433704821, 11192.44037798111, 11220.775584488305, 11222.326660400402, 11086.334819910831, 11144.0, 11149.665510034712, 11149.665510034712, 11157.442127893573, 11029.062529684987, 11086.501107450184, 11092.001719845171, 11105.167112466517, 11118.833217501744, 35038.0, 35368.0, 35375.82312088449, 35464.46803297952, 35560.822195889115, 3933.9016524586827, 3944.704147188944, 3954.8813535593977, 3963.1083006323634, 3996.460477835484, 27682.169534913784, 28073.0, 29179.270518237, 29306.560401593993, 29446.11661650154, 3145.653978062411, 3189.744820414361, 3383.8308084595674, 3388.932221355584, 3394.1853955050856, 464028.0, 464587.0, 465421.0, 466957.0, 468982.0, 57261.42738572561, 57627.711861440424, 57674.711626441596, 57743.422565773806, 57789.71105144447, 59496.40503594995, 59729.80540389255, 59992.70003649954, 59993.40006599965, 60002.699986499785, 15473.148976806384, 15744.842551574338, 15965.962212456154, 15975.760363594556, 16020.919895400448, 11258.09935205198, 11440.084793216523, 12274.38628068593, 12501.624951251477, 12507.812382814265, 17595.91202044007, 17711.82288177102, 17713.29146834138, 17843.197056132507, 17874.910625446788, 8011.759647210593, 8189.918100819034, 8210.671573137128, 8211.917880821115, 8244.29923456501, 857.8069934264865, 868.7741187291224, 878.4539210988706, 898.2230370729403, 909.2453263791037, 25888.8705556471, 29288.853555732512, 30215.395692086036, 30495.0, 30891.073267802003, 1057.3285963413289, 1063.3726101600093, 1081.086481922774, 1114.543037354697, 1205.9638210853689, 12669.683257918441, 15751.763723544156, 15883.52349429519, 15898.966567173096, 16155.11146886909, 582097.0, 584062.0, 585557.0, 588348.0, 588535.0, 61135.38864611386, 61650.075248871304, 61747.6912615443, 61955.690221548604, 61971.69014154901, 1424.3732757586629, 1441.099312929419, 1464.3849583175092, 1466.8679818816145, 1470.1913947328926, 29290.853545732134, 29581.85209073941, 29876.0, 30222.979971948083, 30531.54202686917, 50496.24255636095, 50745.23882141845, 50840.0, 51024.48975510346, 51031.0, 531205.0, 534487.0, 535521.0, 535562.0, 537225.0, 23222.0, 24211.273661790176, 24498.142565010137, 24901.630410327605, 26451.338716532242, 45798.0, 47183.29225061558, 47292.0, 47709.0, 48123.55629331126, 31684.36631267408, 38706.0, 38890.0, 38955.80522097485, 39825.80087099546, 32720.018399448054, 36460.270794583426, 38580.614193858826, 39198.516585948964, 39993.0, 28524.57213141763, 36464.635353646125, 37652.81173594115, 37720.0, 38294.2341153181, 24929.626055609544, 31593.684063159075, 34193.31613367768, 34436.65563344335, 34683.0, 25173.622395664446, 25235.74764252334, 25306.36734081589, 25770.0, 25774.355641109123], "value": 19954.643289747335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.950357446383, 387.6549870615153, 400.7916380742111, 405.98376064957404, 416.5522063781434, 16181.757273640906, 19080.90459547702, 21310.573788524238, 21561.99999999998, 22160.556788864214, 18495.537611559717, 19929.50176245591, 21184.046717897694, 21785.782142178614, 21789.782102178975, 5603.971980140093, 5776.249087618604, 5856.0, 6041.3052498962525, 6143.293521245069, 3933.3903244996927, 4127.463429754128, 4547.204239258133, 6054.6367217966845, 6102.542309326796, 5771.249737534135, 6031.607945483552, 6097.390260973912, 6099.054646529773, 6112.724927378256, 6081.54388420868, 6104.725287362057, 6380.234371875358, 6606.1412016438035, 6671.699773510204, 5973.283206015306, 5977.312609049972, 5978.432048955342, 5994.6403215807195, 6000.459958603703, 13294.0, 13334.333283335794, 13490.662733431645, 13578.728425431535, 13646.317684115853, 2625.960610590843, 2673.8930442782266, 2674.8930042798265, 2682.4769170011855, 2737.2472570043196, 10087.2434567407, 10131.240156988255, 10193.476175247848, 10467.89847796872, 10555.366677999267, 1800.5048611631776, 1824.6806808808406, 1852.3424184414607, 1860.5720684242565, 1863.3757691173473, 109010.45494772555, 131261.0, 140571.0, 140754.29622851923, 141728.0, 11909.821352679717, 12027.458764355624, 12326.691832704075, 12335.876641233473, 12338.753224935452, 15636.2963666633, 15777.68444631101, 15814.367425302858, 15828.92085539588, 15844.970076945192, 8713.607887644945, 8876.644934202559, 8905.376623636414, 8910.910890891138, 8993.595288212045, 8639.222469977733, 8665.913340866511, 8678.088800675965, 8787.297016238686, 8869.822603547893, 4812.1578723723205, 4838.250071238964, 4842.322074909515, 4844.612431005511, 4895.583875370562, 1689.6451745133413, 2016.1935225909754, 2063.690446433047, 2072.958540829175, 2074.854760166804, 905.764501229685, 981.9656312029044, 1015.7714514234239, 1059.86751656043, 1089.743910181107, 19946.0, 21314.254001109886, 21426.678599821014, 21638.567228655338, 21738.0, 915.4781774388667, 974.2254907348674, 1002.8595996560488, 1002.9648962286285, 1009.4649835587151, 6660.800175994728, 6772.322767723188, 6998.6150761708595, 7001.824954376181, 7029.0862187915245, 624441.0, 730375.0, 760577.0, 761610.0, 780300.0, 106649.93350066555, 109035.36446953301, 131869.0, 155619.0, 159366.0, 938.6104766521953, 1074.0977578833817, 1099.1536516882115, 1106.7841770854607, 1108.684025052856, 12112.333821639895, 12130.211536250115, 12335.753284934071, 12553.054276587143, 12554.246745195318, 58555.0, 59546.51133721518, 59768.0, 61034.253458595354, 61827.6908615454, 88995.55502222448, 91752.0, 92270.53864730902, 92443.0, 94311.05688943023, 12484.12611117213, 12513.812292815797, 13029.0, 13401.53094641683, 13450.394732237268, 13989.790153147915, 14013.369398377301, 14393.568192954228, 14444.783328250294, 14577.344019518934, 5745.2818397700285, 7288.234735352712, 8135.877961830459, 11058.447077645924, 11784.932479034098, 8731.214190722865, 11640.592579259684, 11721.824172637247, 11922.0, 12246.326452045223, 10447.94776026115, 12052.939735301268, 12094.818577721517, 12154.331511766937, 12223.44994475233, 11580.478878450322, 13272.27002514871, 13400.731985360044, 13728.93135534316, 13784.172949623055, 11867.881321186678, 12062.819057714318, 12175.817362739388, 12224.388780561114, 12265.38673066361], "value": 9806.748853288875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1118.9328640281583, 1187.2223693480773, 1193.206517665752, 1265.4621785741058, 1267.4613289352023, 7323.633818309077, 7572.318491335779, 7889.763307100789, 8338.166183381667, 8352.373571982103, 7830.8042298942555, 8130.715424960127, 8147.022357317115, 8222.588870556463, 8241.217084376989, 2274.3404412720292, 2310.7111611048617, 2315.513742114158, 2322.814174866007, 2328.0687724910085, 2085.1138266236862, 2287.256641591481, 2329.26628112145, 2334.9066037358484, 2348.812095032402, 2072.5958438104576, 2243.663450482424, 2313.410080429488, 2325.5930212212793, 2327.453048533593, 2167.219800871685, 2178.6514157734764, 2187.147012665062, 2201.042546492281, 2201.2625770366785, 2266.8299877509253, 2296.724393072842, 2315.0045480443405, 2317.4438134847514, 2322.0247496051697, 8140.837183256302, 8166.632501537445, 8253.422260441772, 8255.587220638945, 8261.297789687884, 4580.862574122782, 4995.500449955011, 5030.496950304977, 5180.585553155738, 5181.300524429192, 3436.329915666446, 3445.13871532117, 3503.667151620592, 3519.454484554898, 3574.8391322390553, 1151.6257216404701, 1189.2745425290566, 1204.7831390349734, 1242.2298175131477, 1254.0, 10479.84280235797, 10510.159187265, 10636.095931845724, 10662.946685266601, 10694.572217111307, 4058.8985275367763, 4143.254214241466, 4227.97886010568, 4455.2426087564545, 4538.205813982606, 8460.365472589581, 8550.657973680984, 8560.743177704679, 8565.18630730092, 8569.442986205877, 5082.593392528589, 5083.974580127149, 5088.0587091388215, 5090.261912022736, 5098.515641014098, 4591.9540804591525, 4636.809858838488, 4654.976725116353, 4671.089137618132, 4728.17256980034, 3298.1365528476335, 3661.212839239576, 3673.045008297808, 3714.665680088751, 3746.7002639788752, 1056.3186744549723, 1166.381817636654, 1176.611718133014, 1178.7112157521462, 1182.9231099978647, 784.6625950841079, 877.7805548612847, 899.9775005624912, 901.3330135699536, 942.6794889737522, 4721.220998535272, 5385.973070134624, 5491.341039075257, 5494.09347457665, 5569.136783798518, 925.842606756853, 970.7573106723319, 973.956171972263, 978.5792109393029, 994.3089552760762, 3569.446735755962, 3646.4348026056005, 3733.0853940784136, 3758.642928921748, 3809.8095095245126, 9504.382215155993, 9753.0, 9824.95087524572, 9835.950820245853, 9836.852447213298, 9744.366616169926, 9747.0, 9749.463779492196, 9816.803663926681, 9882.80234395308, 7188.928110718826, 7650.923490765021, 7726.884096738553, 7752.418568607377, 7766.611669416507, 4823.686460380064, 5360.919586206288, 5485.232067510472, 5669.801556945487, 5785.3636100028125, 7252.347288743827, 8366.205210504992, 9130.726078217664, 9141.268698504236, 9271.072892710676, 7690.0, 9084.818303634023, 9187.586558605013, 9229.723108306762, 9368.297377696836, 5303.4696530346655, 7084.25615310385, 7089.432845372461, 7189.604571748604, 7196.316349946746, 7236.878283866009, 7573.697052117854, 7760.262775036363, 7777.883331749915, 7786.649600767866, 6337.2395312562785, 7015.789526314219, 7029.3673569379, 7057.682404291922, 7157.534760240567, 6906.171259448898, 6963.373296403348, 6963.9303606963285, 6982.441404687715, 7047.436205103477, 6330.841728956629, 6337.397947195009, 6350.7777227796805, 6406.487481001602, 6416.647084410402, 4233.936490952699, 4904.411470623548, 4961.454240033666, 4995.975020124876, 5042.294078828893, 4888.584470320063, 4902.313676085422, 5011.2232603944985, 5093.516115968977, 5107.310513080686], "value": 4293.326226312109, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.4984025559105, 355.8078637535729, 364.84129403709386, 368.1752873563216, 372.5027088836403, 4970.6520543561965, 5154.4072431670365, 5296.9735151324285, 5316.946830531693, 5445.1832225166245, 5128.307678463407, 5266.394364648067, 5332.706701131446, 5338.626296159261, 5373.119408207125, 4221.24017676818, 4221.641160501361, 4222.662187025038, 4223.324268117102, 4241.557870324089, 3992.141689536749, 4177.791110444466, 4256.638185754199, 4257.723247988886, 4274.487061552618, 3615.7107431405557, 4162.8126734296875, 4166.145940082276, 4192.7484350938885, 4192.958070419288, 4185.121124563845, 4186.120914607936, 4188.246115699173, 4209.431726716915, 4216.388623649554, 3173.397434295689, 3733.2346868891814, 3739.5325584301963, 3772.2078363543687, 3789.886303410902, 4549.656926682761, 4874.926876096862, 5203.947960520384, 5216.9739151304, 5242.816501422432, 3479.599846017715, 4520.660950428731, 4631.698939568917, 4659.394278743742, 4692.788824502872, 5595.936772013345, 5616.887662246773, 5674.773009079632, 5679.841660169151, 5690.2887139107615, 3621.619729928372, 3807.7905715185652, 3873.573906870242, 3891.9416208756893, 3902.902427439337, 5010.924836127461, 5939.227900372967, 5949.405059494059, 5972.850678733023, 5998.730057147439, 3917.373220284741, 3926.6845606721495, 3932.488776459042, 3938.03518138058, 3947.131631041166, 3839.6928245740273, 3939.7242193046786, 3983.820728067244, 3994.484853329052, 4024.436578878959, 4034.919301613951, 4611.5619016193405, 4633.698809577367, 4636.4899861015265, 4637.188492013884, 4750.097481478508, 5676.829695109153, 5708.80019199326, 5728.1407788831175, 5750.338711048199, 1100.9174311926638, 1213.9863214216227, 1221.908356873238, 1225.6200577820905, 1249.5126900508808, 723.1719680965265, 851.6295411496019, 873.6199753107419, 874.0865795243985, 876.4741155306765, 4304.945288404361, 4583.816647334136, 5007.874803129878, 5034.896559304156, 5035.370578677665, 4773.71357718538, 5287.471252874759, 5308.23030660552, 5511.397982684503, 5547.5007249346945, 4314.50383205929, 4460.565364669186, 4571.634269258451, 4630.513796051433, 4764.2615394613895, 2686.8849427487767, 2733.152722655983, 2748.7526122649056, 2888.5412866502284, 2922.4885645012037, 5159.297431847556, 5709.714514274269, 5721.313442386857, 5725.51333136688, 5753.827385178452, 4776.880577985578, 5522.834314970557, 5616.118600268874, 5629.043062679354, 5757.424257574209, 5471.589630777628, 5701.572382071361, 5704.657720536781, 5721.5708821838525, 5740.6268592541355, 4541.682082254342, 5118.820841270538, 5151.871203219949, 5454.063807348334, 5493.610279528418, 4667.883302917454, 4902.63230257725, 4906.411230652202, 5147.613928955268, 5185.470286265636, 5140.922886156785, 5265.368155821173, 5685.147227915846, 5727.226824378656, 5757.568182386254, 3172.6510083891217, 3328.983355083209, 3459.41189997696, 3471.531343268626, 3739.738218324691, 4986.850394488171, 5043.621728370314, 5163.263470360715, 5218.608604354765, 5476.342838859203, 4311.504177019683, 5415.323084614423, 5449.99175152598, 5461.42655021233, 5606.803761868315, 4806.639502037431, 5142.460041695717, 5587.323802859045, 5592.804251851166, 5624.634398764068, 4850.587700045395, 4890.731009794496, 5251.474852514718, 5485.0, 5505.971715556348, 4549.363089167586, 5256.185291279858, 5588.30146231721, 5649.519790817826, 5677.240055582783, 4433.689641725048, 5386.353637563518, 5407.026735187546, 5503.944960550503, 5517.393086760373], "value": 4039.2886089626804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.4873468001022, 714.1929619529931, 734.537241537831, 745.3157941621876, 751.2640986071345, 14900.701985960275, 15699.450519231828, 15705.371785128582, 15727.370905163809, 15770.684586308282, 13500.459981600725, 14305.213213273291, 14490.0, 14491.855081449183, 14515.927420362883, 633.4837107757163, 705.4532737128715, 876.2157868707535, 877.4691311756392, 879.2745984562729, 860.2515811244195, 867.9262262707678, 876.4346996187455, 876.9079246679103, 878.4860856399014, 918.2516249256868, 919.3197034194682, 921.272194965976, 923.9769005774842, 924.6301479408223, 907.3285768531273, 911.3438324406417, 912.899581046081, 913.1051569461898, 916.3677062826662, 674.6660403100448, 680.0309558878578, 686.2519853359862, 688.0607970120799, 689.5207830557764, 12077.57728479499, 12728.0, 13551.661208469866, 13710.862891371158, 13914.234717090556, 11841.171118021743, 12019.579314723942, 12062.095342849234, 12083.637490875288, 12315.322657253848, 10574.78850422995, 10817.513211905483, 10858.782824343549, 10947.0, 11271.380074095921, 3566.5720113586535, 3587.8744243951337, 3644.908877278063, 3647.708183345326, 3726.8322925468146, 108011.37982930183, 108272.0, 108781.0, 110089.0, 111062.44468777685, 9321.673741419017, 10200.38797672142, 10572.52423640938, 10724.892751072546, 11050.115990720724, 21200.893995529925, 21467.141314347562, 21676.783232167476, 21700.565988680137, 21766.782332176794, 7452.614865535399, 7550.35821955129, 7620.428467864932, 7780.105287891852, 7802.804929876685, 4227.852025179104, 4247.256730072225, 4319.4816622005565, 4354.085642015149, 4375.496817865923, 3436.1581412554083, 3517.4547945068557, 3533.717302615785, 3536.717062634983, 3543.7696549724187, 624.65643895858, 632.8544434780026, 637.7704026550438, 653.7842511971133, 656.4617014048434, 653.2128784814288, 656.7734131724548, 657.1555551116792, 662.3826000988631, 683.5795985468901, 9472.668456604124, 9670.70987870365, 9688.370255933483, 9756.170725488271, 9923.866368730613, 648.9001143062463, 679.1951537428164, 679.7790718016664, 682.1234713393266, 682.4301708073814, 4471.321421794303, 4837.080954618682, 5349.537395333488, 5503.284573005483, 5580.135079062752, 91906.54046729724, 104453.43319850208, 106480.0, 107410.46294768476, 108060.0, 67069.0, 69185.65407172932, 69362.0, 73721.6313918427, 77556.0, 70125.99999999898, 71251.0, 72307.91538126933, 79291.60354198192, 80793.19206807857, 8929.821403572023, 10026.849597256192, 10504.961675677161, 10675.199360048182, 10729.731756706145, 46635.0, 48855.0, 49243.0, 49258.872286072394, 52880.471195289094, 64156.0, 65510.672446637465, 68384.0, 69556.6522167386, 70664.29335706578, 12843.29361885068, 12851.971842252784, 13112.344382781013, 13233.139845909986, 13424.0, 13924.443022278996, 14499.565013049625, 14500.492482763053, 14596.927015364856, 14943.839812716187, 13284.933575332061, 13576.389062492013, 13596.11625244356, 13644.454221831016, 14231.928840355731, 11053.28153670009, 12884.680757463371, 13319.0, 13573.52492662752, 13598.660033499242, 10439.425831579336, 10825.927784097375, 13165.341732913124, 13398.129121607064, 14031.01782875189, 9970.877825544227, 10674.199435042248, 10714.0, 11043.0, 11310.377929213972, 9984.650537231162, 10376.68869933873, 10465.005824446665, 10512.369257844553, 10664.786704266027], "value": 7336.538182178697, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 172.0, 159.0, 117.0, 120.0, 119.0, 119.0, 133.0, 171.0, 159.0], "value": 139.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 115.0, 151.0, 114.0, 115.0, 97.0, 132.0, 165.0, 145.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 194.0, 197.0, 190.0, 200.0, 196.0, 196.0, 201.0, 197.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 62.0, 92.0, 64.0, 61.0, 76.0, 81.0, 73.0, 60.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 87.0, 73.0, 72.0, 72.0, 82.0, 70.0, 70.0, 84.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 92.0, 89.0, 90.0, 88.0, 91.0, 87.0, 91.0, 89.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 99.0, 109.0, 121.0, 96.0, 96.0, 97.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 93.0, 95.0, 77.0, 150.0, 148.0, 95.0, 95.0, 94.0], "value": 113.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 63.0, 65.0, 62.0, 64.0, 63.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 76.0, 77.0, 75.0, 71.0, 73.0, 73.0, 104.0, 62.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 77.0, 102.0, 79.0, 101.0, 104.0, 106.0, 104.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 173.0, 147.0, 125.0, 149.0, 152.0, 170.0, 160.0, 202.0, 183.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 166.0, 161.0, 217.0, 164.0, 215.0, 231.0, 170.0, 176.0, 173.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 63.0, 82.0, 85.0, 84.0, 73.0, 68.0], "value": 72.6, "unit": "score"}]}]} 09:10:27 INFO - Return code: 0 09:10:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:27 ERROR - # TBPL SUCCESS # 09:10:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:27 INFO - 2017-02-07 09:10:27.226 screenresolution[2205:25837] starting screenresolution argv=screenresolution get 09:10:27 INFO - 2017-02-07 09:10:27.230 screenresolution[2205:25837] Display 0: 1600x1200x32@60 09:10:27 INFO - 2017-02-07 09:10:27.236 screenresolution[2206:25840] starting screenresolution argv=screenresolution list 09:10:27 INFO - Available Modes on Display 0 09:10:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:27 INFO - Intel Iris: 09:10:27 INFO - Chipset Model: Intel Iris 09:10:27 INFO - Type: GPU 09:10:27 INFO - Bus: Built-In 09:10:27 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:27 INFO - Vendor: Intel (0x8086) 09:10:27 INFO - Device ID: 0x0a2e 09:10:27 INFO - Revision ID: 0x0009 09:10:27 INFO - Displays: 09:10:27 INFO - Display: 09:10:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:27 INFO - Display Serial Number: 1600x1200 60 09:10:27 INFO - Main Display: Yes 09:10:27 INFO - Mirror: Off 09:10:27 INFO - Online: Yes 09:10:27 INFO - Rotation: Supported 09:10:27 INFO - Return code: 0 09:10:27 INFO - Running post-action listener: _resource_record_post_action 09:10:27 INFO - [mozharness: 2017-02-07 17:10:27.479658Z] Finished run-tests step (success) 09:10:27 INFO - Running post-run listener: _resource_record_post_run 09:10:27 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 856064; Write bytes: 509702656; Read time: 8; Write time: 1648 09:10:27 INFO - TinderboxPrint: CPU usage
54.4% 09:10:27 INFO - TinderboxPrint: I/O read bytes / time
856,064 / 8 09:10:27 INFO - TinderboxPrint: I/O write bytes / time
509,702,656 / 1,648 09:10:27 INFO - TinderboxPrint: CPU idle
2,184.1 (45.6%) 09:10:27 INFO - TinderboxPrint: CPU system
963.1 (20.1%) 09:10:27 INFO - TinderboxPrint: CPU user
1,642.6 (34.3%) 09:10:27 INFO - TinderboxPrint: Swap in / out
208,232,448 / 0 09:10:27 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205136384; Write bytes: 199898624; Read time: 15742; Write time: 449 09:10:27 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 716800; Write bytes: 298769408; Read time: 6; Write time: 1159 09:10:27 INFO - Running post-run listener: _upload_blobber_files 09:10:27 INFO - Blob upload gear active. 09:10:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:27 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 09:10:27 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'] 09:10:27 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 09:10:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:29 INFO - (blobuploader) - INFO - Done attempting. 09:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:10:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:30 INFO - (blobuploader) - INFO - Done attempting. 09:10:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:10:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:31 INFO - (blobuploader) - INFO - Done attempting. 09:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:33 INFO - (blobuploader) - INFO - Done attempting. 09:10:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:33 INFO - Return code: 0 09:10:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb6ea73dfb6aef61ebd9397ae4457f3c45d40da6673b111d7bbfba05730607fb152ba8317c81e47437ea38d133af1e8dc91adf653a86fec88fa39d126d31e485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a8ccd400fea02fe7da4bb6fed3a9c315888cf5672cf9aa52c2e55e61c8810b5b166a732d8303bc3b5e2410a787a6ec5dc5c134e1d2df39222b7e29f1727834a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483f9f4ea12a48b5cb54b3a6997171d1655bb9d5066ef277ef0896a5725b3373464463be7e367bd8bcd277175f5327add0519db126452278da152ff6c72a3330", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c29f62f8a174c559dfe6c879bbf3eda3d74c9954540ccb97bc2489cdcb7cf7cd797da22089ad8b88146b2dbc35cbdb0a29690a5a3e1b3baf203c9c9b49df44c2"} 09:10:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:33 INFO - Contents: 09:10:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb6ea73dfb6aef61ebd9397ae4457f3c45d40da6673b111d7bbfba05730607fb152ba8317c81e47437ea38d133af1e8dc91adf653a86fec88fa39d126d31e485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a8ccd400fea02fe7da4bb6fed3a9c315888cf5672cf9aa52c2e55e61c8810b5b166a732d8303bc3b5e2410a787a6ec5dc5c134e1d2df39222b7e29f1727834a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483f9f4ea12a48b5cb54b3a6997171d1655bb9d5066ef277ef0896a5725b3373464463be7e367bd8bcd277175f5327add0519db126452278da152ff6c72a3330", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c29f62f8a174c559dfe6c879bbf3eda3d74c9954540ccb97bc2489cdcb7cf7cd797da22089ad8b88146b2dbc35cbdb0a29690a5a3e1b3baf203c9c9b49df44c2"} 09:10:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:33 INFO - Copying logs to upload dir... 09:10:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.459864 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-07 09:10:33.706570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 09:10:33.709675) ========= 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.TDPxWtjKik/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.Qse0HmXARz/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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/fb6ea73dfb6aef61ebd9397ae4457f3c45d40da6673b111d7bbfba05730607fb152ba8317c81e47437ea38d133af1e8dc91adf653a86fec88fa39d126d31e485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a8ccd400fea02fe7da4bb6fed3a9c315888cf5672cf9aa52c2e55e61c8810b5b166a732d8303bc3b5e2410a787a6ec5dc5c134e1d2df39222b7e29f1727834a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483f9f4ea12a48b5cb54b3a6997171d1655bb9d5066ef277ef0896a5725b3373464463be7e367bd8bcd277175f5327add0519db126452278da152ff6c72a3330", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c29f62f8a174c559dfe6c879bbf3eda3d74c9954540ccb97bc2489cdcb7cf7cd797da22089ad8b88146b2dbc35cbdb0a29690a5a3e1b3baf203c9c9b49df44c2"} build_url:https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/P9CfnH7VQT6opU9s2TV56Q/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/fb6ea73dfb6aef61ebd9397ae4457f3c45d40da6673b111d7bbfba05730607fb152ba8317c81e47437ea38d133af1e8dc91adf653a86fec88fa39d126d31e485", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a8ccd400fea02fe7da4bb6fed3a9c315888cf5672cf9aa52c2e55e61c8810b5b166a732d8303bc3b5e2410a787a6ec5dc5c134e1d2df39222b7e29f1727834a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483f9f4ea12a48b5cb54b3a6997171d1655bb9d5066ef277ef0896a5725b3373464463be7e367bd8bcd277175f5327add0519db126452278da152ff6c72a3330", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c29f62f8a174c559dfe6c879bbf3eda3d74c9954540ccb97bc2489cdcb7cf7cd797da22089ad8b88146b2dbc35cbdb0a29690a5a3e1b3baf203c9c9b49df44c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 09:10:33.744699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:10:33.745027) ========= 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.TDPxWtjKik/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.Qse0HmXARz/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.004947 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:10:33.795337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 09:10:33.795862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 09:10:33.796420) ========= ========= Total master_lag: 0.19 =========