builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0133 starttime: 1489073480.46 results: success (0) buildid: 20170309053723 builduid: 501c23e5dfc848e89f63c530960ed1d1 revision: 556ffc2114f73aff3bf6d80f0a6648791c17662b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.458345) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.458832) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.459221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.485242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.485672) ========= 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.vMJR0l4Htm/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.NygTmPf7G0/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-03-09 07:31:20-- 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% 39.8M=0s 2017-03-09 07:31:20 (39.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087850 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.599102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.599439) ========= 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.vMJR0l4Htm/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.NygTmPf7G0/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.022123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:20.649045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-09 07:31:20.649457) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 556ffc2114f73aff3bf6d80f0a6648791c17662b --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 556ffc2114f73aff3bf6d80f0a6648791c17662b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vMJR0l4Htm/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.NygTmPf7G0/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-03-09 07:31:20,734 truncating revision to first 12 chars 2017-03-09 07:31:20,734 Setting DEBUG logging. 2017-03-09 07:31:20,734 attempt 1/10 2017-03-09 07:31:20,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/556ffc2114f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 07:31:22,312 unpacking tar archive at: mozilla-aurora-556ffc2114f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.825559 ========= master_lag: 2.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-09 07:31:24.545892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:24.546258) ========= script_repo_revision: 556ffc2114f73aff3bf6d80f0a6648791c17662b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:24.546716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:24.547017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 07:31:24.568972) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-09 07:31:24.569385) ========= /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.vMJR0l4Htm/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.NygTmPf7G0/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:31:24 INFO - MultiFileLogger online at 20170309 07:31:24 in /builds/slave/test 07:31:24 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 07:31:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:31:24 INFO - {'append_to_log': False, 07:31:24 INFO - 'base_work_dir': '/builds/slave/test', 07:31:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:31:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:31:24 INFO - 'branch': 'Mozilla-Aurora', 07:31:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:31:24 INFO - 'config_files': ('talos/mac_config.py',), 07:31:24 INFO - 'default_actions': ('clobber', 07:31:24 INFO - 'read-buildbot-config', 07:31:24 INFO - 'download-and-extract', 07:31:24 INFO - 'populate-webroot', 07:31:24 INFO - 'create-virtualenv', 07:31:24 INFO - 'install', 07:31:24 INFO - 'run-tests'), 07:31:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:31:24 INFO - 'download_minidump_stackwalk': True, 07:31:24 INFO - 'download_symbols': 'ondemand', 07:31:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:31:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:31:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:31:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:31:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:31:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:31:24 INFO - 'gecko_profile': False, 07:31:24 INFO - 'gecko_profile_interval': 0, 07:31:24 INFO - 'installer_path': 'installer.exe', 07:31:24 INFO - 'log_level': 'info', 07:31:24 INFO - 'log_name': 'talos', 07:31:24 INFO - 'log_to_console': True, 07:31:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:31:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:31:24 INFO - 'opt_config_files': (), 07:31:24 INFO - 'pip_index': False, 07:31:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:31:24 INFO - 'cmd': ('bash', 07:31:24 INFO - '-c', 07:31:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:31:24 INFO - 'enabled': True, 07:31:24 INFO - 'halt_on_failure': False, 07:31:24 INFO - 'name': 'check_screen_resolution'},), 07:31:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:31:24 INFO - 'cmd': ('bash', 07:31:24 INFO - '-c', 07:31:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:31:24 INFO - 'enabled': True, 07:31:24 INFO - 'halt_on_failure': False, 07:31:24 INFO - 'name': 'check_screen_resolution'},), 07:31:24 INFO - 'run_cmd_checks_enabled': True, 07:31:24 INFO - 'suite': 'dromaeojs-e10s', 07:31:24 INFO - 'system_bits': '32', 07:31:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:31:24 INFO - 'title': 't-yosemite-r7-0133', 07:31:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:31:24 INFO - 'use_talos_json': True, 07:31:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:31:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:31:24 INFO - 'work_dir': 'build'} 07:31:24 INFO - [mozharness: 2017-03-09 15:31:24.790280Z] Running clobber step. 07:31:24 INFO - Running pre-action listener: _resource_record_pre_action 07:31:24 INFO - Running main action method: clobber 07:31:24 INFO - rmtree: /builds/slave/test/build 07:31:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:31:26 INFO - Running post-action listener: _resource_record_post_action 07:31:26 INFO - [mozharness: 2017-03-09 15:31:26.632966Z] Finished clobber step (success) 07:31:26 INFO - [mozharness: 2017-03-09 15:31:26.633255Z] Running read-buildbot-config step. 07:31:26 INFO - Running pre-action listener: _resource_record_pre_action 07:31:26 INFO - Running main action method: read_buildbot_config 07:31:26 INFO - Using buildbot properties: 07:31:26 INFO - { 07:31:26 INFO - "project": "", 07:31:26 INFO - "product": "firefox", 07:31:26 INFO - "script_repo_revision": "production", 07:31:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:31:26 INFO - "repository": "", 07:31:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:31:26 INFO - "buildid": "20170309053723", 07:31:26 INFO - "pgo_build": "False", 07:31:26 INFO - "basedir": "/builds/slave/test", 07:31:26 INFO - "buildnumber": 6, 07:31:26 INFO - "slavename": "t-yosemite-r7-0133", 07:31:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:31:26 INFO - "platform": "yosemite_r7", 07:31:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:31:26 INFO - "branch": "mozilla-aurora", 07:31:26 INFO - "repo_path": "releases/mozilla-aurora", 07:31:26 INFO - "revision": "556ffc2114f73aff3bf6d80f0a6648791c17662b", 07:31:26 INFO - "stage_platform": "macosx64", 07:31:26 INFO - "builduid": "501c23e5dfc848e89f63c530960ed1d1", 07:31:26 INFO - "slavebuilddir": "test" 07:31:26 INFO - } 07:31:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 07:31:26 INFO - Running post-action listener: _resource_record_post_action 07:31:26 INFO - [mozharness: 2017-03-09 15:31:26.639045Z] Finished read-buildbot-config step (success) 07:31:26 INFO - [mozharness: 2017-03-09 15:31:26.639227Z] Running download-and-extract step. 07:31:26 INFO - Running pre-action listener: _resource_record_pre_action 07:31:26 INFO - Running main action method: download_and_extract 07:31:26 INFO - mkdir: /builds/slave/test/build/tests 07:31:26 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')]} 07:31:26 INFO - trying https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 07:31:26 INFO - Downloading https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 07:31:27 INFO - Downloaded 1199 bytes. 07:31:27 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:31:27 INFO - Using the following test package requirements: 07:31:27 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:31:27 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 07:31:27 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 07:31:27 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'jsshell-mac.zip'], 07:31:27 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 07:31:27 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:31:27 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 07:31:27 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 07:31:27 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 07:31:27 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:31:27 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 07:31:27 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:31:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:31:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:31:27 INFO - Fetch https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:31:29 INFO - Expected file size: 51779051 07:31:29 INFO - Obtained file size: 51779051 07:31:45 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:31:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:31:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:31:45 INFO - Fetch https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:31:46 INFO - Expected file size: 51779051 07:31:46 INFO - Obtained file size: 51779051 07:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 07:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 07:32:03 INFO - Expected file size: 14404424 07:32:03 INFO - Obtained file size: 14404424 07:32:03 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')]} 07:32:03 INFO - trying https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:32:03 INFO - Downloading https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 07:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 07:32:06 INFO - Downloaded 74618759 bytes. 07:32:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:32:06 INFO - mkdir: /builds/slave/test/properties 07:32:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:06 INFO - Contents: 07:32:06 INFO - build_url:https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:32:06 INFO - Running post-action listener: _resource_record_post_action 07:32:06 INFO - Running post-action listener: set_extra_try_arguments 07:32:06 INFO - [mozharness: 2017-03-09 15:32:06.732556Z] Finished download-and-extract step (success) 07:32:06 INFO - [mozharness: 2017-03-09 15:32:06.732684Z] Running populate-webroot step. 07:32:06 INFO - Running pre-action listener: _resource_record_pre_action 07:32:06 INFO - Running main action method: populate_webroot 07:32:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:06 INFO - '--tppagecycles', 07:32:06 INFO - '7'], 07:32:06 INFO - 'tests': ['tsvgm']}}, 07:32:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['damp', 'tps']}, 07:32:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'tests': ['damp', 'tps']}, 07:32:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['dromaeo_dom']}, 07:32:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['basic_compositor_video']}, 07:32:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['a11yr', 07:32:06 INFO - 'ts_paint', 07:32:06 INFO - 'tpaint', 07:32:06 INFO - 'sessionrestore', 07:32:06 INFO - 'sessionrestore_no_auto_restore', 07:32:06 INFO - 'tabpaint']}, 07:32:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:06 INFO - 'ts_paint', 07:32:06 INFO - 'tpaint', 07:32:06 INFO - 'sessionrestore', 07:32:06 INFO - 'sessionrestore_no_auto_restore', 07:32:06 INFO - 'tabpaint']}, 07:32:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:06 INFO - 'ts_paint', 07:32:06 INFO - 'tpaint', 07:32:06 INFO - 'sessionrestore', 07:32:06 INFO - 'sessionrestore_no_auto_restore', 07:32:06 INFO - 'tabpaint']}, 07:32:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:06 INFO - 'ts_paint', 07:32:06 INFO - 'tpaint', 07:32:06 INFO - 'sessionrestore', 07:32:06 INFO - 'sessionrestore_no_auto_restore', 07:32:06 INFO - 'tabpaint']}, 07:32:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['a11yr', 07:32:06 INFO - 'ts_paint', 07:32:06 INFO - 'tpaint', 07:32:06 INFO - 'sessionrestore', 07:32:06 INFO - 'sessionrestore_no_auto_restore', 07:32:06 INFO - 'tabpaint']}, 07:32:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['a11yr', 07:32:06 INFO - 'ts_paint', 07:32:06 INFO - 'tpaint', 07:32:06 INFO - 'sessionrestore', 07:32:06 INFO - 'sessionrestore_no_auto_restore', 07:32:06 INFO - 'tabpaint']}, 07:32:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['tsvgx', 07:32:06 INFO - 'tsvgr_opacity', 07:32:06 INFO - 'tart', 07:32:06 INFO - 'tscrollx', 07:32:06 INFO - 'cart', 07:32:06 INFO - 'tsvg_static']}, 07:32:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:06 INFO - 'tsvgr_opacity', 07:32:06 INFO - 'tart', 07:32:06 INFO - 'tscrollx', 07:32:06 INFO - 'cart', 07:32:06 INFO - 'tsvg_static']}, 07:32:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'talos_options': ['--disable-e10s'], 07:32:06 INFO - 'tests': ['tp5o']}, 07:32:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:32:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'talos_options': ['--disable-e10s', 07:32:06 INFO - '--xperf_path', 07:32:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:06 INFO - 'tests': ['tp5n']}, 07:32:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:32:06 INFO - 'talos_options': ['--xperf_path', 07:32:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:06 INFO - 'tests': ['tp5n']}}, 07:32:06 INFO - 'talos.zip': {'path': '', 07:32:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:06 INFO - Running post-action listener: _resource_record_post_action 07:32:06 INFO - [mozharness: 2017-03-09 15:32:06.751427Z] Finished populate-webroot step (success) 07:32:06 INFO - [mozharness: 2017-03-09 15:32:06.751540Z] Running create-virtualenv step. 07:32:06 INFO - Running pre-action listener: _resource_record_pre_action 07:32:06 INFO - Running main action method: create_virtualenv 07:32:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:06 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 07:32:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:06 INFO - Using real prefix '/tools/python27' 07:32:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:10 INFO - Installing pip.................done. 07:32:10 INFO - Return code: 0 07:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:10 INFO - Reading from file tmpfile_stdout 07:32:10 INFO - Output received: 07:32:10 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) 07:32:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:10 INFO - 'HOME': '/Users/cltbld', 07:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:10 INFO - 'LOGNAME': 'cltbld', 07:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:10 INFO - 'MOZ_NO_REMOTE': '1', 07:32:10 INFO - 'NO_EM_RESTART': '1', 07:32:10 INFO - 'PAGER': '/bin/cat', 07:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:10 INFO - 'PWD': '/builds/slave/test', 07:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:10 INFO - 'SHELL': '/bin/bash', 07:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:10 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:10 INFO - 'USER': 'cltbld', 07:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:10 INFO - 'XPC_FLAGS': '0x0', 07:32:10 INFO - 'XPC_SERVICE_NAME': '0', 07:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:11 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 07:32:11 INFO - Cleaning up... 07:32:11 INFO - Return code: 0 07:32:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32:11 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')]} 07:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:11 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')]} 07:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:11 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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:11 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 07:32:11 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 07:32:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:11 INFO - 'HOME': '/Users/cltbld', 07:32:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:11 INFO - 'LOGNAME': 'cltbld', 07:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:11 INFO - 'MOZ_NO_REMOTE': '1', 07:32:11 INFO - 'NO_EM_RESTART': '1', 07:32:11 INFO - 'PAGER': '/bin/cat', 07:32:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:11 INFO - 'PWD': '/builds/slave/test', 07:32:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:11 INFO - 'SHELL': '/bin/bash', 07:32:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:11 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:11 INFO - 'USER': 'cltbld', 07:32:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:11 INFO - 'XPC_FLAGS': '0x0', 07:32:11 INFO - 'XPC_SERVICE_NAME': '0', 07:32:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:11 INFO - Downloading/unpacking psutil>=3.1.1 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:14 INFO - Installing collected packages: psutil 07:32:14 INFO - Running setup.py install for psutil 07:32:14 INFO - building 'psutil._psutil_osx' extension 07:32:14 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 07:32:15 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 07:32:15 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 07:32:15 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 07:32:15 INFO - building 'psutil._psutil_posix' extension 07:32:15 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 07:32:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:32:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:32:15 INFO - ^ 07:32:15 INFO - 1 warning generated. 07:32:15 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 07:32:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:15 INFO - Successfully installed psutil 07:32:15 INFO - Cleaning up... 07:32:15 INFO - Return code: 0 07:32:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:15 INFO - 'HOME': '/Users/cltbld', 07:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:15 INFO - 'LOGNAME': 'cltbld', 07:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:15 INFO - 'MOZ_NO_REMOTE': '1', 07:32:15 INFO - 'NO_EM_RESTART': '1', 07:32:15 INFO - 'PAGER': '/bin/cat', 07:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:15 INFO - 'PWD': '/builds/slave/test', 07:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:15 INFO - 'SHELL': '/bin/bash', 07:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:15 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:15 INFO - 'USER': 'cltbld', 07:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:15 INFO - 'XPC_FLAGS': '0x0', 07:32:15 INFO - 'XPC_SERVICE_NAME': '0', 07:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:18 INFO - Installing collected packages: mozsystemmonitor 07:32:18 INFO - Running setup.py install for mozsystemmonitor 07:32:18 INFO - Successfully installed mozsystemmonitor 07:32:18 INFO - Cleaning up... 07:32:19 INFO - Return code: 0 07:32:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32:19 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')]} 07:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:19 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')]} 07:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:19 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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:19 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 07:32:19 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 07:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:19 INFO - 'HOME': '/Users/cltbld', 07:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:19 INFO - 'LOGNAME': 'cltbld', 07:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:19 INFO - 'MOZ_NO_REMOTE': '1', 07:32:19 INFO - 'NO_EM_RESTART': '1', 07:32:19 INFO - 'PAGER': '/bin/cat', 07:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:19 INFO - 'PWD': '/builds/slave/test', 07:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:19 INFO - 'SHELL': '/bin/bash', 07:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:19 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:19 INFO - 'USER': 'cltbld', 07:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:19 INFO - 'XPC_FLAGS': '0x0', 07:32:19 INFO - 'XPC_SERVICE_NAME': '0', 07:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:22 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 07:32:22 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 07:32:22 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 07:32:22 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 07:32:22 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 07:32:22 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 07:32:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:22 INFO - warning: no files found matching '*.txt' 07:32:22 INFO - no previously-included directories found matching 'build' 07:32:22 INFO - no previously-included directories found matching 'dist' 07:32:22 INFO - no previously-included directories found matching '.git*' 07:32:22 INFO - Installing collected packages: jsonschema, functools32 07:32:22 INFO - Running setup.py install for functools32 07:32:22 INFO - warning: no files found matching '*.txt' 07:32:22 INFO - no previously-included directories found matching 'build' 07:32:22 INFO - no previously-included directories found matching 'dist' 07:32:22 INFO - no previously-included directories found matching '.git*' 07:32:22 INFO - Successfully installed jsonschema functools32 07:32:22 INFO - Cleaning up... 07:32:23 INFO - Return code: 0 07:32:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:23 INFO - 'HOME': '/Users/cltbld', 07:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:23 INFO - 'LOGNAME': 'cltbld', 07:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:23 INFO - 'MOZ_NO_REMOTE': '1', 07:32:23 INFO - 'NO_EM_RESTART': '1', 07:32:23 INFO - 'PAGER': '/bin/cat', 07:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:23 INFO - 'PWD': '/builds/slave/test', 07:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:23 INFO - 'SHELL': '/bin/bash', 07:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:23 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:23 INFO - 'USER': 'cltbld', 07:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:23 INFO - 'XPC_FLAGS': '0x0', 07:32:23 INFO - 'XPC_SERVICE_NAME': '0', 07:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:23 INFO - Cleaning up... 07:32:23 INFO - Return code: 0 07:32:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:23 INFO - 'HOME': '/Users/cltbld', 07:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:23 INFO - 'LOGNAME': 'cltbld', 07:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:23 INFO - 'MOZ_NO_REMOTE': '1', 07:32:23 INFO - 'NO_EM_RESTART': '1', 07:32:23 INFO - 'PAGER': '/bin/cat', 07:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:23 INFO - 'PWD': '/builds/slave/test', 07:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:23 INFO - 'SHELL': '/bin/bash', 07:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:23 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:23 INFO - 'USER': 'cltbld', 07:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:23 INFO - 'XPC_FLAGS': '0x0', 07:32:23 INFO - 'XPC_SERVICE_NAME': '0', 07:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:23 INFO - Downloading/unpacking blobuploader==1.2.4 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:27 INFO - Downloading docopt-0.6.1.tar.gz 07:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:27 INFO - Running setup.py install for blobuploader 07:32:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:27 INFO - Running setup.py install for requests 07:32:28 INFO - Running setup.py install for docopt 07:32:28 INFO - Successfully installed blobuploader requests docopt 07:32:28 INFO - Cleaning up... 07:32:28 INFO - Return code: 0 07:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:28 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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:28 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 07:32:28 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 07:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:28 INFO - 'HOME': '/Users/cltbld', 07:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:28 INFO - 'LOGNAME': 'cltbld', 07:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:28 INFO - 'MOZ_NO_REMOTE': '1', 07:32:28 INFO - 'NO_EM_RESTART': '1', 07:32:28 INFO - 'PAGER': '/bin/cat', 07:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:28 INFO - 'PWD': '/builds/slave/test', 07:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:28 INFO - 'SHELL': '/bin/bash', 07:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:28 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:28 INFO - 'USER': 'cltbld', 07:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:28 INFO - 'XPC_FLAGS': '0x0', 07:32:28 INFO - 'XPC_SERVICE_NAME': '0', 07:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:28 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-7Xe4Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:28 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-SMFdyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:28 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-WRGSB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:28 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-hFSLYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-WrSIS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-gVjIcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-qVec6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-sZ6sHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-f4YFHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-yhbGm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-qM5gTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-6serbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:29 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-URB9iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:30 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-H70Bwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:30 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-kJEXPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:30 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-5bG68i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:30 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-h15M_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:30 INFO - Running setup.py install for manifestparser 07:32:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:30 INFO - Running setup.py install for mozcrash 07:32:30 INFO - Running setup.py install for mozdebug 07:32:30 INFO - Running setup.py install for mozdevice 07:32:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Running setup.py install for mozfile 07:32:31 INFO - Running setup.py install for mozhttpd 07:32:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Running setup.py install for mozinfo 07:32:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Running setup.py install for mozInstall 07:32:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Running setup.py install for mozleak 07:32:31 INFO - Running setup.py install for mozlog 07:32:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Running setup.py install for moznetwork 07:32:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozprocess 07:32:32 INFO - Running setup.py install for mozprofile 07:32:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozrunner 07:32:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozscreenshot 07:32:32 INFO - Running setup.py install for moztest 07:32:32 INFO - Running setup.py install for mozversion 07:32:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:33 INFO - Cleaning up... 07:32:33 INFO - Return code: 0 07:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:33 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')]} 07:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:33 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')]} 07:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:33 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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:33 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 07:32:33 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 07:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:33 INFO - 'HOME': '/Users/cltbld', 07:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:33 INFO - 'LOGNAME': 'cltbld', 07:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:33 INFO - 'MOZ_NO_REMOTE': '1', 07:32:33 INFO - 'NO_EM_RESTART': '1', 07:32:33 INFO - 'PAGER': '/bin/cat', 07:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:33 INFO - 'PWD': '/builds/slave/test', 07:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:33 INFO - 'SHELL': '/bin/bash', 07:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:33 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:33 INFO - 'USER': 'cltbld', 07:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:33 INFO - 'XPC_FLAGS': '0x0', 07:32:33 INFO - 'XPC_SERVICE_NAME': '0', 07:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:33 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Nat65C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:33 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)) 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:33 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-nDj41W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:33 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)) 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:33 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-daD40J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:33 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)) 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:33 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-_5blTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:33 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)) 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:33 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-DCdvmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:33 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)) 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:33 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-kqjhqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:33 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)) 07:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-kZakMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-cs8hFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-j7D4T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-pvI0PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-4hP0i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-KPgFi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-HUMDOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-YoQuFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-MmrIKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:34 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)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:34 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-hUoVMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:35 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)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:35 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-fx_CYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:35 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)) 07:32:35 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)) 07:32:35 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)) 07:32:35 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)) 07:32:35 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)) 07:32:35 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)) 07:32:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:35 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 07:32:37 INFO - Downloading blessings-1.6.tar.gz 07:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:37 INFO - Installing collected packages: blessings 07:32:37 INFO - Running setup.py install for blessings 07:32:38 INFO - Successfully installed blessings 07:32:38 INFO - Cleaning up... 07:32:38 INFO - Return code: 0 07:32:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:38 INFO - Reading from file tmpfile_stdout 07:32:38 INFO - Current package versions: 07:32:38 INFO - blessings == 1.6 07:32:38 INFO - blobuploader == 1.2.4 07:32:38 INFO - docopt == 0.6.1 07:32:38 INFO - functools32 == 3.2.3-2 07:32:38 INFO - jsonschema == 2.5.1 07:32:38 INFO - manifestparser == 1.1 07:32:38 INFO - mozInstall == 1.12 07:32:38 INFO - mozcrash == 1.0 07:32:38 INFO - mozdebug == 0.1 07:32:38 INFO - mozdevice == 0.49 07:32:38 INFO - mozfile == 1.2 07:32:38 INFO - mozhttpd == 0.7 07:32:38 INFO - mozinfo == 0.9 07:32:38 INFO - mozleak == 0.1 07:32:38 INFO - mozlog == 3.4 07:32:38 INFO - moznetwork == 0.27 07:32:38 INFO - mozprocess == 0.25 07:32:38 INFO - mozprofile == 0.28 07:32:38 INFO - mozrunner == 6.13 07:32:38 INFO - mozscreenshot == 0.1 07:32:38 INFO - mozsystemmonitor == 0.3 07:32:38 INFO - moztest == 0.8 07:32:38 INFO - mozversion == 1.4 07:32:38 INFO - psutil == 3.1.1 07:32:38 INFO - requests == 1.2.3 07:32:38 INFO - wsgiref == 0.1.2 07:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:38 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')]} 07:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 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')]} 07:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:38 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 07:32:38 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 07:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:38 INFO - 'HOME': '/Users/cltbld', 07:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:38 INFO - 'LOGNAME': 'cltbld', 07:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:38 INFO - 'MOZ_NO_REMOTE': '1', 07:32:38 INFO - 'NO_EM_RESTART': '1', 07:32:38 INFO - 'PAGER': '/bin/cat', 07:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:38 INFO - 'PWD': '/builds/slave/test', 07:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:38 INFO - 'SHELL': '/bin/bash', 07:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:38 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:38 INFO - 'USER': 'cltbld', 07:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:38 INFO - 'XPC_FLAGS': '0x0', 07:32:38 INFO - 'XPC_SERVICE_NAME': '0', 07:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 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)) 07:32:38 INFO - Cleaning up... 07:32:38 INFO - Return code: 0 07:32:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:32:38 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')]} 07:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 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')]} 07:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 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 0x10b4bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81f2d56de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, '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.vMJR0l4Htm/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.NygTmPf7G0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 07:32:38 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 07:32:38 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 07:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:38 INFO - 'HOME': '/Users/cltbld', 07:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:38 INFO - 'LOGNAME': 'cltbld', 07:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:38 INFO - 'MOZ_NO_REMOTE': '1', 07:32:38 INFO - 'NO_EM_RESTART': '1', 07:32:38 INFO - 'PAGER': '/bin/cat', 07:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:38 INFO - 'PWD': '/builds/slave/test', 07:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:38 INFO - 'SHELL': '/bin/bash', 07:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:32:38 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:38 INFO - 'USER': 'cltbld', 07:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:38 INFO - 'XPC_FLAGS': '0x0', 07:32:38 INFO - 'XPC_SERVICE_NAME': '0', 07:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:32:39 INFO - Cleaning up... 07:32:39 INFO - Return code: 0 07:32:39 INFO - Running post-action listener: _resource_record_post_action 07:32:39 INFO - Running post-action listener: _start_resource_monitoring 07:32:39 INFO - Starting resource monitoring. 07:32:39 INFO - [mozharness: 2017-03-09 15:32:39.043077Z] Finished create-virtualenv step (success) 07:32:39 INFO - [mozharness: 2017-03-09 15:32:39.044094Z] Running install step. 07:32:39 INFO - Running pre-action listener: _resource_record_pre_action 07:32:39 INFO - Running main action method: install 07:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:39 INFO - Reading from file tmpfile_stdout 07:32:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:32:39 INFO - Reading from file tmpfile_stdout 07:32:39 INFO - Output received: 07:32:39 INFO - Usage: mozinstall [options] installer 07:32:39 INFO - Options: 07:32:39 INFO - -h, --help show this help message and exit 07:32:39 INFO - -d DEST, --destination=DEST 07:32:39 INFO - Directory to install application into. [default: 07:32:39 INFO - "/builds/slave/test"] 07:32:39 INFO - --app=APP Application being installed. [default: firefox] 07:32:39 INFO - mkdir: /builds/slave/test/build/application 07:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:33:00 INFO - Reading from file tmpfile_stdout 07:33:00 INFO - Output received: 07:33:00 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:33:00 INFO - Running post-action listener: _resource_record_post_action 07:33:00 INFO - [mozharness: 2017-03-09 15:33:00.246314Z] Finished install step (success) 07:33:00 INFO - [mozharness: 2017-03-09 15:33:00.246459Z] Running run-tests step. 07:33:00 INFO - Running pre-action listener: _resource_record_pre_action 07:33:00 INFO - Running main action method: run_tests 07:33:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:00 INFO - 2017-03-09 07:33:00.261 screenresolution[2716:39079] starting screenresolution argv=screenresolution get 07:33:00 INFO - 2017-03-09 07:33:00.263 screenresolution[2716:39079] Display 0: 1600x1200x32@60 07:33:00 INFO - 2017-03-09 07:33:00.269 screenresolution[2717:39081] starting screenresolution argv=screenresolution list 07:33:00 INFO - Available Modes on Display 0 07:33:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:00 INFO - Intel Iris: 07:33:00 INFO - Chipset Model: Intel Iris 07:33:00 INFO - Type: GPU 07:33:00 INFO - Bus: Built-In 07:33:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:00 INFO - Vendor: Intel (0x8086) 07:33:00 INFO - Device ID: 0x0a2e 07:33:00 INFO - Revision ID: 0x0009 07:33:00 INFO - Displays: 07:33:00 INFO - Display: 07:33:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:00 INFO - Display Serial Number: 1600x1200 60 07:33:00 INFO - Main Display: Yes 07:33:00 INFO - Mirror: Off 07:33:00 INFO - Online: Yes 07:33:00 INFO - Rotation: Supported 07:33:00 INFO - Return code: 0 07:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:00 INFO - Python 2.7.3 07:33:00 INFO - Return code: 0 07:33:00 INFO - grabbing minidump binary from tooltool 07:33: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')]} 07:33:00 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 0x10b29dd30>, '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 0x10b1c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b292be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:00 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 07:33:00 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 07:33:00 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 07:33:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:00 INFO - Return code: 0 07:33:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:33:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:00 INFO - ENV: RUST_BACKTRACE is now 1 07:33:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:33:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:00 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/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 07:33:00 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/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0133 --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 07:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMJR0l4Htm/Render', 07:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:00 INFO - 'HOME': '/Users/cltbld', 07:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:00 INFO - 'LOGNAME': 'cltbld', 07:33:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:00 INFO - 'MOZ_NO_REMOTE': '1', 07:33:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:00 INFO - 'NO_EM_RESTART': '1', 07:33:00 INFO - 'PAGER': '/bin/cat', 07:33:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:00 INFO - 'PWD': '/builds/slave/test', 07:33:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:00 INFO - 'RUST_BACKTRACE': '1', 07:33:00 INFO - 'SHELL': '/bin/bash', 07:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NygTmPf7G0/Listeners', 07:33:00 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 07:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:00 INFO - 'USER': 'cltbld', 07:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:00 INFO - 'XPC_FLAGS': '0x0', 07:33:00 INFO - 'XPC_SERVICE_NAME': '0', 07:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:00 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/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 07:33:00 INFO - mozversion application_buildid: 20170309053723 07:33:00 INFO - mozversion application_changeset: 556ffc2114f73aff3bf6d80f0a6648791c17662b 07:33:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:33:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:00 INFO - mozversion application_name: Firefox 07:33:00 INFO - mozversion application_remotingname: firefox-dev 07:33:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:00 INFO - mozversion application_vendor: Mozilla 07:33:00 INFO - mozversion application_version: 54.0a2 07:33:00 INFO - mozversion platform_buildid: 20170309053723 07:33:00 INFO - mozversion platform_changeset: 556ffc2114f73aff3bf6d80f0a6648791c17662b 07:33:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:00 INFO - mozversion platform_version: 54.0a2 07:33:00 INFO - using testdate: 1489073580 07:33:00 INFO - actual date: 1489073580 07:33:00 INFO - starting webserver on 'localhost:62681' 07:33:00 INFO - SUITE-START | Running 2 tests 07:33:00 INFO - TEST-START | dromaeo_css 07:33:00 INFO - operating with platform_type : mac_ 07:33:00 INFO - Initialising browser for dromaeo_css test... 07:33:00 INFO - TEST-INFO | started process 2727 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmptwEuB8/profile http://localhost:62681/getInfo.html) 07:33:03 INFO - PROCESS | 2727 | 2017-03-09 07:33:03.734 plugin-container[2729:39253] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494b, name = 'com.apple.tsm.portname' 07:33:03 INFO - PROCESS | 2727 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:03 INFO - PROCESS | 2727 | 2017-03-09 07:33:03.739 plugin-container[2729:39253] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c0f, name = 'com.apple.CFPasteboardClient' 07:33:03 INFO - PROCESS | 2727 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:03 INFO - PROCESS | 2727 | 2017-03-09 07:33:03.739 plugin-container[2729:39253] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:03 INFO - PROCESS | 2727 | __metrics Screen width/height:1600/1200 07:33:03 INFO - PROCESS | 2727 | colorDepth:24 07:33:03 INFO - PROCESS | 2727 | Browser inner width/height: 1024/689 07:33:03 INFO - PROCESS | 2727 | __metrics 07:33:03 ERROR - PROCESS | 2727 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:33:04 INFO - TEST-INFO | 2727: exit 0 07:33:04 INFO - Browser initialized. 07:33:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:04 INFO - TEST-INFO | started process 2730 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmptwEuB8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:07 INFO - PROCESS | 2730 | 2017-03-09 07:33:07.427 plugin-container[2731:39380] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 07:33:07 INFO - PROCESS | 2730 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:07 INFO - PROCESS | 2730 | 2017-03-09 07:33:07.428 plugin-container[2731:39380] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 07:33:07 INFO - PROCESS | 2730 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:07 INFO - PROCESS | 2730 | 2017-03-09 07:33:07.428 plugin-container[2731:39380] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:17 INFO - PROCESS | 2730 | RSS: Main: 220057600 07:33:17 INFO - PROCESS | 2730 | 07:36:21 INFO - PROCESS | 2730 | Cycle 1(1): loaded http://localhost:62681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62681/tests/dromaeo/cssquery-ext.html) 07:36:23 INFO - PROCESS | 2730 | RSS: Main: 242253824 07:36:23 INFO - PROCESS | 2730 | 07:38:05 INFO - PROCESS | 2730 | ************************* 07:38:05 INFO - PROCESS | 2730 | A coding exception was thrown and uncaught in a Task. 07:38:05 INFO - PROCESS | 2730 | 07:38:05 ERROR - PROCESS | 2730 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:05 INFO - PROCESS | 2730 | Full stack: 07:38:05 INFO - PROCESS | 2730 | ************************* 07:39:25 INFO - PROCESS | 2730 | Cycle 1(1): loaded http://localhost:62681/tests/dromaeo/cssquery-ext.html (next: http://localhost:62681/tests/dromaeo/cssquery-jquery.html) 07:39:26 INFO - PROCESS | 2730 | RSS: Main: 248803328 07:39:26 INFO - PROCESS | 2730 | 07:42:28 INFO - PROCESS | 2730 | Cycle 1(1): loaded http://localhost:62681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62681/tests/dromaeo/cssquery-mootools.html) 07:42:28 INFO - PROCESS | 2730 | RSS: Main: 256008192 07:42:28 INFO - PROCESS | 2730 | 07:45:30 INFO - PROCESS | 2730 | Cycle 1(1): loaded http://localhost:62681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62681/tests/dromaeo/cssquery-prototype.html) 07:45:31 INFO - PROCESS | 2730 | RSS: Main: 252170240 07:45:31 INFO - PROCESS | 2730 | 07:48:34 INFO - PROCESS | 2730 | Cycle 1(1): loaded http://localhost:62681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62681/tests/dromaeo/cssquery-yui.html) 07:48:35 INFO - PROCESS | 2730 | RSS: Main: 257355776 07:48:35 INFO - PROCESS | 2730 | 07:51:37 INFO - PROCESS | 2730 | Cycle 1(1): loaded http://localhost:62681/tests/dromaeo/cssquery-yui.html (next: http://localhost:62681/tests/dromaeo/cssquery-dojo.html) 07:51:38 INFO - PROCESS | 2730 | RSS: Main: 254529536 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | __start_tp_report 07:51:38 INFO - PROCESS | 2730 | _x_x_mozilla_page_load 07:51:38 INFO - PROCESS | 2730 | _x_x_mozilla_page_load_details 07:51:38 INFO - PROCESS | 2730 | |i|pagename|runs| 07:51:38 INFO - PROCESS | 2730 | |0;dojo.html;3059.8929037483686;3499.3701133795907;3508.3860324443217;3515.1563624730074;3529.5588051493555;5297.9668964551975;5701.287339082614;6121.66330851803;6159.137720719097;6183.103449999748;4692.389989301395;6166.7841625543115;6210.937890621092;6224.346443623423;6247.312795592481;5551.528120109796;5586.608937374385;5641.605087643846;5687.772489100431;5702;5283.392409872856;5628.971855140739;5646.435356464362;5653.604247702662;5657;5406.107992181285;5445.754941027643;5736.713164341766;5744.79893203738;5745.655260684352;5519.034169020425;5538.944610553883;5540.196671482653;5541.974734674098;5543.473370029841;5345.973270133663;5461.563074953994;5485.149801780731;5501.174823776426;5519.613627046108;6096.390360963913;6123.4351415035735;6133.1413602095745;6139.584134579331;6198.3801619838105;5042.319286896295;6402.423781859655;6437.581557198767;6503.869922601569;6531.118299029666;6624.834379140512;6628.270890202122;6630.336966303379;6631.071649969008;6639.170103737033;6065;6126.969365153146;6149.354317796657;6203.069539569011;6285.120083188357;6143.450468055797;6463.935360646427;6804.625745583941;6805.285445028299;6825.385715285648;6393.936060639334;6403.103565500834;6405.935940640627;6409.519286053472;6434.099226108348;5371.75827087782;6254.312025677172;6302.432781049728;6567.671616419256;6569.57297775643;6293.465055470337;6304.842378940563;6362.968185159045;6382.8723425531225;6416.197975253093;6463.806085817433;6482;6493.610383377012;6493.837654058591;6518.28298887122;4646.907061858811;5092.872678183075;5143.8199663012365;5201.869953251199;5204.583633309327;4584.220682483986;4597.103564804831;4638;4698;4734.905301893943;6005.279366475964;6076.3316035236085;6129.175413489909;6220.657863817533;6228.719707613168;6557.868842623121;6629.237637671633;6629.86740265192;6635.900461493082;6645.169353830771;5785.247917770663;5829.533637309005;5989.431004054608;6064.332923378425;6219.253689557192;5691.146328050825;5708.600397972185;5712.428757124338;5720.570957178228;5777.335606405233;6804.353586409283;6806.523543351917;6808.761693340709;6811.863762724619;6820.31796820314;5909.349971503045;6574.243961944438;6612.371824676648;6620.702068406837;6627.701753421011;5447.945520544744;5552.972700050504;6251.343608920998;6502.739890404331;6811.445707859552;6318.178636777373;6345.555811093179;6454.128692626623;6460.806175814733;6465.806025819233;6565.901511477427;6578.868422631616;6586.110875031809;6607.702653380513;6610.3720146586;6121.818815678178;6215.875682486416;6363.045543168561;6363.840903977252;6388.712507937061;6154.723037463415;6185.948388773829;6197.690115494117;6339.112524246517;6344.936550634435;6120.724567394389;6209.565330426827;6235.095911092957;6248.968755156195;6252.499800016079;6306.558540902093;6315.747370105144;6343.619382837044;6355.809325720235;6374.362563743774;6111.287884814297;6146.938530614637;6188.597741146811;6189.84525386869;6275.466585340115 07:51:38 INFO - PROCESS | 2730 | |1;ext.html;725.484905716941;791.9010123734533;819.2954059508821;943.71688493452;945.5461378538297;38257.23485530288;39307.606923930754;40569.18861622766;40619.59380406195;40649.39025914614;38995.41506877399;39242.8037859811;39244.21511569767;39281.41077883827;39322.60677393225;6842.897356539644;8022.759317220463;10399.53202105907;10716.946415267912;10854.34873907568;9903.603855845793;10328.122109620692;10557.41934193619;10626.78746425071;10651.573937042509;10607.15142788575;10691.625793097242;10693.411862347606;10706.571737130505;10739.624113156042;10608.575656973711;10640.255182137253;10649.520771565298;10666;10671.253012289142;10323.690289291333;10347.223958203089;10353.585856565729;10375.377477351383;10389.584416623326;34121.658783412095;34186.82906585451;34193.82903085493;34253;34316.656833431596;3620.5112309838096;3634.7637403568683;3662.1393972416463;3709.981450092759;3756.2487502499607;19631;23838.16566420167;24702.629460558106;26228.73771262282;26268;2572.8199026068182;2983.298924752681;3078.892238771632;3116.8597413116463;3150.795198312125;327055;328671;328704;328732;330207;45099.54900451019;45147.774261128485;45322;45416.09167816625;45954.770226148656;45184.77407612941;45328.54671453243;45411.31883021758;45482.635520934426;45543;13015.284159371326;13088.934555327352;13105.868941310655;13108.016898732443;13329.200247985153;10163.441010744333;10219.233557483218;11047.83428248577;11067.225294229487;11335.376554289593;8555.743327700178;10551.94724026375;11734.471948762326;11839.822402663967;11860.288382697066;4661.487236403993;5314;5585;5622.409646987089;5627.88702323585;1080.4975686305906;1084.7342401111778;1112.2436743014828;1117.3072694929197;1164.7088227943013;24463.89912453944;25353.492930141292;26344.868275658882;27054.729452705615;27123;1119.5801574409597;1124.891981398322;1214.5991822698488;1227;1248.9812652810215;12975.675608109872;13762.518311859038;13775.448982040807;13970.371333290026;14090.436382544789;469021;470470;472066;472496;473279;57771.71114144402;57798.55503612443;57830.71084644634;57884.4211557879;57910.71044644834;1063.6543123484898;1272.3892531584706;1333.3000174908057;1367.787992861108;1412.7951447040123;25291.747082529677;29676;30720.84639576788;30896.845515773177;31267;42488.7253382399;42641.147177056904;42708;42746.57253427426;42828.78585607052;406673;408786;408821;409249;410474;29491.410171796873;30344.84827575848;31325.216869578442;31367.372652546364;32475.67524324821;31194.688053120088;37675.62324376831;38167.61832381641;38498.6150138495;39108.80445597754;32678.673213268514;33041.66958330386;33094.33811323808;33097.50353744648;33828.815991440184;31027.53458698076;33250.00249992504;33254.23255628445;33547.1549064794;33909.98270051902;32681;32951;33039.174020649676;33274.667253327156;33276.16809579683;27593.724062759116;29553.704462955095;29768.553471698375;30116.397672045998;30123.69876301209;20528.897355513724;21086.47283817917;22990.456414966233;23304.766952330938;23351.883240584368 07:51:38 INFO - PROCESS | 2730 | |2;jquery.html;399.6003996003998;402.9556748757634;418.6629763040752;421.65003047470594;442.7786106946527;19531.5117122072;19827.504312392197;20991.580168396624;21078.894605526988;21123.15507379705;16433.58916027097;20632.896835515803;21169.894150529224;21231.57536849262;21271;6604.900926486094;6823.010663453796;6834.521583489158;6882.9311706883045;6885.070515480396;6619.93380066198;6674.2658307586125;7075.257098004713;7449.441291903102;7573.848523029536;7326.230745771697;7555.0933887933525;7565.13001004886;7569.318761311481;7582.014338136062;7508.924910750878;7543.73596924105;7585.696572137108;7589;7612.467127301091;7154.4634152438775;7411.370033547155;7439.330460258549;7439.4792364534505;7464.514806537612;25160;25444.872775636188;25758.613620795702;25844.612330815053;26138.085167019253;2934.339773550955;2954.3943491584173;3024.652165001031;3033.2720147164523;3069.0332545248175;15798.05211687291;16016.599585010352;16021.87846850721;16027.439039633557;16884.324627015027;1639.6802623488306;1788.7674602301747;1952.3459641020274;2012.7081573171954;2033.7356143701372;161232;166601.16699416545;168334;169412.1529392345;169582;16399.508014759576;17156.39952601653;19512.414627561197;20179.596408071757;20549.178032878815;31080.533791993137;31248.68751312503;31349.216269593442;31525.684743152276;31544.684553154173;8033.317168040782;8503;9827;10225.488725563691;10309.94845025785;8317.792055198548;8376;8390.454620449651;8543.35924805642;8545.060043395222;8131.430799844073;8347.4156809024;9587.089226523469;9670.984546622503;9733.805323893483;3495.5106285120105;3988.6809055275507;4080.2859499587453;4105.486814148231;4118.876433706993;810.4529442626203;825.8561891779808;835.8829763833069;839.0644431458879;879.2262808728406;15729.451439746028;21201.25795597147;21706.457338566663;21739.456513587287;22808.745518996282;730.7577118897894;869.6347534035721;877.8727084572702;890.4790697441939;894.08356434655;9923.702288931343;10821.945890270656;11360.147988900866;11402.828957565644;11410.315381077162;738682;745448;746803;761927;762772;146143;156972;162908;165811.34188657958;168064.15967920082;1350.6285771412743;1353.6886516101156;1412.3503188533184;1413.8798202152932;1415.547024952026;19660.80339196647;20008.69943453671;20331.796682033582;20349.694754578988;20387.388378348674;63815.36184638094;64758.676206618664;66133.33866661272;66242;66523.66738166472;67079;76668;79094.604526977;84337.15662843293;93585;11428.657140285804;11691.064714822964;11753.294802311888;12085.516579336729;12110.152289339661;13212.273324967218;13276.734465310832;13555.983301252249;13697.315134243447;13698.246596437291;11294.830577541508;11486.277058441301;11573.685262947276;11636.243644163102;11730.530778768754;10262.486875656337;11030.889691102986;11213.551457941918;11283.717907052389;11573.710657233636;11120.388378639253;11575.768484630093;11863.169578129447;11965.923066924019;11988.040956723615;11698.181127321006;11709.121815864015;11901.404929753304;12005.459754310903;12052.939735301268;11341.546338146713;11384.715382115513;11406.885931140583;11555.595554155565;11655.708607284885 07:51:38 INFO - PROCESS | 2730 | |3;mootools.html;1275.228486765507;1443.473132306708;1465.4944044304711;1486.4277253257492;1490.634794475353;10615.31000484968;10884.07485363745;11210.831837522444;11307.265027773188;11333.716657083576;10912;11308.208425410225;11330.206885518017;11349.886501134986;11431.02836258919;2168.6746987951856;2281.3384118605586;2335.9766402336013;2392.342105920868;2394.209910729464;2330.755270696578;2365.1012615206196;2370.3600027992434;2377.5720370333333;2379.310000099969;2329.801966832821;2345.437095097173;2353.317537914003;2366.8934897929635;2372.9288121356385;2279.566882292376;2296.666983287422;2315.3169814904477;2317.1194945920524;2331.2889568681544;2255.639097744353;2289.8969546370454;2354.128972280267;2363.3264519612;2363.7990770784504;11257.774844503147;11299.096072314278;11318.377489238088;11335.773284534263;11343.886561134448;4863.659543831933;5946.583739138262;6023.819285421444;6024.909626355608;6030.909536356959;3471.73961952852;3603.621619729943;3608.2963822054708;3654.1595433050284;3664;1185.82805493203;1196.8324434579165;1236.7217376090398;1257.7987521996529;1261.148724610884;13614.931925340408;14014.789778153336;15398.769018464733;15585.688286234212;15586.986845854983;4545.477270113913;4727.699882532263;4749.335093086971;4756.453007904066;4776.880577985578;11633.127515436376;11677.824832627517;11678.88321116795;11710.1217408693;11752.70618234551;5721.056025755787;5731.455511726379;5761.020626493506;5772.769089236467;5781.046127388934;5057.241413787961;5325.8934821303355;5362.91955620666;5400.108982017923;5416.0521908666615;3851.826667799956;3938.6258305460933;3953.2093581283857;4036.1120553478186;4045.1505183911117;986.5313975861552;999.8202121496558;1054.383185836279;1065.589747947046;1077.7682798198425;750.264740554249;768.1588660416835;781.8827175923543;784.7175016993878;788.7751990682742;6332.588381755263;6481.578697384655;6657.933420665731;6689.364510371507;6701.731930722716;980.4362491567234;981.5190556627201;985.8570507276405;993.3940296419179;1010.7927874785652;3994.3609022556834;4067.3085575452246;4557.498675145731;4651.813927442932;4749.738764367924;13735.175889446666;13793.517226897011;13938.512152074629;13950.860491395159;13951.441942322397;13190.670233244246;13702.38339274735;13841.377138028813;13860.584182474542;13868.93065534666;9902.405855648683;10165.28842980999;10187.694369168938;10196.38821670702;10218.386896786067;5925.288965324189;6183.072539119168;6277.121203031488;6416.7754128605275;6445.677716114082;11842.822357664814;12148.331841748788;12181.208221465577;12270.4478298475;12304.323262220663;11463.197576169921;11792.941035295113;12104.273743575413;12419.689507762378;12620.873791262336;7672.309492145734;9330.393524420891;9461.574229159567;9463.716088517356;9469.195118415011;10286.2799604027;10294.3823370598;10298.742531436774;10393.740156495845;10419.583216671248;9230.892292924893;9256.72229833106;9268.53657317145;9316.021817709043;9442.244620430487;9041.59312830911;9066.773330666787;9142.58858351389;9176.95411522938;9365.859512107187;6719.764808231688;7890.566018869017;7980.84038319242;7985.361171106414;7992.960035199787;5747.281589801275;5773.3072031356505;5862.560307976833;5954.374790647093;6059.787907423219;5870.119482077552;5963.880722385615;6068.969655151696;6079.544034197364;6153.354377272445 07:51:38 INFO - PROCESS | 2730 | |4;prototype.html;361.75942997906395;366.83492428407226;379.7114193213158;380.4141621902267;384.8980020294621;4585.784767036734;5090.541851233388;5294.444083371249;5372.6213136293945;5477.850820228982;4178.6448151907125;4834.927476087862;5080.974595127029;5157.406898206707;5253.452075743271;3831.9808400957954;4386.7587282699515;4387.016828556581;4658.324542941272;4697.168104439272;3201.791883527575;4355.36847157162;4465.186932232689;4668.673192876483;4731.763411829412;3825.751326163804;3992.1217332187016;4095.692823038284;4289.1850548395705;4333.956660433387;3604.7837129772297;3736.7197460190596;4301.4729770931335;4373.103513779699;4442.4669039715445;3619.5294611700574;4022.0950286185666;4057.0526147449095;4069.593040695907;4118.217538667674;4822.300766388889;4952.752362381866;5040.924386134211;5073.365829271341;5080.443689417422;4511.368408422823;4587.087199628227;4970.179920313144;5013.671377085076;5023.734572527849;5408.4050754416985;5601.467860553241;5605.971970140164;5657.519110875581;5747.39652336507;3835.7698538087525;4039.9596004040172;4254.680898932593;4443.622292105175;4515.254982927813;4809.831655892027;5095.133827249377;5900.055991041456;5910.320313163955;5933.664925391839;4078.653314468244;4267.8263477543305;4294.377315289265;4382.671299652538;4469.687121901436;3943.5464921533817;4667.066586682609;4672.322513235562;4675.906481870344;4728.787204575802;4154.608206250879;4709.858704238878;4978.825741099116;5036.6726162799305;5074.771635276422;4799.544043315879;5598.552115830724;5692.658440493501;5695.914561281584;5773.624714393551;1533.0648304534225;1585.2549301828121;1596.5928688184438;1612.6292651246347;1615.6041769766482;1146.827975803636;1168.2873447197203;1174.8707642159357;1187.456306801155;1208.6555331730415;4906.509349065065;5224.399194092652;5291.153415453509;5296.576273898079;5313.123334649817;5115.948840511622;5567.884204002534;5595.440455954372;5620.859478512988;5714.514106426435;4577.496475387705;4828.299896514985;4942.604591632661;5030.597552195815;5249.895002099936;2721.3740839607003;2947.7641788656856;3039.802412843158;3072.723454889026;3084.383123375334;5130.846074617767;6078.016026858022;6095.542834287447;6098.969505152446;6110.5722599418505;5036.143855544567;5583.464547249458;5837.416258374129;6044.214252147192;6118;6149.354317796657;6166.938330616636;6180.81457556274;6187.3503282154725;6208.099825525183;4979.701217926936;5531.474509921551;5867.5063098182245;5887.499562537232;5945;4951.861071953399;5492.505674489315;5734.254546908875;5824.767009319579;5850.034744267148;5877.911831322619;5927.940720592739;6166.907496387468;6189.566730328834;6202.317745048132;3974.602539746002;4373.540778218368;4403;4420.7789610519985;4499.920019195435;5127.794888204579;5575.303087114111;5799.739011744397;5824.136276391514;5842.188921434369;5006.824761133343;5167.767450464813;5491.28613280271;5620.662760234399;5654.483754729106;4794.856154315376;5299.258103865539;5561.386148510193;5688.345840228427;5728.79949201776;4635.188841952712;4777.856664300077;4945.826896058621;4981.576565991932;5480.150576660624;4996.775145118406;5613.775448982158;5723;5744.655320680772;5804.158397032322;5006.769279958429;5254;5370.275012873369;5543.362513311021;5569.688579239571 07:51:38 INFO - PROCESS | 2730 | |5;yui.html;712.5795780489514;731.9304666056722;768.5619197057675;815.8082850530126;822.5064961023385;14951.401943922243;15645.843541564582;16135.9511631744;16167.75748363774;16267.10530920799;14572.198529080897;14847.55457336279;15153.621159471018;15155.469558565424;15188.924055379735;905.9184673379411;941;941.7975135345899;946.280826571807;949.6818565780437;884.5798245833209;918.6555041859302;924.4545718026396;924.865894445305;931.0363773494435;960.0639376607821;970.611755297883;976.5800705696547;977.5210147027941;978.4862946952871;972.8054389122204;972.9610815567369;973.6154219083458;976.4678250353539;976.653288082731;717.1967396515936;718.4252597921642;718.6945548142019;718.8274814044644;720.1574158234878;15814.9209253953;16247.675046499122;16373.263203155768;16726.24731887068;17126.05806680632;13732.794008089886;13845.792313115311;13865.09876858001;13925.303734813218;14088.577342679737;11774.293542387484;11850.170488065838;11889.821652675217;12025.579104731292;12275.263484190977;3235.88674396395;3602.6397360263763;3648.0515066082744;3652.2330310634798;3757.7369584129124;113417.43291283573;113854;114409;114712;115144;9975.900240997642;10770.676879693621;10922.72693182661;11217.775644487065;11345.09239260857;22264.554708906056;22685.546289074126;22816.88591557065;23038.193663221708;23043.078276869073;7591.074953639976;7619.123800762984;7624.161073825503;7628.8474230516185;7800.531968081933;4231.703780735319;4258.765767882796;4295.076558539929;4321.395004699345;4367.235733746646;3393.745469089828;3473.4789781532468;3502.387082260594;3516.771409858351;3520.753547251668;548.0409283753431;606.9817905462843;613.2487702564412;619.8078595635368;632.0708558419117;660.5937348530715;690.2097098821821;699.7830672491442;713.3829237709448;716.455493824697;10187.54156062979;10382.948085259526;10426.582936682447;10470.11004064663;10504.272404130803;552.8065177187952;566.3911295357507;571.8027280588191;572.1874937588634;576.6280748916926;4021.7586944783407;4972.825951091694;5007;5013;5014.222795466709;79076.60461697655;89375.55312223527;92467;95930;99121.00878991262;54487;74776.62611686907;82682;84112.15887841166;84955.72566411509;73203;74754.62622686852;75567;76362;78728.42543149105;10213.234007449322;10848.837267440837;11202.607908723481;11230.270032447865;11246.325220486797;36917.3858203345;48772.02455950932;49376.5311734419;50286.74283142951;51101;65189.67405162944;66742.33257667361;67238.65522689617;70504.64747676229;71520.64239678977;10195.796084078129;12851.550195743104;12963.481460741465;13030.674233143867;13156.276404797827;14556.563303100924;14639.48761793332;14855.405783768529;15027.774583381039;15189.924050379677;13529.86470135286;13697.315134243447;13993.300334983007;14343.928280358532;14633.34149963233;13456.86543134556;13869.86130138726;13912.234827084203;14172.929135354258;14489.927550362181;12342.629721108382;13612.863871361556;13792.93103534476;13812.37844296989;14055;10642.73393165177;10963.342199468058;11099.389533575408;11102.222844400814;11192.440377980905;10097.192224621866;11083.640713787518;11281.943590281997;11296.6046188383;11322.773544529227 07:51:38 INFO - PROCESS | 2730 | __end_tp_report 07:51:38 INFO - PROCESS | 2730 | __start_cc_report 07:51:38 INFO - PROCESS | 2730 | _x_x_mozilla_cycle_collect,418 07:51:38 INFO - PROCESS | 2730 | __end_cc_report 07:51:38 INFO - PROCESS | 2730 | __startTimestamp1489074698219__endTimestamp 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | ------- Summary: start ------- 07:51:38 INFO - PROCESS | 2730 | Number of tests: 6 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | [#0] dojo.html Cycles:165 Average:6001.79 Median:6203.07 stddev:690.43 (11.1%) stddev-sans-first:652.84 07:51:38 INFO - PROCESS | 2730 | Values: 3059.9 3499.4 3508.4 3515.2 3529.6 5298.0 5701.3 6121.7 6159.1 6183.1 4692.4 6166.8 6210.9 6224.3 6247.3 5551.5 5586.6 5641.6 5687.8 5702.0 5283.4 5629.0 5646.4 5653.6 5657.0 5406.1 5445.8 5736.7 5744.8 5745.7 5519.0 5538.9 5540.2 5542.0 5543.5 5346.0 5461.6 5485.1 5501.2 5519.6 6096.4 6123.4 6133.1 6139.6 6198.4 5042.3 6402.4 6437.6 6503.9 6531.1 6624.8 6628.3 6630.3 6631.1 6639.2 6065.0 6127.0 6149.4 6203.1 6285.1 6143.5 6463.9 6804.6 6805.3 6825.4 6393.9 6403.1 6405.9 6409.5 6434.1 5371.8 6254.3 6302.4 6567.7 6569.6 6293.5 6304.8 6363.0 6382.9 6416.2 6463.8 6482.0 6493.6 6493.8 6518.3 4646.9 5092.9 5143.8 5201.9 5204.6 4584.2 4597.1 4638.0 4698.0 4734.9 6005.3 6076.3 6129.2 6220.7 6228.7 6557.9 6629.2 6629.9 6635.9 6645.2 5785.2 5829.5 5989.4 6064.3 6219.3 5691.1 5708.6 5712.4 5720.6 5777.3 6804.4 6806.5 6808.8 6811.9 6820.3 5909.3 6574.2 6612.4 6620.7 6627.7 5447.9 5553.0 6251.3 6502.7 6811.4 6318.2 6345.6 6454.1 6460.8 6465.8 6565.9 6578.9 6586.1 6607.7 6610.4 6121.8 6215.9 6363.0 6363.8 6388.7 6154.7 6185.9 6197.7 6339.1 6344.9 6120.7 6209.6 6235.1 6249.0 6252.5 6306.6 6315.7 6343.6 6355.8 6374.4 6111.3 6146.9 6188.6 6189.8 6275.5 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | [#1] ext.html Cycles:180 Average:53571.55 Median:17259.08 stddev:108057.41 (626.1%) stddev-sans-first:108287.70 07:51:38 INFO - PROCESS | 2730 | Values: 725.5 791.9 819.3 943.7 945.5 38257.2 39307.6 40569.2 40619.6 40649.4 38995.4 39242.8 39244.2 39281.4 39322.6 6842.9 8022.8 10399.5 10716.9 10854.3 9903.6 10328.1 10557.4 10626.8 10651.6 10607.2 10691.6 10693.4 10706.6 10739.6 10608.6 10640.3 10649.5 10666.0 10671.3 10323.7 10347.2 10353.6 10375.4 10389.6 34121.7 34186.8 34193.8 34253.0 34316.7 3620.5 3634.8 3662.1 3710.0 3756.2 19631.0 23838.2 24702.6 26228.7 26268.0 2572.8 2983.3 3078.9 3116.9 3150.8 327055.0 328671.0 328704.0 328732.0 330207.0 45099.5 45147.8 45322.0 45416.1 45954.8 45184.8 45328.5 45411.3 45482.6 45543.0 13015.3 13088.9 13105.9 13108.0 13329.2 10163.4 10219.2 11047.8 11067.2 11335.4 8555.7 10551.9 11734.5 11839.8 11860.3 4661.5 5314.0 5585.0 5622.4 5627.9 1080.5 1084.7 1112.2 1117.3 1164.7 24463.9 25353.5 26344.9 27054.7 27123.0 1119.6 1124.9 1214.6 1227.0 1249.0 12975.7 13762.5 13775.4 13970.4 14090.4 469021.0 470470.0 472066.0 472496.0 473279.0 57771.7 57798.6 57830.7 57884.4 57910.7 1063.7 1272.4 1333.3 1367.8 1412.8 25291.7 29676.0 30720.8 30896.8 31267.0 42488.7 42641.1 42708.0 42746.6 42828.8 406673.0 408786.0 408821.0 409249.0 410474.0 29491.4 30344.8 31325.2 31367.4 32475.7 31194.7 37675.6 38167.6 38498.6 39108.8 32678.7 33041.7 33094.3 33097.5 33828.8 31027.5 33250.0 33254.2 33547.2 33910.0 32681.0 32951.0 33039.2 33274.7 33276.2 27593.7 29553.7 29768.6 30116.4 30123.7 20528.9 21086.5 22990.5 23304.8 23351.9 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | [#2] jquery.html Cycles:180 Average:43519.73 Median:23984.37 stddev:125741.40 (524.3%) stddev-sans-first:126052.46 07:51:38 INFO - PROCESS | 2730 | Values: 399.6 403.0 418.7 421.7 442.8 19531.5 19827.5 20991.6 21078.9 21123.2 16433.6 20632.9 21169.9 21231.6 21271.0 6604.9 6823.0 6834.5 6882.9 6885.1 6619.9 6674.3 7075.3 7449.4 7573.8 7326.2 7555.1 7565.1 7569.3 7582.0 7508.9 7543.7 7585.7 7589.0 7612.5 7154.5 7411.4 7439.3 7439.5 7464.5 25160.0 25444.9 25758.6 25844.6 26138.1 2934.3 2954.4 3024.7 3033.3 3069.0 15798.1 16016.6 16021.9 16027.4 16884.3 1639.7 1788.8 1952.3 2012.7 2033.7 161232.0 166601.2 168334.0 169412.2 169582.0 16399.5 17156.4 19512.4 20179.6 20549.2 31080.5 31248.7 31349.2 31525.7 31544.7 8033.3 8503.0 9827.0 10225.5 10309.9 8317.8 8376.0 8390.5 8543.4 8545.1 8131.4 8347.4 9587.1 9671.0 9733.8 3495.5 3988.7 4080.3 4105.5 4118.9 810.5 825.9 835.9 839.1 879.2 15729.5 21201.3 21706.5 21739.5 22808.7 730.8 869.6 877.9 890.5 894.1 9923.7 10821.9 11360.1 11402.8 11410.3 738682.0 745448.0 746803.0 761927.0 762772.0 146143.0 156972.0 162908.0 165811.3 168064.2 1350.6 1353.7 1412.4 1413.9 1415.5 19660.8 20008.7 20331.8 20349.7 20387.4 63815.4 64758.7 66133.3 66242.0 66523.7 67079.0 76668.0 79094.6 84337.2 93585.0 11428.7 11691.1 11753.3 12085.5 12110.2 13212.3 13276.7 13556.0 13697.3 13698.2 11294.8 11486.3 11573.7 11636.2 11730.5 10262.5 11030.9 11213.6 11283.7 11573.7 11120.4 11575.8 11863.2 11965.9 11988.0 11698.2 11709.1 11901.4 12005.5 12052.9 11341.5 11384.7 11406.9 11555.6 11655.7 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | [#3] mootools.html Cycles:180 Average:6752.32 Median:2385.83 stddev:4235.77 (177.5%) stddev-sans-first:4227.65 07:51:38 INFO - PROCESS | 2730 | Values: 1275.2 1443.5 1465.5 1486.4 1490.6 10615.3 10884.1 11210.8 11307.3 11333.7 10912.0 11308.2 11330.2 11349.9 11431.0 2168.7 2281.3 2336.0 2392.3 2394.2 2330.8 2365.1 2370.4 2377.6 2379.3 2329.8 2345.4 2353.3 2366.9 2372.9 2279.6 2296.7 2315.3 2317.1 2331.3 2255.6 2289.9 2354.1 2363.3 2363.8 11257.8 11299.1 11318.4 11335.8 11343.9 4863.7 5946.6 6023.8 6024.9 6030.9 3471.7 3603.6 3608.3 3654.2 3664.0 1185.8 1196.8 1236.7 1257.8 1261.1 13614.9 14014.8 15398.8 15585.7 15587.0 4545.5 4727.7 4749.3 4756.5 4776.9 11633.1 11677.8 11678.9 11710.1 11752.7 5721.1 5731.5 5761.0 5772.8 5781.0 5057.2 5325.9 5362.9 5400.1 5416.1 3851.8 3938.6 3953.2 4036.1 4045.2 986.5 999.8 1054.4 1065.6 1077.8 750.3 768.2 781.9 784.7 788.8 6332.6 6481.6 6657.9 6689.4 6701.7 980.4 981.5 985.9 993.4 1010.8 3994.4 4067.3 4557.5 4651.8 4749.7 13735.2 13793.5 13938.5 13950.9 13951.4 13190.7 13702.4 13841.4 13860.6 13868.9 9902.4 10165.3 10187.7 10196.4 10218.4 5925.3 6183.1 6277.1 6416.8 6445.7 11842.8 12148.3 12181.2 12270.4 12304.3 11463.2 11792.9 12104.3 12419.7 12620.9 7672.3 9330.4 9461.6 9463.7 9469.2 10286.3 10294.4 10298.7 10393.7 10419.6 9230.9 9256.7 9268.5 9316.0 9442.2 9041.6 9066.8 9142.6 9177.0 9365.9 6719.8 7890.6 7980.8 7985.4 7993.0 5747.3 5773.3 5862.6 5954.4 6059.8 5870.1 5963.9 6069.0 6079.5 6153.4 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | [#4] prototype.html Cycles:180 Average:4687.36 Median:5006.80 stddev:1331.32 (26.6%) stddev-sans-first:1294.86 07:51:38 INFO - PROCESS | 2730 | Values: 361.8 366.8 379.7 380.4 384.9 4585.8 5090.5 5294.4 5372.6 5477.9 4178.6 4834.9 5081.0 5157.4 5253.5 3832.0 4386.8 4387.0 4658.3 4697.2 3201.8 4355.4 4465.2 4668.7 4731.8 3825.8 3992.1 4095.7 4289.2 4334.0 3604.8 3736.7 4301.5 4373.1 4442.5 3619.5 4022.1 4057.1 4069.6 4118.2 4822.3 4952.8 5040.9 5073.4 5080.4 4511.4 4587.1 4970.2 5013.7 5023.7 5408.4 5601.5 5606.0 5657.5 5747.4 3835.8 4040.0 4254.7 4443.6 4515.3 4809.8 5095.1 5900.1 5910.3 5933.7 4078.7 4267.8 4294.4 4382.7 4469.7 3943.5 4667.1 4672.3 4675.9 4728.8 4154.6 4709.9 4978.8 5036.7 5074.8 4799.5 5598.6 5692.7 5695.9 5773.6 1533.1 1585.3 1596.6 1612.6 1615.6 1146.8 1168.3 1174.9 1187.5 1208.7 4906.5 5224.4 5291.2 5296.6 5313.1 5115.9 5567.9 5595.4 5620.9 5714.5 4577.5 4828.3 4942.6 5030.6 5249.9 2721.4 2947.8 3039.8 3072.7 3084.4 5130.8 6078.0 6095.5 6099.0 6110.6 5036.1 5583.5 5837.4 6044.2 6118.0 6149.4 6166.9 6180.8 6187.4 6208.1 4979.7 5531.5 5867.5 5887.5 5945.0 4951.9 5492.5 5734.3 5824.8 5850.0 5877.9 5927.9 6166.9 6189.6 6202.3 3974.6 4373.5 4403.0 4420.8 4499.9 5127.8 5575.3 5799.7 5824.1 5842.2 5006.8 5167.8 5491.3 5620.7 5654.5 4794.9 5299.3 5561.4 5688.3 5728.8 4635.2 4777.9 4945.8 4981.6 5480.2 4996.8 5613.8 5723.0 5744.7 5804.2 5006.8 5254.0 5370.3 5543.4 5569.7 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - PROCESS | 2730 | [#5] yui.html Cycles:180 Average:20079.72 Median:3625.35 stddev:28358.41 (782.2%) stddev-sans-first:28400.67 07:51:38 INFO - PROCESS | 2730 | Values: 712.6 731.9 768.6 815.8 822.5 14951.4 15645.8 16136.0 16167.8 16267.1 14572.2 14847.6 15153.6 15155.5 15188.9 905.9 941.0 941.8 946.3 949.7 884.6 918.7 924.5 924.9 931.0 960.1 970.6 976.6 977.5 978.5 972.8 973.0 973.6 976.5 976.7 717.2 718.4 718.7 718.8 720.2 15814.9 16247.7 16373.3 16726.2 17126.1 13732.8 13845.8 13865.1 13925.3 14088.6 11774.3 11850.2 11889.8 12025.6 12275.3 3235.9 3602.6 3648.1 3652.2 3757.7 113417.4 113854.0 114409.0 114712.0 115144.0 9975.9 10770.7 10922.7 11217.8 11345.1 22264.6 22685.5 22816.9 23038.2 23043.1 7591.1 7619.1 7624.2 7628.8 7800.5 4231.7 4258.8 4295.1 4321.4 4367.2 3393.7 3473.5 3502.4 3516.8 3520.8 548.0 607.0 613.2 619.8 632.1 660.6 690.2 699.8 713.4 716.5 10187.5 10382.9 10426.6 10470.1 10504.3 552.8 566.4 571.8 572.2 576.6 4021.8 4972.8 5007.0 5013.0 5014.2 79076.6 89375.6 92467.0 95930.0 99121.0 54487.0 74776.6 82682.0 84112.2 84955.7 73203.0 74754.6 75567.0 76362.0 78728.4 10213.2 10848.8 11202.6 11230.3 11246.3 36917.4 48772.0 49376.5 50286.7 51101.0 65189.7 66742.3 67238.7 70504.6 71520.6 10195.8 12851.6 12963.5 13030.7 13156.3 14556.6 14639.5 14855.4 15027.8 15189.9 13529.9 13697.3 13993.3 14343.9 14633.3 13456.9 13869.9 13912.2 14172.9 14489.9 12342.6 13612.9 13792.9 13812.4 14055.0 10642.7 10963.3 11099.4 11102.2 11192.4 10097.2 11083.6 11281.9 11296.6 11322.8 07:51:38 INFO - PROCESS | 2730 | -------- Summary: end -------- 07:51:38 INFO - PROCESS | 2730 | 07:51:38 INFO - TEST-INFO | 2730: exit 0 07:51:38 INFO - TEST-OK | dromaeo_css | took 1118015ms 07:51:38 INFO - TEST-START | kraken 07:51:38 INFO - operating with platform_type : mac_ 07:51:38 INFO - Initialising browser for kraken test... 07:51:38 INFO - TEST-INFO | started process 2735 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpMkol4X/profile http://localhost:62681/getInfo.html) 07:51:41 INFO - PROCESS | 2735 | 2017-03-09 07:51:41.701 plugin-container[2736:41655] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 07:51:41 INFO - PROCESS | 2735 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:41 INFO - PROCESS | 2735 | 2017-03-09 07:51:41.704 plugin-container[2736:41655] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:51:41 INFO - PROCESS | 2735 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:41 INFO - PROCESS | 2735 | 2017-03-09 07:51:41.704 plugin-container[2736:41655] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:51:41 INFO - PROCESS | 2735 | __metrics Screen width/height:1600/1200 07:51:41 INFO - PROCESS | 2735 | colorDepth:24 07:51:41 INFO - PROCESS | 2735 | Browser inner width/height: 1024/689 07:51:41 INFO - PROCESS | 2735 | __metrics 07:51:41 ERROR - PROCESS | 2735 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:51:42 INFO - TEST-INFO | 2735: exit 0 07:51:42 INFO - Browser initialized. 07:51:42 INFO - Running cycle 1/1 for kraken test... 07:51:42 INFO - TEST-INFO | started process 2737 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpMkol4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:45 INFO - PROCESS | 2737 | 2017-03-09 07:51:45.194 plugin-container[2738:41787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 07:51:45 INFO - PROCESS | 2737 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:45 INFO - PROCESS | 2737 | 2017-03-09 07:51:45.194 plugin-container[2738:41787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 07:51:45 INFO - PROCESS | 2737 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:51:45 INFO - PROCESS | 2737 | 2017-03-09 07:51:45.194 plugin-container[2738:41787] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:51:54 INFO - PROCESS | 2737 | RSS: Main: 220176384 07:51:54 INFO - PROCESS | 2737 | 07:51:57 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62681/tests/kraken/driver.html?testName=audio-beat-detection) 07:51:58 INFO - PROCESS | 2737 | RSS: Main: 234975232 07:51:58 INFO - PROCESS | 2737 | 07:52:01 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62681/tests/kraken/driver.html?testName=audio-dft) 07:52:02 INFO - PROCESS | 2737 | RSS: Main: 243134464 07:52:02 INFO - PROCESS | 2737 | 07:52:05 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62681/tests/kraken/driver.html?testName=audio-fft) 07:52:06 INFO - PROCESS | 2737 | RSS: Main: 246910976 07:52:06 INFO - PROCESS | 2737 | 07:52:07 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62681/tests/kraken/driver.html?testName=audio-oscillator) 07:52:08 INFO - PROCESS | 2737 | RSS: Main: 248262656 07:52:08 INFO - PROCESS | 2737 | 07:52:10 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:11 INFO - PROCESS | 2737 | RSS: Main: 248303616 07:52:11 INFO - PROCESS | 2737 | 07:52:14 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62681/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:15 INFO - PROCESS | 2737 | RSS: Main: 249917440 07:52:15 INFO - PROCESS | 2737 | 07:52:18 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62681/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:19 INFO - PROCESS | 2737 | RSS: Main: 249876480 07:52:19 INFO - PROCESS | 2737 | 07:52:22 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62681/tests/kraken/driver.html?testName=json-parse-financial) 07:52:23 INFO - PROCESS | 2737 | RSS: Main: 250920960 07:52:23 INFO - PROCESS | 2737 | 07:52:25 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:25 INFO - PROCESS | 2737 | RSS: Main: 250941440 07:52:25 INFO - PROCESS | 2737 | 07:52:27 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:28 INFO - PROCESS | 2737 | RSS: Main: 250941440 07:52:28 INFO - PROCESS | 2737 | 07:52:30 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:31 INFO - PROCESS | 2737 | RSS: Main: 251043840 07:52:31 INFO - PROCESS | 2737 | 07:52:34 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:35 INFO - PROCESS | 2737 | RSS: Main: 251551744 07:52:35 INFO - PROCESS | 2737 | 07:52:37 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:38 INFO - PROCESS | 2737 | RSS: Main: 251138048 07:52:38 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | Cycle 1(1): loaded http://localhost:62681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62681/tests/kraken/driver.html?testName=ai-astar) 07:52:40 INFO - PROCESS | 2737 | RSS: Main: 254578688 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | __start_tp_report 07:52:40 INFO - PROCESS | 2737 | _x_x_mozilla_page_load 07:52:40 INFO - PROCESS | 2737 | _x_x_mozilla_page_load_details 07:52:40 INFO - PROCESS | 2737 | |i|pagename|runs| 07:52:40 INFO - PROCESS | 2737 | |0;ai-astar;108;117;118;119;119;118;124;118;128;119 07:52:40 INFO - PROCESS | 2737 | |1;audio-beat-detection;144;107;125;148;107;98;135;144;160;144 07:52:40 INFO - PROCESS | 2737 | |2;audio-dft;205;199;199;198;199;199;199;197;201;197 07:52:40 INFO - PROCESS | 2737 | |3;audio-fft;85;60;63;91;65;65;62;62;77;63 07:52:40 INFO - PROCESS | 2737 | |4;audio-oscillator;88;71;85;71;71;71;82;70;69;84 07:52:40 INFO - PROCESS | 2737 | |5;imaging-gaussian-blur;92;136;119;135;82;138;89;136;136;95 07:52:40 INFO - PROCESS | 2737 | |6;imaging-darkroom;111;106;154;126;101;100;101;113;152;127 07:52:40 INFO - PROCESS | 2737 | |7;imaging-desaturate;92;103;148;122;89;94;93;91;93;93 07:52:40 INFO - PROCESS | 2737 | |8;json-parse-financial;67;68;67;67;72;69;70;70;69;70 07:52:40 INFO - PROCESS | 2737 | |9;json-stringify-tinderbox;58;62;70;62;54;65;84;83;58;59 07:52:40 INFO - PROCESS | 2737 | |10;stanford-crypto-aes;85;84;88;88;97;104;102;104;76;111 07:52:40 INFO - PROCESS | 2737 | |11;stanford-crypto-ccm;143;141;140;139;143;156;147;149;211;151 07:52:40 INFO - PROCESS | 2737 | |12;stanford-crypto-pbkdf2;173;183;174;174;178;176;174;174;172;171 07:52:40 INFO - PROCESS | 2737 | |13;stanford-crypto-sha256-iterative;66;66;68;66;69;82;76;87;67;68 07:52:40 INFO - PROCESS | 2737 | __end_tp_report 07:52:40 INFO - PROCESS | 2737 | __start_cc_report 07:52:40 INFO - PROCESS | 2737 | _x_x_mozilla_cycle_collect,1030 07:52:40 INFO - PROCESS | 2737 | __end_cc_report 07:52:40 INFO - PROCESS | 2737 | __startTimestamp1489074760554__endTimestamp 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | ------- Summary: start ------- 07:52:40 INFO - PROCESS | 2737 | Number of tests: 14 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#0] ai-astar Cycles:10 Average:118.80 Median:119.00 stddev:5.09 (4.3%) stddev-sans-first:3.61 07:52:40 INFO - PROCESS | 2737 | Values: 108.0 117.0 118.0 119.0 119.0 118.0 124.0 118.0 128.0 119.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:144.00 stddev:20.90 (14.5%) stddev-sans-first:21.64 07:52:40 INFO - PROCESS | 2737 | Values: 144.0 107.0 125.0 148.0 107.0 98.0 135.0 144.0 160.0 144.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#2] audio-dft Cycles:10 Average:199.30 Median:199.00 stddev:2.31 (1.2%) stddev-sans-first:1.22 07:52:40 INFO - PROCESS | 2737 | Values: 205.0 199.0 199.0 198.0 199.0 199.0 199.0 197.0 201.0 197.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#3] audio-fft Cycles:10 Average:69.30 Median:65.00 stddev:10.99 (16.9%) stddev-sans-first:10.08 07:52:40 INFO - PROCESS | 2737 | Values: 85.0 60.0 63.0 91.0 65.0 65.0 62.0 62.0 77.0 63.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.50 stddev:7.52 (9.8%) stddev-sans-first:6.66 07:52:40 INFO - PROCESS | 2737 | Values: 88.0 71.0 85.0 71.0 71.0 71.0 82.0 70.0 69.0 84.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:110.00 stddev:23.47 (21.3%) stddev-sans-first:23.25 07:52:40 INFO - PROCESS | 2737 | Values: 92.0 136.0 119.0 135.0 82.0 138.0 89.0 136.0 136.0 95.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#6] imaging-darkroom Cycles:10 Average:119.10 Median:119.50 stddev:20.29 (17.0%) stddev-sans-first:21.31 07:52:40 INFO - PROCESS | 2737 | Values: 111.0 106.0 154.0 126.0 101.0 100.0 101.0 113.0 152.0 127.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#7] imaging-desaturate Cycles:10 Average:101.80 Median:92.50 stddev:18.90 (20.4%) stddev-sans-first:19.71 07:52:40 INFO - PROCESS | 2737 | Values: 92.0 103.0 148.0 122.0 89.0 94.0 93.0 91.0 93.0 93.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:69.50 stddev:1.66 (2.4%) stddev-sans-first:1.62 07:52:40 INFO - PROCESS | 2737 | Values: 67.0 68.0 67.0 67.0 72.0 69.0 70.0 70.0 69.0 70.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:63.50 stddev:10.44 (16.4%) stddev-sans-first:10.71 07:52:40 INFO - PROCESS | 2737 | Values: 58.0 62.0 70.0 62.0 54.0 65.0 84.0 83.0 58.0 59.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:84.50 stddev:11.25 (13.3%) stddev-sans-first:11.46 07:52:40 INFO - PROCESS | 2737 | Values: 85.0 84.0 88.0 88.0 97.0 104.0 102.0 104.0 76.0 111.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:148.00 stddev:21.42 (14.5%) stddev-sans-first:22.47 07:52:40 INFO - PROCESS | 2737 | Values: 143.0 141.0 140.0 139.0 143.0 156.0 147.0 149.0 211.0 151.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.00 stddev:3.45 (2.0%) stddev-sans-first:3.59 07:52:40 INFO - PROCESS | 2737 | Values: 173.0 183.0 174.0 174.0 178.0 176.0 174.0 174.0 172.0 171.0 07:52:40 INFO - PROCESS | 2737 | 07:52:40 INFO - PROCESS | 2737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:68.50 stddev:7.55 (11.0%) stddev-sans-first:7.74 07:52:40 INFO - PROCESS | 2737 | Values: 66.0 66.0 68.0 66.0 69.0 82.0 76.0 87.0 67.0 68.0 07:52:40 INFO - PROCESS | 2737 | -------- Summary: end -------- 07:52:40 INFO - PROCESS | 2737 | 07:52:41 INFO - TEST-INFO | 2737: exit 0 07:52:41 INFO - TEST-OK | kraken | took 62559ms 07:52:41 INFO - SUITE-END | took 1180s 07:52:41 INFO - Completed test suite (00:19:40) 07:52:41 INFO - javascript benchmark 07:52:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7697.365773630055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.8929037483686, 3499.3701133795907, 3508.3860324443217, 3515.1563624730074, 3529.5588051493555, 5297.9668964551975, 5701.287339082614, 6121.66330851803, 6159.137720719097, 6183.103449999748, 4692.389989301395, 6166.7841625543115, 6210.937890621092, 6224.346443623423, 6247.312795592481, 5551.528120109796, 5586.608937374385, 5641.605087643846, 5687.772489100431, 5702.0, 5283.392409872856, 5628.971855140739, 5646.435356464362, 5653.604247702662, 5657.0, 5406.107992181285, 5445.754941027643, 5736.713164341766, 5744.79893203738, 5745.655260684352, 5519.034169020425, 5538.944610553883, 5540.196671482653, 5541.974734674098, 5543.473370029841, 5345.973270133663, 5461.563074953994, 5485.149801780731, 5501.174823776426, 5519.613627046108, 6096.390360963913, 6123.4351415035735, 6133.1413602095745, 6139.584134579331, 6198.3801619838105, 5042.319286896295, 6402.423781859655, 6437.581557198767, 6503.869922601569, 6531.118299029666, 6624.834379140512, 6628.270890202122, 6630.336966303379, 6631.071649969008, 6639.170103737033, 6065.0, 6126.969365153146, 6149.354317796657, 6203.069539569011, 6285.120083188357, 6143.450468055797, 6463.935360646427, 6804.625745583941, 6805.285445028299, 6825.385715285648, 6393.936060639334, 6403.103565500834, 6405.935940640627, 6409.519286053472, 6434.099226108348, 5371.75827087782, 6254.312025677172, 6302.432781049728, 6567.671616419256, 6569.57297775643, 6293.465055470337, 6304.842378940563, 6362.968185159045, 6382.8723425531225, 6416.197975253093, 6463.806085817433, 6482.0, 6493.610383377012, 6493.837654058591, 6518.28298887122, 4646.907061858811, 5092.872678183075, 5143.8199663012365, 5201.869953251199, 5204.583633309327, 4584.220682483986, 4597.103564804831, 4638.0, 4698.0, 4734.905301893943, 6005.279366475964, 6076.3316035236085, 6129.175413489909, 6220.657863817533, 6228.719707613168, 6557.868842623121, 6629.237637671633, 6629.86740265192, 6635.900461493082, 6645.169353830771, 5785.247917770663, 5829.533637309005, 5989.431004054608, 6064.332923378425, 6219.253689557192, 5691.146328050825, 5708.600397972185, 5712.428757124338, 5720.570957178228, 5777.335606405233, 6804.353586409283, 6806.523543351917, 6808.761693340709, 6811.863762724619, 6820.31796820314, 5909.349971503045, 6574.243961944438, 6612.371824676648, 6620.702068406837, 6627.701753421011, 5447.945520544744, 5552.972700050504, 6251.343608920998, 6502.739890404331, 6811.445707859552, 6318.178636777373, 6345.555811093179, 6454.128692626623, 6460.806175814733, 6465.806025819233, 6565.901511477427, 6578.868422631616, 6586.110875031809, 6607.702653380513, 6610.3720146586, 6121.818815678178, 6215.875682486416, 6363.045543168561, 6363.840903977252, 6388.712507937061, 6154.723037463415, 6185.948388773829, 6197.690115494117, 6339.112524246517, 6344.936550634435, 6120.724567394389, 6209.565330426827, 6235.095911092957, 6248.968755156195, 6252.499800016079, 6306.558540902093, 6315.747370105144, 6343.619382837044, 6355.809325720235, 6374.362563743774, 6111.287884814297, 6146.938530614637, 6188.597741146811, 6189.84525386869, 6275.466585340115], "value": 5958.718220474882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.484905716941, 791.9010123734533, 819.2954059508821, 943.71688493452, 945.5461378538297, 38257.23485530288, 39307.606923930754, 40569.18861622766, 40619.59380406195, 40649.39025914614, 38995.41506877399, 39242.8037859811, 39244.21511569767, 39281.41077883827, 39322.60677393225, 6842.897356539644, 8022.759317220463, 10399.53202105907, 10716.946415267912, 10854.34873907568, 9903.603855845793, 10328.122109620692, 10557.41934193619, 10626.78746425071, 10651.573937042509, 10607.15142788575, 10691.625793097242, 10693.411862347606, 10706.571737130505, 10739.624113156042, 10608.575656973711, 10640.255182137253, 10649.520771565298, 10666.0, 10671.253012289142, 10323.690289291333, 10347.223958203089, 10353.585856565729, 10375.377477351383, 10389.584416623326, 34121.658783412095, 34186.82906585451, 34193.82903085493, 34253.0, 34316.656833431596, 3620.5112309838096, 3634.7637403568683, 3662.1393972416463, 3709.981450092759, 3756.2487502499607, 19631.0, 23838.16566420167, 24702.629460558106, 26228.73771262282, 26268.0, 2572.8199026068182, 2983.298924752681, 3078.892238771632, 3116.8597413116463, 3150.795198312125, 327055.0, 328671.0, 328704.0, 328732.0, 330207.0, 45099.54900451019, 45147.774261128485, 45322.0, 45416.09167816625, 45954.770226148656, 45184.77407612941, 45328.54671453243, 45411.31883021758, 45482.635520934426, 45543.0, 13015.284159371326, 13088.934555327352, 13105.868941310655, 13108.016898732443, 13329.200247985153, 10163.441010744333, 10219.233557483218, 11047.83428248577, 11067.225294229487, 11335.376554289593, 8555.743327700178, 10551.94724026375, 11734.471948762326, 11839.822402663967, 11860.288382697066, 4661.487236403993, 5314.0, 5585.0, 5622.409646987089, 5627.88702323585, 1080.4975686305906, 1084.7342401111778, 1112.2436743014828, 1117.3072694929197, 1164.7088227943013, 24463.89912453944, 25353.492930141292, 26344.868275658882, 27054.729452705615, 27123.0, 1119.5801574409597, 1124.891981398322, 1214.5991822698488, 1227.0, 1248.9812652810215, 12975.675608109872, 13762.518311859038, 13775.448982040807, 13970.371333290026, 14090.436382544789, 469021.0, 470470.0, 472066.0, 472496.0, 473279.0, 57771.71114144402, 57798.55503612443, 57830.71084644634, 57884.4211557879, 57910.71044644834, 1063.6543123484898, 1272.3892531584706, 1333.3000174908057, 1367.787992861108, 1412.7951447040123, 25291.747082529677, 29676.0, 30720.84639576788, 30896.845515773177, 31267.0, 42488.7253382399, 42641.147177056904, 42708.0, 42746.57253427426, 42828.78585607052, 406673.0, 408786.0, 408821.0, 409249.0, 410474.0, 29491.410171796873, 30344.84827575848, 31325.216869578442, 31367.372652546364, 32475.67524324821, 31194.688053120088, 37675.62324376831, 38167.61832381641, 38498.6150138495, 39108.80445597754, 32678.673213268514, 33041.66958330386, 33094.33811323808, 33097.50353744648, 33828.815991440184, 31027.53458698076, 33250.00249992504, 33254.23255628445, 33547.1549064794, 33909.98270051902, 32681.0, 32951.0, 33039.174020649676, 33274.667253327156, 33276.16809579683, 27593.724062759116, 29553.704462955095, 29768.553471698375, 30116.397672045998, 30123.69876301209, 20528.897355513724, 21086.47283817917, 22990.456414966233, 23304.766952330938, 23351.883240584368], "value": 18073.836800636494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6003996003998, 402.9556748757634, 418.6629763040752, 421.65003047470594, 442.7786106946527, 19531.5117122072, 19827.504312392197, 20991.580168396624, 21078.894605526988, 21123.15507379705, 16433.58916027097, 20632.896835515803, 21169.894150529224, 21231.57536849262, 21271.0, 6604.900926486094, 6823.010663453796, 6834.521583489158, 6882.9311706883045, 6885.070515480396, 6619.93380066198, 6674.2658307586125, 7075.257098004713, 7449.441291903102, 7573.848523029536, 7326.230745771697, 7555.0933887933525, 7565.13001004886, 7569.318761311481, 7582.014338136062, 7508.924910750878, 7543.73596924105, 7585.696572137108, 7589.0, 7612.467127301091, 7154.4634152438775, 7411.370033547155, 7439.330460258549, 7439.4792364534505, 7464.514806537612, 25160.0, 25444.872775636188, 25758.613620795702, 25844.612330815053, 26138.085167019253, 2934.339773550955, 2954.3943491584173, 3024.652165001031, 3033.2720147164523, 3069.0332545248175, 15798.05211687291, 16016.599585010352, 16021.87846850721, 16027.439039633557, 16884.324627015027, 1639.6802623488306, 1788.7674602301747, 1952.3459641020274, 2012.7081573171954, 2033.7356143701372, 161232.0, 166601.16699416545, 168334.0, 169412.1529392345, 169582.0, 16399.508014759576, 17156.39952601653, 19512.414627561197, 20179.596408071757, 20549.178032878815, 31080.533791993137, 31248.68751312503, 31349.216269593442, 31525.684743152276, 31544.684553154173, 8033.317168040782, 8503.0, 9827.0, 10225.488725563691, 10309.94845025785, 8317.792055198548, 8376.0, 8390.454620449651, 8543.35924805642, 8545.060043395222, 8131.430799844073, 8347.4156809024, 9587.089226523469, 9670.984546622503, 9733.805323893483, 3495.5106285120105, 3988.6809055275507, 4080.2859499587453, 4105.486814148231, 4118.876433706993, 810.4529442626203, 825.8561891779808, 835.8829763833069, 839.0644431458879, 879.2262808728406, 15729.451439746028, 21201.25795597147, 21706.457338566663, 21739.456513587287, 22808.745518996282, 730.7577118897894, 869.6347534035721, 877.8727084572702, 890.4790697441939, 894.08356434655, 9923.702288931343, 10821.945890270656, 11360.147988900866, 11402.828957565644, 11410.315381077162, 738682.0, 745448.0, 746803.0, 761927.0, 762772.0, 146143.0, 156972.0, 162908.0, 165811.34188657958, 168064.15967920082, 1350.6285771412743, 1353.6886516101156, 1412.3503188533184, 1413.8798202152932, 1415.547024952026, 19660.80339196647, 20008.69943453671, 20331.796682033582, 20349.694754578988, 20387.388378348674, 63815.36184638094, 64758.676206618664, 66133.33866661272, 66242.0, 66523.66738166472, 67079.0, 76668.0, 79094.604526977, 84337.15662843293, 93585.0, 11428.657140285804, 11691.064714822964, 11753.294802311888, 12085.516579336729, 12110.152289339661, 13212.273324967218, 13276.734465310832, 13555.983301252249, 13697.315134243447, 13698.246596437291, 11294.830577541508, 11486.277058441301, 11573.685262947276, 11636.243644163102, 11730.530778768754, 10262.486875656337, 11030.889691102986, 11213.551457941918, 11283.717907052389, 11573.710657233636, 11120.388378639253, 11575.768484630093, 11863.169578129447, 11965.923066924019, 11988.040956723615, 11698.181127321006, 11709.121815864015, 11901.404929753304, 12005.459754310903, 12052.939735301268, 11341.546338146713, 11384.715382115513, 11406.885931140583, 11555.595554155565, 11655.708607284885], "value": 11607.095519382265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.228486765507, 1443.473132306708, 1465.4944044304711, 1486.4277253257492, 1490.634794475353, 10615.31000484968, 10884.07485363745, 11210.831837522444, 11307.265027773188, 11333.716657083576, 10912.0, 11308.208425410225, 11330.206885518017, 11349.886501134986, 11431.02836258919, 2168.6746987951856, 2281.3384118605586, 2335.9766402336013, 2392.342105920868, 2394.209910729464, 2330.755270696578, 2365.1012615206196, 2370.3600027992434, 2377.5720370333333, 2379.310000099969, 2329.801966832821, 2345.437095097173, 2353.317537914003, 2366.8934897929635, 2372.9288121356385, 2279.566882292376, 2296.666983287422, 2315.3169814904477, 2317.1194945920524, 2331.2889568681544, 2255.639097744353, 2289.8969546370454, 2354.128972280267, 2363.3264519612, 2363.7990770784504, 11257.774844503147, 11299.096072314278, 11318.377489238088, 11335.773284534263, 11343.886561134448, 4863.659543831933, 5946.583739138262, 6023.819285421444, 6024.909626355608, 6030.909536356959, 3471.73961952852, 3603.621619729943, 3608.2963822054708, 3654.1595433050284, 3664.0, 1185.82805493203, 1196.8324434579165, 1236.7217376090398, 1257.7987521996529, 1261.148724610884, 13614.931925340408, 14014.789778153336, 15398.769018464733, 15585.688286234212, 15586.986845854983, 4545.477270113913, 4727.699882532263, 4749.335093086971, 4756.453007904066, 4776.880577985578, 11633.127515436376, 11677.824832627517, 11678.88321116795, 11710.1217408693, 11752.70618234551, 5721.056025755787, 5731.455511726379, 5761.020626493506, 5772.769089236467, 5781.046127388934, 5057.241413787961, 5325.8934821303355, 5362.91955620666, 5400.108982017923, 5416.0521908666615, 3851.826667799956, 3938.6258305460933, 3953.2093581283857, 4036.1120553478186, 4045.1505183911117, 986.5313975861552, 999.8202121496558, 1054.383185836279, 1065.589747947046, 1077.7682798198425, 750.264740554249, 768.1588660416835, 781.8827175923543, 784.7175016993878, 788.7751990682742, 6332.588381755263, 6481.578697384655, 6657.933420665731, 6689.364510371507, 6701.731930722716, 980.4362491567234, 981.5190556627201, 985.8570507276405, 993.3940296419179, 1010.7927874785652, 3994.3609022556834, 4067.3085575452246, 4557.498675145731, 4651.813927442932, 4749.738764367924, 13735.175889446666, 13793.517226897011, 13938.512152074629, 13950.860491395159, 13951.441942322397, 13190.670233244246, 13702.38339274735, 13841.377138028813, 13860.584182474542, 13868.93065534666, 9902.405855648683, 10165.28842980999, 10187.694369168938, 10196.38821670702, 10218.386896786067, 5925.288965324189, 6183.072539119168, 6277.121203031488, 6416.7754128605275, 6445.677716114082, 11842.822357664814, 12148.331841748788, 12181.208221465577, 12270.4478298475, 12304.323262220663, 11463.197576169921, 11792.941035295113, 12104.273743575413, 12419.689507762378, 12620.873791262336, 7672.309492145734, 9330.393524420891, 9461.574229159567, 9463.716088517356, 9469.195118415011, 10286.2799604027, 10294.3823370598, 10298.742531436774, 10393.740156495845, 10419.583216671248, 9230.892292924893, 9256.72229833106, 9268.53657317145, 9316.021817709043, 9442.244620430487, 9041.59312830911, 9066.773330666787, 9142.58858351389, 9176.95411522938, 9365.859512107187, 6719.764808231688, 7890.566018869017, 7980.84038319242, 7985.361171106414, 7992.960035199787, 5747.281589801275, 5773.3072031356505, 5862.560307976833, 5954.374790647093, 6059.787907423219, 5870.119482077552, 5963.880722385615, 6068.969655151696, 6079.544034197364, 6153.354377272445], "value": 5108.522690352718, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.75942997906395, 366.83492428407226, 379.7114193213158, 380.4141621902267, 384.8980020294621, 4585.784767036734, 5090.541851233388, 5294.444083371249, 5372.6213136293945, 5477.850820228982, 4178.6448151907125, 4834.927476087862, 5080.974595127029, 5157.406898206707, 5253.452075743271, 3831.9808400957954, 4386.7587282699515, 4387.016828556581, 4658.324542941272, 4697.168104439272, 3201.791883527575, 4355.36847157162, 4465.186932232689, 4668.673192876483, 4731.763411829412, 3825.751326163804, 3992.1217332187016, 4095.692823038284, 4289.1850548395705, 4333.956660433387, 3604.7837129772297, 3736.7197460190596, 4301.4729770931335, 4373.103513779699, 4442.4669039715445, 3619.5294611700574, 4022.0950286185666, 4057.0526147449095, 4069.593040695907, 4118.217538667674, 4822.300766388889, 4952.752362381866, 5040.924386134211, 5073.365829271341, 5080.443689417422, 4511.368408422823, 4587.087199628227, 4970.179920313144, 5013.671377085076, 5023.734572527849, 5408.4050754416985, 5601.467860553241, 5605.971970140164, 5657.519110875581, 5747.39652336507, 3835.7698538087525, 4039.9596004040172, 4254.680898932593, 4443.622292105175, 4515.254982927813, 4809.831655892027, 5095.133827249377, 5900.055991041456, 5910.320313163955, 5933.664925391839, 4078.653314468244, 4267.8263477543305, 4294.377315289265, 4382.671299652538, 4469.687121901436, 3943.5464921533817, 4667.066586682609, 4672.322513235562, 4675.906481870344, 4728.787204575802, 4154.608206250879, 4709.858704238878, 4978.825741099116, 5036.6726162799305, 5074.771635276422, 4799.544043315879, 5598.552115830724, 5692.658440493501, 5695.914561281584, 5773.624714393551, 1533.0648304534225, 1585.2549301828121, 1596.5928688184438, 1612.6292651246347, 1615.6041769766482, 1146.827975803636, 1168.2873447197203, 1174.8707642159357, 1187.456306801155, 1208.6555331730415, 4906.509349065065, 5224.399194092652, 5291.153415453509, 5296.576273898079, 5313.123334649817, 5115.948840511622, 5567.884204002534, 5595.440455954372, 5620.859478512988, 5714.514106426435, 4577.496475387705, 4828.299896514985, 4942.604591632661, 5030.597552195815, 5249.895002099936, 2721.3740839607003, 2947.7641788656856, 3039.802412843158, 3072.723454889026, 3084.383123375334, 5130.846074617767, 6078.016026858022, 6095.542834287447, 6098.969505152446, 6110.5722599418505, 5036.143855544567, 5583.464547249458, 5837.416258374129, 6044.214252147192, 6118.0, 6149.354317796657, 6166.938330616636, 6180.81457556274, 6187.3503282154725, 6208.099825525183, 4979.701217926936, 5531.474509921551, 5867.5063098182245, 5887.499562537232, 5945.0, 4951.861071953399, 5492.505674489315, 5734.254546908875, 5824.767009319579, 5850.034744267148, 5877.911831322619, 5927.940720592739, 6166.907496387468, 6189.566730328834, 6202.317745048132, 3974.602539746002, 4373.540778218368, 4403.0, 4420.7789610519985, 4499.920019195435, 5127.794888204579, 5575.303087114111, 5799.739011744397, 5824.136276391514, 5842.188921434369, 5006.824761133343, 5167.767450464813, 5491.28613280271, 5620.662760234399, 5654.483754729106, 4794.856154315376, 5299.258103865539, 5561.386148510193, 5688.345840228427, 5728.79949201776, 4635.188841952712, 4777.856664300077, 4945.826896058621, 4981.576565991932, 5480.150576660624, 4996.775145118406, 5613.775448982158, 5723.0, 5744.655320680772, 5804.158397032322, 5006.769279958429, 5254.0, 5370.275012873369, 5543.362513311021, 5569.688579239571], "value": 4300.699391375094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5795780489514, 731.9304666056722, 768.5619197057675, 815.8082850530126, 822.5064961023385, 14951.401943922243, 15645.843541564582, 16135.9511631744, 16167.75748363774, 16267.10530920799, 14572.198529080897, 14847.55457336279, 15153.621159471018, 15155.469558565424, 15188.924055379735, 905.9184673379411, 941.0, 941.7975135345899, 946.280826571807, 949.6818565780437, 884.5798245833209, 918.6555041859302, 924.4545718026396, 924.865894445305, 931.0363773494435, 960.0639376607821, 970.611755297883, 976.5800705696547, 977.5210147027941, 978.4862946952871, 972.8054389122204, 972.9610815567369, 973.6154219083458, 976.4678250353539, 976.653288082731, 717.1967396515936, 718.4252597921642, 718.6945548142019, 718.8274814044644, 720.1574158234878, 15814.9209253953, 16247.675046499122, 16373.263203155768, 16726.24731887068, 17126.05806680632, 13732.794008089886, 13845.792313115311, 13865.09876858001, 13925.303734813218, 14088.577342679737, 11774.293542387484, 11850.170488065838, 11889.821652675217, 12025.579104731292, 12275.263484190977, 3235.88674396395, 3602.6397360263763, 3648.0515066082744, 3652.2330310634798, 3757.7369584129124, 113417.43291283573, 113854.0, 114409.0, 114712.0, 115144.0, 9975.900240997642, 10770.676879693621, 10922.72693182661, 11217.775644487065, 11345.09239260857, 22264.554708906056, 22685.546289074126, 22816.88591557065, 23038.193663221708, 23043.078276869073, 7591.074953639976, 7619.123800762984, 7624.161073825503, 7628.8474230516185, 7800.531968081933, 4231.703780735319, 4258.765767882796, 4295.076558539929, 4321.395004699345, 4367.235733746646, 3393.745469089828, 3473.4789781532468, 3502.387082260594, 3516.771409858351, 3520.753547251668, 548.0409283753431, 606.9817905462843, 613.2487702564412, 619.8078595635368, 632.0708558419117, 660.5937348530715, 690.2097098821821, 699.7830672491442, 713.3829237709448, 716.455493824697, 10187.54156062979, 10382.948085259526, 10426.582936682447, 10470.11004064663, 10504.272404130803, 552.8065177187952, 566.3911295357507, 571.8027280588191, 572.1874937588634, 576.6280748916926, 4021.7586944783407, 4972.825951091694, 5007.0, 5013.0, 5014.222795466709, 79076.60461697655, 89375.55312223527, 92467.0, 95930.0, 99121.00878991262, 54487.0, 74776.62611686907, 82682.0, 84112.15887841166, 84955.72566411509, 73203.0, 74754.62622686852, 75567.0, 76362.0, 78728.42543149105, 10213.234007449322, 10848.837267440837, 11202.607908723481, 11230.270032447865, 11246.325220486797, 36917.3858203345, 48772.02455950932, 49376.5311734419, 50286.74283142951, 51101.0, 65189.67405162944, 66742.33257667361, 67238.65522689617, 70504.64747676229, 71520.64239678977, 10195.796084078129, 12851.550195743104, 12963.481460741465, 13030.674233143867, 13156.276404797827, 14556.563303100924, 14639.48761793332, 14855.405783768529, 15027.774583381039, 15189.924050379677, 13529.86470135286, 13697.315134243447, 13993.300334983007, 14343.928280358532, 14633.34149963233, 13456.86543134556, 13869.86130138726, 13912.234827084203, 14172.929135354258, 14489.927550362181, 12342.629721108382, 13612.863871361556, 13792.93103534476, 13812.37844296989, 14055.0, 10642.73393165177, 10963.342199468058, 11099.389533575408, 11102.222844400814, 11192.440377980905, 10097.192224621866, 11083.640713787518, 11281.943590281997, 11296.6046188383, 11322.773544529227], "value": 7572.729278030696, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 118.0, 119.0, 119.0, 118.0, 124.0, 118.0, 128.0, 119.0], "value": 118.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 107.0, 125.0, 148.0, 107.0, 98.0, 135.0, 144.0, 160.0, 144.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 199.0, 199.0, 198.0, 199.0, 199.0, 199.0, 197.0, 201.0, 197.0], "value": 199.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 63.0, 91.0, 65.0, 65.0, 62.0, 62.0, 77.0, 63.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 85.0, 71.0, 71.0, 71.0, 82.0, 70.0, 69.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 136.0, 119.0, 135.0, 82.0, 138.0, 89.0, 136.0, 136.0, 95.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 154.0, 126.0, 101.0, 100.0, 101.0, 113.0, 152.0, 127.0], "value": 119.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 103.0, 148.0, 122.0, 89.0, 94.0, 93.0, 91.0, 93.0, 93.0], "value": 101.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 72.0, 69.0, 70.0, 70.0, 69.0, 70.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 70.0, 62.0, 54.0, 65.0, 84.0, 83.0, 58.0, 59.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 88.0, 88.0, 97.0, 104.0, 102.0, 104.0, 76.0, 111.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 140.0, 139.0, 143.0, 156.0, 147.0, 149.0, 211.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 183.0, 174.0, 174.0, 178.0, 176.0, 174.0, 174.0, 172.0, 171.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 66.0, 69.0, 82.0, 76.0, 87.0, 67.0, 68.0], "value": 71.5, "unit": "score"}]}]} 07:52:41 INFO - Return code: 0 07:52:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:52:41 ERROR - # TBPL SUCCESS # 07:52:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:52:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:52:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:52:41 INFO - 2017-03-09 07:52:41.925 screenresolution[2742:42180] starting screenresolution argv=screenresolution get 07:52:41 INFO - 2017-03-09 07:52:41.927 screenresolution[2742:42180] Display 0: 1600x1200x32@60 07:52:41 INFO - 2017-03-09 07:52:41.933 screenresolution[2743:42184] starting screenresolution argv=screenresolution list 07:52:41 INFO - Available Modes on Display 0 07:52:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:52:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:52:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:52:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:52:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:52:42 INFO - Intel Iris: 07:52:42 INFO - Chipset Model: Intel Iris 07:52:42 INFO - Type: GPU 07:52:42 INFO - Bus: Built-In 07:52:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:52:42 INFO - Vendor: Intel (0x8086) 07:52:42 INFO - Device ID: 0x0a2e 07:52:42 INFO - Revision ID: 0x0009 07:52:42 INFO - Displays: 07:52:42 INFO - Display: 07:52:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:52:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:52:42 INFO - Display Serial Number: 1600x1200 60 07:52:42 INFO - Main Display: Yes 07:52:42 INFO - Mirror: Off 07:52:42 INFO - Online: Yes 07:52:42 INFO - Rotation: Supported 07:52:42 INFO - Return code: 0 07:52:42 INFO - Running post-action listener: _resource_record_post_action 07:52:42 INFO - [mozharness: 2017-03-09 15:52:42.168394Z] Finished run-tests step (success) 07:52:42 INFO - Running post-run listener: _resource_record_post_run 07:52:42 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 360448; Write bytes: 514556928; Read time: 3; Write time: 1866 07:52:42 INFO - TinderboxPrint: CPU usage
54.7% 07:52:42 INFO - TinderboxPrint: I/O read bytes / time
360,448 / 3 07:52:42 INFO - TinderboxPrint: I/O write bytes / time
514,556,928 / 1,866 07:52:42 INFO - TinderboxPrint: CPU idle
2,176.8 (45.3%) 07:52:42 INFO - TinderboxPrint: CPU system
973.9 (20.2%) 07:52:42 INFO - TinderboxPrint: CPU user
1,658.9 (34.5%) 07:52:42 INFO - TinderboxPrint: Swap in / out
208,465,920 / 0 07:52:42 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 208081408; Write bytes: 203929600; Read time: 16776; Write time: 421 07:52:42 INFO - run-tests - Wall time: 1182s; CPU: 55.0%; Read bytes: 221184; Write bytes: 300502016; Read time: 2; Write time: 1411 07:52:42 INFO - Running post-run listener: _upload_blobber_files 07:52:42 INFO - Blob upload gear active. 07:52:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:52:42 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 07:52:42 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'] 07:52:42 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 07:52:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:43 INFO - (blobuploader) - INFO - Done attempting. 07:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:44 INFO - (blobuploader) - INFO - Done attempting. 07:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:46 INFO - (blobuploader) - INFO - Done attempting. 07:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:48 INFO - (blobuploader) - INFO - Done attempting. 07:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:52:48 INFO - Return code: 0 07:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14e4d7c83e8d7ba343fdb302d3a8cc9443ad743b490b6af1a338799eff3b1f48659b08d2c101e70a3c78b34976be600ae9ce6fb91e6d7714be834855129107c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c940fa1645846c11d158e46acdf0246cc4a0b3bf0fd7a4e0c7192c69092317d7e52a2228a05e18b5e6ca1f3bfe8214a22349bcaf9b3c3350726c654bc5f9b8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591666e72c4c65693c131cff51c5d10c2d8a1a9055fe9ae7d2b3cfcfed44927c85a9ed6b68949c4974dd058e4c0a05a5caa801de14b57ba5b30f2a0aca7bc2d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/950207e197ce95ac8d012540849206f1cdce8ea47a950858c9939c2b97f81343ea24668b071b3572cb0c7b21dcab5fe7f1dc44265d64192202858fa5c573ae5f"} 07:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:52:48 INFO - Contents: 07:52:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14e4d7c83e8d7ba343fdb302d3a8cc9443ad743b490b6af1a338799eff3b1f48659b08d2c101e70a3c78b34976be600ae9ce6fb91e6d7714be834855129107c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c940fa1645846c11d158e46acdf0246cc4a0b3bf0fd7a4e0c7192c69092317d7e52a2228a05e18b5e6ca1f3bfe8214a22349bcaf9b3c3350726c654bc5f9b8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591666e72c4c65693c131cff51c5d10c2d8a1a9055fe9ae7d2b3cfcfed44927c85a9ed6b68949c4974dd058e4c0a05a5caa801de14b57ba5b30f2a0aca7bc2d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/950207e197ce95ac8d012540849206f1cdce8ea47a950858c9939c2b97f81343ea24668b071b3572cb0c7b21dcab5fe7f1dc44265d64192202858fa5c573ae5f"} 07:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:52:48 INFO - Copying logs to upload dir... 07:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.914810 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-09 07:52:48.521625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 07:52:48.525346) ========= 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.vMJR0l4Htm/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.NygTmPf7G0/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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/14e4d7c83e8d7ba343fdb302d3a8cc9443ad743b490b6af1a338799eff3b1f48659b08d2c101e70a3c78b34976be600ae9ce6fb91e6d7714be834855129107c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c940fa1645846c11d158e46acdf0246cc4a0b3bf0fd7a4e0c7192c69092317d7e52a2228a05e18b5e6ca1f3bfe8214a22349bcaf9b3c3350726c654bc5f9b8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591666e72c4c65693c131cff51c5d10c2d8a1a9055fe9ae7d2b3cfcfed44927c85a9ed6b68949c4974dd058e4c0a05a5caa801de14b57ba5b30f2a0aca7bc2d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/950207e197ce95ac8d012540849206f1cdce8ea47a950858c9939c2b97f81343ea24668b071b3572cb0c7b21dcab5fe7f1dc44265d64192202858fa5c573ae5f"} build_url:https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/MKdHiLevTYmcs0ZqTg1wuQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14e4d7c83e8d7ba343fdb302d3a8cc9443ad743b490b6af1a338799eff3b1f48659b08d2c101e70a3c78b34976be600ae9ce6fb91e6d7714be834855129107c6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c940fa1645846c11d158e46acdf0246cc4a0b3bf0fd7a4e0c7192c69092317d7e52a2228a05e18b5e6ca1f3bfe8214a22349bcaf9b3c3350726c654bc5f9b8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/591666e72c4c65693c131cff51c5d10c2d8a1a9055fe9ae7d2b3cfcfed44927c85a9ed6b68949c4974dd058e4c0a05a5caa801de14b57ba5b30f2a0aca7bc2d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/950207e197ce95ac8d012540849206f1cdce8ea47a950858c9939c2b97f81343ea24668b071b3572cb0c7b21dcab5fe7f1dc44265d64192202858fa5c573ae5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 07:52:48.561165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 07:52:48.561635) ========= 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.vMJR0l4Htm/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.NygTmPf7G0/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.005300 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 07:52:48.611262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 07:52:48.611821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 07:52:48.612220) ========= ========= Total master_lag: 2.23 =========