builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0231 starttime: 1484569976.88 results: success (0) buildid: 20170116030326 builduid: 8b7f7b8e31d74370a600ffc7916060ad revision: 8eaf154b385bbe0ff06155294ccf7962aa2d3324 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:56.878054) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:56.878447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:56.878731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:56.909289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:56.909622) ========= 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.yEC0ia47YV/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.dXSl86IcPZ/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-16 04:32:56-- 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% 41.9M=0s 2017-01-16 04:32:57 (41.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.558224 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:57.641079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:57.641385) ========= 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.yEC0ia47YV/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.dXSl86IcPZ/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.025319 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:57.688597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 04:32:57.688953) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8eaf154b385bbe0ff06155294ccf7962aa2d3324 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8eaf154b385bbe0ff06155294ccf7962aa2d3324 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yEC0ia47YV/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.dXSl86IcPZ/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-16 04:32:57,787 truncating revision to first 12 chars 2017-01-16 04:32:57,787 Setting DEBUG logging. 2017-01-16 04:32:57,787 attempt 1/10 2017-01-16 04:32:57,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8eaf154b385b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 04:32:58,836 unpacking tar archive at: mozilla-central-8eaf154b385b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 04:32:59.040370) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:59.040682) ========= script_repo_revision: 8eaf154b385bbe0ff06155294ccf7962aa2d3324 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:59.041061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:59.041324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 04:32:59.060802) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-16 04:32:59.061102) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yEC0ia47YV/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.dXSl86IcPZ/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:32:59 INFO - MultiFileLogger online at 20170116 04:32:59 in /builds/slave/test 04:32:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:59 INFO - {'append_to_log': False, 04:32:59 INFO - 'base_work_dir': '/builds/slave/test', 04:32:59 INFO - 'blob_upload_branch': 'Firefox', 04:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:59 INFO - 'branch': 'Firefox', 04:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:59 INFO - 'config_files': ('talos/mac_config.py',), 04:32:59 INFO - 'default_actions': ('clobber', 04:32:59 INFO - 'read-buildbot-config', 04:32:59 INFO - 'download-and-extract', 04:32:59 INFO - 'populate-webroot', 04:32:59 INFO - 'create-virtualenv', 04:32:59 INFO - 'install', 04:32:59 INFO - 'run-tests'), 04:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:59 INFO - 'download_minidump_stackwalk': True, 04:32:59 INFO - 'download_symbols': 'ondemand', 04:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:59 INFO - 'installer_path': 'installer.exe', 04:32:59 INFO - 'log_level': 'info', 04:32:59 INFO - 'log_name': 'talos', 04:32:59 INFO - 'log_to_console': True, 04:32:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:32:59 INFO - 'opt_config_files': (), 04:32:59 INFO - 'pip_index': False, 04:32:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:59 INFO - 'cmd': ('bash', 04:32:59 INFO - '-c', 04:32:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:59 INFO - 'enabled': True, 04:32:59 INFO - 'halt_on_failure': False, 04:32:59 INFO - 'name': 'check_screen_resolution'},), 04:32:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:59 INFO - 'cmd': ('bash', 04:32:59 INFO - '-c', 04:32:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:59 INFO - 'enabled': True, 04:32:59 INFO - 'halt_on_failure': False, 04:32:59 INFO - 'name': 'check_screen_resolution'},), 04:32:59 INFO - 'run_cmd_checks_enabled': True, 04:32:59 INFO - 'sps_profile': False, 04:32:59 INFO - 'sps_profile_interval': 0, 04:32:59 INFO - 'suite': 'dromaeojs-e10s', 04:32:59 INFO - 'system_bits': '32', 04:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:59 INFO - 'title': 't-yosemite-r7-0231', 04:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:59 INFO - 'use_talos_json': True, 04:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:59 INFO - 'work_dir': 'build'} 04:32:59 INFO - [mozharness: 2017-01-16 12:32:59.272411Z] Running clobber step. 04:32:59 INFO - Running pre-action listener: _resource_record_pre_action 04:32:59 INFO - Running main action method: clobber 04:32:59 INFO - rmtree: /builds/slave/test/build 04:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:01 INFO - Running post-action listener: _resource_record_post_action 04:33:01 INFO - [mozharness: 2017-01-16 12:33:01.634051Z] Finished clobber step (success) 04:33:01 INFO - [mozharness: 2017-01-16 12:33:01.634188Z] Running read-buildbot-config step. 04:33:01 INFO - Running pre-action listener: _resource_record_pre_action 04:33:01 INFO - Running main action method: read_buildbot_config 04:33:01 INFO - Using buildbot properties: 04:33:01 INFO - { 04:33:01 INFO - "project": "", 04:33:01 INFO - "product": "firefox", 04:33:01 INFO - "script_repo_revision": "production", 04:33:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:33:01 INFO - "repository": "", 04:33:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:33:01 INFO - "buildid": "20170116030326", 04:33:01 INFO - "stage_platform": "macosx64", 04:33:01 INFO - "basedir": "/builds/slave/test", 04:33:01 INFO - "nightly_build": "True", 04:33:01 INFO - "buildnumber": 58, 04:33:01 INFO - "slavename": "t-yosemite-r7-0231", 04:33:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:33:01 INFO - "platform": "yosemite_r7", 04:33:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:33:01 INFO - "branch": "mozilla-central", 04:33:01 INFO - "repo_path": "mozilla-central", 04:33:01 INFO - "revision": "8eaf154b385bbe0ff06155294ccf7962aa2d3324", 04:33:01 INFO - "pgo_build": "False", 04:33:01 INFO - "builduid": "8b7f7b8e31d74370a600ffc7916060ad", 04:33:01 INFO - "slavebuilddir": "test" 04:33:01 INFO - } 04:33:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:33:01 INFO - Running post-action listener: _resource_record_post_action 04:33:01 INFO - [mozharness: 2017-01-16 12:33:01.637607Z] Finished read-buildbot-config step (success) 04:33:01 INFO - [mozharness: 2017-01-16 12:33:01.637714Z] Running download-and-extract step. 04:33:01 INFO - Running pre-action listener: _resource_record_pre_action 04:33:01 INFO - Running main action method: download_and_extract 04:33:01 INFO - mkdir: /builds/slave/test/build/tests 04:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:01 INFO - trying https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:33:01 INFO - Downloading https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:33:02 INFO - Downloaded 1199 bytes. 04:33:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:33:02 INFO - Using the following test package requirements: 04:33:02 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:33:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:33:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:33:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'jsshell-mac.zip'], 04:33:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:33:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:33:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:33:02 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:33:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:33:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:33:02 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:33:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:33:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:33:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:02 INFO - Fetch https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:33:03 INFO - Expected file size: 16324495 04:33:03 INFO - Obtained file size: 16324495 04:33:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:33:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:33:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:09 INFO - Fetch https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:33:10 INFO - Expected file size: 16324495 04:33:10 INFO - Obtained file size: 16324495 04:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:33:17 INFO - Expected file size: 14403463 04:33:17 INFO - Obtained file size: 14403463 04:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:18 INFO - trying https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:33:18 INFO - Downloading https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:33:20 INFO - Downloaded 70207187 bytes. 04:33:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:33:20 INFO - mkdir: /builds/slave/test/properties 04:33:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:20 INFO - Contents: 04:33:20 INFO - build_url:https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:33:20 INFO - Running post-action listener: _resource_record_post_action 04:33:20 INFO - Running post-action listener: set_extra_try_arguments 04:33:20 INFO - [mozharness: 2017-01-16 12:33:20.683832Z] Finished download-and-extract step (success) 04:33:20 INFO - [mozharness: 2017-01-16 12:33:20.684042Z] Running populate-webroot step. 04:33:20 INFO - Running pre-action listener: _resource_record_pre_action 04:33:20 INFO - Running main action method: populate_webroot 04:33:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:20 INFO - '--tppagecycles', 04:33:20 INFO - '7'], 04:33:20 INFO - 'tests': ['tsvgm']}}, 04:33:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['damp', 'tps']}, 04:33:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'tests': ['damp', 'tps']}, 04:33:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['dromaeo_dom']}, 04:33:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['basic_compositor_video']}, 04:33:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:33:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['a11yr', 04:33:20 INFO - 'ts_paint', 04:33:20 INFO - 'tpaint', 04:33:20 INFO - 'sessionrestore', 04:33:20 INFO - 'sessionrestore_no_auto_restore', 04:33:20 INFO - 'tabpaint']}, 04:33:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:20 INFO - 'ts_paint', 04:33:20 INFO - 'tpaint', 04:33:20 INFO - 'sessionrestore', 04:33:20 INFO - 'sessionrestore_no_auto_restore', 04:33:20 INFO - 'tabpaint']}, 04:33:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:20 INFO - 'ts_paint', 04:33:20 INFO - 'tpaint', 04:33:20 INFO - 'sessionrestore', 04:33:20 INFO - 'sessionrestore_no_auto_restore', 04:33:20 INFO - 'tabpaint']}, 04:33:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:20 INFO - 'ts_paint', 04:33:20 INFO - 'tpaint', 04:33:20 INFO - 'sessionrestore', 04:33:20 INFO - 'sessionrestore_no_auto_restore', 04:33:20 INFO - 'tabpaint']}, 04:33:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['a11yr', 04:33:20 INFO - 'ts_paint', 04:33:20 INFO - 'tpaint', 04:33:20 INFO - 'sessionrestore', 04:33:20 INFO - 'sessionrestore_no_auto_restore', 04:33:20 INFO - 'tabpaint']}, 04:33:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['a11yr', 04:33:20 INFO - 'ts_paint', 04:33:20 INFO - 'tpaint', 04:33:20 INFO - 'sessionrestore', 04:33:20 INFO - 'sessionrestore_no_auto_restore', 04:33:20 INFO - 'tabpaint']}, 04:33:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['tsvgx', 04:33:20 INFO - 'tsvgr_opacity', 04:33:20 INFO - 'tart', 04:33:20 INFO - 'tscrollx', 04:33:20 INFO - 'cart', 04:33:20 INFO - 'tsvg_static']}, 04:33:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:20 INFO - 'tsvgr_opacity', 04:33:20 INFO - 'tart', 04:33:20 INFO - 'tscrollx', 04:33:20 INFO - 'cart', 04:33:20 INFO - 'tsvg_static']}, 04:33:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'talos_options': ['--disable-e10s'], 04:33:20 INFO - 'tests': ['tp5o']}, 04:33:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:33:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'talos_options': ['--disable-e10s', 04:33:20 INFO - '--xperf_path', 04:33:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:20 INFO - 'tests': ['tp5n']}, 04:33:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:33:20 INFO - 'talos_options': ['--xperf_path', 04:33:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:20 INFO - 'tests': ['tp5n']}}, 04:33:20 INFO - 'talos.zip': {'path': '', 04:33:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:20 INFO - Running post-action listener: _resource_record_post_action 04:33:20 INFO - [mozharness: 2017-01-16 12:33:20.703072Z] Finished populate-webroot step (success) 04:33:20 INFO - [mozharness: 2017-01-16 12:33:20.703180Z] Running create-virtualenv step. 04:33:20 INFO - Running pre-action listener: _resource_record_pre_action 04:33:20 INFO - Running main action method: create_virtualenv 04:33:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:20 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 04:33:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:20 INFO - Using real prefix '/tools/python27' 04:33:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:24 INFO - Installing pip.................done. 04:33:24 INFO - Return code: 0 04:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:33:24 INFO - Reading from file tmpfile_stdout 04:33:24 INFO - Output received: 04:33:24 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) 04:33:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:24 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')]} 04:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:24 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')]} 04:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:24 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:24 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 04:33:24 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 04:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:24 INFO - 'HOME': '/Users/cltbld', 04:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:24 INFO - 'LOGNAME': 'cltbld', 04:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:24 INFO - 'MOZ_NO_REMOTE': '1', 04:33:24 INFO - 'NO_EM_RESTART': '1', 04:33:24 INFO - 'PAGER': '/bin/cat', 04:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:24 INFO - 'PWD': '/builds/slave/test', 04:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:24 INFO - 'SHELL': '/bin/bash', 04:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:24 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:24 INFO - 'USER': 'cltbld', 04:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:24 INFO - 'XPC_FLAGS': '0x0', 04:33:24 INFO - 'XPC_SERVICE_NAME': '0', 04:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:25 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 04:33:25 INFO - Cleaning up... 04:33:25 INFO - Return code: 0 04:33:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:25 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:25 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 04:33:25 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 04:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:25 INFO - 'HOME': '/Users/cltbld', 04:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:25 INFO - 'LOGNAME': 'cltbld', 04:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:25 INFO - 'MOZ_NO_REMOTE': '1', 04:33:25 INFO - 'NO_EM_RESTART': '1', 04:33:25 INFO - 'PAGER': '/bin/cat', 04:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:25 INFO - 'PWD': '/builds/slave/test', 04:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:25 INFO - 'SHELL': '/bin/bash', 04:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:25 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:25 INFO - 'USER': 'cltbld', 04:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:25 INFO - 'XPC_FLAGS': '0x0', 04:33:25 INFO - 'XPC_SERVICE_NAME': '0', 04:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:25 INFO - Downloading/unpacking psutil>=3.1.1 04:33:25 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 04:33:25 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 04:33:25 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 04:33:25 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 04:33:25 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 04:33:25 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 04:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:29 INFO - Installing collected packages: psutil 04:33:29 INFO - Running setup.py install for psutil 04:33:29 INFO - building 'psutil._psutil_osx' extension 04:33:29 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 04:33:29 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 04:33:30 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 04:33:30 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 04:33:30 INFO - building 'psutil._psutil_posix' extension 04:33:30 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 04:33:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:33:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:33:30 INFO - ^ 04:33:30 INFO - 1 warning generated. 04:33:30 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 04:33:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:30 INFO - Successfully installed psutil 04:33:30 INFO - Cleaning up... 04:33:30 INFO - Return code: 0 04:33:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:30 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:30 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 04:33:30 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 04:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:30 INFO - 'HOME': '/Users/cltbld', 04:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:30 INFO - 'LOGNAME': 'cltbld', 04:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:30 INFO - 'MOZ_NO_REMOTE': '1', 04:33:30 INFO - 'NO_EM_RESTART': '1', 04:33:30 INFO - 'PAGER': '/bin/cat', 04:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:30 INFO - 'PWD': '/builds/slave/test', 04:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:30 INFO - 'SHELL': '/bin/bash', 04:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:30 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:30 INFO - 'USER': 'cltbld', 04:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:30 INFO - 'XPC_FLAGS': '0x0', 04:33:30 INFO - 'XPC_SERVICE_NAME': '0', 04:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:33:30 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 04:33:30 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 04:33:30 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 04:33:30 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 04:33:30 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 04:33:30 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 04:33:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:33:33 INFO - Installing collected packages: mozsystemmonitor 04:33:33 INFO - Running setup.py install for mozsystemmonitor 04:33:33 INFO - Successfully installed mozsystemmonitor 04:33:33 INFO - Cleaning up... 04:33:33 INFO - Return code: 0 04:33:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:33: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')]} 04:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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')]} 04:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:33 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:33 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 04:33:33 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 04:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:33 INFO - 'HOME': '/Users/cltbld', 04:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:33 INFO - 'LOGNAME': 'cltbld', 04:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:33 INFO - 'MOZ_NO_REMOTE': '1', 04:33:33 INFO - 'NO_EM_RESTART': '1', 04:33:33 INFO - 'PAGER': '/bin/cat', 04:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:33 INFO - 'PWD': '/builds/slave/test', 04:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:33 INFO - 'SHELL': '/bin/bash', 04:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:33 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:33 INFO - 'USER': 'cltbld', 04:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:33 INFO - 'XPC_FLAGS': '0x0', 04:33:33 INFO - 'XPC_SERVICE_NAME': '0', 04:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:33:34 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 04:33:34 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 04:33:34 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 04:33:34 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 04:33:34 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 04:33:34 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 04:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:33:36 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 04:33:36 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 04:33:36 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 04:33:36 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 04:33:36 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 04:33:36 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 04:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:37 INFO - warning: no files found matching '*.txt' 04:33:37 INFO - no previously-included directories found matching 'build' 04:33:37 INFO - no previously-included directories found matching 'dist' 04:33:37 INFO - no previously-included directories found matching '.git*' 04:33:37 INFO - Installing collected packages: jsonschema, functools32 04:33:37 INFO - Running setup.py install for functools32 04:33:37 INFO - warning: no files found matching '*.txt' 04:33:37 INFO - no previously-included directories found matching 'build' 04:33:37 INFO - no previously-included directories found matching 'dist' 04:33:37 INFO - no previously-included directories found matching '.git*' 04:33:37 INFO - Successfully installed jsonschema functools32 04:33:37 INFO - Cleaning up... 04:33:37 INFO - Return code: 0 04:33:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:37 INFO - 'HOME': '/Users/cltbld', 04:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:37 INFO - 'LOGNAME': 'cltbld', 04:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:37 INFO - 'MOZ_NO_REMOTE': '1', 04:33:37 INFO - 'NO_EM_RESTART': '1', 04:33:37 INFO - 'PAGER': '/bin/cat', 04:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:37 INFO - 'PWD': '/builds/slave/test', 04:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:37 INFO - 'SHELL': '/bin/bash', 04:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:37 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:37 INFO - 'USER': 'cltbld', 04:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:37 INFO - 'XPC_FLAGS': '0x0', 04:33:37 INFO - 'XPC_SERVICE_NAME': '0', 04:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:33:37 INFO - Cleaning up... 04:33:37 INFO - Return code: 0 04:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:37 INFO - 'HOME': '/Users/cltbld', 04:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:37 INFO - 'LOGNAME': 'cltbld', 04:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:37 INFO - 'MOZ_NO_REMOTE': '1', 04:33:37 INFO - 'NO_EM_RESTART': '1', 04:33:37 INFO - 'PAGER': '/bin/cat', 04:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:37 INFO - 'PWD': '/builds/slave/test', 04:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:37 INFO - 'SHELL': '/bin/bash', 04:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:37 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:37 INFO - 'USER': 'cltbld', 04:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:37 INFO - 'XPC_FLAGS': '0x0', 04:33:37 INFO - 'XPC_SERVICE_NAME': '0', 04:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:33:38 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 04:33:38 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 04:33:38 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 04:33:38 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 04:33:38 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 04:33:38 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 04:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 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 04:33:41 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 04:33:42 INFO - Downloading docopt-0.6.1.tar.gz 04:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:42 INFO - Running setup.py install for blobuploader 04:33:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:42 INFO - Running setup.py install for requests 04:33:42 INFO - Running setup.py install for docopt 04:33:43 INFO - Successfully installed blobuploader requests docopt 04:33:43 INFO - Cleaning up... 04:33:43 INFO - Return code: 0 04:33:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:43 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')]} 04:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:43 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')]} 04:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:43 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:43 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 04:33:43 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 04:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:43 INFO - 'HOME': '/Users/cltbld', 04:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:43 INFO - 'LOGNAME': 'cltbld', 04:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:43 INFO - 'MOZ_NO_REMOTE': '1', 04:33:43 INFO - 'NO_EM_RESTART': '1', 04:33:43 INFO - 'PAGER': '/bin/cat', 04:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:43 INFO - 'PWD': '/builds/slave/test', 04:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:43 INFO - 'SHELL': '/bin/bash', 04:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:43 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:43 INFO - 'USER': 'cltbld', 04:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:43 INFO - 'XPC_FLAGS': '0x0', 04:33:43 INFO - 'XPC_SERVICE_NAME': '0', 04:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-_dtA3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-KDynY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-OeFF7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-8IDPvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-VJrQpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-PB3L83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-lfVgsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-225Tnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-9HB6rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-PuH8A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-kRYmMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Q1gMIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-5SLIyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-CCQQnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Ck2wCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:45 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Uo_cXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:45 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-ZsKMdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:45 INFO - Running setup.py install for manifestparser 04:33:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:45 INFO - Running setup.py install for mozcrash 04:33:45 INFO - Running setup.py install for mozdebug 04:33:45 INFO - Running setup.py install for mozdevice 04:33:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:33:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:45 INFO - Running setup.py install for mozfile 04:33:45 INFO - Running setup.py install for mozhttpd 04:33:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Running setup.py install for mozinfo 04:33:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Running setup.py install for mozInstall 04:33:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Running setup.py install for mozleak 04:33:46 INFO - Running setup.py install for mozlog 04:33:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Running setup.py install for moznetwork 04:33:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:46 INFO - Running setup.py install for mozprocess 04:33:47 INFO - Running setup.py install for mozprofile 04:33:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:47 INFO - Running setup.py install for mozrunner 04:33:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:47 INFO - Running setup.py install for mozscreenshot 04:33:47 INFO - Running setup.py install for moztest 04:33:47 INFO - Running setup.py install for mozversion 04:33:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:47 INFO - Cleaning up... 04:33:47 INFO - Return code: 0 04:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:47 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:47 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 04:33:47 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 04:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:47 INFO - 'HOME': '/Users/cltbld', 04:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:47 INFO - 'LOGNAME': 'cltbld', 04:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:47 INFO - 'MOZ_NO_REMOTE': '1', 04:33:47 INFO - 'NO_EM_RESTART': '1', 04:33:47 INFO - 'PAGER': '/bin/cat', 04:33:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:47 INFO - 'PWD': '/builds/slave/test', 04:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:47 INFO - 'SHELL': '/bin/bash', 04:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:47 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:47 INFO - 'USER': 'cltbld', 04:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:47 INFO - 'XPC_FLAGS': '0x0', 04:33:47 INFO - 'XPC_SERVICE_NAME': '0', 04:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-y9NrCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-3o7Or1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-FWHpUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-wMbFZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-07_NyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-rFQVlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-7DTv6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-duLOpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:48 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)) 04:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zSn28h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-nNFKMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Qst6Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-7nerNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-W6JsMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-JGogIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-r5PDae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-9RV7F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:49 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)) 04:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-fZZvvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:49 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)) 04:33:49 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)) 04:33:49 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)) 04:33:49 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)) 04:33:49 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)) 04:33:49 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)) 04:33:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:49 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 04:33:49 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 04:33:49 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 04:33:49 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 04:33:49 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 04:33:49 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 04:33:52 INFO - Downloading blessings-1.6.tar.gz 04:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:52 INFO - Installing collected packages: blessings 04:33:52 INFO - Running setup.py install for blessings 04:33:52 INFO - Successfully installed blessings 04:33:52 INFO - Cleaning up... 04:33:52 INFO - Return code: 0 04:33:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:53 INFO - Reading from file tmpfile_stdout 04:33:53 INFO - Current package versions: 04:33:53 INFO - blessings == 1.6 04:33:53 INFO - blobuploader == 1.2.4 04:33:53 INFO - docopt == 0.6.1 04:33:53 INFO - functools32 == 3.2.3-2 04:33:53 INFO - jsonschema == 2.5.1 04:33:53 INFO - manifestparser == 1.1 04:33:53 INFO - mozInstall == 1.12 04:33:53 INFO - mozcrash == 1.0 04:33:53 INFO - mozdebug == 0.1 04:33:53 INFO - mozdevice == 0.49 04:33:53 INFO - mozfile == 1.2 04:33:53 INFO - mozhttpd == 0.7 04:33:53 INFO - mozinfo == 0.9 04:33:53 INFO - mozleak == 0.1 04:33:53 INFO - mozlog == 3.4 04:33:53 INFO - moznetwork == 0.27 04:33:53 INFO - mozprocess == 0.24 04:33:53 INFO - mozprofile == 0.28 04:33:53 INFO - mozrunner == 6.13 04:33:53 INFO - mozscreenshot == 0.1 04:33:53 INFO - mozsystemmonitor == 0.3 04:33:53 INFO - moztest == 0.8 04:33:53 INFO - mozversion == 1.4 04:33:53 INFO - psutil == 3.1.1 04:33:53 INFO - requests == 1.2.3 04:33:53 INFO - wsgiref == 0.1.2 04:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:53 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 04:33:53 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 04:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:53 INFO - 'HOME': '/Users/cltbld', 04:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:53 INFO - 'LOGNAME': 'cltbld', 04:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:53 INFO - 'MOZ_NO_REMOTE': '1', 04:33:53 INFO - 'NO_EM_RESTART': '1', 04:33:53 INFO - 'PAGER': '/bin/cat', 04:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:53 INFO - 'PWD': '/builds/slave/test', 04:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:53 INFO - 'SHELL': '/bin/bash', 04:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:53 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:53 INFO - 'USER': 'cltbld', 04:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:53 INFO - 'XPC_FLAGS': '0x0', 04:33:53 INFO - 'XPC_SERVICE_NAME': '0', 04:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 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)) 04:33:53 INFO - Cleaning up... 04:33:53 INFO - Return code: 0 04:33:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 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 0x1012d9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012dc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddf949b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, '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.yEC0ia47YV/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.dXSl86IcPZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:33:53 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 04:33:53 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 04:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:53 INFO - 'HOME': '/Users/cltbld', 04:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:53 INFO - 'LOGNAME': 'cltbld', 04:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:53 INFO - 'MOZ_NO_REMOTE': '1', 04:33:53 INFO - 'NO_EM_RESTART': '1', 04:33:53 INFO - 'PAGER': '/bin/cat', 04:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:53 INFO - 'PWD': '/builds/slave/test', 04:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:53 INFO - 'SHELL': '/bin/bash', 04:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:33:53 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:53 INFO - 'USER': 'cltbld', 04:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:53 INFO - 'XPC_FLAGS': '0x0', 04:33:53 INFO - 'XPC_SERVICE_NAME': '0', 04:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:33:53 INFO - Cleaning up... 04:33:53 INFO - Return code: 0 04:33:53 INFO - Running post-action listener: _resource_record_post_action 04:33:53 INFO - Running post-action listener: _start_resource_monitoring 04:33:53 INFO - Starting resource monitoring. 04:33:53 INFO - [mozharness: 2017-01-16 12:33:53.774297Z] Finished create-virtualenv step (success) 04:33:53 INFO - [mozharness: 2017-01-16 12:33:53.775283Z] Running install step. 04:33:53 INFO - Running pre-action listener: _resource_record_pre_action 04:33:53 INFO - Running main action method: install 04:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:54 INFO - Reading from file tmpfile_stdout 04:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:54 INFO - Reading from file tmpfile_stdout 04:33:54 INFO - Output received: 04:33:54 INFO - Usage: mozinstall [options] installer 04:33:54 INFO - Options: 04:33:54 INFO - -h, --help show this help message and exit 04:33:54 INFO - -d DEST, --destination=DEST 04:33:54 INFO - Directory to install application into. [default: 04:33:54 INFO - "/builds/slave/test"] 04:33:54 INFO - --app=APP Application being installed. [default: firefox] 04:33:54 INFO - mkdir: /builds/slave/test/build/application 04:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:34:15 INFO - Reading from file tmpfile_stdout 04:34:15 INFO - Output received: 04:34:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:34:15 INFO - Running post-action listener: _resource_record_post_action 04:34:15 INFO - [mozharness: 2017-01-16 12:34:15.976718Z] Finished install step (success) 04:34:15 INFO - [mozharness: 2017-01-16 12:34:15.976864Z] Running run-tests step. 04:34:15 INFO - Running pre-action listener: _resource_record_pre_action 04:34:15 INFO - Running main action method: run_tests 04:34:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:15 INFO - 2017-01-16 04:34:15.991 screenresolution[1628:7550] starting screenresolution argv=screenresolution get 04:34:15 INFO - 2017-01-16 04:34:15.994 screenresolution[1628:7550] Display 0: 1600x1200x32@60 04:34:16 INFO - 2017-01-16 04:34:16.000 screenresolution[1629:7552] starting screenresolution argv=screenresolution list 04:34:16 INFO - Available Modes on Display 0 04:34:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:16 INFO - Intel Iris: 04:34:16 INFO - Chipset Model: Intel Iris 04:34:16 INFO - Type: GPU 04:34:16 INFO - Bus: Built-In 04:34:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:16 INFO - Vendor: Intel (0x8086) 04:34:16 INFO - Device ID: 0x0a2e 04:34:16 INFO - Revision ID: 0x0009 04:34:16 INFO - Displays: 04:34:16 INFO - Display: 04:34:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:16 INFO - Display Serial Number: 1600x1200 60 04:34:16 INFO - Main Display: Yes 04:34:16 INFO - Mirror: Off 04:34:16 INFO - Online: Yes 04:34:16 INFO - Rotation: Supported 04:34:16 INFO - Return code: 0 04:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:16 INFO - Python 2.7.3 04:34:16 INFO - Return code: 0 04:34:16 INFO - grabbing minidump binary from tooltool 04:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:16 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 0x1010b7d30>, '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 0x100fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010acbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:16 INFO - Return code: 0 04:34:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:34:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:34:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 04:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0231 --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 04:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yEC0ia47YV/Render', 04:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:16 INFO - 'HOME': '/Users/cltbld', 04:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:16 INFO - 'LOGNAME': 'cltbld', 04:34:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:16 INFO - 'MOZ_NO_REMOTE': '1', 04:34:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:16 INFO - 'NO_EM_RESTART': '1', 04:34:16 INFO - 'PAGER': '/bin/cat', 04:34:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:16 INFO - 'PWD': '/builds/slave/test', 04:34:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:16 INFO - 'SHELL': '/bin/bash', 04:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dXSl86IcPZ/Listeners', 04:34:16 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:16 INFO - 'USER': 'cltbld', 04:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:16 INFO - 'XPC_FLAGS': '0x0', 04:34:16 INFO - 'XPC_SERVICE_NAME': '0', 04:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 04:34:16 INFO - mozversion application_buildid: 20170116030326 04:34:16 INFO - mozversion application_changeset: 8eaf154b385bbe0ff06155294ccf7962aa2d3324 04:34:16 INFO - mozversion application_display_name: Nightly 04:34:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:16 INFO - mozversion application_name: Firefox 04:34:16 INFO - mozversion application_remotingname: firefox 04:34:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:34:16 INFO - mozversion application_vendor: Mozilla 04:34:16 INFO - mozversion application_version: 53.0a1 04:34:16 INFO - mozversion platform_buildid: 20170116030326 04:34:16 INFO - mozversion platform_changeset: 8eaf154b385bbe0ff06155294ccf7962aa2d3324 04:34:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:34:16 INFO - mozversion platform_version: 53.0a1 04:34:16 INFO - using testdate: 1484570056 04:34:16 INFO - actual date: 1484570056 04:34:16 INFO - starting webserver on 'localhost:49242' 04:34:16 INFO - SUITE-START | Running 2 tests 04:34:16 INFO - TEST-START | dromaeo_css 04:34:16 INFO - operating with platform_type : mac_ 04:34:16 INFO - Initialising browser for dromaeo_css test... 04:34:16 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpKopfbW/profile http://localhost:49242/getInfo.html) 04:34:19 INFO - PROCESS | 1639 | 2017-01-16 04:34:19.624 plugin-container[1642:7735] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x924f, name = 'com.apple.tsm.portname' 04:34:19 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:19 INFO - PROCESS | 1639 | 2017-01-16 04:34:19.625 plugin-container[1642:7735] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b23, name = 'com.apple.CFPasteboardClient' 04:34:19 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:19 INFO - PROCESS | 1639 | 2017-01-16 04:34:19.625 plugin-container[1642:7735] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:34:19 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 04:34:19 INFO - PROCESS | 1639 | colorDepth:24 04:34:19 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 04:34:19 INFO - PROCESS | 1639 | __metrics 04:34:19 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 04:34:20 INFO - TEST-INFO | 1639: exit 0 04:34:20 INFO - Browser initialized. 04:34:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:20 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpKopfbW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:22 INFO - PROCESS | 1643 | 2017-01-16 04:34:22.856 plugin-container[1644:7854] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:34:22 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:22 INFO - PROCESS | 1643 | 2017-01-16 04:34:22.856 plugin-container[1644:7854] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 04:34:22 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:22 INFO - PROCESS | 1643 | 2017-01-16 04:34:22.856 plugin-container[1644:7854] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:34:32 INFO - PROCESS | 1643 | RSS: Main: 233422848 04:34:32 INFO - PROCESS | 1643 | 04:37:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:37:36 INFO - PROCESS | 1643 | RSS: Main: 255045632 04:37:36 INFO - PROCESS | 1643 | 04:39:20 INFO - PROCESS | 1643 | ************************* 04:39:20 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 04:39:20 INFO - PROCESS | 1643 | 04:39:20 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:20 INFO - PROCESS | 1643 | Full stack: 04:39:20 INFO - PROCESS | 1643 | ************************* 04:40:39 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:40:39 INFO - PROCESS | 1643 | RSS: Main: 262492160 04:40:39 INFO - PROCESS | 1643 | 04:43:41 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:43:42 INFO - PROCESS | 1643 | RSS: Main: 270127104 04:43:42 INFO - PROCESS | 1643 | 04:46:44 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 04:46:45 INFO - PROCESS | 1643 | RSS: Main: 266223616 04:46:45 INFO - PROCESS | 1643 | 04:49:47 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 04:49:48 INFO - PROCESS | 1643 | RSS: Main: 271069184 04:49:48 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 04:52:51 INFO - PROCESS | 1643 | RSS: Main: 273551360 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | __start_tp_report 04:52:51 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 04:52:51 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 04:52:51 INFO - PROCESS | 1643 | |i|pagename|runs| 04:52:51 INFO - PROCESS | 1643 | |0;dojo.html;3412.0616830371646;3422.965770342299;3423.2297733010078;3432.262063656314;3435.8453869575874;5750.568707346955;5755.39568345324;5819.563532735041;5820.912686309698;5881.117832325153;4480.350349199364;5631.831045068644;5761.625494342875;5782.710864456771;5787.82636520904;5199.142141546659;5201.86995325118;5237.8952420951555;5282;5337.653052551591;5296.788128474856;5311.389190243113;5315.441878602749;5369.060414427479;5369.979703856275;5245.763940622681;5349.732513374335;5352.973235133819;5359.7320133993335;5362.35651721794;4485.327200919855;5346.331708536433;5395.352557693062;5397.109476936301;5410.3507579090765;5154.433012368637;5175.327207463043;5206.401263854629;5210.166373380241;5230.712310822903;5543.473370029841;5784.88430231393;5864.76540938362;5871.765129394819;5911.93585154672;6185.505159587222;6259.561830671855;6282.994720844688;6293.1504246927;6298.874022519524;6213.906791398087;6223.875522489525;6262.6868656566985;6264.843378915518;6264.87470250597;5910.674912879833;5914.556408269397;5948.405159484104;5960.254968128984;6048.334683184846;5523.8066667666435;6368.5860419072615;6385.329540398191;6433.613983161025;6457.7094030767785;5458.5087342139395;6047.304559975659;6223.973044447615;6229.937700622936;6260.812175634738;4703.506131856174;5084.3898732152375;6023.397660234029;6097.917917222642;6202.782902598477;5595.440455954454;5921;6255.843603909939;6270.122182894398;6296.181496405438;6128.411459112287;6197.81406557804;6231.261890295519;6254.718537665816;6315.905261421082;5000.299958005882;5000.799968001239;5013.774380152902;5052.317937078521;5102.08162530748;4479.574440428154;4510.548945105529;4512.706674066241;4525.773711314421;4555.589996900295;5789.565782566325;6041.486473649789;6043;6046.032634778414;6053.334133245339;6173.043178307369;6178.907316390258;6212.968935155386;6269.68651567429;6270.874582508324;6018.8194354169445;6024.969875150597;6033.306169790442;6040.184575082308;6078.878422431527;5520.1167813149705;5526.530244929146;5530.751116199781;5533.889322213533;5543.556515478752;6179.918514259896;6291.150694656163;6308.14839996613;6471.773487927994;6501.902471463027;6177.104319873503;6184.474319682878;6247.250329960434;6255;6259.937400626118;6424.775132870327;6440.25937017249;6444.097826304415;6456.838579035561;6470.320616335217;6111.53096535531;6164.4143806338325;6185.536084793568;6226.097215903759;6255.185166675105;6193.597416167935;6220.937790622217;6226.25284965807;6274.749010039547;6277.183966084563;6151.876962460815;6156.415140561639;6162.198914141133;6168.19813424252;6171.413715697002;5977.402259773988;6087.299960504599;6152;6159.168512250789;6166.753329866755;5255.975084858416;5466.644668096561;5883.558733094949;5964.701764911824;6017.789377371771;6125.54069408161;6136.20229370179;6169.96915015422;6231.4391704746795;6233.937660623335;5955.910661339996;5983.850403739767;5996.820095397145;6093.695315234309;6097.146399504161 04:52:51 INFO - PROCESS | 1643 | |1;ext.html;441.3578243655481;504.79051193754594;534.8235082422801;535.419070308715;549.9962568312831;31329.68670313296;39744.60255397445;39790.40314395279;39863.800680996625;39895.601043989554;40630.18739625213;41106;41198.79400603;41208.17583648333;41315.58684413155;9138.994710581846;9344.345895787297;10734.838977415346;11043.72390690235;11062.1703372247;10832.025117739402;10925.399103049329;10926.672199834018;10948.781024379547;10975.945120274388;10943.179261555415;11000.669979900576;11007.339559626407;11024.118070554336;11031.83452248213;10949.562017519289;10980.341179529254;11006.339619622848;11011.944940275247;11025.889741102566;9671.516424178762;10849.891501085045;11002.394868282321;11104.056155226815;11104.61133860311;36013.81993090018;36279.81860090709;36333.454998175046;36345.45481817775;36355.09112272188;3866.2267546490534;3923.9607603923882;3936.114374265796;3936.6063393660693;3949.4273330366937;27685.623816317355;28272.151835444765;28455.715442845514;28468.430631387462;28739;3115.8286294253808;3150.2439414540345;3237.223066464055;3298.175456135966;3308.0902751743224;470491;473477.63261183817;475405.2459475396;475495;475806;53510.464895351324;53665.1950220747;53975.92048159015;54112.729436352565;54126.58734126635;56942.7152864233;57176.42823571711;57510.7124464375;57513;57657.42342576604;13570.982176336815;14729.55811325662;14901.776473352907;15223.31495082724;15225.695486090217;10577;11566.190366674253;11768.764624707457;11812.70468238301;11836.349000805038;17060.57348566271;17067;17198.65602687939;17220;17296.567585810455;7784.532928024337;7785.727499537489;7802.453828231969;7859.921400786034;7860.371170306476;821.2895845093951;824.8122703307218;883.571467838098;905.9728208153766;913.5751875377981;30207.69792302093;30314.393712125635;30393.392132157234;30903.690963090532;30920.536191957137;942.8255772682076;1039.443897514826;1060.565168281001;1093.1855767453299;1096.6216655253925;15156.848431515764;15717;15718.842811571967;15762.211889405713;15944;571775;601461;606655;607072;607640;58954;59423.70288148532;59642.508937276914;59792;59934.40065599288;1360.6462319796924;1432.4485073246667;1443.884489240858;1446.6889618732234;1449.8332691740584;25790.871045644653;29612;29631;29724.851375742983;30412.84793576018;49693.25460118029;50058.749706251234;50086.749566251936;50100;50363.74818125886;539153;541030;541064;541395;542448;24247;24543.263702088967;24910.626340604544;25564;25866;27711.44577108406;32415.35169296648;40273;40325;41389;28886.133415997552;34405;35574.46638300376;35680.10799730028;36555;35324.646753532135;35358.646413535535;36100.63899361078;36189.27621447609;36397.63602364049;34493.82753086218;35041.824790875886;35524.46713299251;35601.82199088988;35638.8218058908;24070.759292406852;30250.638721257157;30263.394732104793;30902.690973089982;31789.20526986844;23672.408189794704;23820.658093268434;24026.918788654202;24218.878905606063;24356.02575897015 04:52:51 INFO - PROCESS | 1643 | |2;jquery.html;357.56912919931483;384.96342847429486;390.37150188197;398.0645483114679;411.0545744786989;19508.707369389453;20966.37100886976;21091.668790827614;21238.57522849542;21444.785552144473;20788.480287992807;20963.6855447168;21298.46753831151;21433.821139837302;21661.891690541524;5753.223314852483;5857.531397488191;5995.700214989255;6078.361772013941;6109.602875813081;3898.142408670088;4218.578142185772;6062;6112.449879510843;6118.4799292060225;6030.63816171029;6095.756169753205;6104.816855494342;6114.021756518958;6128.662923539204;5895.027320492135;6028.3971602839365;6077.7568897244055;6085.665288409135;6108.320211941707;5878.706064696791;5909.556783241274;5943.078822782476;5945;5951.732172052268;18745.437636870778;19894.502637434034;24931.626025609632;25418.745812541823;25666.23001309945;2645.1667724666668;2842.445723083979;3000.6699263081046;3032.7877048606606;3090.2583379988864;8022.67909283628;9430.151286384189;9784.168345690625;10144.94927525365;10208.540615672238;1782.9643407131914;1831.9633607327778;1848.7504186934725;1866.6919958207015;1877.9154938027684;102694.45958310556;119178.23287068507;124122;125151.37424312912;125488;11432.828507572392;11491;11796.351200683874;11881.762364752656;11989;15628;15659.451919183002;15703;15716.68566628684;15741.763873541906;8513.702020429255;8617.655293788179;8781.429207101519;8899.73300800977;8917.152870477294;6698.698558564876;7628.580428076398;7800.141984381714;8490.702825401082;8507.82984340322;4258.552851950501;4501.347304640874;4699.271612900006;4764.95235047652;4846.588040016568;1771.9822801772075;1786.9821301786815;1836.861146089433;1849.1493912799995;1945.2121890634032;791.7545560876032;1037.0510982451124;1048.4390850894736;1067.6049861551276;1110.0453609895483;20005.499862503555;21239.78760212409;21334.893325533274;21343.78656213449;21348.466288342606;878.8549889268199;993.8807343118727;1041.234692501011;1056.7569459024467;1103.3435106111851;9808.46053467052;9930.702078937644;10792.730181745363;11068.612598559012;11221.66335009951;721396;723985;730317.382763813;731336;742402;94514.10971780526;105418;136989;146188.53811461962;150295.2485237567;861.6036623153294;950.6815216902415;976.8534719792088;1021.6322124035341;1024.666983230453;16311.184440777677;16315.286894876343;18491.16789744438;18602.53493662615;18790.53023674419;55556.72221639028;57307;57862.4213757857;57992;58138.4186158133;65632.68734625376;83542;84189;84537.57731211305;84826;8141.3893957952205;8248.216419440143;8298.875516867372;8331.583420829056;8464.238218560358;9253.444793312423;12317.815232771336;12873.163244389085;13356.866431335951;13378.264195469343;10490;10716.196285278791;11007.559697612327;11096.88903110991;11455.484503197209;10658.307210031633;10778.461076946278;10846.620368287073;11052.889471105507;11271.436428178722;11216.83174752363;11299.209055366046;11319.603813866475;11474.541018359172;11493.94253028763;8286.70996515119;8436.088876483997;8466;8485.278751306209;8617.267532259577;7239.565626062453;9663.226941844776;11167.664970050912;11314.547418103184;11409.486573104065 04:52:51 INFO - PROCESS | 1643 | |3;mootools.html;1257.8239046533486;1269.0355329949236;1288.8453385593727;1441.1425202004802;1471.087925486198;7522.172561018284;7727.536347819135;8091.474054186474;8538;8555.871661925075;6547.247066587344;6936.6878490467925;8213.83572328553;8312.251897329239;8312.792180195498;2078.511549785799;2179.8365122615787;2311.5839148953182;2346.4251258441705;2350.9655751469386;2090.3937858021154;2153.9030743616495;2289.461976435536;2318.1422873536817;2362.7400985891536;2258.6499092640584;2327.7788610082016;2327.8836058197107;2338.3101984914406;2343.4258606641397;2108.8822923850385;2255.064148378421;2263;2270.6026445372077;2297.7357603875603;2177.5644871025856;2317.4322291038634;2323.384303159664;2344.4724936889065;2349.2717257650183;7342.77971660851;8399.034111077242;8443.240108390275;8522.616482258314;8553.48679079251;5097.515736005073;5181.0674078665825;5229.450907654679;5232.450592687751;5245.737713114368;2773.4037182005763;2998.865051072707;3431.7769344992494;3522.0314413536225;3559.5906470755676;1189.6550000499844;1197.0662882951312;1225.8835410635975;1229.3914512316371;1239.5227837282712;10729.248952573324;10774.461276936201;10871.619493317696;10882.61910833117;10916.235863489559;4252.617264446215;4446.644268458515;4516.8193272268745;4532.184206842734;4553.681242313072;8603.483790972561;8752.737417877473;8755.124487551195;8766.167214114648;8769.12308769118;5126.92309615356;5144.459831717616;5152.046871328816;5155.9742201288755;5166.121759300928;3951.6048395160255;4674.088552732184;4745.810167593327;4757.119932812371;4822.059698358857;3608.5128507651657;3629.219717760694;3680.2639472105684;3698.3712768829364;3718.2935242304416;1053.2042866911897;1073.727632755172;1089.9400532970762;1110.8833572474934;1116.7598966222301;767.9270469305519;878.1701292278863;901.2069378946616;916.9862452063225;930.7580029192324;5637;5728.140778883201;5745.109508026263;5766.509846662997;6007.459328660354;971.0871780526282;975.3075316525346;979.7354714227118;992.3103443107116;1030.4229631406436;3735.1595890924323;3850.6919446444776;3868.6518213360932;3899.337112690849;3907.199024200032;9437.339386242897;9773.41359518431;9786.804263914682;9801;9885.703428897144;9844.50777461124;9845.360051596766;9846.359986600848;9907.356021858555;10005;7704.191059938737;7821.7262395817015;7925.841483170304;7926.841463170705;7945;5438;5523.254360661259;5544.0575102231915;5554.833354999357;5569.888602228014;7083.327083927019;8914.242289405214;9115.270778337584;9150.176484116462;9188.632454701738;9194;9239.815203696024;9326;9337.486438245962;9428.528573571431;7207.603581802841;7335.633218338955;7354.301341372561;7366.521176123535;7373.446991475554;6673.499487538357;6806.965965170142;7709.498882572615;7810.336121429742;7845.6077196141105;5782.2483077199695;6989.895151572832;7068.399186069036;7203.8919416207755;7272.818179545342;6899.6205208714;7042.542234754725;7062.682179302046;7123.928760712327;7181.066461360198;6334.936650633619;6391.552591318563;6455.289918108911;6466.612003279818;6489.123968264224;4903.33804936329;4956.653034287565;5018.04657115147;5030.5975521957425;5137.460566640449;4215.641670458045;4542.750148741851;4782.426108866958;4976.278439626161;5074.908894587681 04:52:51 INFO - PROCESS | 1643 | |4;prototype.html;288.5138541557476;294.6979346170174;342.5170509581489;357.9606243313237;359.57966034165054;4967.801287948478;5183.714895680736;5380.167187671655;5538.335399752031;5551.111822108458;4708.387909571751;4725.858224253269;5079.831638723096;5257.50161204056;5486.780528778844;3542.919409580077;3945.4279129526203;4210.578942105795;4274.422952901357;4322.610965013148;3601.603823579404;3776.3957766757326;4187.937180942288;4296.656267498593;4320.567943205686;3361.5798025246845;3601.4957905893198;3755.680767134797;3895.6883449324127;4268.40242366069;3599.8560057597665;3692.593814680383;4152.750834949913;4224.746515209097;4239.936400954003;3504.211552400715;3652.2695460907657;3769.981150094259;3807.990882416162;3825.713071519647;5003.949960500385;5023.447420783711;5333.706646134461;5380.461953804627;5413.998410294108;4910.926336104962;4940.25896115582;4957.851264462072;4962.49394056003;4992.775325110342;5835.854103647443;5857.414258574151;5860.706964651793;5875.6474611523445;5887.941120588782;3330.8501117449773;3521.8767343142868;4170.97811036298;4185.953511622094;4189.539150693421;5559.360673522516;5706.201131841504;5718.313802343745;5843.2403787507355;6144.927536231884;3612.3497770401054;4222.493300803923;4226.725262857904;4250.829966801355;4255.97872010638;3921.235359105004;4087.7751723655483;4183.769892655933;4313.84901528445;4320.092780516064;4231.767252801125;4499.010217752089;4759.928601070987;4925.21196608541;4961.8511444656;4988.975055124701;5557.694326812064;5882.794102206402;5898.675572843449;5900.232969713996;1177.43483128099;1231.7043909461843;1284.6724085358173;1421.422221334318;1427.2649585463494;882.5190271302156;899.7300809757047;921.8294615496154;951.2912879904516;990.6235630460523;4843.8304659337455;4986.501349864984;5151.639385242997;5198.570393141917;5234.979179060047;4922.8769280768265;5417.39521406801;5495.6153069285565;5501.084425254541;5723.338647528919;4550.47117751933;4588.2888152336445;5213.139831927765;5215.322008138917;5223.608229382811;2500.5499010177978;2566.8459892406518;2700.7434293742062;2897.7392034716554;2979.493486107367;4975.402951645826;5933.110033495011;5956.463918247378;5975.671338076448;6015.39846015395;5195.844124676266;5416.47724150331;5831.675944711558;5878.177764892896;5926.362768567946;4991.07665081961;5705.828825135252;5925.526227698147;5968.641881487125;5995.880082398327;4981.576565991932;5351.892962140813;5365.382980957083;5732.914006289992;5738.8278351649515;4803.927941080817;5108.386993560796;5597.9491177307655;5642.774289028393;5694.4590263924865;4927.827526036572;5962.344142144274;5987.371326010706;6014.8195554133445;6025.457708806053;3620.3483372993114;3631.600523942417;3885.4366116912324;4061.7766022869027;4096.91806163881;5660.29246344207;5679.5172410345585;5685.459881311269;5699.373068962328;5724;5300.3639563252655;5620.437956204347;5763.279590051244;5800.418813628064;5813.738381772746;5777.3933736957015;5788.392218816964;5799.217105690678;5806.622569532967;5836.883262334814;4603.987122832971;4713.3401323814005;4748.406449193851;5285.9471405286995;5698.458646428583;5782.653040817564;5790.334111577223;5796.565257605612;5811.820567287267;5819.79630712923;5425.620206585501;5635.8591035224445;5678.4605462480995;5679.097502336598;5698.153746221367 04:52:51 INFO - PROCESS | 1643 | |5;yui.html;683.2115917238909;696.6412297666706;751.2374939436473;790.6679194738209;822.4571782623468;14794.260286985662;15181.468648597302;15595.220238988048;15683.059016459021;15879.444219452322;14522.346494407751;14635.780463293058;14794.482193123244;14852.925735371307;15692.450764223255;842.376641285449;865.1348651348651;869.4609342207808;872.5462759365126;874.4447275979735;841.9242268195861;864.576357584782;877.8814859993915;884.9690260840872;886.5877367024333;892.9151730585584;913.1416468519603;913.7304495173939;913.9261367892733;914.5153068873508;902.5487256371814;909.1454033208829;909.7725568607848;909.822584596004;912.3567884641312;658.5258613798057;680.2789043613785;680.357062575866;681.4071757570896;681.4548361310981;15046.699066018618;15264;15467.690646187013;15542.9222853885;15624.062556246661;13958.371873265727;14212.50256241037;14328.856711432856;14338.713225735426;14360.210188439632;11830.408479575986;11867.821982670266;11868.228565143238;11894.583689570823;11948.402579871059;3089.3049063960652;3209.3741720364537;3689.096171438015;3749.3438648236724;3819.102510909934;96961;98628;106390;109765.45117274362;110958.89041109566;10813.83779243312;10917.687513432149;10971.053458570423;11104.278221915549;11398.316101033965;17763.644727105642;21731.348059558237;21950.121995120015;21977.34067977963;22044.669329960063;7709;7909.7231596893835;7917.2874441300555;7974.202579741979;8047.195280471906;4094.1811637672586;4149.8340066397;4193.22425351311;4200.3699445082875;4205.17998990194;3536.4341705327024;3548.556430446194;3568.2149927016017;3591.712662987007;3615.2227271136308;659.9340065993458;660.6168422315046;663.4095654867172;670.7954074007474;678.5792808458788;658.6838317607575;667.6561570791047;675.7128220506265;682.3176823176823;711.8540699156661;8567.88617479736;9171.58727857248;9896.950515247378;10491.213159013105;10637.62768303121;686.2691233835949;700.6776882633943;705.336983235767;706.3148745716646;720.5669253826093;4995.493499185863;5022.1771386519;5022.824201152942;5061.215511595708;5108.923366149511;79024.60487697525;101231.98768012373;102751;107440;109209;68969.65515172391;77991.61004194943;88315.55842220748;88555;88574.55712721395;66461.33538664647;75756.24243757493;81723.18276817155;82864;83171;9847.310688251753;9858.556364963737;9859.950700246452;9869.358491698016;9882.160016398686;50323.24515132203;50479.990400192524;51604.96790064253;51957.42702454204;52660.21009684935;64279;66087;67205.66397167982;68975.65512172406;69129;11672;11837.348945807718;12413.31726755001;13397.531086412318;13459.394327255493;14915.116618725218;15013.474528391891;15080.85802817179;15186.772198417253;15302.540923772305;13553.235617405664;13710.794338084737;13856.445742170603;14026.579202623938;14863.554093377215;11156.44217789091;14011.337845809263;14068.226247556073;14161.362738676578;14583.489577864724;11269;13262.53581124656;13563.660908477366;13572.796408054084;13825.86174138286;8860.778480538038;10951.34291942486;11203.85773130563;11320.886791131983;11365.374904380338;8343.707970221256;9201.76995575116;11082.422840736952;11229.831552526883;11268.323900565993 04:52:51 INFO - PROCESS | 1643 | __end_tp_report 04:52:51 INFO - PROCESS | 1643 | __start_cc_report 04:52:51 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,379 04:52:51 INFO - PROCESS | 1643 | __end_cc_report 04:52:51 INFO - PROCESS | 1643 | __startTimestamp1484571171471__endTimestamp 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | ------- Summary: start ------- 04:52:51 INFO - PROCESS | 1643 | Number of tests: 6 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5771.98 Median:6024.97 stddev:644.17 (10.7%) stddev-sans-first:618.97 04:52:51 INFO - PROCESS | 1643 | Values: 3412.1 3423.0 3423.2 3432.3 3435.8 5750.6 5755.4 5819.6 5820.9 5881.1 4480.4 5631.8 5761.6 5782.7 5787.8 5199.1 5201.9 5237.9 5282.0 5337.7 5296.8 5311.4 5315.4 5369.1 5370.0 5245.8 5349.7 5353.0 5359.7 5362.4 4485.3 5346.3 5395.4 5397.1 5410.4 5154.4 5175.3 5206.4 5210.2 5230.7 5543.5 5784.9 5864.8 5871.8 5911.9 6185.5 6259.6 6283.0 6293.2 6298.9 6213.9 6223.9 6262.7 6264.8 6264.9 5910.7 5914.6 5948.4 5960.3 6048.3 5523.8 6368.6 6385.3 6433.6 6457.7 5458.5 6047.3 6224.0 6229.9 6260.8 4703.5 5084.4 6023.4 6097.9 6202.8 5595.4 5921.0 6255.8 6270.1 6296.2 6128.4 6197.8 6231.3 6254.7 6315.9 5000.3 5000.8 5013.8 5052.3 5102.1 4479.6 4510.5 4512.7 4525.8 4555.6 5789.6 6041.5 6043.0 6046.0 6053.3 6173.0 6178.9 6213.0 6269.7 6270.9 6018.8 6025.0 6033.3 6040.2 6078.9 5520.1 5526.5 5530.8 5533.9 5543.6 6179.9 6291.2 6308.1 6471.8 6501.9 6177.1 6184.5 6247.3 6255.0 6259.9 6424.8 6440.3 6444.1 6456.8 6470.3 6111.5 6164.4 6185.5 6226.1 6255.2 6193.6 6220.9 6226.3 6274.7 6277.2 6151.9 6156.4 6162.2 6168.2 6171.4 5977.4 6087.3 6152.0 6159.2 6166.8 5256.0 5466.6 5883.6 5964.7 6017.8 6125.5 6136.2 6170.0 6231.4 6233.9 5955.9 5983.9 5996.8 6093.7 6097.1 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:66400.20 Median:34449.41 stddev:144323.22 (418.9%) stddev-sans-first:144643.12 04:52:51 INFO - PROCESS | 1643 | Values: 441.4 504.8 534.8 535.4 550.0 31329.7 39744.6 39790.4 39863.8 39895.6 40630.2 41106.0 41198.8 41208.2 41315.6 9139.0 9344.3 10734.8 11043.7 11062.2 10832.0 10925.4 10926.7 10948.8 10975.9 10943.2 11000.7 11007.3 11024.1 11031.8 10949.6 10980.3 11006.3 11011.9 11025.9 9671.5 10849.9 11002.4 11104.1 11104.6 36013.8 36279.8 36333.5 36345.5 36355.1 3866.2 3924.0 3936.1 3936.6 3949.4 27685.6 28272.2 28455.7 28468.4 28739.0 3115.8 3150.2 3237.2 3298.2 3308.1 470491.0 473477.6 475405.2 475495.0 475806.0 53510.5 53665.2 53975.9 54112.7 54126.6 56942.7 57176.4 57510.7 57513.0 57657.4 13571.0 14729.6 14901.8 15223.3 15225.7 10577.0 11566.2 11768.8 11812.7 11836.3 17060.6 17067.0 17198.7 17220.0 17296.6 7784.5 7785.7 7802.5 7859.9 7860.4 821.3 824.8 883.6 906.0 913.6 30207.7 30314.4 30393.4 30903.7 30920.5 942.8 1039.4 1060.6 1093.2 1096.6 15156.8 15717.0 15718.8 15762.2 15944.0 571775.0 601461.0 606655.0 607072.0 607640.0 58954.0 59423.7 59642.5 59792.0 59934.4 1360.6 1432.4 1443.9 1446.7 1449.8 25790.9 29612.0 29631.0 29724.9 30412.8 49693.3 50058.7 50086.7 50100.0 50363.7 539153.0 541030.0 541064.0 541395.0 542448.0 24247.0 24543.3 24910.6 25564.0 25866.0 27711.4 32415.4 40273.0 40325.0 41389.0 28886.1 34405.0 35574.5 35680.1 36555.0 35324.6 35358.6 36100.6 36189.3 36397.6 34493.8 35041.8 35524.5 35601.8 35638.8 24070.8 30250.6 30263.4 30902.7 31789.2 23672.4 23820.7 24026.9 24218.9 24356.0 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:38831.22 Median:2743.81 stddev:120878.11 (4405.5%) stddev-sans-first:121182.68 04:52:51 INFO - PROCESS | 1643 | Values: 357.6 385.0 390.4 398.1 411.1 19508.7 20966.4 21091.7 21238.6 21444.8 20788.5 20963.7 21298.5 21433.8 21661.9 5753.2 5857.5 5995.7 6078.4 6109.6 3898.1 4218.6 6062.0 6112.4 6118.5 6030.6 6095.8 6104.8 6114.0 6128.7 5895.0 6028.4 6077.8 6085.7 6108.3 5878.7 5909.6 5943.1 5945.0 5951.7 18745.4 19894.5 24931.6 25418.7 25666.2 2645.2 2842.4 3000.7 3032.8 3090.3 8022.7 9430.2 9784.2 10144.9 10208.5 1783.0 1832.0 1848.8 1866.7 1877.9 102694.5 119178.2 124122.0 125151.4 125488.0 11432.8 11491.0 11796.4 11881.8 11989.0 15628.0 15659.5 15703.0 15716.7 15741.8 8513.7 8617.7 8781.4 8899.7 8917.2 6698.7 7628.6 7800.1 8490.7 8507.8 4258.6 4501.3 4699.3 4765.0 4846.6 1772.0 1787.0 1836.9 1849.1 1945.2 791.8 1037.1 1048.4 1067.6 1110.0 20005.5 21239.8 21334.9 21343.8 21348.5 878.9 993.9 1041.2 1056.8 1103.3 9808.5 9930.7 10792.7 11068.6 11221.7 721396.0 723985.0 730317.4 731336.0 742402.0 94514.1 105418.0 136989.0 146188.5 150295.2 861.6 950.7 976.9 1021.6 1024.7 16311.2 16315.3 18491.2 18602.5 18790.5 55556.7 57307.0 57862.4 57992.0 58138.4 65632.7 83542.0 84189.0 84537.6 84826.0 8141.4 8248.2 8298.9 8331.6 8464.2 9253.4 12317.8 12873.2 13356.9 13378.3 10490.0 10716.2 11007.6 11096.9 11455.5 10658.3 10778.5 10846.6 11052.9 11271.4 11216.8 11299.2 11319.6 11474.5 11493.9 8286.7 8436.1 8466.0 8485.3 8617.3 7239.6 9663.2 11167.7 11314.5 11409.5 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5338.46 Median:5239.09 stddev:2904.72 (55.4%) stddev-sans-first:2896.67 04:52:51 INFO - PROCESS | 1643 | Values: 1257.8 1269.0 1288.8 1441.1 1471.1 7522.2 7727.5 8091.5 8538.0 8555.9 6547.2 6936.7 8213.8 8312.3 8312.8 2078.5 2179.8 2311.6 2346.4 2351.0 2090.4 2153.9 2289.5 2318.1 2362.7 2258.6 2327.8 2327.9 2338.3 2343.4 2108.9 2255.1 2263.0 2270.6 2297.7 2177.6 2317.4 2323.4 2344.5 2349.3 7342.8 8399.0 8443.2 8522.6 8553.5 5097.5 5181.1 5229.5 5232.5 5245.7 2773.4 2998.9 3431.8 3522.0 3559.6 1189.7 1197.1 1225.9 1229.4 1239.5 10729.2 10774.5 10871.6 10882.6 10916.2 4252.6 4446.6 4516.8 4532.2 4553.7 8603.5 8752.7 8755.1 8766.2 8769.1 5126.9 5144.5 5152.0 5156.0 5166.1 3951.6 4674.1 4745.8 4757.1 4822.1 3608.5 3629.2 3680.3 3698.4 3718.3 1053.2 1073.7 1089.9 1110.9 1116.8 767.9 878.2 901.2 917.0 930.8 5637.0 5728.1 5745.1 5766.5 6007.5 971.1 975.3 979.7 992.3 1030.4 3735.2 3850.7 3868.7 3899.3 3907.2 9437.3 9773.4 9786.8 9801.0 9885.7 9844.5 9845.4 9846.4 9907.4 10005.0 7704.2 7821.7 7925.8 7926.8 7945.0 5438.0 5523.3 5544.1 5554.8 5569.9 7083.3 8914.2 9115.3 9150.2 9188.6 9194.0 9239.8 9326.0 9337.5 9428.5 7207.6 7335.6 7354.3 7366.5 7373.4 6673.5 6807.0 7709.5 7810.3 7845.6 5782.2 6989.9 7068.4 7203.9 7272.8 6899.6 7042.5 7062.7 7123.9 7181.1 6334.9 6391.6 6455.3 6466.6 6489.1 4903.3 4956.7 5018.0 5030.6 5137.5 4215.6 4542.8 4782.4 4976.3 5074.9 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4616.18 Median:5130.01 stddev:1413.03 (27.5%) stddev-sans-first:1379.15 04:52:51 INFO - PROCESS | 1643 | Values: 288.5 294.7 342.5 358.0 359.6 4967.8 5183.7 5380.2 5538.3 5551.1 4708.4 4725.9 5079.8 5257.5 5486.8 3542.9 3945.4 4210.6 4274.4 4322.6 3601.6 3776.4 4187.9 4296.7 4320.6 3361.6 3601.5 3755.7 3895.7 4268.4 3599.9 3692.6 4152.8 4224.7 4239.9 3504.2 3652.3 3770.0 3808.0 3825.7 5003.9 5023.4 5333.7 5380.5 5414.0 4910.9 4940.3 4957.9 4962.5 4992.8 5835.9 5857.4 5860.7 5875.6 5887.9 3330.9 3521.9 4171.0 4186.0 4189.5 5559.4 5706.2 5718.3 5843.2 6144.9 3612.3 4222.5 4226.7 4250.8 4256.0 3921.2 4087.8 4183.8 4313.8 4320.1 4231.8 4499.0 4759.9 4925.2 4961.9 4989.0 5557.7 5882.8 5898.7 5900.2 1177.4 1231.7 1284.7 1421.4 1427.3 882.5 899.7 921.8 951.3 990.6 4843.8 4986.5 5151.6 5198.6 5235.0 4922.9 5417.4 5495.6 5501.1 5723.3 4550.5 4588.3 5213.1 5215.3 5223.6 2500.5 2566.8 2700.7 2897.7 2979.5 4975.4 5933.1 5956.5 5975.7 6015.4 5195.8 5416.5 5831.7 5878.2 5926.4 4991.1 5705.8 5925.5 5968.6 5995.9 4981.6 5351.9 5365.4 5732.9 5738.8 4803.9 5108.4 5597.9 5642.8 5694.5 4927.8 5962.3 5987.4 6014.8 6025.5 3620.3 3631.6 3885.4 4061.8 4096.9 5660.3 5679.5 5685.5 5699.4 5724.0 5300.4 5620.4 5763.3 5800.4 5813.7 5777.4 5788.4 5799.2 5806.6 5836.9 4604.0 4713.3 4748.4 5285.9 5698.5 5782.7 5790.3 5796.6 5811.8 5819.8 5425.6 5635.9 5678.5 5679.1 5698.2 04:52:51 INFO - PROCESS | 1643 | 04:52:51 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20211.94 Median:4600.34 stddev:28757.00 (625.1%) stddev-sans-first:28800.28 04:52:51 INFO - PROCESS | 1643 | Values: 683.2 696.6 751.2 790.7 822.5 14794.3 15181.5 15595.2 15683.1 15879.4 14522.3 14635.8 14794.5 14852.9 15692.5 842.4 865.1 869.5 872.5 874.4 841.9 864.6 877.9 885.0 886.6 892.9 913.1 913.7 913.9 914.5 902.5 909.1 909.8 909.8 912.4 658.5 680.3 680.4 681.4 681.5 15046.7 15264.0 15467.7 15542.9 15624.1 13958.4 14212.5 14328.9 14338.7 14360.2 11830.4 11867.8 11868.2 11894.6 11948.4 3089.3 3209.4 3689.1 3749.3 3819.1 96961.0 98628.0 106390.0 109765.5 110958.9 10813.8 10917.7 10971.1 11104.3 11398.3 17763.6 21731.3 21950.1 21977.3 22044.7 7709.0 7909.7 7917.3 7974.2 8047.2 4094.2 4149.8 4193.2 4200.4 4205.2 3536.4 3548.6 3568.2 3591.7 3615.2 659.9 660.6 663.4 670.8 678.6 658.7 667.7 675.7 682.3 711.9 8567.9 9171.6 9897.0 10491.2 10637.6 686.3 700.7 705.3 706.3 720.6 4995.5 5022.2 5022.8 5061.2 5108.9 79024.6 101232.0 102751.0 107440.0 109209.0 68969.7 77991.6 88315.6 88555.0 88574.6 66461.3 75756.2 81723.2 82864.0 83171.0 9847.3 9858.6 9860.0 9869.4 9882.2 50323.2 50480.0 51605.0 51957.4 52660.2 64279.0 66087.0 67205.7 68975.7 69129.0 11672.0 11837.3 12413.3 13397.5 13459.4 14915.1 15013.5 15080.9 15186.8 15302.5 13553.2 13710.8 13856.4 14026.6 14863.6 11156.4 14011.3 14068.2 14161.4 14583.5 11269.0 13262.5 13563.7 13572.8 13825.9 8860.8 10951.3 11203.9 11320.9 11365.4 8343.7 9201.8 11082.4 11229.8 11268.3 04:52:51 INFO - PROCESS | 1643 | -------- Summary: end -------- 04:52:51 INFO - PROCESS | 1643 | 04:52:52 INFO - TEST-INFO | 1643: exit 0 04:52:52 INFO - TEST-OK | dromaeo_css | took 1115676ms 04:52:52 INFO - TEST-START | kraken 04:52:52 INFO - operating with platform_type : mac_ 04:52:52 INFO - Initialising browser for kraken test... 04:52:52 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpLxD2_i/profile http://localhost:49242/getInfo.html) 04:52:55 INFO - PROCESS | 1651 | 2017-01-16 04:52:55.102 plugin-container[1653:10065] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 04:52:55 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:55 INFO - PROCESS | 1651 | 2017-01-16 04:52:55.102 plugin-container[1653:10065] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 04:52:55 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:55 INFO - PROCESS | 1651 | 2017-01-16 04:52:55.102 plugin-container[1653:10065] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:52:55 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 04:52:55 INFO - PROCESS | 1651 | colorDepth:24 04:52:55 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 04:52:55 INFO - PROCESS | 1651 | __metrics 04:52:55 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 04:52:56 INFO - TEST-INFO | 1651: exit 0 04:52:56 INFO - Browser initialized. 04:52:56 INFO - Running cycle 1/1 for kraken test... 04:52:56 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpLxD2_i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:58 INFO - PROCESS | 1654 | 2017-01-16 04:52:58.419 plugin-container[1655:10182] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 04:52:58 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:58 INFO - PROCESS | 1654 | 2017-01-16 04:52:58.420 plugin-container[1655:10182] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 04:52:58 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:52:58 INFO - PROCESS | 1654 | 2017-01-16 04:52:58.420 plugin-container[1655:10182] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:08 INFO - PROCESS | 1654 | RSS: Main: 233652224 04:53:08 INFO - PROCESS | 1654 | 04:53:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:12 INFO - PROCESS | 1654 | RSS: Main: 245911552 04:53:12 INFO - PROCESS | 1654 | 04:53:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 04:53:15 INFO - PROCESS | 1654 | RSS: Main: 254177280 04:53:15 INFO - PROCESS | 1654 | 04:53:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 04:53:19 INFO - PROCESS | 1654 | RSS: Main: 256684032 04:53:19 INFO - PROCESS | 1654 | 04:53:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 04:53:22 INFO - PROCESS | 1654 | RSS: Main: 257826816 04:53:22 INFO - PROCESS | 1654 | 04:53:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:24 INFO - PROCESS | 1654 | RSS: Main: 258170880 04:53:24 INFO - PROCESS | 1654 | 04:53:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:28 INFO - PROCESS | 1654 | RSS: Main: 265441280 04:53:28 INFO - PROCESS | 1654 | 04:53:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:32 INFO - PROCESS | 1654 | RSS: Main: 264048640 04:53:32 INFO - PROCESS | 1654 | 04:53:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 04:53:35 INFO - PROCESS | 1654 | RSS: Main: 263970816 04:53:35 INFO - PROCESS | 1654 | 04:53:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:38 INFO - PROCESS | 1654 | RSS: Main: 263651328 04:53:38 INFO - PROCESS | 1654 | 04:53:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:41 INFO - PROCESS | 1654 | RSS: Main: 263544832 04:53:41 INFO - PROCESS | 1654 | 04:53:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:43 INFO - PROCESS | 1654 | RSS: Main: 263589888 04:53:43 INFO - PROCESS | 1654 | 04:53:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:47 INFO - PROCESS | 1654 | RSS: Main: 263991296 04:53:47 INFO - PROCESS | 1654 | 04:53:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:51 INFO - PROCESS | 1654 | RSS: Main: 263823360 04:53:51 INFO - PROCESS | 1654 | 04:53:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 04:53:53 INFO - PROCESS | 1654 | RSS: Main: 265744384 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | __start_tp_report 04:53:53 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 04:53:53 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 04:53:53 INFO - PROCESS | 1654 | |i|pagename|runs| 04:53:53 INFO - PROCESS | 1654 | |0;ai-astar;106;127;173;161;118;116;116;117;117;119 04:53:53 INFO - PROCESS | 1654 | |1;audio-beat-detection;149;117;121;167;120;100;114;145;167;129 04:53:53 INFO - PROCESS | 1654 | |2;audio-dft;203;235;195;199;203;199;227;220;191;192 04:53:53 INFO - PROCESS | 1654 | |3;audio-fft;81;58;61;85;61;62;61;60;73;59 04:53:53 INFO - PROCESS | 1654 | |4;audio-oscillator;88;71;83;71;71;70;80;70;72;86 04:53:53 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;105;138;80;137;134;90;86;98;86 04:53:53 INFO - PROCESS | 1654 | |6;imaging-darkroom;174;174;176;101;99;100;99;99;134;99 04:53:53 INFO - PROCESS | 1654 | |7;imaging-desaturate;94;96;76;148;146;92;101;108;98;145 04:53:53 INFO - PROCESS | 1654 | |8;json-parse-financial;61;61;71;71;51;84;95;99;97;67 04:53:53 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;73;71;97;112;113;82;71;72;72;71 04:53:53 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;86;87;85;91;82;110;113;110;90;89 04:53:53 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;144;141;142;162;153;132;144;141;207;186 04:53:53 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;172;173;174;176;175;173;177;178;174;173 04:53:53 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;70;67;69;85;66;62;59;83;89 04:53:53 INFO - PROCESS | 1654 | __end_tp_report 04:53:53 INFO - PROCESS | 1654 | __start_cc_report 04:53:53 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,920 04:53:53 INFO - PROCESS | 1654 | __end_cc_report 04:53:53 INFO - PROCESS | 1654 | __startTimestamp1484571233148__endTimestamp 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | ------- Summary: start ------- 04:53:53 INFO - PROCESS | 1654 | Number of tests: 14 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:127.00 Median:118.50 stddev:21.86 (18.4%) stddev-sans-first:21.82 04:53:53 INFO - PROCESS | 1654 | Values: 106.0 127.0 173.0 161.0 118.0 116.0 116.0 117.0 117.0 119.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:137.00 stddev:22.97 (16.8%) stddev-sans-first:23.61 04:53:53 INFO - PROCESS | 1654 | Values: 149.0 117.0 121.0 167.0 120.0 100.0 114.0 145.0 167.0 129.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:206.40 Median:203.00 stddev:15.40 (7.6%) stddev-sans-first:16.28 04:53:53 INFO - PROCESS | 1654 | Values: 203.0 235.0 195.0 199.0 203.0 199.0 227.0 220.0 191.0 192.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.50 stddev:9.86 (16.0%) stddev-sans-first:8.86 04:53:53 INFO - PROCESS | 1654 | Values: 81.0 58.0 61.0 85.0 61.0 62.0 61.0 60.0 73.0 59.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.00 stddev:7.24 (9.5%) stddev-sans-first:6.29 04:53:53 INFO - PROCESS | 1654 | Values: 88.0 71.0 83.0 71.0 71.0 70.0 80.0 70.0 72.0 86.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:104.30 Median:86.00 stddev:23.16 (26.9%) stddev-sans-first:23.89 04:53:53 INFO - PROCESS | 1654 | Values: 89.0 105.0 138.0 80.0 137.0 134.0 90.0 86.0 98.0 86.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:125.50 Median:137.50 stddev:35.57 (25.9%) stddev-sans-first:33.12 04:53:53 INFO - PROCESS | 1654 | Values: 174.0 174.0 176.0 101.0 99.0 100.0 99.0 99.0 134.0 99.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:110.40 Median:84.00 stddev:26.09 (31.1%) stddev-sans-first:26.99 04:53:53 INFO - PROCESS | 1654 | Values: 94.0 96.0 76.0 148.0 146.0 92.0 101.0 108.0 98.0 145.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:75.70 Median:77.50 stddev:17.00 (21.9%) stddev-sans-first:17.18 04:53:53 INFO - PROCESS | 1654 | Values: 61.0 61.0 71.0 71.0 51.0 84.0 95.0 99.0 97.0 67.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:83.40 Median:72.00 stddev:17.35 (24.1%) stddev-sans-first:17.99 04:53:53 INFO - PROCESS | 1654 | Values: 73.0 71.0 97.0 112.0 113.0 82.0 71.0 72.0 72.0 71.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:86.50 stddev:11.83 (13.7%) stddev-sans-first:12.16 04:53:53 INFO - PROCESS | 1654 | Values: 86.0 87.0 85.0 91.0 82.0 110.0 113.0 110.0 90.0 89.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:148.50 stddev:23.69 (16.0%) stddev-sans-first:24.77 04:53:53 INFO - PROCESS | 1654 | Values: 144.0 141.0 142.0 162.0 153.0 132.0 144.0 141.0 207.0 186.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:174.50 stddev:1.96 (1.1%) stddev-sans-first:1.86 04:53:53 INFO - PROCESS | 1654 | Values: 172.0 173.0 174.0 176.0 175.0 173.0 177.0 178.0 174.0 173.0 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:69.50 stddev:10.25 (14.8%) stddev-sans-first:10.73 04:53:53 INFO - PROCESS | 1654 | Values: 67.0 70.0 67.0 69.0 85.0 66.0 62.0 59.0 83.0 89.0 04:53:53 INFO - PROCESS | 1654 | -------- Summary: end -------- 04:53:53 INFO - PROCESS | 1654 | 04:53:53 INFO - TEST-INFO | 1654: exit 0 04:53:54 INFO - TEST-OK | kraken | took 61780ms 04:53:54 INFO - SUITE-END | took 1177s 04:53:54 INFO - Completed test suite (00:19:37) 04:53:54 INFO - javascript benchmark 04:53:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7266.823364597225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.0616830371646, 3422.965770342299, 3423.2297733010078, 3432.262063656314, 3435.8453869575874, 5750.568707346955, 5755.39568345324, 5819.563532735041, 5820.912686309698, 5881.117832325153, 4480.350349199364, 5631.831045068644, 5761.625494342875, 5782.710864456771, 5787.82636520904, 5199.142141546659, 5201.86995325118, 5237.8952420951555, 5282.0, 5337.653052551591, 5296.788128474856, 5311.389190243113, 5315.441878602749, 5369.060414427479, 5369.979703856275, 5245.763940622681, 5349.732513374335, 5352.973235133819, 5359.7320133993335, 5362.35651721794, 4485.327200919855, 5346.331708536433, 5395.352557693062, 5397.109476936301, 5410.3507579090765, 5154.433012368637, 5175.327207463043, 5206.401263854629, 5210.166373380241, 5230.712310822903, 5543.473370029841, 5784.88430231393, 5864.76540938362, 5871.765129394819, 5911.93585154672, 6185.505159587222, 6259.561830671855, 6282.994720844688, 6293.1504246927, 6298.874022519524, 6213.906791398087, 6223.875522489525, 6262.6868656566985, 6264.843378915518, 6264.87470250597, 5910.674912879833, 5914.556408269397, 5948.405159484104, 5960.254968128984, 6048.334683184846, 5523.8066667666435, 6368.5860419072615, 6385.329540398191, 6433.613983161025, 6457.7094030767785, 5458.5087342139395, 6047.304559975659, 6223.973044447615, 6229.937700622936, 6260.812175634738, 4703.506131856174, 5084.3898732152375, 6023.397660234029, 6097.917917222642, 6202.782902598477, 5595.440455954454, 5921.0, 6255.843603909939, 6270.122182894398, 6296.181496405438, 6128.411459112287, 6197.81406557804, 6231.261890295519, 6254.718537665816, 6315.905261421082, 5000.299958005882, 5000.799968001239, 5013.774380152902, 5052.317937078521, 5102.08162530748, 4479.574440428154, 4510.548945105529, 4512.706674066241, 4525.773711314421, 4555.589996900295, 5789.565782566325, 6041.486473649789, 6043.0, 6046.032634778414, 6053.334133245339, 6173.043178307369, 6178.907316390258, 6212.968935155386, 6269.68651567429, 6270.874582508324, 6018.8194354169445, 6024.969875150597, 6033.306169790442, 6040.184575082308, 6078.878422431527, 5520.1167813149705, 5526.530244929146, 5530.751116199781, 5533.889322213533, 5543.556515478752, 6179.918514259896, 6291.150694656163, 6308.14839996613, 6471.773487927994, 6501.902471463027, 6177.104319873503, 6184.474319682878, 6247.250329960434, 6255.0, 6259.937400626118, 6424.775132870327, 6440.25937017249, 6444.097826304415, 6456.838579035561, 6470.320616335217, 6111.53096535531, 6164.4143806338325, 6185.536084793568, 6226.097215903759, 6255.185166675105, 6193.597416167935, 6220.937790622217, 6226.25284965807, 6274.749010039547, 6277.183966084563, 6151.876962460815, 6156.415140561639, 6162.198914141133, 6168.19813424252, 6171.413715697002, 5977.402259773988, 6087.299960504599, 6152.0, 6159.168512250789, 6166.753329866755, 5255.975084858416, 5466.644668096561, 5883.558733094949, 5964.701764911824, 6017.789377371771, 6125.54069408161, 6136.20229370179, 6169.96915015422, 6231.4391704746795, 6233.937660623335, 5955.910661339996, 5983.850403739767, 5996.820095397145, 6093.695315234309, 6097.146399504161], "value": 5733.251254555853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.3578243655481, 504.79051193754594, 534.8235082422801, 535.419070308715, 549.9962568312831, 31329.68670313296, 39744.60255397445, 39790.40314395279, 39863.800680996625, 39895.601043989554, 40630.18739625213, 41106.0, 41198.79400603, 41208.17583648333, 41315.58684413155, 9138.994710581846, 9344.345895787297, 10734.838977415346, 11043.72390690235, 11062.1703372247, 10832.025117739402, 10925.399103049329, 10926.672199834018, 10948.781024379547, 10975.945120274388, 10943.179261555415, 11000.669979900576, 11007.339559626407, 11024.118070554336, 11031.83452248213, 10949.562017519289, 10980.341179529254, 11006.339619622848, 11011.944940275247, 11025.889741102566, 9671.516424178762, 10849.891501085045, 11002.394868282321, 11104.056155226815, 11104.61133860311, 36013.81993090018, 36279.81860090709, 36333.454998175046, 36345.45481817775, 36355.09112272188, 3866.2267546490534, 3923.9607603923882, 3936.114374265796, 3936.6063393660693, 3949.4273330366937, 27685.623816317355, 28272.151835444765, 28455.715442845514, 28468.430631387462, 28739.0, 3115.8286294253808, 3150.2439414540345, 3237.223066464055, 3298.175456135966, 3308.0902751743224, 470491.0, 473477.63261183817, 475405.2459475396, 475495.0, 475806.0, 53510.464895351324, 53665.1950220747, 53975.92048159015, 54112.729436352565, 54126.58734126635, 56942.7152864233, 57176.42823571711, 57510.7124464375, 57513.0, 57657.42342576604, 13570.982176336815, 14729.55811325662, 14901.776473352907, 15223.31495082724, 15225.695486090217, 10577.0, 11566.190366674253, 11768.764624707457, 11812.70468238301, 11836.349000805038, 17060.57348566271, 17067.0, 17198.65602687939, 17220.0, 17296.567585810455, 7784.532928024337, 7785.727499537489, 7802.453828231969, 7859.921400786034, 7860.371170306476, 821.2895845093951, 824.8122703307218, 883.571467838098, 905.9728208153766, 913.5751875377981, 30207.69792302093, 30314.393712125635, 30393.392132157234, 30903.690963090532, 30920.536191957137, 942.8255772682076, 1039.443897514826, 1060.565168281001, 1093.1855767453299, 1096.6216655253925, 15156.848431515764, 15717.0, 15718.842811571967, 15762.211889405713, 15944.0, 571775.0, 601461.0, 606655.0, 607072.0, 607640.0, 58954.0, 59423.70288148532, 59642.508937276914, 59792.0, 59934.40065599288, 1360.6462319796924, 1432.4485073246667, 1443.884489240858, 1446.6889618732234, 1449.8332691740584, 25790.871045644653, 29612.0, 29631.0, 29724.851375742983, 30412.84793576018, 49693.25460118029, 50058.749706251234, 50086.749566251936, 50100.0, 50363.74818125886, 539153.0, 541030.0, 541064.0, 541395.0, 542448.0, 24247.0, 24543.263702088967, 24910.626340604544, 25564.0, 25866.0, 27711.44577108406, 32415.35169296648, 40273.0, 40325.0, 41389.0, 28886.133415997552, 34405.0, 35574.46638300376, 35680.10799730028, 36555.0, 35324.646753532135, 35358.646413535535, 36100.63899361078, 36189.27621447609, 36397.63602364049, 34493.82753086218, 35041.824790875886, 35524.46713299251, 35601.82199088988, 35638.8218058908, 24070.759292406852, 30250.638721257157, 30263.394732104793, 30902.690973089982, 31789.20526986844, 23672.408189794704, 23820.658093268434, 24026.918788654202, 24218.878905606063, 24356.02575897015], "value": 19441.6942809377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.56912919931483, 384.96342847429486, 390.37150188197, 398.0645483114679, 411.0545744786989, 19508.707369389453, 20966.37100886976, 21091.668790827614, 21238.57522849542, 21444.785552144473, 20788.480287992807, 20963.6855447168, 21298.46753831151, 21433.821139837302, 21661.891690541524, 5753.223314852483, 5857.531397488191, 5995.700214989255, 6078.361772013941, 6109.602875813081, 3898.142408670088, 4218.578142185772, 6062.0, 6112.449879510843, 6118.4799292060225, 6030.63816171029, 6095.756169753205, 6104.816855494342, 6114.021756518958, 6128.662923539204, 5895.027320492135, 6028.3971602839365, 6077.7568897244055, 6085.665288409135, 6108.320211941707, 5878.706064696791, 5909.556783241274, 5943.078822782476, 5945.0, 5951.732172052268, 18745.437636870778, 19894.502637434034, 24931.626025609632, 25418.745812541823, 25666.23001309945, 2645.1667724666668, 2842.445723083979, 3000.6699263081046, 3032.7877048606606, 3090.2583379988864, 8022.67909283628, 9430.151286384189, 9784.168345690625, 10144.94927525365, 10208.540615672238, 1782.9643407131914, 1831.9633607327778, 1848.7504186934725, 1866.6919958207015, 1877.9154938027684, 102694.45958310556, 119178.23287068507, 124122.0, 125151.37424312912, 125488.0, 11432.828507572392, 11491.0, 11796.351200683874, 11881.762364752656, 11989.0, 15628.0, 15659.451919183002, 15703.0, 15716.68566628684, 15741.763873541906, 8513.702020429255, 8617.655293788179, 8781.429207101519, 8899.73300800977, 8917.152870477294, 6698.698558564876, 7628.580428076398, 7800.141984381714, 8490.702825401082, 8507.82984340322, 4258.552851950501, 4501.347304640874, 4699.271612900006, 4764.95235047652, 4846.588040016568, 1771.9822801772075, 1786.9821301786815, 1836.861146089433, 1849.1493912799995, 1945.2121890634032, 791.7545560876032, 1037.0510982451124, 1048.4390850894736, 1067.6049861551276, 1110.0453609895483, 20005.499862503555, 21239.78760212409, 21334.893325533274, 21343.78656213449, 21348.466288342606, 878.8549889268199, 993.8807343118727, 1041.234692501011, 1056.7569459024467, 1103.3435106111851, 9808.46053467052, 9930.702078937644, 10792.730181745363, 11068.612598559012, 11221.66335009951, 721396.0, 723985.0, 730317.382763813, 731336.0, 742402.0, 94514.10971780526, 105418.0, 136989.0, 146188.53811461962, 150295.2485237567, 861.6036623153294, 950.6815216902415, 976.8534719792088, 1021.6322124035341, 1024.666983230453, 16311.184440777677, 16315.286894876343, 18491.16789744438, 18602.53493662615, 18790.53023674419, 55556.72221639028, 57307.0, 57862.4213757857, 57992.0, 58138.4186158133, 65632.68734625376, 83542.0, 84189.0, 84537.57731211305, 84826.0, 8141.3893957952205, 8248.216419440143, 8298.875516867372, 8331.583420829056, 8464.238218560358, 9253.444793312423, 12317.815232771336, 12873.163244389085, 13356.866431335951, 13378.264195469343, 10490.0, 10716.196285278791, 11007.559697612327, 11096.88903110991, 11455.484503197209, 10658.307210031633, 10778.461076946278, 10846.620368287073, 11052.889471105507, 11271.436428178722, 11216.83174752363, 11299.209055366046, 11319.603813866475, 11474.541018359172, 11493.94253028763, 8286.70996515119, 8436.088876483997, 8466.0, 8485.278751306209, 8617.267532259577, 7239.565626062453, 9663.226941844776, 11167.664970050912, 11314.547418103184, 11409.486573104065], "value": 9713.683156274505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.8239046533486, 1269.0355329949236, 1288.8453385593727, 1441.1425202004802, 1471.087925486198, 7522.172561018284, 7727.536347819135, 8091.474054186474, 8538.0, 8555.871661925075, 6547.247066587344, 6936.6878490467925, 8213.83572328553, 8312.251897329239, 8312.792180195498, 2078.511549785799, 2179.8365122615787, 2311.5839148953182, 2346.4251258441705, 2350.9655751469386, 2090.3937858021154, 2153.9030743616495, 2289.461976435536, 2318.1422873536817, 2362.7400985891536, 2258.6499092640584, 2327.7788610082016, 2327.8836058197107, 2338.3101984914406, 2343.4258606641397, 2108.8822923850385, 2255.064148378421, 2263.0, 2270.6026445372077, 2297.7357603875603, 2177.5644871025856, 2317.4322291038634, 2323.384303159664, 2344.4724936889065, 2349.2717257650183, 7342.77971660851, 8399.034111077242, 8443.240108390275, 8522.616482258314, 8553.48679079251, 5097.515736005073, 5181.0674078665825, 5229.450907654679, 5232.450592687751, 5245.737713114368, 2773.4037182005763, 2998.865051072707, 3431.7769344992494, 3522.0314413536225, 3559.5906470755676, 1189.6550000499844, 1197.0662882951312, 1225.8835410635975, 1229.3914512316371, 1239.5227837282712, 10729.248952573324, 10774.461276936201, 10871.619493317696, 10882.61910833117, 10916.235863489559, 4252.617264446215, 4446.644268458515, 4516.8193272268745, 4532.184206842734, 4553.681242313072, 8603.483790972561, 8752.737417877473, 8755.124487551195, 8766.167214114648, 8769.12308769118, 5126.92309615356, 5144.459831717616, 5152.046871328816, 5155.9742201288755, 5166.121759300928, 3951.6048395160255, 4674.088552732184, 4745.810167593327, 4757.119932812371, 4822.059698358857, 3608.5128507651657, 3629.219717760694, 3680.2639472105684, 3698.3712768829364, 3718.2935242304416, 1053.2042866911897, 1073.727632755172, 1089.9400532970762, 1110.8833572474934, 1116.7598966222301, 767.9270469305519, 878.1701292278863, 901.2069378946616, 916.9862452063225, 930.7580029192324, 5637.0, 5728.140778883201, 5745.109508026263, 5766.509846662997, 6007.459328660354, 971.0871780526282, 975.3075316525346, 979.7354714227118, 992.3103443107116, 1030.4229631406436, 3735.1595890924323, 3850.6919446444776, 3868.6518213360932, 3899.337112690849, 3907.199024200032, 9437.339386242897, 9773.41359518431, 9786.804263914682, 9801.0, 9885.703428897144, 9844.50777461124, 9845.360051596766, 9846.359986600848, 9907.356021858555, 10005.0, 7704.191059938737, 7821.7262395817015, 7925.841483170304, 7926.841463170705, 7945.0, 5438.0, 5523.254360661259, 5544.0575102231915, 5554.833354999357, 5569.888602228014, 7083.327083927019, 8914.242289405214, 9115.270778337584, 9150.176484116462, 9188.632454701738, 9194.0, 9239.815203696024, 9326.0, 9337.486438245962, 9428.528573571431, 7207.603581802841, 7335.633218338955, 7354.301341372561, 7366.521176123535, 7373.446991475554, 6673.499487538357, 6806.965965170142, 7709.498882572615, 7810.336121429742, 7845.6077196141105, 5782.2483077199695, 6989.895151572832, 7068.399186069036, 7203.8919416207755, 7272.818179545342, 6899.6205208714, 7042.542234754725, 7062.682179302046, 7123.928760712327, 7181.066461360198, 6334.936650633619, 6391.552591318563, 6455.289918108911, 6466.612003279818, 6489.123968264224, 4903.33804936329, 4956.653034287565, 5018.04657115147, 5030.5975521957425, 5137.460566640449, 4215.641670458045, 4542.750148741851, 4782.426108866958, 4976.278439626161, 5074.908894587681], "value": 4340.03439342965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5138541557476, 294.6979346170174, 342.5170509581489, 357.9606243313237, 359.57966034165054, 4967.801287948478, 5183.714895680736, 5380.167187671655, 5538.335399752031, 5551.111822108458, 4708.387909571751, 4725.858224253269, 5079.831638723096, 5257.50161204056, 5486.780528778844, 3542.919409580077, 3945.4279129526203, 4210.578942105795, 4274.422952901357, 4322.610965013148, 3601.603823579404, 3776.3957766757326, 4187.937180942288, 4296.656267498593, 4320.567943205686, 3361.5798025246845, 3601.4957905893198, 3755.680767134797, 3895.6883449324127, 4268.40242366069, 3599.8560057597665, 3692.593814680383, 4152.750834949913, 4224.746515209097, 4239.936400954003, 3504.211552400715, 3652.2695460907657, 3769.981150094259, 3807.990882416162, 3825.713071519647, 5003.949960500385, 5023.447420783711, 5333.706646134461, 5380.461953804627, 5413.998410294108, 4910.926336104962, 4940.25896115582, 4957.851264462072, 4962.49394056003, 4992.775325110342, 5835.854103647443, 5857.414258574151, 5860.706964651793, 5875.6474611523445, 5887.941120588782, 3330.8501117449773, 3521.8767343142868, 4170.97811036298, 4185.953511622094, 4189.539150693421, 5559.360673522516, 5706.201131841504, 5718.313802343745, 5843.2403787507355, 6144.927536231884, 3612.3497770401054, 4222.493300803923, 4226.725262857904, 4250.829966801355, 4255.97872010638, 3921.235359105004, 4087.7751723655483, 4183.769892655933, 4313.84901528445, 4320.092780516064, 4231.767252801125, 4499.010217752089, 4759.928601070987, 4925.21196608541, 4961.8511444656, 4988.975055124701, 5557.694326812064, 5882.794102206402, 5898.675572843449, 5900.232969713996, 1177.43483128099, 1231.7043909461843, 1284.6724085358173, 1421.422221334318, 1427.2649585463494, 882.5190271302156, 899.7300809757047, 921.8294615496154, 951.2912879904516, 990.6235630460523, 4843.8304659337455, 4986.501349864984, 5151.639385242997, 5198.570393141917, 5234.979179060047, 4922.8769280768265, 5417.39521406801, 5495.6153069285565, 5501.084425254541, 5723.338647528919, 4550.47117751933, 4588.2888152336445, 5213.139831927765, 5215.322008138917, 5223.608229382811, 2500.5499010177978, 2566.8459892406518, 2700.7434293742062, 2897.7392034716554, 2979.493486107367, 4975.402951645826, 5933.110033495011, 5956.463918247378, 5975.671338076448, 6015.39846015395, 5195.844124676266, 5416.47724150331, 5831.675944711558, 5878.177764892896, 5926.362768567946, 4991.07665081961, 5705.828825135252, 5925.526227698147, 5968.641881487125, 5995.880082398327, 4981.576565991932, 5351.892962140813, 5365.382980957083, 5732.914006289992, 5738.8278351649515, 4803.927941080817, 5108.386993560796, 5597.9491177307655, 5642.774289028393, 5694.4590263924865, 4927.827526036572, 5962.344142144274, 5987.371326010706, 6014.8195554133445, 6025.457708806053, 3620.3483372993114, 3631.600523942417, 3885.4366116912324, 4061.7766022869027, 4096.91806163881, 5660.29246344207, 5679.5172410345585, 5685.459881311269, 5699.373068962328, 5724.0, 5300.3639563252655, 5620.437956204347, 5763.279590051244, 5800.418813628064, 5813.738381772746, 5777.3933736957015, 5788.392218816964, 5799.217105690678, 5806.622569532967, 5836.883262334814, 4603.987122832971, 4713.3401323814005, 4748.406449193851, 5285.9471405286995, 5698.458646428583, 5782.653040817564, 5790.334111577223, 5796.565257605612, 5811.820567287267, 5819.79630712923, 5425.620206585501, 5635.8591035224445, 5678.4605462480995, 5679.097502336598, 5698.153746221367], "value": 4169.386960431637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.2115917238909, 696.6412297666706, 751.2374939436473, 790.6679194738209, 822.4571782623468, 14794.260286985662, 15181.468648597302, 15595.220238988048, 15683.059016459021, 15879.444219452322, 14522.346494407751, 14635.780463293058, 14794.482193123244, 14852.925735371307, 15692.450764223255, 842.376641285449, 865.1348651348651, 869.4609342207808, 872.5462759365126, 874.4447275979735, 841.9242268195861, 864.576357584782, 877.8814859993915, 884.9690260840872, 886.5877367024333, 892.9151730585584, 913.1416468519603, 913.7304495173939, 913.9261367892733, 914.5153068873508, 902.5487256371814, 909.1454033208829, 909.7725568607848, 909.822584596004, 912.3567884641312, 658.5258613798057, 680.2789043613785, 680.357062575866, 681.4071757570896, 681.4548361310981, 15046.699066018618, 15264.0, 15467.690646187013, 15542.9222853885, 15624.062556246661, 13958.371873265727, 14212.50256241037, 14328.856711432856, 14338.713225735426, 14360.210188439632, 11830.408479575986, 11867.821982670266, 11868.228565143238, 11894.583689570823, 11948.402579871059, 3089.3049063960652, 3209.3741720364537, 3689.096171438015, 3749.3438648236724, 3819.102510909934, 96961.0, 98628.0, 106390.0, 109765.45117274362, 110958.89041109566, 10813.83779243312, 10917.687513432149, 10971.053458570423, 11104.278221915549, 11398.316101033965, 17763.644727105642, 21731.348059558237, 21950.121995120015, 21977.34067977963, 22044.669329960063, 7709.0, 7909.7231596893835, 7917.2874441300555, 7974.202579741979, 8047.195280471906, 4094.1811637672586, 4149.8340066397, 4193.22425351311, 4200.3699445082875, 4205.17998990194, 3536.4341705327024, 3548.556430446194, 3568.2149927016017, 3591.712662987007, 3615.2227271136308, 659.9340065993458, 660.6168422315046, 663.4095654867172, 670.7954074007474, 678.5792808458788, 658.6838317607575, 667.6561570791047, 675.7128220506265, 682.3176823176823, 711.8540699156661, 8567.88617479736, 9171.58727857248, 9896.950515247378, 10491.213159013105, 10637.62768303121, 686.2691233835949, 700.6776882633943, 705.336983235767, 706.3148745716646, 720.5669253826093, 4995.493499185863, 5022.1771386519, 5022.824201152942, 5061.215511595708, 5108.923366149511, 79024.60487697525, 101231.98768012373, 102751.0, 107440.0, 109209.0, 68969.65515172391, 77991.61004194943, 88315.55842220748, 88555.0, 88574.55712721395, 66461.33538664647, 75756.24243757493, 81723.18276817155, 82864.0, 83171.0, 9847.310688251753, 9858.556364963737, 9859.950700246452, 9869.358491698016, 9882.160016398686, 50323.24515132203, 50479.990400192524, 51604.96790064253, 51957.42702454204, 52660.21009684935, 64279.0, 66087.0, 67205.66397167982, 68975.65512172406, 69129.0, 11672.0, 11837.348945807718, 12413.31726755001, 13397.531086412318, 13459.394327255493, 14915.116618725218, 15013.474528391891, 15080.85802817179, 15186.772198417253, 15302.540923772305, 13553.235617405664, 13710.794338084737, 13856.445742170603, 14026.579202623938, 14863.554093377215, 11156.44217789091, 14011.337845809263, 14068.226247556073, 14161.362738676578, 14583.489577864724, 11269.0, 13262.53581124656, 13563.660908477366, 13572.796408054084, 13825.86174138286, 8860.778480538038, 10951.34291942486, 11203.85773130563, 11320.886791131983, 11365.374904380338, 8343.707970221256, 9201.76995575116, 11082.422840736952, 11229.831552526883, 11268.323900565993], "value": 7515.138870451294, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 127.0, 173.0, 161.0, 118.0, 116.0, 116.0, 117.0, 117.0, 119.0], "value": 127.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 121.0, 167.0, 120.0, 100.0, 114.0, 145.0, 167.0, 129.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 235.0, 195.0, 199.0, 203.0, 199.0, 227.0, 220.0, 191.0, 192.0], "value": 206.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 61.0, 85.0, 61.0, 62.0, 61.0, 60.0, 73.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 83.0, 71.0, 71.0, 70.0, 80.0, 70.0, 72.0, 86.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 105.0, 138.0, 80.0, 137.0, 134.0, 90.0, 86.0, 98.0, 86.0], "value": 104.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 176.0, 101.0, 99.0, 100.0, 99.0, 99.0, 134.0, 99.0], "value": 125.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 76.0, 148.0, 146.0, 92.0, 101.0, 108.0, 98.0, 145.0], "value": 110.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 71.0, 71.0, 51.0, 84.0, 95.0, 99.0, 97.0, 67.0], "value": 75.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 97.0, 112.0, 113.0, 82.0, 71.0, 72.0, 72.0, 71.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 91.0, 82.0, 110.0, 113.0, 110.0, 90.0, 89.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 142.0, 162.0, 153.0, 132.0, 144.0, 141.0, 207.0, 186.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 174.0, 176.0, 175.0, 173.0, 177.0, 178.0, 174.0, 173.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 69.0, 85.0, 66.0, 62.0, 59.0, 83.0, 89.0], "value": 71.7, "unit": "score"}]}]} 04:53:54 INFO - Return code: 0 04:53:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:53:54 ERROR - # TBPL SUCCESS # 04:53:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:54 INFO - 2017-01-16 04:53:54.436 screenresolution[1659:10564] starting screenresolution argv=screenresolution get 04:53:54 INFO - 2017-01-16 04:53:54.438 screenresolution[1659:10564] Display 0: 1600x1200x32@60 04:53:54 INFO - 2017-01-16 04:53:54.445 screenresolution[1660:10567] starting screenresolution argv=screenresolution list 04:53:54 INFO - Available Modes on Display 0 04:53:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:54 INFO - Intel Iris: 04:53:54 INFO - Chipset Model: Intel Iris 04:53:54 INFO - Type: GPU 04:53:54 INFO - Bus: Built-In 04:53:54 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:54 INFO - Vendor: Intel (0x8086) 04:53:54 INFO - Device ID: 0x0a2e 04:53:54 INFO - Revision ID: 0x0009 04:53:54 INFO - Displays: 04:53:54 INFO - Display: 04:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:54 INFO - Display Serial Number: 1600x1200 60 04:53:54 INFO - Main Display: Yes 04:53:54 INFO - Mirror: Off 04:53:54 INFO - Online: Yes 04:53:54 INFO - Rotation: Supported 04:53:54 INFO - Return code: 0 04:53:54 INFO - Running post-action listener: _resource_record_post_action 04:53:54 INFO - [mozharness: 2017-01-16 12:53:54.687566Z] Finished run-tests step (success) 04:53:54 INFO - Running post-run listener: _resource_record_post_run 04:53:54 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 33685504; Write bytes: 555554816; Read time: 206; Write time: 1712 04:53:54 INFO - TinderboxPrint: CPU usage
54.5% 04:53:54 INFO - TinderboxPrint: I/O read bytes / time
33,685,504 / 206 04:53:54 INFO - TinderboxPrint: I/O write bytes / time
555,554,816 / 1,712 04:53:54 INFO - TinderboxPrint: CPU idle
2,186.7 (45.5%) 04:53:54 INFO - TinderboxPrint: CPU system
967.6 (20.2%) 04:53:54 INFO - TinderboxPrint: CPU user
1,647.4 (34.3%) 04:53:54 INFO - TinderboxPrint: Swap in / out
281,137,152 / 0 04:53:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249690624; Write bytes: 241991680; Read time: 18314; Write time: 528 04:53:54 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31567872; Write bytes: 300872704; Read time: 186; Write time: 1146 04:53:55 INFO - Running post-run listener: _upload_blobber_files 04:53:55 INFO - Blob upload gear active. 04:53:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:55 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 04:53:55 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:53:55 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:56 INFO - (blobuploader) - INFO - Done attempting. 04:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:57 INFO - (blobuploader) - INFO - Done attempting. 04:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:58 INFO - (blobuploader) - INFO - Done attempting. 04:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:00 INFO - (blobuploader) - INFO - Done attempting. 04:54:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:00 INFO - Return code: 0 04:54:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42ba46acbdfe67ae11df32d8834ec229c66420762a534ccf345e65d3bc0340ef2ec6ecd6ff5cedeb4f5a2cdfde5409a6f47043f127a382527809d62bb0d2711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270e475dbc899739eb2e0d3a6c690895d14f6c7cf98d8acdd6cdf855f5e563dfe10432d2d8e428296134d26d94fc5300dc70cc0621e9ba852d2d211532ae8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef8adba4b23e2bb71baa265bbaa337bfdf090f103dccd4e4ef4f27e953527e2a65d26d3f80084bf41ec5a26280c3ef8e52a5293dde1fc2afc59360b1d7145c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2600fcfdda32e7b9dd89378a6c0a9ecb3dbce403ddf476d327fddf3221c98268d6d7029bc8a668c2fbfdd5f6191aa7cbf2402c710d3586cdda73ff5f5be1e2a"} 04:54:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:00 INFO - Contents: 04:54:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42ba46acbdfe67ae11df32d8834ec229c66420762a534ccf345e65d3bc0340ef2ec6ecd6ff5cedeb4f5a2cdfde5409a6f47043f127a382527809d62bb0d2711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270e475dbc899739eb2e0d3a6c690895d14f6c7cf98d8acdd6cdf855f5e563dfe10432d2d8e428296134d26d94fc5300dc70cc0621e9ba852d2d211532ae8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef8adba4b23e2bb71baa265bbaa337bfdf090f103dccd4e4ef4f27e953527e2a65d26d3f80084bf41ec5a26280c3ef8e52a5293dde1fc2afc59360b1d7145c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2600fcfdda32e7b9dd89378a6c0a9ecb3dbce403ddf476d327fddf3221c98268d6d7029bc8a668c2fbfdd5f6191aa7cbf2402c710d3586cdda73ff5f5be1e2a"} 04:54:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:00 INFO - Copying logs to upload dir... 04:54:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.817804 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-16 04:54:00.919133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 04:54:00.923065) ========= 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.yEC0ia47YV/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.dXSl86IcPZ/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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/Firefox/sha512/d42ba46acbdfe67ae11df32d8834ec229c66420762a534ccf345e65d3bc0340ef2ec6ecd6ff5cedeb4f5a2cdfde5409a6f47043f127a382527809d62bb0d2711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270e475dbc899739eb2e0d3a6c690895d14f6c7cf98d8acdd6cdf855f5e563dfe10432d2d8e428296134d26d94fc5300dc70cc0621e9ba852d2d211532ae8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef8adba4b23e2bb71baa265bbaa337bfdf090f103dccd4e4ef4f27e953527e2a65d26d3f80084bf41ec5a26280c3ef8e52a5293dde1fc2afc59360b1d7145c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2600fcfdda32e7b9dd89378a6c0a9ecb3dbce403ddf476d327fddf3221c98268d6d7029bc8a668c2fbfdd5f6191aa7cbf2402c710d3586cdda73ff5f5be1e2a"} build_url:https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010930 build_url: 'https://queue.taskcluster.net/v1/task/bO8kg_S2Q5WS2oDtliAgBA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42ba46acbdfe67ae11df32d8834ec229c66420762a534ccf345e65d3bc0340ef2ec6ecd6ff5cedeb4f5a2cdfde5409a6f47043f127a382527809d62bb0d2711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270e475dbc899739eb2e0d3a6c690895d14f6c7cf98d8acdd6cdf855f5e563dfe10432d2d8e428296134d26d94fc5300dc70cc0621e9ba852d2d211532ae8c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef8adba4b23e2bb71baa265bbaa337bfdf090f103dccd4e4ef4f27e953527e2a65d26d3f80084bf41ec5a26280c3ef8e52a5293dde1fc2afc59360b1d7145c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2600fcfdda32e7b9dd89378a6c0a9ecb3dbce403ddf476d327fddf3221c98268d6d7029bc8a668c2fbfdd5f6191aa7cbf2402c710d3586cdda73ff5f5be1e2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 04:54:00.957493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 04:54:00.957826) ========= 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.yEC0ia47YV/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.dXSl86IcPZ/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.005004 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 04:54:01.006436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 04:54:01.006755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 04:54:01.007064) ========= ========= Total master_lag: 0.33 =========