builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0315 starttime: 1486762473.55 results: success (0) buildid: 20170210122019 builduid: 835de1cc733a43b2a152cba2bc5a1ab3 revision: e26d8e25df97df3471cab4a48e0c0bfe4843dc2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.553969) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.554547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.554870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.581985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.582418) ========= 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.2DoigI45lw/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.Wk7A0o5amG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-10 13:34:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.3M=0.001s 2017-02-10 13:34:33 (17.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.762124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.762499) ========= 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.2DoigI45lw/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.Wk7A0o5amG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.025688 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:33.811656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 13:34:33.812065) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e26d8e25df97df3471cab4a48e0c0bfe4843dc2a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e26d8e25df97df3471cab4a48e0c0bfe4843dc2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2DoigI45lw/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.Wk7A0o5amG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-10 13:34:33,934 truncating revision to first 12 chars 2017-02-10 13:34:33,935 Setting DEBUG logging. 2017-02-10 13:34:33,935 attempt 1/10 2017-02-10 13:34:33,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e26d8e25df97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 13:34:35,577 unpacking tar archive at: mozilla-aurora-e26d8e25df97/testing/mozharness/ program finished with exit code 0 elapsedTime=1.918497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 13:34:35.754801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:35.755180) ========= script_repo_revision: e26d8e25df97df3471cab4a48e0c0bfe4843dc2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:35.755667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:35.755976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 13:34:35.775943) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-10 13:34:35.776304) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2DoigI45lw/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.Wk7A0o5amG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:34:35 INFO - MultiFileLogger online at 20170210 13:34:35 in /builds/slave/test 13:34:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:34:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:34:35 INFO - {'append_to_log': False, 13:34:35 INFO - 'base_work_dir': '/builds/slave/test', 13:34:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:34:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:34:35 INFO - 'branch': 'Mozilla-Aurora', 13:34:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:34:35 INFO - 'config_files': ('talos/mac_config.py',), 13:34:35 INFO - 'default_actions': ('clobber', 13:34:35 INFO - 'read-buildbot-config', 13:34:35 INFO - 'download-and-extract', 13:34:35 INFO - 'populate-webroot', 13:34:35 INFO - 'create-virtualenv', 13:34:35 INFO - 'install', 13:34:35 INFO - 'run-tests'), 13:34:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:34:35 INFO - 'download_minidump_stackwalk': True, 13:34:35 INFO - 'download_symbols': 'ondemand', 13:34:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:34:35 INFO - 'tooltool.py': '/tools/tooltool.py', 13:34:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:34:35 INFO - '/tools/misc-python/virtualenv.py')}, 13:34:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:34:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:34:35 INFO - 'installer_path': 'installer.exe', 13:34:35 INFO - 'log_level': 'info', 13:34:35 INFO - 'log_name': 'talos', 13:34:35 INFO - 'log_to_console': True, 13:34:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:34:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:34:35 INFO - 'opt_config_files': (), 13:34:35 INFO - 'pip_index': False, 13:34:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:34:35 INFO - 'cmd': ('bash', 13:34:35 INFO - '-c', 13:34:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:34:35 INFO - 'enabled': True, 13:34:35 INFO - 'halt_on_failure': False, 13:34:35 INFO - 'name': 'check_screen_resolution'},), 13:34:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:34:35 INFO - 'cmd': ('bash', 13:34:35 INFO - '-c', 13:34:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:34:36 INFO - 'enabled': True, 13:34:36 INFO - 'halt_on_failure': False, 13:34:36 INFO - 'name': 'check_screen_resolution'},), 13:34:36 INFO - 'run_cmd_checks_enabled': True, 13:34:36 INFO - 'sps_profile': False, 13:34:36 INFO - 'sps_profile_interval': 0, 13:34:36 INFO - 'suite': 'dromaeojs-e10s', 13:34:36 INFO - 'system_bits': '32', 13:34:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:34:36 INFO - 'title': 't-yosemite-r7-0315', 13:34:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:34:36 INFO - 'use_talos_json': True, 13:34:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:34:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:34:36 INFO - 'work_dir': 'build'} 13:34:36 INFO - [mozharness: 2017-02-10 21:34:36.001759Z] Running clobber step. 13:34:36 INFO - Running pre-action listener: _resource_record_pre_action 13:34:36 INFO - Running main action method: clobber 13:34:36 INFO - rmtree: /builds/slave/test/build 13:34:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:34:38 INFO - Running post-action listener: _resource_record_post_action 13:34:38 INFO - [mozharness: 2017-02-10 21:34:38.388567Z] Finished clobber step (success) 13:34:38 INFO - [mozharness: 2017-02-10 21:34:38.388722Z] Running read-buildbot-config step. 13:34:38 INFO - Running pre-action listener: _resource_record_pre_action 13:34:38 INFO - Running main action method: read_buildbot_config 13:34:38 INFO - Using buildbot properties: 13:34:38 INFO - { 13:34:38 INFO - "project": "", 13:34:38 INFO - "product": "firefox", 13:34:38 INFO - "script_repo_revision": "production", 13:34:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:34:38 INFO - "repository": "", 13:34:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:34:38 INFO - "buildid": "20170210122019", 13:34:38 INFO - "pgo_build": "False", 13:34:38 INFO - "basedir": "/builds/slave/test", 13:34:38 INFO - "buildnumber": 83, 13:34:38 INFO - "slavename": "t-yosemite-r7-0315", 13:34:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:34:38 INFO - "platform": "yosemite_r7", 13:34:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:34:38 INFO - "branch": "mozilla-aurora", 13:34:38 INFO - "repo_path": "releases/mozilla-aurora", 13:34:38 INFO - "revision": "e26d8e25df97df3471cab4a48e0c0bfe4843dc2a", 13:34:38 INFO - "stage_platform": "macosx64", 13:34:38 INFO - "builduid": "835de1cc733a43b2a152cba2bc5a1ab3", 13:34:38 INFO - "slavebuilddir": "test" 13:34:38 INFO - } 13:34:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 13:34:38 INFO - Running post-action listener: _resource_record_post_action 13:34:38 INFO - [mozharness: 2017-02-10 21:34:38.392210Z] Finished read-buildbot-config step (success) 13:34:38 INFO - [mozharness: 2017-02-10 21:34:38.392348Z] Running download-and-extract step. 13:34:38 INFO - Running pre-action listener: _resource_record_pre_action 13:34:38 INFO - Running main action method: download_and_extract 13:34:38 INFO - mkdir: /builds/slave/test/build/tests 13:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:38 INFO - trying https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 13:34:38 INFO - Downloading https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 13:34:38 INFO - Downloaded 1199 bytes. 13:34:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:34:38 INFO - Using the following test package requirements: 13:34:38 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:34:38 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 13:34:38 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 13:34:38 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'jsshell-mac.zip'], 13:34:38 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 13:34:38 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:34:38 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 13:34:38 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 13:34:38 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 13:34:38 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:34:38 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 13:34:38 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:34:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:34:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:34:38 INFO - Fetch https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:34:40 INFO - Expected file size: 16358340 13:34:40 INFO - Obtained file size: 16358340 13:34:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:34:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:34:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:34:46 INFO - Fetch https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:34:47 INFO - Expected file size: 16358340 13:34:47 INFO - Obtained file size: 16358340 13:34:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 13:34:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:34:53 INFO - Fetch https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 13:34:55 INFO - Expected file size: 14403485 13:34:55 INFO - Obtained file size: 14403485 13:34:55 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')]} 13:34:55 INFO - trying https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 13:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 13:34:59 INFO - Downloaded 73854018 bytes. 13:34:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:34:59 INFO - mkdir: /builds/slave/test/properties 13:34:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:34:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:34:59 INFO - Contents: 13:34:59 INFO - build_url:https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:35:00 INFO - Running post-action listener: _resource_record_post_action 13:35:00 INFO - Running post-action listener: set_extra_try_arguments 13:35:00 INFO - [mozharness: 2017-02-10 21:35:00.405322Z] Finished download-and-extract step (success) 13:35:00 INFO - [mozharness: 2017-02-10 21:35:00.405425Z] Running populate-webroot step. 13:35:00 INFO - Running pre-action listener: _resource_record_pre_action 13:35:00 INFO - Running main action method: populate_webroot 13:35:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:35:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:35:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:35:00 INFO - '--tppagecycles', 13:35:00 INFO - '7'], 13:35:00 INFO - 'tests': ['tsvgm']}}, 13:35:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:35:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:35:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:35:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:35:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['damp', 'tps']}, 13:35:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'tests': ['damp', 'tps']}, 13:35:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['dromaeo_dom']}, 13:35:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:35:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['basic_compositor_video']}, 13:35:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:35:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['a11yr', 13:35:00 INFO - 'ts_paint', 13:35:00 INFO - 'tpaint', 13:35:00 INFO - 'sessionrestore', 13:35:00 INFO - 'sessionrestore_no_auto_restore', 13:35:00 INFO - 'tabpaint']}, 13:35:00 INFO - 'other-e10s': {'tests': ['a11yr', 13:35:00 INFO - 'ts_paint', 13:35:00 INFO - 'tpaint', 13:35:00 INFO - 'sessionrestore', 13:35:00 INFO - 'sessionrestore_no_auto_restore', 13:35:00 INFO - 'tabpaint']}, 13:35:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:35:00 INFO - 'ts_paint', 13:35:00 INFO - 'tpaint', 13:35:00 INFO - 'sessionrestore', 13:35:00 INFO - 'sessionrestore_no_auto_restore', 13:35:00 INFO - 'tabpaint']}, 13:35:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:35:00 INFO - 'ts_paint', 13:35:00 INFO - 'tpaint', 13:35:00 INFO - 'sessionrestore', 13:35:00 INFO - 'sessionrestore_no_auto_restore', 13:35:00 INFO - 'tabpaint']}, 13:35:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['a11yr', 13:35:00 INFO - 'ts_paint', 13:35:00 INFO - 'tpaint', 13:35:00 INFO - 'sessionrestore', 13:35:00 INFO - 'sessionrestore_no_auto_restore', 13:35:00 INFO - 'tabpaint']}, 13:35:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['a11yr', 13:35:00 INFO - 'ts_paint', 13:35:00 INFO - 'tpaint', 13:35:00 INFO - 'sessionrestore', 13:35:00 INFO - 'sessionrestore_no_auto_restore', 13:35:00 INFO - 'tabpaint']}, 13:35:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['tsvgx', 13:35:00 INFO - 'tsvgr_opacity', 13:35:00 INFO - 'tart', 13:35:00 INFO - 'tscrollx', 13:35:00 INFO - 'cart', 13:35:00 INFO - 'tsvg_static']}, 13:35:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:35:00 INFO - 'tsvgr_opacity', 13:35:00 INFO - 'tart', 13:35:00 INFO - 'tscrollx', 13:35:00 INFO - 'cart', 13:35:00 INFO - 'tsvg_static']}, 13:35:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'talos_options': ['--disable-e10s'], 13:35:00 INFO - 'tests': ['tp5o']}, 13:35:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:35:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'talos_options': ['--disable-e10s', 13:35:00 INFO - '--xperf_path', 13:35:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:00 INFO - 'tests': ['tp5n']}, 13:35:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:35:00 INFO - 'talos_options': ['--xperf_path', 13:35:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:00 INFO - 'tests': ['tp5n']}}, 13:35:00 INFO - 'talos.zip': {'path': '', 13:35:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:35:00 INFO - Running post-action listener: _resource_record_post_action 13:35:00 INFO - [mozharness: 2017-02-10 21:35:00.423170Z] Finished populate-webroot step (success) 13:35:00 INFO - [mozharness: 2017-02-10 21:35:00.423281Z] Running create-virtualenv step. 13:35:00 INFO - Running pre-action listener: _resource_record_pre_action 13:35:00 INFO - Running main action method: create_virtualenv 13:35:00 INFO - Creating virtualenv /builds/slave/test/build/venv 13:35:00 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 13:35:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:35:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:35:00 INFO - Using real prefix '/tools/python27' 13:35:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:35:01 INFO - Installing distribute.............................................................................................................................................................................................done. 13:35:04 INFO - Installing pip.................done. 13:35:04 INFO - Return code: 0 13:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:35:04 INFO - Reading from file tmpfile_stdout 13:35:04 INFO - Output received: 13:35:04 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) 13:35:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:35:04 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')]} 13:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:04 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')]} 13:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:04 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:04 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 13:35:04 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 13:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:04 INFO - 'HOME': '/Users/cltbld', 13:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:04 INFO - 'LOGNAME': 'cltbld', 13:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:04 INFO - 'MOZ_NO_REMOTE': '1', 13:35:04 INFO - 'NO_EM_RESTART': '1', 13:35:04 INFO - 'PAGER': '/bin/cat', 13:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:04 INFO - 'PWD': '/builds/slave/test', 13:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:04 INFO - 'SHELL': '/bin/bash', 13:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:04 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:04 INFO - 'USER': 'cltbld', 13:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:04 INFO - 'XPC_FLAGS': '0x0', 13:35:04 INFO - 'XPC_SERVICE_NAME': '0', 13:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:04 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 13:35:04 INFO - Cleaning up... 13:35:04 INFO - Return code: 0 13:35:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:35:04 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')]} 13:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:04 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')]} 13:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:04 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:04 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 13:35:04 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 13:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:04 INFO - 'HOME': '/Users/cltbld', 13:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:04 INFO - 'LOGNAME': 'cltbld', 13:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:04 INFO - 'MOZ_NO_REMOTE': '1', 13:35:04 INFO - 'NO_EM_RESTART': '1', 13:35:04 INFO - 'PAGER': '/bin/cat', 13:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:04 INFO - 'PWD': '/builds/slave/test', 13:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:04 INFO - 'SHELL': '/bin/bash', 13:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:04 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:04 INFO - 'USER': 'cltbld', 13:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:04 INFO - 'XPC_FLAGS': '0x0', 13:35:04 INFO - 'XPC_SERVICE_NAME': '0', 13:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:04 INFO - Downloading/unpacking psutil>=3.1.1 13:35:04 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 13:35:04 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 13:35:04 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 13:35:04 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 13:35:04 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 13:35:04 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 13:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:35:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:08 INFO - Installing collected packages: psutil 13:35:08 INFO - Running setup.py install for psutil 13:35:08 INFO - building 'psutil._psutil_osx' extension 13:35:08 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 13:35:09 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 13:35:09 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 13:35:09 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 13:35:09 INFO - building 'psutil._psutil_posix' extension 13:35:09 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 13:35:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:35:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:35:09 INFO - ^ 13:35:09 INFO - 1 warning generated. 13:35:09 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 13:35:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:09 INFO - Successfully installed psutil 13:35:09 INFO - Cleaning up... 13:35:09 INFO - Return code: 0 13:35:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:35:09 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')]} 13:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:09 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')]} 13:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:09 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:09 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 13:35:09 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 13:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:09 INFO - 'HOME': '/Users/cltbld', 13:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:09 INFO - 'LOGNAME': 'cltbld', 13:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:09 INFO - 'MOZ_NO_REMOTE': '1', 13:35:09 INFO - 'NO_EM_RESTART': '1', 13:35:09 INFO - 'PAGER': '/bin/cat', 13:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:09 INFO - 'PWD': '/builds/slave/test', 13:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:09 INFO - 'SHELL': '/bin/bash', 13:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:09 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:09 INFO - 'USER': 'cltbld', 13:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:09 INFO - 'XPC_FLAGS': '0x0', 13:35:09 INFO - 'XPC_SERVICE_NAME': '0', 13:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:35:09 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 13:35:09 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 13:35:09 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 13:35:09 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 13:35:09 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 13:35:09 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 13:35:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:35:12 INFO - Installing collected packages: mozsystemmonitor 13:35:12 INFO - Running setup.py install for mozsystemmonitor 13:35:12 INFO - Successfully installed mozsystemmonitor 13:35:12 INFO - Cleaning up... 13:35:12 INFO - Return code: 0 13:35:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:12 INFO - 'HOME': '/Users/cltbld', 13:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:12 INFO - 'LOGNAME': 'cltbld', 13:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:12 INFO - 'MOZ_NO_REMOTE': '1', 13:35:12 INFO - 'NO_EM_RESTART': '1', 13:35:12 INFO - 'PAGER': '/bin/cat', 13:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:12 INFO - 'PWD': '/builds/slave/test', 13:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:12 INFO - 'SHELL': '/bin/bash', 13:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:12 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:12 INFO - 'USER': 'cltbld', 13:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:12 INFO - 'XPC_FLAGS': '0x0', 13:35:12 INFO - 'XPC_SERVICE_NAME': '0', 13:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:13 INFO - Downloading/unpacking jsonschema==2.5.1 13:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:35:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:16 INFO - Downloading functools32-3.2.3-2.tar.gz 13:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:35:16 INFO - warning: no files found matching '*.txt' 13:35:16 INFO - no previously-included directories found matching 'build' 13:35:16 INFO - no previously-included directories found matching 'dist' 13:35:16 INFO - no previously-included directories found matching '.git*' 13:35:16 INFO - Installing collected packages: jsonschema, functools32 13:35:16 INFO - Running setup.py install for functools32 13:35:16 INFO - warning: no files found matching '*.txt' 13:35:16 INFO - no previously-included directories found matching 'build' 13:35:16 INFO - no previously-included directories found matching 'dist' 13:35:16 INFO - no previously-included directories found matching '.git*' 13:35:16 INFO - Successfully installed jsonschema functools32 13:35:16 INFO - Cleaning up... 13:35:16 INFO - Return code: 0 13:35:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:16 INFO - 'HOME': '/Users/cltbld', 13:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:16 INFO - 'LOGNAME': 'cltbld', 13:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:16 INFO - 'MOZ_NO_REMOTE': '1', 13:35:16 INFO - 'NO_EM_RESTART': '1', 13:35:16 INFO - 'PAGER': '/bin/cat', 13:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:16 INFO - 'PWD': '/builds/slave/test', 13:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:16 INFO - 'SHELL': '/bin/bash', 13:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:16 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:16 INFO - 'USER': 'cltbld', 13:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:16 INFO - 'XPC_FLAGS': '0x0', 13:35:16 INFO - 'XPC_SERVICE_NAME': '0', 13:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:35:16 INFO - Cleaning up... 13:35:16 INFO - Return code: 0 13:35:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:16 INFO - 'HOME': '/Users/cltbld', 13:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:16 INFO - 'LOGNAME': 'cltbld', 13:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:16 INFO - 'MOZ_NO_REMOTE': '1', 13:35:16 INFO - 'NO_EM_RESTART': '1', 13:35:16 INFO - 'PAGER': '/bin/cat', 13:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:16 INFO - 'PWD': '/builds/slave/test', 13:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:16 INFO - 'SHELL': '/bin/bash', 13:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:16 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:16 INFO - 'USER': 'cltbld', 13:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:16 INFO - 'XPC_FLAGS': '0x0', 13:35:16 INFO - 'XPC_SERVICE_NAME': '0', 13:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:16 INFO - Downloading/unpacking blobuploader==1.2.4 13:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:19 INFO - Downloading blobuploader-1.2.4.tar.gz 13:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:35:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:35:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:20 INFO - Downloading docopt-0.6.1.tar.gz 13:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:35:20 INFO - Installing collected packages: blobuploader, requests, docopt 13:35:20 INFO - Running setup.py install for blobuploader 13:35:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:35:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:35:21 INFO - Running setup.py install for requests 13:35:21 INFO - Running setup.py install for docopt 13:35:21 INFO - Successfully installed blobuploader requests docopt 13:35:21 INFO - Cleaning up... 13:35:21 INFO - Return code: 0 13:35:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:21 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')]} 13:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:21 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')]} 13:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:21 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:21 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 13:35:21 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 13:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:21 INFO - 'HOME': '/Users/cltbld', 13:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:21 INFO - 'LOGNAME': 'cltbld', 13:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:21 INFO - 'MOZ_NO_REMOTE': '1', 13:35:21 INFO - 'NO_EM_RESTART': '1', 13:35:21 INFO - 'PAGER': '/bin/cat', 13:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:21 INFO - 'PWD': '/builds/slave/test', 13:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:21 INFO - 'SHELL': '/bin/bash', 13:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:21 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:21 INFO - 'USER': 'cltbld', 13:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:21 INFO - 'XPC_FLAGS': '0x0', 13:35:21 INFO - 'XPC_SERVICE_NAME': '0', 13:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-YHEW7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-aMlmP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-wMjt0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Fq5opl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-SbpOzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-4_xkZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-YVEl09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-QnJJ6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:22 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-eMzbYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-_aj2qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-5bogxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-04qAi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-oxjd2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-mNUeAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-ArVYD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-MeXoIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:23 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-erTNf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:35:23 INFO - Running setup.py install for manifestparser 13:35:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:35:24 INFO - Running setup.py install for mozcrash 13:35:24 INFO - Running setup.py install for mozdebug 13:35:24 INFO - Running setup.py install for mozdevice 13:35:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:35:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:35:24 INFO - Running setup.py install for mozfile 13:35:24 INFO - Running setup.py install for mozhttpd 13:35:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:35:24 INFO - Running setup.py install for mozinfo 13:35:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:35:24 INFO - Running setup.py install for mozInstall 13:35:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Running setup.py install for mozleak 13:35:25 INFO - Running setup.py install for mozlog 13:35:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Running setup.py install for moznetwork 13:35:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Running setup.py install for mozprocess 13:35:25 INFO - Running setup.py install for mozprofile 13:35:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:35:25 INFO - Running setup.py install for mozrunner 13:35:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:35:26 INFO - Running setup.py install for mozscreenshot 13:35:26 INFO - Running setup.py install for moztest 13:35:26 INFO - Running setup.py install for mozversion 13:35:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:35:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:35:26 INFO - Cleaning up... 13:35:26 INFO - Return code: 0 13:35:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:26 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:26 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 13:35:26 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 13:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:26 INFO - 'HOME': '/Users/cltbld', 13:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:26 INFO - 'LOGNAME': 'cltbld', 13:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:26 INFO - 'MOZ_NO_REMOTE': '1', 13:35:26 INFO - 'NO_EM_RESTART': '1', 13:35:26 INFO - 'PAGER': '/bin/cat', 13:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:26 INFO - 'PWD': '/builds/slave/test', 13:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:26 INFO - 'SHELL': '/bin/bash', 13:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:26 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:26 INFO - 'USER': 'cltbld', 13:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:26 INFO - 'XPC_FLAGS': '0x0', 13:35:26 INFO - 'XPC_SERVICE_NAME': '0', 13:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:26 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-AOe2Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:26 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)) 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:26 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-b56Dku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:26 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)) 13:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:26 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-ieuwYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-QhubsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-1PkJ1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-j4m5SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-67d0Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-vISIEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-io2r87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-7b3j1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-qFA08_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-FqXeXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:27 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)) 13:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:27 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-0PUQPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:28 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)) 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:28 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-JpNy9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:28 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)) 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:28 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-NOMdgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:28 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)) 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:28 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-2JWmfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:28 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)) 13:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:28 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-A8wN10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:28 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)) 13:35:28 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)) 13:35:28 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)) 13:35:28 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)) 13:35:28 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)) 13:35:28 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)) 13:35:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:35:28 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 13:35:28 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 13:35:28 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 13:35:28 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 13:35:28 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 13:35:28 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 13:35:31 INFO - Downloading blessings-1.6.tar.gz 13:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:35:31 INFO - Installing collected packages: blessings 13:35:31 INFO - Running setup.py install for blessings 13:35:31 INFO - Successfully installed blessings 13:35:31 INFO - Cleaning up... 13:35:31 INFO - Return code: 0 13:35:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:32 INFO - Reading from file tmpfile_stdout 13:35:32 INFO - Current package versions: 13:35:32 INFO - blessings == 1.6 13:35:32 INFO - blobuploader == 1.2.4 13:35:32 INFO - docopt == 0.6.1 13:35:32 INFO - functools32 == 3.2.3-2 13:35:32 INFO - jsonschema == 2.5.1 13:35:32 INFO - manifestparser == 1.1 13:35:32 INFO - mozInstall == 1.12 13:35:32 INFO - mozcrash == 1.0 13:35:32 INFO - mozdebug == 0.1 13:35:32 INFO - mozdevice == 0.49 13:35:32 INFO - mozfile == 1.2 13:35:32 INFO - mozhttpd == 0.7 13:35:32 INFO - mozinfo == 0.9 13:35:32 INFO - mozleak == 0.1 13:35:32 INFO - mozlog == 3.4 13:35:32 INFO - moznetwork == 0.27 13:35:32 INFO - mozprocess == 0.24 13:35:32 INFO - mozprofile == 0.28 13:35:32 INFO - mozrunner == 6.13 13:35:32 INFO - mozscreenshot == 0.1 13:35:32 INFO - mozsystemmonitor == 0.3 13:35:32 INFO - moztest == 0.8 13:35:32 INFO - mozversion == 1.4 13:35:32 INFO - psutil == 3.1.1 13:35:32 INFO - requests == 1.2.3 13:35:32 INFO - wsgiref == 0.1.2 13:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:32 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')]} 13:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 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')]} 13:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:32 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 13:35:32 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 13:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:32 INFO - 'HOME': '/Users/cltbld', 13:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:32 INFO - 'LOGNAME': 'cltbld', 13:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:32 INFO - 'MOZ_NO_REMOTE': '1', 13:35:32 INFO - 'NO_EM_RESTART': '1', 13:35:32 INFO - 'PAGER': '/bin/cat', 13:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:32 INFO - 'PWD': '/builds/slave/test', 13:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:32 INFO - 'SHELL': '/bin/bash', 13:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:32 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:32 INFO - 'USER': 'cltbld', 13:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:32 INFO - 'XPC_FLAGS': '0x0', 13:35:32 INFO - 'XPC_SERVICE_NAME': '0', 13:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 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)) 13:35:32 INFO - Cleaning up... 13:35:32 INFO - Return code: 0 13:35:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:35:32 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')]} 13:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 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')]} 13:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 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 0x10ea6ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea6d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d2494d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, '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.2DoigI45lw/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.Wk7A0o5amG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 13:35:32 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 13:35:32 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 13:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:32 INFO - 'HOME': '/Users/cltbld', 13:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:32 INFO - 'LOGNAME': 'cltbld', 13:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:32 INFO - 'MOZ_NO_REMOTE': '1', 13:35:32 INFO - 'NO_EM_RESTART': '1', 13:35:32 INFO - 'PAGER': '/bin/cat', 13:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:32 INFO - 'PWD': '/builds/slave/test', 13:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:32 INFO - 'SHELL': '/bin/bash', 13:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:32 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:32 INFO - 'USER': 'cltbld', 13:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:32 INFO - 'XPC_FLAGS': '0x0', 13:35:32 INFO - 'XPC_SERVICE_NAME': '0', 13:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:35:32 INFO - Cleaning up... 13:35:33 INFO - Return code: 0 13:35:33 INFO - Running post-action listener: _resource_record_post_action 13:35:33 INFO - Running post-action listener: _start_resource_monitoring 13:35:33 INFO - Starting resource monitoring. 13:35:33 INFO - [mozharness: 2017-02-10 21:35:33.042629Z] Finished create-virtualenv step (success) 13:35:33 INFO - [mozharness: 2017-02-10 21:35:33.043469Z] Running install step. 13:35:33 INFO - Running pre-action listener: _resource_record_pre_action 13:35:33 INFO - Running main action method: install 13:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:33 INFO - Reading from file tmpfile_stdout 13:35:33 INFO - Detecting whether we're running mozinstall >=1.0... 13:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:35:33 INFO - Reading from file tmpfile_stdout 13:35:33 INFO - Output received: 13:35:33 INFO - Usage: mozinstall [options] installer 13:35:33 INFO - Options: 13:35:33 INFO - -h, --help show this help message and exit 13:35:33 INFO - -d DEST, --destination=DEST 13:35:33 INFO - Directory to install application into. [default: 13:35:33 INFO - "/builds/slave/test"] 13:35:33 INFO - --app=APP Application being installed. [default: firefox] 13:35:33 INFO - mkdir: /builds/slave/test/build/application 13:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:35:53 INFO - Reading from file tmpfile_stdout 13:35:53 INFO - Output received: 13:35:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:35:53 INFO - Running post-action listener: _resource_record_post_action 13:35:53 INFO - [mozharness: 2017-02-10 21:35:53.365025Z] Finished install step (success) 13:35:53 INFO - [mozharness: 2017-02-10 21:35:53.365207Z] Running run-tests step. 13:35:53 INFO - Running pre-action listener: _resource_record_pre_action 13:35:53 INFO - Running main action method: run_tests 13:35:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:35:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:35:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:35:53 INFO - 2017-02-10 13:35:53.379 screenresolution[1622:7334] starting screenresolution argv=screenresolution get 13:35:53 INFO - 2017-02-10 13:35:53.382 screenresolution[1622:7334] Display 0: 1600x1200x32@60 13:35:53 INFO - 2017-02-10 13:35:53.388 screenresolution[1623:7337] starting screenresolution argv=screenresolution list 13:35:53 INFO - Available Modes on Display 0 13:35:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:35:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:35:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:35:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:35:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:35:53 INFO - Intel Iris: 13:35:53 INFO - Chipset Model: Intel Iris 13:35:53 INFO - Type: GPU 13:35:53 INFO - Bus: Built-In 13:35:53 INFO - VRAM (Dynamic, Max): 1536 MB 13:35:53 INFO - Vendor: Intel (0x8086) 13:35:53 INFO - Device ID: 0x0a2e 13:35:53 INFO - Revision ID: 0x0009 13:35:53 INFO - Displays: 13:35:53 INFO - Display: 13:35:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:35:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:35:53 INFO - Display Serial Number: 1600x1200 60 13:35:53 INFO - Main Display: Yes 13:35:53 INFO - Mirror: Off 13:35:53 INFO - Online: Yes 13:35:53 INFO - Rotation: Supported 13:35:53 INFO - Return code: 0 13:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:35:53 INFO - Python 2.7.3 13:35:53 INFO - Return code: 0 13:35:53 INFO - grabbing minidump binary from tooltool 13:35: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')]} 13:35:53 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 0x10e848d30>, '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 0x10e76fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e83dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:35:53 INFO - Return code: 0 13:35:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:35:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:35:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:35:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:35:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 13:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0315 --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 13:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2DoigI45lw/Render', 13:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:53 INFO - 'HOME': '/Users/cltbld', 13:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:53 INFO - 'LOGNAME': 'cltbld', 13:35:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:35:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:53 INFO - 'MOZ_NO_REMOTE': '1', 13:35:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:35:53 INFO - 'NO_EM_RESTART': '1', 13:35:53 INFO - 'PAGER': '/bin/cat', 13:35:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:53 INFO - 'PWD': '/builds/slave/test', 13:35:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:53 INFO - 'SHELL': '/bin/bash', 13:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wk7A0o5amG/Listeners', 13:35:53 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 13:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:53 INFO - 'USER': 'cltbld', 13:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:53 INFO - 'XPC_FLAGS': '0x0', 13:35:53 INFO - 'XPC_SERVICE_NAME': '0', 13:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 13:35:53 INFO - mozversion application_buildid: 20170210122019 13:35:53 INFO - mozversion application_changeset: e26d8e25df97df3471cab4a48e0c0bfe4843dc2a 13:35:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:35:53 INFO - mozversion application_name: Firefox 13:35:53 INFO - mozversion application_remotingname: firefox-dev 13:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:35:53 INFO - mozversion application_vendor: Mozilla 13:35:53 INFO - mozversion application_version: 53.0a2 13:35:53 INFO - mozversion platform_buildid: 20170210122019 13:35:53 INFO - mozversion platform_changeset: e26d8e25df97df3471cab4a48e0c0bfe4843dc2a 13:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:35:53 INFO - mozversion platform_version: 53.0a2 13:35:53 INFO - using testdate: 1486762553 13:35:53 INFO - actual date: 1486762553 13:35:53 INFO - starting webserver on 'localhost:49242' 13:35:53 INFO - SUITE-START | Running 2 tests 13:35:53 INFO - TEST-START | dromaeo_css 13:35:53 INFO - operating with platform_type : mac_ 13:35:53 INFO - Initialising browser for dromaeo_css test... 13:35:53 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpc2FIPg/profile http://localhost:49242/getInfo.html) 13:35:56 INFO - PROCESS | 1633 | 2017-02-10 13:35:56.780 plugin-container[1635:7513] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 13:35:56 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:56 INFO - PROCESS | 1633 | 2017-02-10 13:35:56.784 plugin-container[1635:7513] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 13:35:56 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:56 INFO - PROCESS | 1633 | 2017-02-10 13:35:56.784 plugin-container[1635:7513] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:35:56 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 13:35:56 INFO - PROCESS | 1633 | colorDepth:24 13:35:56 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 13:35:56 INFO - PROCESS | 1633 | __metrics 13:35:56 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 13:35:57 INFO - TEST-INFO | 1633: exit 0 13:35:57 INFO - Browser initialized. 13:35:57 INFO - Running cycle 1/1 for dromaeo_css test... 13:35:57 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpc2FIPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:00 INFO - PROCESS | 1636 | 2017-02-10 13:36:00.358 plugin-container[1637:7646] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 13:36:00 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:36:00 INFO - PROCESS | 1636 | 2017-02-10 13:36:00.358 plugin-container[1637:7646] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 13:36:00 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:36:00 INFO - PROCESS | 1636 | 2017-02-10 13:36:00.358 plugin-container[1637:7646] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:36:10 INFO - PROCESS | 1636 | RSS: Main: 218849280 13:36:10 INFO - PROCESS | 1636 | 13:39:12 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 13:39:13 INFO - PROCESS | 1636 | RSS: Main: 240029696 13:39:13 INFO - PROCESS | 1636 | 13:40:58 INFO - PROCESS | 1636 | ************************* 13:40:58 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 13:40:58 INFO - PROCESS | 1636 | 13:40:58 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:40:58 INFO - PROCESS | 1636 | Full stack: 13:40:58 INFO - PROCESS | 1636 | ************************* 13:42:16 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 13:42:16 INFO - PROCESS | 1636 | RSS: Main: 250028032 13:42:16 INFO - PROCESS | 1636 | 13:45:18 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 13:45:19 INFO - PROCESS | 1636 | RSS: Main: 256356352 13:45:19 INFO - PROCESS | 1636 | 13:48:21 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 13:48:21 INFO - PROCESS | 1636 | RSS: Main: 252755968 13:48:21 INFO - PROCESS | 1636 | 13:51:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 13:51:25 INFO - PROCESS | 1636 | RSS: Main: 257822720 13:51:25 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 13:54:28 INFO - PROCESS | 1636 | RSS: Main: 259194880 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | __start_tp_report 13:54:28 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 13:54:28 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 13:54:28 INFO - PROCESS | 1636 | |i|pagename|runs| 13:54:28 INFO - PROCESS | 1636 | |0;dojo.html;2710.281775329538;3364.478505831597;3382.509536117265;3397.609274933382;3421.914452138696;5645.379008309083;5664.660120392774;5675.233843431146;5678.34699009614;5682.744276507557;4655.2784318430695;5604.075327570946;5667.5749318801045;5689.203511508382;5704.172894930243;4158.835526052695;4388.517263101072;5163.664361816479;5206.921896171561;5239.685618862862;5192.909489007294;5242.239875218091;5252.212168174785;5255.76349064293;5273.446288139748;5139.537441630253;5156.974215128919;5244.711540865251;5266.683998960056;5274.55166310864;4537.750423726694;5246.108161612516;5261.184516399964;5278.604104692164;5330.093884039684;3960.5445373782095;4799.7520644632295;5107.591392688576;5218.2955301034635;5268.5521730652945;5485.917711234335;5664.688442135722;5707.315122185323;5827.970860145714;5831.679257640828;6123.343628574293;6139.785107521216;6166.136740856284;6178.042403427476;6267.05994100884;6237.126802247689;6237.563370564062;6252.906206406908;6268.09112678659;6277.591956522857;5801.100829371454;5835.766569337264;5839.912401313941;5869.442402971711;5878.706064696791;6134.528431832413;6180.134781130645;6181.84545386369;6186.505079593621;6220.813375598649;6105.297890742532;6141.4101092759665;6175.320714721377;6177.536684748662;6230.096635987847;6164.167837341902;6172.22847144107;6218.098375735493;6234.719437625317;6251.906221406683;6002.609830361012;6089.208402907594;6151.169592105009;6194.287656919422;6238.313785483593;6258.530610204253;6260.968695156495;6294.213223347082;6301.7164227609865;6303.149074874833;4962.602991760723;4965.056639238605;4967.7019378837385;4980.2778597103215;4983.177775667047;4344.956550434518;4364.432623758955;4387.056782791715;4461.286194208911;4472.195004899149;5688.943110568841;5711.742971566289;5787.681677507778;5790.189373487715;5835.2122463466885;6233;6241.032639940817;6282.371762823681;6285.057241413824;6285.717142728497;5531.308586426697;5592.189132575835;5722.399148089391;5773.88452230953;5776.855578610568;5466.098093814556;5472.343318801769;5474.671519708751;5497.175423686479;5501.202325662836;6290.276618188876;6294.968525157345;6308.936910630835;6315.873682526416;6345.619262844337;5557.666540007613;6083.026715725463;6119.106526814536;6213.844653883508;6221.564490485804;6227.252729672468;6295.213098362705;6299.118123462627;6309.842253943504;6342.39747224013;5274.736263186902;6069.241344831896;6192;6204.3795620437595;6216.502679785516;6130.172426722514;6186.041163619646;6219.2865527327485;6232.719527621177;6281.497480201481;5019.899602008012;5998.220231369894;6021.7591296347655;6139.658497107545;6145.248604147797;6100.969495152496;6102.908456373069;6103.3591472894705;6111;6133.26400831903;4748.786304616369;5765.221695071112;5892.6759028252145;6001.5798894077;6026.789062382795;5937.198478205387;5990.4908082813445;5993.250843644544;6042.365551617193;6121.724522396414;5896.882062358814;5918.763249469973;5918.763249470146;5921.17103605487;5921.792737254175 13:54:28 INFO - PROCESS | 1636 | |1;ext.html;446.8034065011395;451.8666993236995;494.9826756063538;505.8811179372849;514.596042106946;35607;41819.58180418199;41879;41897.58102418975;42010.99999999996;42877;43326;43587.564124358745;43614.56385436145;43652.345214821806;8383.455075420108;9158.129977652112;9307.720768376927;9322.86015709765;9376;8437.029741579736;11099.112071034298;11375.886241137607;11411.600593979212;11569.190156689036;10178;11112.666620001413;11416.200865939347;11458.770824583504;11467.59863404781;11350.318980861133;11414.201005929588;11418.143639227092;11423.428828558539;11428.828567571492;11277.436128193558;11341;11348.148888833288;11349.43252837363;11368.943155284252;40426.19147617031;40650.79674601608;40734;40764.592354076376;40774.388384174265;3895.5520115186832;3953.697761992162;4010.799460026987;4011.3581826907553;4017.1563971566006;28913.718125619478;30014.949476768208;30017.399652006836;30455;30941;3218.0828463887915;3229.919252018695;3237.336346049054;3266.836658167082;3305.7851239669344;498133.50933245465;503012;503642.4817875924;503657.48171259277;504159;61715;61837.07244391338;62035.6898215506;62114;62232.75534489285;64071;64610.030849537296;64736.67631661812;64823.40706371692;65308.020379694346;16519.752203716955;16681.83318166827;16712.74930876038;16733.16334183286;16739.74890376621;11626.128040397005;11952.223105498115;12970.092093553361;12985.415656295489;13022.804657930139;19027.14377853;20222.595548088957;21143.365699029055;21777.34667959964;21786.782132178476;8731.869021964676;8913.598888050054;8964.238039766693;8991.955040224757;9120.042395548504;765.7281665008842;835.1606635331574;858.7810108422312;869.7216890595075;887.5606574745414;28656.426871462452;28662.426751464853;29227.85386073056;29629.259268518028;30788;909.1045320359441;970.8640790289365;1027.1833892055834;1036.8392899100652;1037.2376303416982;13763.174209547458;14565;15272.465463708717;15429.691406172038;15456.690866182613;671641;675721;675990;676792;677314;45699.543004570194;52641;53535.732321338146;53879.730601347524;54083.45916540784;1325.0989327257557;1325.15190278222;1386.6671998720435;1422.0472283570032;1422.6372275069998;20798.064087116418;27350.316242094108;27590.862045690446;28441.857790710914;28799.8560007207;36901.44647830231;43768.78115609402;44852.55147448484;44977.32534012058;45233.64299071033;509583;583385;586740;586781;587998;21640.458988525414;22288.554228915655;24185.516289673757;24519.38701532476;24639;40683.389749154376;40699.1860162801;41243.587564123976;41398.58601413947;41431.7928410356;28525.429491410472;33618.831905840314;33641.495377569845;34386.312273754884;35221.471677925365;33631.82288619887;34153.65846341505;34174.31651366909;34175;34235.14412139716;33036.50445243371;33713.83143084367;33799.83100084484;34539.4819077709;35205.76779812797;30087.699123009366;31659.84170079135;31940.84029579837;31985.360292794478;32049.67950320467;23761.9802316805;24204.63693044641;24472.021119155033;24479;25413.74586254114 13:54:28 INFO - PROCESS | 1636 | |2;jquery.html;385.65483891916716;386.57476775546894;390.7635880292424;397.21946375372386;414.0807407555228;17408.216630251638;19611.803881961176;21619.135234590598;21987.890060549715;22084.33746987591;21274.46813829655;21609.783902160973;21641.891790541064;21738.89130554345;22241;5728.283964504427;5994.220751302325;6034.034554471285;6051.848703782419;6054.424829641199;4605.884852878671;5864.149698293745;5874.5594080443925;5908.822735317947;5926.348101708809;4231.322988321869;4433.711808732438;6367.395097465734;6662.300458451866;6670.833229169261;6438.581492203039;6605.372489613479;6644.302348253436;6720.3279672032895;6723.764668236613;5804;5828.446297601721;5830.5044071254;5837.211976383219;5838.912416313716;25286.87356563224;25308.873455632787;25350.112746053983;26109;26177.476450471073;2969.228000719807;3074.3851229753914;3095.2107212660626;3118.251619611277;3122.500399936022;15891.60270993223;15944.96357736755;15995;16100.114493702842;16233.2695028724;1562.617158796091;1845.5386153461634;1848.4639454558162;1858.7583614130076;1864.6363959027994;120706;123231;124293;124799.37600312031;126300;11175.552977880794;11537.192396532162;11545.307281563133;11611.535538578362;11744.29534227949;14007.579772606838;14079.788803167961;14108.2945852709;14118.364673589713;14144.504942326968;8582.87125693115;8798.912010879809;8808.647654093893;8825.117488251124;8935.821283574292;8884;8884.97822750379;8935.597898094602;9008.41445306053;9026.368154229272;7271.8909216360735;7400.407967362706;7434.3309102181065;7439.590822504814;7457.216992215739;1924.6246981838408;1982.2467462364498;1982.4548249231289;1984.374921899597;1985.2852972929734;400.96550898681335;401.26768647218944;421.55736476699343;422.9133027729308;430.77814925313487;10647.787044259072;11350.14873884462;11926.761464770829;11999.520019199133;12213.816792748115;443.37705523739197;443.8158164361754;447.8052047359344;452.5271091709106;454.79306915353436;4651.930221046687;5584.832455026356;6153.230846144232;6237.438630523184;6318.462930650854;538891;647732;753154;753335;759345;129101.70898291084;157864;163282;165059;167177.82055448467;965.8792650918635;1008.2236677758232;1042.1610603464133;1042.3016578892161;1043.5512729526376;19717;20136.295229666892;20224.59550808946;20427.4893127673;20622.484437889172;47573.76213118912;52718.20922686086;53757;53818.73090634522;54040.729796350766;82904;83524.16475835163;84311;84761.57619211865;85352.1464785369;8532.445391049561;8612.698555550525;8796.780080498038;8861;8906.688265910661;7647.082350118021;8220.095789463036;9310.487923164292;11273;12805.935970320088;11094.500747466222;11303.660890173307;11428.599998999995;11510.48202830858;11638.6508404748;11501.022413094981;11511.07911367072;11532.308061516336;11552.364619945984;11568.47941842636;9532.85700714476;11602.47788849487;11815.763684726086;11909.642710718692;12088.576899808464;7937.801554961172;8305.916940830755;8598.65605375803;8710.21608055278;8724;9365.391249568756;11210.607628733282;11521.711957200801;11812.527498899948;11894.762104758029 13:54:28 INFO - PROCESS | 1636 | |3;mootools.html;1418;1424.750668632989;1431.627776778038;1441.7476941535233;1450.187894778924;7513.962430187841;7764.728234511793;8124.146964568717;8586.484810911343;8605.784855378619;8084.15116412777;8271.751847444571;8303.958480207606;8437.746867593967;8453.535055571941;1911.550785565391;2358.599038163508;2361.480474295652;2364.6453032045247;2375.5130198309307;1729.7578339032482;2136.540643761591;2330.207729372013;2371.4071482129466;2372.9288121356385;1961.695937129747;2263.807576356012;2344.109238489372;2346.9647955280684;2349.7767712067325;2070.1098527633185;2309.688192094071;2329.939877355799;2348.694669692929;2348.8473249238746;2144.970414201192;2284.383216531544;2311.202635090891;2363.5391098735754;2371.8814059296965;7546.207648196915;8068.878966815502;8401.453905496122;8512.319014478826;8514.446560973578;5130.820421285237;5255.737213139328;5293.86765330866;5298.999999999962;5309.283246761676;3502.1944952660774;3532.438981738245;3546;3581.6418358164237;3628.818559072036;1222.9633111006683;1229.975400491985;1269.7841366967639;1284.9614511564669;1290.135609141868;10831.729206769895;10920.453977301104;10938.835917461245;10950.945245273882;10971.615993440271;4350.1734670412525;4430.357598148251;4470.374147619336;4472.0832229393545;4779.880502987384;9523.238140948708;9639.566219520138;9653;9654.082862128087;9656.71029869105;5234.26720259164;5315.176147697036;5315.176147697113;5320;5325.4674532547215;4654.813807447732;4850.514948505192;4852.51474852519;4862.978774457403;4871.244957031595;3900.726949113535;3931.8230679619487;3964.0684439156776;4000.0599859033105;4037.6164264394833;1177.776222517719;1217.3487184356327;1273.726148877977;1277.9488820447077;1300.856905740368;724.6774636288794;751.4289140253446;775.8254392761584;789.2975252025702;822.5352675738188;4865.318855360181;5514.420985796514;5537.861553461115;5662.122371032497;5712.80005199816;966.4201479112477;978.1929907826072;990.5542505872386;1004.1765752083368;1019.8929112443235;3732.6080761519647;3771.73597848148;3784.6026167252044;3866.439366291872;3891.3968334908136;9638.855417168748;10151.593936242616;10156.339837910513;10166.339187952759;10185.796284074277;9742.805143897082;9927.801443971224;10063.19494440443;10152.23858210637;10168.034036766496;7824.804379890548;7914.366850651934;8014.559199244098;8020.318272946864;8026.197380261927;5431.185322201543;5453.972730136324;5533.170024496358;5570.6657600544095;5584.832455026356;9202.309826762885;9207.447553146832;9290.349675522648;9398.577064032272;9406.95296523513;9049.954750226207;9282.62869485213;9343.626254949726;9381.624735010522;9464.19554337889;6947.826304342432;7076;7275.417966562768;7365.668544915385;7379.114506259283;8047.678092876454;8068.1528439513;8144.918550814653;8145.42981991255;8163.306118979954;6214.9067763984485;7096.929030709834;7170.211276759656;7175.067241258603;7201.531900426456;5895.764169433346;6906.447484201151;7029.191642961125;7083.893741593984;7099.219085900443;5796.536277097738;6361.2048493938255;6400.615963042233;6489.1888513935755;6504.219493660791;3888.766673999569;4078.5105787305715;4875.414950205856;4979.701217926936;4988.102141614544;4948.554630083309;4987.800487980585;4992.750362481789;5088.211327244283;5101.7704203310195 13:54:28 INFO - PROCESS | 1636 | |4;prototype.html;356.8501229483617;358.0708062577611;362.6228722128986;365.67637640688;375.5962340483979;4486.596206341429;4546.840860569877;4722.527747225276;5094.490550944904;5246.711430871301;5039.773210205541;5199.194124910645;5237.397699264586;5243.318368612085;5270.49930256626;3496.2483066140776;4147.7926103694845;4162.833486660537;4181.665466762667;4193.81127849246;3497.720182385403;3829.3872980323013;4054.97972510137;4188.81150348235;4195.538490766014;4043.3126368517273;4052.007258221725;4053.6351728344443;4073.714839961204;4075.4294398784195;4067.1052368478886;4077.7961101944784;4081.9591804082024;4083.4487344208746;4097.672186225095;3484.8257587120797;3519.483569247974;3528.6824185823143;3536.2397084626673;3549.2369140634887;4704.576588107053;4981.825636102755;5065.848024559269;5155.0358543837065;5162.805807531784;4605.30920361945;4642.792873852789;4644.883877903079;4654.767261636905;4682.518265319352;5351.331083614548;5683.772649094031;5694;5708.915306091871;5712.685802280873;3775.414810704345;3863.053551879779;3890.649841514249;3904.39481880309;3908.511436070491;5349.812756553502;5895.170318247266;5939.970300148515;5965.46467751204;6012.278526576839;3305.5372247885316;3904.7852368120025;3929.31237033518;3962.3660214365564;3974.2647610192207;3190.3938251732097;3411.880584179542;3524.718022558189;3702.33357995558;3810.123671555558;4623.53764623535;4650.488446270908;4652.278896771006;4665.393498845128;4699.788509517011;4577.542245775396;4777.300825033844;5283.996040752321;5716.371199168088;5745.299709136699;1126.318577260762;1202.8392601139942;1249.8250244965711;1253.573784913134;1286.7169222770976;741.9390271911219;871.9956400218085;887.0907319996926;889.1686273334453;889.58634235081;5044.344235249394;5062.860856307301;5071.695698258116;5079.644424890223;5096.745162741848;4758.857234282977;4972.8756781080765;5020.748962551931;5417.3770016447825;5580.804671836548;4212;4491.730496170175;4560.879191176119;4580.702254353457;4700.130475861976;2425.4300239443714;2510.221831232324;2698.257979055775;2759.889604415801;2772.9445411091665;4573.085382923428;5404.91892621611;5419.647722897999;5488.780448782004;5567.66594004361;4277.807498662568;5555.500004999489;5767.279090113736;5768.942310576925;6050.90923636137;5095.031943930641;5218.060749065129;5559.8888022240135;5972.805438912235;6026.5178785697035;4760.714357138583;4956.859922217838;5864.856353011121;5915.70421478933;5923.911141332969;5442.231274835774;5775.314478767394;5828.883422331614;5830.125481177857;5863.296404431496;6089.421504957022;6105.358937311518;6123.357047510125;6128.9693551531955;6131.294901086254;3530.0524062408176;3812.790296533717;3945.861894833667;3953.102510794777;3967.3057214986684;5110.488951105009;5565.5825813063375;5713.971430142823;5775;5843.853903652443;5187.533122019036;5549.0289199389135;5562.888742225214;5685.374608793112;5693.857653558694;4987.102321582005;5388.892222155457;5645.717714114196;5679.460451257124;5688.488036076607;5314.813981510629;5513.924784666951;5545.944540554543;5577.3028371453565;5612.691301978431;4757.740947451007;5693.5445164387575;5715.599908006399;5717.113847353667;5742.942570574241;4668.85993420198;4907.2393778964315;5558.555315574825;5567.331920169606;5581 13:54:28 INFO - PROCESS | 1636 | |5;yui.html;564.6329885574379;635.7457017193125;669.4677731203692;760.9543427394357;790.2374208888423;14695.33870975806;15197.316120774563;15681.843181568182;15727.056376617411;15831.208439578018;14211.502597409093;14366.425342986295;14505.492307769204;14522.636934076627;14523.709525809478;812.2446125103636;832.1678321678322;849.8342823149488;851.6976473351964;852.0669866496177;670.9329067093277;692.2800287700785;831.8128421105233;854.4318028511033;860.42781550269;897.3942588752599;911.7994041310934;912.5938957164065;913.9086091390874;916.9908300916973;897.5243121145803;903.3405613901889;903.3495882964255;905.1446383167909;906.5331354352546;667.2060248304502;671.781670956941;675.7736158386946;676.1075380497745;678.1049015299807;14956.62608434787;15436.845631543652;16056.357745690158;16121;16188.271527781279;14248.786268205986;14467.421303147861;14677.633059173606;14685.48600798967;14742.410303587843;11293.265937714023;11380.317180969168;11524.539018439253;11755.764884702257;11954.940225298906;3651.5618125824803;3703.777773333609;3736.7010639148803;3878.0111071676824;3878.534575850916;93897;104364.47817760939;109209;109376.45311773391;110128.9999999992;10844.13246940243;10952.780944381067;11225.158113141548;11437.656870293904;11503.309801411775;22992.88503557505;23014.079436822674;23337;23528.529429411316;23554.646680299807;7405.3463181953475;7461;7468.663910124057;7541.095068591804;7656.081270247606;4096.651784598283;4176.2900306947895;4182.1008483176265;4215.57844215576;4235.97882010588;3027.666956634768;3533;3604.6395360463744;3649.361361761681;3651.1967367179177;624.622103627308;633.8954072577973;636.4431122767578;640.4620119099978;658.275896513831;649.4122818848949;669.3139531979759;686.2485578291762;704.2218348724688;715.5563550598662;9612.375195612263;10385.792284154426;10389.480525973822;10391.84412233817;10586.89413105859;675.1054852320694;695.4644923408947;696.1646024770296;697.083335413929;697.1982220446425;4746.240601503743;4952.380952380952;5017.147084995559;5017.172166592544;5018.172001619692;75481.11297217614;90097;106855.46572267244;107069;107652;72827;78863.60568197122;80279;85652;96882.54676179722;74965.62517187488;75411.73764787066;76528;78466.21533784589;79253.60373198097;10486.423246721504;10991.725206869573;11044.723881903017;11044.779104417707;11191;51031.744841275555;52438;52580;53841.46158538521;54578.454215457336;52291;65728.34271657413;66042.66978665076;69195.65402173158;72228;12608.936955315165;12615;12656.17734847232;13057.412416441093;13880;12967.675808104872;13565.321733913068;14466.20435876037;14920.7761883574;15324.927255092036;13536.59390218295;13639.522616708367;13701.794473082713;13916.930415347859;14181.929090354482;13545.353322463849;13570.253636050113;13649.795253071014;13719.1082579632;13735.656608584864;13289.734205316034;13370.264635445144;13389.732205355644;13741.931290343484;13772.724545509234;11411.828822567833;11416.257943233662;11428.71428214268;11638.5344586219;11830.585929492427;10836.620718274822;11021.559137634726;11032.889671103187;11054.281471704313;11081.501332439899 13:54:28 INFO - PROCESS | 1636 | __end_tp_report 13:54:28 INFO - PROCESS | 1636 | __start_cc_report 13:54:28 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,384 13:54:28 INFO - PROCESS | 1636 | __end_cc_report 13:54:28 INFO - PROCESS | 1636 | __startTimestamp1486763668430__endTimestamp 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | ------- Summary: start ------- 13:54:28 INFO - PROCESS | 1636 | Number of tests: 6 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5686.12 Median:5918.76 stddev:688.95 (11.6%) stddev-sans-first:650.31 13:54:28 INFO - PROCESS | 1636 | Values: 2710.3 3364.5 3382.5 3397.6 3421.9 5645.4 5664.7 5675.2 5678.3 5682.7 4655.3 5604.1 5667.6 5689.2 5704.2 4158.8 4388.5 5163.7 5206.9 5239.7 5192.9 5242.2 5252.2 5255.8 5273.4 5139.5 5157.0 5244.7 5266.7 5274.6 4537.8 5246.1 5261.2 5278.6 5330.1 3960.5 4799.8 5107.6 5218.3 5268.6 5485.9 5664.7 5707.3 5828.0 5831.7 6123.3 6139.8 6166.1 6178.0 6267.1 6237.1 6237.6 6252.9 6268.1 6277.6 5801.1 5835.8 5839.9 5869.4 5878.7 6134.5 6180.1 6181.8 6186.5 6220.8 6105.3 6141.4 6175.3 6177.5 6230.1 6164.2 6172.2 6218.1 6234.7 6251.9 6002.6 6089.2 6151.2 6194.3 6238.3 6258.5 6261.0 6294.2 6301.7 6303.1 4962.6 4965.1 4967.7 4980.3 4983.2 4345.0 4364.4 4387.1 4461.3 4472.2 5688.9 5711.7 5787.7 5790.2 5835.2 6233.0 6241.0 6282.4 6285.1 6285.7 5531.3 5592.2 5722.4 5773.9 5776.9 5466.1 5472.3 5474.7 5497.2 5501.2 6290.3 6295.0 6308.9 6315.9 6345.6 5557.7 6083.0 6119.1 6213.8 6221.6 6227.3 6295.2 6299.1 6309.8 6342.4 5274.7 6069.2 6192.0 6204.4 6216.5 6130.2 6186.0 6219.3 6232.7 6281.5 5019.9 5998.2 6021.8 6139.7 6145.2 6101.0 6102.9 6103.4 6111.0 6133.3 4748.8 5765.2 5892.7 6001.6 6026.8 5937.2 5990.5 5993.3 6042.4 6121.7 5896.9 5918.8 5918.8 5921.2 5921.8 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:70605.01 Median:34174.66 stddev:157278.15 (460.2%) stddev-sans-first:157631.14 13:54:28 INFO - PROCESS | 1636 | Values: 446.8 451.9 495.0 505.9 514.6 35607.0 41819.6 41879.0 41897.6 42011.0 42877.0 43326.0 43587.6 43614.6 43652.3 8383.5 9158.1 9307.7 9322.9 9376.0 8437.0 11099.1 11375.9 11411.6 11569.2 10178.0 11112.7 11416.2 11458.8 11467.6 11350.3 11414.2 11418.1 11423.4 11428.8 11277.4 11341.0 11348.1 11349.4 11368.9 40426.2 40650.8 40734.0 40764.6 40774.4 3895.6 3953.7 4010.8 4011.4 4017.2 28913.7 30014.9 30017.4 30455.0 30941.0 3218.1 3229.9 3237.3 3266.8 3305.8 498133.5 503012.0 503642.5 503657.5 504159.0 61715.0 61837.1 62035.7 62114.0 62232.8 64071.0 64610.0 64736.7 64823.4 65308.0 16519.8 16681.8 16712.7 16733.2 16739.7 11626.1 11952.2 12970.1 12985.4 13022.8 19027.1 20222.6 21143.4 21777.3 21786.8 8731.9 8913.6 8964.2 8992.0 9120.0 765.7 835.2 858.8 869.7 887.6 28656.4 28662.4 29227.9 29629.3 30788.0 909.1 970.9 1027.2 1036.8 1037.2 13763.2 14565.0 15272.5 15429.7 15456.7 671641.0 675721.0 675990.0 676792.0 677314.0 45699.5 52641.0 53535.7 53879.7 54083.5 1325.1 1325.2 1386.7 1422.0 1422.6 20798.1 27350.3 27590.9 28441.9 28799.9 36901.4 43768.8 44852.6 44977.3 45233.6 509583.0 583385.0 586740.0 586781.0 587998.0 21640.5 22288.6 24185.5 24519.4 24639.0 40683.4 40699.2 41243.6 41398.6 41431.8 28525.4 33618.8 33641.5 34386.3 35221.5 33631.8 34153.7 34174.3 34175.0 34235.1 33036.5 33713.8 33799.8 34539.5 35205.8 30087.7 31659.8 31940.8 31985.4 32049.7 23762.0 24204.6 24472.0 24479.0 25413.7 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:38641.99 Median:388.67 stddev:116306.86 (29924.4%) stddev-sans-first:116597.66 13:54:28 INFO - PROCESS | 1636 | Values: 385.7 386.6 390.8 397.2 414.1 17408.2 19611.8 21619.1 21987.9 22084.3 21274.5 21609.8 21641.9 21738.9 22241.0 5728.3 5994.2 6034.0 6051.8 6054.4 4605.9 5864.1 5874.6 5908.8 5926.3 4231.3 4433.7 6367.4 6662.3 6670.8 6438.6 6605.4 6644.3 6720.3 6723.8 5804.0 5828.4 5830.5 5837.2 5838.9 25286.9 25308.9 25350.1 26109.0 26177.5 2969.2 3074.4 3095.2 3118.3 3122.5 15891.6 15945.0 15995.0 16100.1 16233.3 1562.6 1845.5 1848.5 1858.8 1864.6 120706.0 123231.0 124293.0 124799.4 126300.0 11175.6 11537.2 11545.3 11611.5 11744.3 14007.6 14079.8 14108.3 14118.4 14144.5 8582.9 8798.9 8808.6 8825.1 8935.8 8884.0 8885.0 8935.6 9008.4 9026.4 7271.9 7400.4 7434.3 7439.6 7457.2 1924.6 1982.2 1982.5 1984.4 1985.3 401.0 401.3 421.6 422.9 430.8 10647.8 11350.1 11926.8 11999.5 12213.8 443.4 443.8 447.8 452.5 454.8 4651.9 5584.8 6153.2 6237.4 6318.5 538891.0 647732.0 753154.0 753335.0 759345.0 129101.7 157864.0 163282.0 165059.0 167177.8 965.9 1008.2 1042.2 1042.3 1043.6 19717.0 20136.3 20224.6 20427.5 20622.5 47573.8 52718.2 53757.0 53818.7 54040.7 82904.0 83524.2 84311.0 84761.6 85352.1 8532.4 8612.7 8796.8 8861.0 8906.7 7647.1 8220.1 9310.5 11273.0 12805.9 11094.5 11303.7 11428.6 11510.5 11638.7 11501.0 11511.1 11532.3 11552.4 11568.5 9532.9 11602.5 11815.8 11909.6 12088.6 7937.8 8305.9 8598.7 8710.2 8724.0 9365.4 11210.6 11521.7 11812.5 11894.8 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5444.49 Median:5182.54 stddev:2988.14 (57.7%) stddev-sans-first:2981.20 13:54:28 INFO - PROCESS | 1636 | Values: 1418.0 1424.8 1431.6 1441.7 1450.2 7514.0 7764.7 8124.1 8586.5 8605.8 8084.2 8271.8 8304.0 8437.7 8453.5 1911.6 2358.6 2361.5 2364.6 2375.5 1729.8 2136.5 2330.2 2371.4 2372.9 1961.7 2263.8 2344.1 2347.0 2349.8 2070.1 2309.7 2329.9 2348.7 2348.8 2145.0 2284.4 2311.2 2363.5 2371.9 7546.2 8068.9 8401.5 8512.3 8514.4 5130.8 5255.7 5293.9 5299.0 5309.3 3502.2 3532.4 3546.0 3581.6 3628.8 1223.0 1230.0 1269.8 1285.0 1290.1 10831.7 10920.5 10938.8 10950.9 10971.6 4350.2 4430.4 4470.4 4472.1 4779.9 9523.2 9639.6 9653.0 9654.1 9656.7 5234.3 5315.2 5315.2 5320.0 5325.5 4654.8 4850.5 4852.5 4863.0 4871.2 3900.7 3931.8 3964.1 4000.1 4037.6 1177.8 1217.3 1273.7 1277.9 1300.9 724.7 751.4 775.8 789.3 822.5 4865.3 5514.4 5537.9 5662.1 5712.8 966.4 978.2 990.6 1004.2 1019.9 3732.6 3771.7 3784.6 3866.4 3891.4 9638.9 10151.6 10156.3 10166.3 10185.8 9742.8 9927.8 10063.2 10152.2 10168.0 7824.8 7914.4 8014.6 8020.3 8026.2 5431.2 5454.0 5533.2 5570.7 5584.8 9202.3 9207.4 9290.3 9398.6 9407.0 9050.0 9282.6 9343.6 9381.6 9464.2 6947.8 7076.0 7275.4 7365.7 7379.1 8047.7 8068.2 8144.9 8145.4 8163.3 6214.9 7096.9 7170.2 7175.1 7201.5 5895.8 6906.4 7029.2 7083.9 7099.2 5796.5 6361.2 6400.6 6489.2 6504.2 3888.8 4078.5 4875.4 4979.7 4988.1 4948.6 4987.8 4992.8 5088.2 5101.8 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4503.93 Median:4984.46 stddev:1398.21 (28.1%) stddev-sans-first:1367.04 13:54:28 INFO - PROCESS | 1636 | Values: 356.9 358.1 362.6 365.7 375.6 4486.6 4546.8 4722.5 5094.5 5246.7 5039.8 5199.2 5237.4 5243.3 5270.5 3496.2 4147.8 4162.8 4181.7 4193.8 3497.7 3829.4 4055.0 4188.8 4195.5 4043.3 4052.0 4053.6 4073.7 4075.4 4067.1 4077.8 4082.0 4083.4 4097.7 3484.8 3519.5 3528.7 3536.2 3549.2 4704.6 4981.8 5065.8 5155.0 5162.8 4605.3 4642.8 4644.9 4654.8 4682.5 5351.3 5683.8 5694.0 5708.9 5712.7 3775.4 3863.1 3890.6 3904.4 3908.5 5349.8 5895.2 5940.0 5965.5 6012.3 3305.5 3904.8 3929.3 3962.4 3974.3 3190.4 3411.9 3524.7 3702.3 3810.1 4623.5 4650.5 4652.3 4665.4 4699.8 4577.5 4777.3 5284.0 5716.4 5745.3 1126.3 1202.8 1249.8 1253.6 1286.7 741.9 872.0 887.1 889.2 889.6 5044.3 5062.9 5071.7 5079.6 5096.7 4758.9 4972.9 5020.7 5417.4 5580.8 4212.0 4491.7 4560.9 4580.7 4700.1 2425.4 2510.2 2698.3 2759.9 2772.9 4573.1 5404.9 5419.6 5488.8 5567.7 4277.8 5555.5 5767.3 5768.9 6050.9 5095.0 5218.1 5559.9 5972.8 6026.5 4760.7 4956.9 5864.9 5915.7 5923.9 5442.2 5775.3 5828.9 5830.1 5863.3 6089.4 6105.4 6123.4 6129.0 6131.3 3530.1 3812.8 3945.9 3953.1 3967.3 5110.5 5565.6 5714.0 5775.0 5843.9 5187.5 5549.0 5562.9 5685.4 5693.9 4987.1 5388.9 5645.7 5679.5 5688.5 5314.8 5513.9 5545.9 5577.3 5612.7 4757.7 5693.5 5715.6 5717.1 5742.9 4668.9 4907.2 5558.6 5567.3 5581.0 13:54:28 INFO - PROCESS | 1636 | 13:54:28 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20264.50 Median:3651.38 stddev:28564.83 (782.3%) stddev-sans-first:28606.66 13:54:28 INFO - PROCESS | 1636 | Values: 564.6 635.7 669.5 761.0 790.2 14695.3 15197.3 15681.8 15727.1 15831.2 14211.5 14366.4 14505.5 14522.6 14523.7 812.2 832.2 849.8 851.7 852.1 670.9 692.3 831.8 854.4 860.4 897.4 911.8 912.6 913.9 917.0 897.5 903.3 903.3 905.1 906.5 667.2 671.8 675.8 676.1 678.1 14956.6 15436.8 16056.4 16121.0 16188.3 14248.8 14467.4 14677.6 14685.5 14742.4 11293.3 11380.3 11524.5 11755.8 11954.9 3651.6 3703.8 3736.7 3878.0 3878.5 93897.0 104364.5 109209.0 109376.5 110129.0 10844.1 10952.8 11225.2 11437.7 11503.3 22992.9 23014.1 23337.0 23528.5 23554.6 7405.3 7461.0 7468.7 7541.1 7656.1 4096.7 4176.3 4182.1 4215.6 4236.0 3027.7 3533.0 3604.6 3649.4 3651.2 624.6 633.9 636.4 640.5 658.3 649.4 669.3 686.2 704.2 715.6 9612.4 10385.8 10389.5 10391.8 10586.9 675.1 695.5 696.2 697.1 697.2 4746.2 4952.4 5017.1 5017.2 5018.2 75481.1 90097.0 106855.5 107069.0 107652.0 72827.0 78863.6 80279.0 85652.0 96882.5 74965.6 75411.7 76528.0 78466.2 79253.6 10486.4 10991.7 11044.7 11044.8 11191.0 51031.7 52438.0 52580.0 53841.5 54578.5 52291.0 65728.3 66042.7 69195.7 72228.0 12608.9 12615.0 12656.2 13057.4 13880.0 12967.7 13565.3 14466.2 14920.8 15324.9 13536.6 13639.5 13701.8 13916.9 14181.9 13545.4 13570.3 13649.8 13719.1 13735.7 13289.7 13370.3 13389.7 13741.9 13772.7 11411.8 11416.3 11428.7 11638.5 11830.6 10836.6 11021.6 11032.9 11054.3 11081.5 13:54:28 INFO - PROCESS | 1636 | -------- Summary: end -------- 13:54:28 INFO - PROCESS | 1636 | 13:54:29 INFO - TEST-INFO | 1636: exit 0 13:54:29 INFO - TEST-OK | dromaeo_css | took 1115071ms 13:54:29 INFO - TEST-START | kraken 13:54:29 INFO - operating with platform_type : mac_ 13:54:29 INFO - Initialising browser for kraken test... 13:54:29 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpxkOz4q/profile http://localhost:49242/getInfo.html) 13:54:31 INFO - PROCESS | 1647 | 2017-02-10 13:54:31.894 plugin-container[1648:9881] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 13:54:31 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:54:31 INFO - PROCESS | 1647 | 2017-02-10 13:54:31.897 plugin-container[1648:9881] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8833, name = 'com.apple.CFPasteboardClient' 13:54:31 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:54:31 INFO - PROCESS | 1647 | 2017-02-10 13:54:31.897 plugin-container[1648:9881] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:54:31 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 13:54:31 INFO - PROCESS | 1647 | colorDepth:24 13:54:31 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 13:54:31 INFO - PROCESS | 1647 | __metrics 13:54:32 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 13:54:32 INFO - TEST-INFO | 1647: exit 0 13:54:32 INFO - Browser initialized. 13:54:32 INFO - Running cycle 1/1 for kraken test... 13:54:32 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpxkOz4q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:54:35 INFO - PROCESS | 1649 | 2017-02-10 13:54:35.423 plugin-container[1650:9998] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 13:54:35 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:54:35 INFO - PROCESS | 1649 | 2017-02-10 13:54:35.424 plugin-container[1650:9998] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 13:54:35 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:54:35 INFO - PROCESS | 1649 | 2017-02-10 13:54:35.424 plugin-container[1650:9998] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:54:45 INFO - PROCESS | 1649 | RSS: Main: 218996736 13:54:45 INFO - PROCESS | 1649 | 13:54:47 INFO - PROCESS | 1649 | 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) 13:54:48 INFO - PROCESS | 1649 | RSS: Main: 232960000 13:54:48 INFO - PROCESS | 1649 | 13:54:51 INFO - PROCESS | 1649 | 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) 13:54:52 INFO - PROCESS | 1649 | RSS: Main: 240898048 13:54:52 INFO - PROCESS | 1649 | 13:54:55 INFO - PROCESS | 1649 | 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) 13:54:56 INFO - PROCESS | 1649 | RSS: Main: 244715520 13:54:56 INFO - PROCESS | 1649 | 13:54:57 INFO - PROCESS | 1649 | 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) 13:54:58 INFO - PROCESS | 1649 | RSS: Main: 246165504 13:54:58 INFO - PROCESS | 1649 | 13:55:00 INFO - PROCESS | 1649 | 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) 13:55:01 INFO - PROCESS | 1649 | RSS: Main: 246136832 13:55:01 INFO - PROCESS | 1649 | 13:55:04 INFO - PROCESS | 1649 | 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) 13:55:04 INFO - PROCESS | 1649 | RSS: Main: 250392576 13:55:04 INFO - PROCESS | 1649 | 13:55:07 INFO - PROCESS | 1649 | 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) 13:55:08 INFO - PROCESS | 1649 | RSS: Main: 249262080 13:55:08 INFO - PROCESS | 1649 | 13:55:11 INFO - PROCESS | 1649 | 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) 13:55:12 INFO - PROCESS | 1649 | RSS: Main: 249540608 13:55:12 INFO - PROCESS | 1649 | 13:55:13 INFO - PROCESS | 1649 | 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) 13:55:14 INFO - PROCESS | 1649 | RSS: Main: 248860672 13:55:14 INFO - PROCESS | 1649 | 13:55:16 INFO - PROCESS | 1649 | 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) 13:55:17 INFO - PROCESS | 1649 | RSS: Main: 248938496 13:55:17 INFO - PROCESS | 1649 | 13:55:19 INFO - PROCESS | 1649 | 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) 13:55:19 INFO - PROCESS | 1649 | RSS: Main: 248897536 13:55:19 INFO - PROCESS | 1649 | 13:55:22 INFO - PROCESS | 1649 | 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) 13:55:23 INFO - PROCESS | 1649 | RSS: Main: 249356288 13:55:23 INFO - PROCESS | 1649 | 13:55:26 INFO - PROCESS | 1649 | 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) 13:55:27 INFO - PROCESS | 1649 | RSS: Main: 249434112 13:55:27 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | 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) 13:55:29 INFO - PROCESS | 1649 | RSS: Main: 251072512 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | __start_tp_report 13:55:29 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 13:55:29 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 13:55:29 INFO - PROCESS | 1649 | |i|pagename|runs| 13:55:29 INFO - PROCESS | 1649 | |0;ai-astar;156;173;125;120;119;120;118;116;117;120 13:55:29 INFO - PROCESS | 1649 | |1;audio-beat-detection;133;113;111;140;113;117;139;144;144;114 13:55:29 INFO - PROCESS | 1649 | |2;audio-dft;197;203;197;200;201;197;197;197;260;278 13:55:29 INFO - PROCESS | 1649 | |3;audio-fft;80;59;60;86;60;62;59;59;71;63 13:55:29 INFO - PROCESS | 1649 | |4;audio-oscillator;91;71;86;73;73;101;112;104;78;81 13:55:29 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;90;88;90;88;91;87;102;88;91;87 13:55:29 INFO - PROCESS | 1649 | |6;imaging-darkroom;97;97;97;98;98;120;154;112;154;154 13:55:29 INFO - PROCESS | 1649 | |7;imaging-desaturate;145;77;85;144;151;103;92;77;152;133 13:55:29 INFO - PROCESS | 1649 | |8;json-parse-financial;60;56;58;58;59;60;61;61;60;61 13:55:29 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;69;74;71;79;79;72;73;74;74;74 13:55:29 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;84;81;83;86;84;83;82;84;84;82 13:55:29 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;147;150;175;152;151;142;143;144;195;148 13:55:29 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;173;179;171;174;176;172;202;251;179;170 13:55:29 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;78;88;89;79;61;64;65;75;84;95 13:55:29 INFO - PROCESS | 1649 | __end_tp_report 13:55:29 INFO - PROCESS | 1649 | __start_cc_report 13:55:29 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,952 13:55:29 INFO - PROCESS | 1649 | __end_cc_report 13:55:29 INFO - PROCESS | 1649 | __startTimestamp1486763729342__endTimestamp 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | ------- Summary: start ------- 13:55:29 INFO - PROCESS | 1649 | Number of tests: 14 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:128.40 Median:120.00 stddev:19.59 (16.3%) stddev-sans-first:18.06 13:55:29 INFO - PROCESS | 1649 | Values: 156.0 173.0 125.0 120.0 119.0 120.0 118.0 116.0 117.0 120.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:136.00 stddev:14.31 (10.5%) stddev-sans-first:15.00 13:55:29 INFO - PROCESS | 1649 | Values: 133.0 113.0 111.0 140.0 113.0 117.0 139.0 144.0 144.0 114.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:212.70 Median:200.50 stddev:30.05 (15.0%) stddev-sans-first:31.33 13:55:29 INFO - PROCESS | 1649 | Values: 197.0 203.0 197.0 200.0 201.0 197.0 197.0 197.0 260.0 278.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.90 Median:62.50 stddev:9.80 (15.7%) stddev-sans-first:8.97 13:55:29 INFO - PROCESS | 1649 | Values: 80.0 59.0 60.0 86.0 60.0 62.0 59.0 59.0 71.0 63.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:75.50 stddev:14.50 (19.2%) stddev-sans-first:15.31 13:55:29 INFO - PROCESS | 1649 | Values: 91.0 71.0 86.0 73.0 73.0 101.0 112.0 104.0 78.0 81.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:89.00 stddev:4.42 (5.0%) stddev-sans-first:4.68 13:55:29 INFO - PROCESS | 1649 | Values: 90.0 88.0 90.0 88.0 91.0 87.0 102.0 88.0 91.0 87.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:118.10 Median:97.00 stddev:25.93 (26.7%) stddev-sans-first:26.35 13:55:29 INFO - PROCESS | 1649 | Values: 97.0 97.0 97.0 98.0 98.0 120.0 154.0 112.0 154.0 154.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:115.90 Median:114.50 stddev:31.94 (27.9%) stddev-sans-first:32.10 13:55:29 INFO - PROCESS | 1649 | Values: 145.0 77.0 85.0 144.0 151.0 103.0 92.0 77.0 152.0 133.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 13:55:29 INFO - PROCESS | 1649 | Values: 60.0 56.0 58.0 58.0 59.0 60.0 61.0 61.0 60.0 61.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:74.00 stddev:3.14 (4.2%) stddev-sans-first:2.79 13:55:29 INFO - PROCESS | 1649 | Values: 69.0 74.0 71.0 79.0 79.0 72.0 73.0 74.0 74.0 74.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.42 (1.7%) stddev-sans-first:1.48 13:55:29 INFO - PROCESS | 1649 | Values: 84.0 81.0 83.0 86.0 84.0 83.0 82.0 84.0 84.0 82.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:150.50 stddev:16.98 (11.3%) stddev-sans-first:17.78 13:55:29 INFO - PROCESS | 1649 | Values: 147.0 150.0 175.0 152.0 151.0 142.0 143.0 144.0 195.0 148.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:177.50 stddev:25.06 (14.1%) stddev-sans-first:26.22 13:55:29 INFO - PROCESS | 1649 | Values: 173.0 179.0 171.0 174.0 176.0 172.0 202.0 251.0 179.0 170.0 13:55:29 INFO - PROCESS | 1649 | 13:55:29 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:81.50 stddev:11.59 (14.2%) stddev-sans-first:12.30 13:55:29 INFO - PROCESS | 1649 | Values: 78.0 88.0 89.0 79.0 61.0 64.0 65.0 75.0 84.0 95.0 13:55:29 INFO - PROCESS | 1649 | -------- Summary: end -------- 13:55:29 INFO - PROCESS | 1649 | 13:55:30 INFO - TEST-INFO | 1649: exit 0 13:55:30 INFO - TEST-OK | kraken | took 61192ms 13:55:30 INFO - SUITE-END | took 1176s 13:55:30 INFO - Completed test suite (00:19:36) 13:55:30 INFO - javascript benchmark 13:55:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7221.998817985909, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2710.281775329538, 3364.478505831597, 3382.509536117265, 3397.609274933382, 3421.914452138696, 5645.379008309083, 5664.660120392774, 5675.233843431146, 5678.34699009614, 5682.744276507557, 4655.2784318430695, 5604.075327570946, 5667.5749318801045, 5689.203511508382, 5704.172894930243, 4158.835526052695, 4388.517263101072, 5163.664361816479, 5206.921896171561, 5239.685618862862, 5192.909489007294, 5242.239875218091, 5252.212168174785, 5255.76349064293, 5273.446288139748, 5139.537441630253, 5156.974215128919, 5244.711540865251, 5266.683998960056, 5274.55166310864, 4537.750423726694, 5246.108161612516, 5261.184516399964, 5278.604104692164, 5330.093884039684, 3960.5445373782095, 4799.7520644632295, 5107.591392688576, 5218.2955301034635, 5268.5521730652945, 5485.917711234335, 5664.688442135722, 5707.315122185323, 5827.970860145714, 5831.679257640828, 6123.343628574293, 6139.785107521216, 6166.136740856284, 6178.042403427476, 6267.05994100884, 6237.126802247689, 6237.563370564062, 6252.906206406908, 6268.09112678659, 6277.591956522857, 5801.100829371454, 5835.766569337264, 5839.912401313941, 5869.442402971711, 5878.706064696791, 6134.528431832413, 6180.134781130645, 6181.84545386369, 6186.505079593621, 6220.813375598649, 6105.297890742532, 6141.4101092759665, 6175.320714721377, 6177.536684748662, 6230.096635987847, 6164.167837341902, 6172.22847144107, 6218.098375735493, 6234.719437625317, 6251.906221406683, 6002.609830361012, 6089.208402907594, 6151.169592105009, 6194.287656919422, 6238.313785483593, 6258.530610204253, 6260.968695156495, 6294.213223347082, 6301.7164227609865, 6303.149074874833, 4962.602991760723, 4965.056639238605, 4967.7019378837385, 4980.2778597103215, 4983.177775667047, 4344.956550434518, 4364.432623758955, 4387.056782791715, 4461.286194208911, 4472.195004899149, 5688.943110568841, 5711.742971566289, 5787.681677507778, 5790.189373487715, 5835.2122463466885, 6233.0, 6241.032639940817, 6282.371762823681, 6285.057241413824, 6285.717142728497, 5531.308586426697, 5592.189132575835, 5722.399148089391, 5773.88452230953, 5776.855578610568, 5466.098093814556, 5472.343318801769, 5474.671519708751, 5497.175423686479, 5501.202325662836, 6290.276618188876, 6294.968525157345, 6308.936910630835, 6315.873682526416, 6345.619262844337, 5557.666540007613, 6083.026715725463, 6119.106526814536, 6213.844653883508, 6221.564490485804, 6227.252729672468, 6295.213098362705, 6299.118123462627, 6309.842253943504, 6342.39747224013, 5274.736263186902, 6069.241344831896, 6192.0, 6204.3795620437595, 6216.502679785516, 6130.172426722514, 6186.041163619646, 6219.2865527327485, 6232.719527621177, 6281.497480201481, 5019.899602008012, 5998.220231369894, 6021.7591296347655, 6139.658497107545, 6145.248604147797, 6100.969495152496, 6102.908456373069, 6103.3591472894705, 6111.0, 6133.26400831903, 4748.786304616369, 5765.221695071112, 5892.6759028252145, 6001.5798894077, 6026.789062382795, 5937.198478205387, 5990.4908082813445, 5993.250843644544, 6042.365551617193, 6121.724522396414, 5896.882062358814, 5918.763249469973, 5918.763249470146, 5921.17103605487, 5921.792737254175], "value": 5641.08986142437, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.8034065011395, 451.8666993236995, 494.9826756063538, 505.8811179372849, 514.596042106946, 35607.0, 41819.58180418199, 41879.0, 41897.58102418975, 42010.99999999996, 42877.0, 43326.0, 43587.564124358745, 43614.56385436145, 43652.345214821806, 8383.455075420108, 9158.129977652112, 9307.720768376927, 9322.86015709765, 9376.0, 8437.029741579736, 11099.112071034298, 11375.886241137607, 11411.600593979212, 11569.190156689036, 10178.0, 11112.666620001413, 11416.200865939347, 11458.770824583504, 11467.59863404781, 11350.318980861133, 11414.201005929588, 11418.143639227092, 11423.428828558539, 11428.828567571492, 11277.436128193558, 11341.0, 11348.148888833288, 11349.43252837363, 11368.943155284252, 40426.19147617031, 40650.79674601608, 40734.0, 40764.592354076376, 40774.388384174265, 3895.5520115186832, 3953.697761992162, 4010.799460026987, 4011.3581826907553, 4017.1563971566006, 28913.718125619478, 30014.949476768208, 30017.399652006836, 30455.0, 30941.0, 3218.0828463887915, 3229.919252018695, 3237.336346049054, 3266.836658167082, 3305.7851239669344, 498133.50933245465, 503012.0, 503642.4817875924, 503657.48171259277, 504159.0, 61715.0, 61837.07244391338, 62035.6898215506, 62114.0, 62232.75534489285, 64071.0, 64610.030849537296, 64736.67631661812, 64823.40706371692, 65308.020379694346, 16519.752203716955, 16681.83318166827, 16712.74930876038, 16733.16334183286, 16739.74890376621, 11626.128040397005, 11952.223105498115, 12970.092093553361, 12985.415656295489, 13022.804657930139, 19027.14377853, 20222.595548088957, 21143.365699029055, 21777.34667959964, 21786.782132178476, 8731.869021964676, 8913.598888050054, 8964.238039766693, 8991.955040224757, 9120.042395548504, 765.7281665008842, 835.1606635331574, 858.7810108422312, 869.7216890595075, 887.5606574745414, 28656.426871462452, 28662.426751464853, 29227.85386073056, 29629.259268518028, 30788.0, 909.1045320359441, 970.8640790289365, 1027.1833892055834, 1036.8392899100652, 1037.2376303416982, 13763.174209547458, 14565.0, 15272.465463708717, 15429.691406172038, 15456.690866182613, 671641.0, 675721.0, 675990.0, 676792.0, 677314.0, 45699.543004570194, 52641.0, 53535.732321338146, 53879.730601347524, 54083.45916540784, 1325.0989327257557, 1325.15190278222, 1386.6671998720435, 1422.0472283570032, 1422.6372275069998, 20798.064087116418, 27350.316242094108, 27590.862045690446, 28441.857790710914, 28799.8560007207, 36901.44647830231, 43768.78115609402, 44852.55147448484, 44977.32534012058, 45233.64299071033, 509583.0, 583385.0, 586740.0, 586781.0, 587998.0, 21640.458988525414, 22288.554228915655, 24185.516289673757, 24519.38701532476, 24639.0, 40683.389749154376, 40699.1860162801, 41243.587564123976, 41398.58601413947, 41431.7928410356, 28525.429491410472, 33618.831905840314, 33641.495377569845, 34386.312273754884, 35221.471677925365, 33631.82288619887, 34153.65846341505, 34174.31651366909, 34175.0, 34235.14412139716, 33036.50445243371, 33713.83143084367, 33799.83100084484, 34539.4819077709, 35205.76779812797, 30087.699123009366, 31659.84170079135, 31940.84029579837, 31985.360292794478, 32049.67950320467, 23761.9802316805, 24204.63693044641, 24472.021119155033, 24479.0, 25413.74586254114], "value": 19821.473168488923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.65483891916716, 386.57476775546894, 390.7635880292424, 397.21946375372386, 414.0807407555228, 17408.216630251638, 19611.803881961176, 21619.135234590598, 21987.890060549715, 22084.33746987591, 21274.46813829655, 21609.783902160973, 21641.891790541064, 21738.89130554345, 22241.0, 5728.283964504427, 5994.220751302325, 6034.034554471285, 6051.848703782419, 6054.424829641199, 4605.884852878671, 5864.149698293745, 5874.5594080443925, 5908.822735317947, 5926.348101708809, 4231.322988321869, 4433.711808732438, 6367.395097465734, 6662.300458451866, 6670.833229169261, 6438.581492203039, 6605.372489613479, 6644.302348253436, 6720.3279672032895, 6723.764668236613, 5804.0, 5828.446297601721, 5830.5044071254, 5837.211976383219, 5838.912416313716, 25286.87356563224, 25308.873455632787, 25350.112746053983, 26109.0, 26177.476450471073, 2969.228000719807, 3074.3851229753914, 3095.2107212660626, 3118.251619611277, 3122.500399936022, 15891.60270993223, 15944.96357736755, 15995.0, 16100.114493702842, 16233.2695028724, 1562.617158796091, 1845.5386153461634, 1848.4639454558162, 1858.7583614130076, 1864.6363959027994, 120706.0, 123231.0, 124293.0, 124799.37600312031, 126300.0, 11175.552977880794, 11537.192396532162, 11545.307281563133, 11611.535538578362, 11744.29534227949, 14007.579772606838, 14079.788803167961, 14108.2945852709, 14118.364673589713, 14144.504942326968, 8582.87125693115, 8798.912010879809, 8808.647654093893, 8825.117488251124, 8935.821283574292, 8884.0, 8884.97822750379, 8935.597898094602, 9008.41445306053, 9026.368154229272, 7271.8909216360735, 7400.407967362706, 7434.3309102181065, 7439.590822504814, 7457.216992215739, 1924.6246981838408, 1982.2467462364498, 1982.4548249231289, 1984.374921899597, 1985.2852972929734, 400.96550898681335, 401.26768647218944, 421.55736476699343, 422.9133027729308, 430.77814925313487, 10647.787044259072, 11350.14873884462, 11926.761464770829, 11999.520019199133, 12213.816792748115, 443.37705523739197, 443.8158164361754, 447.8052047359344, 452.5271091709106, 454.79306915353436, 4651.930221046687, 5584.832455026356, 6153.230846144232, 6237.438630523184, 6318.462930650854, 538891.0, 647732.0, 753154.0, 753335.0, 759345.0, 129101.70898291084, 157864.0, 163282.0, 165059.0, 167177.82055448467, 965.8792650918635, 1008.2236677758232, 1042.1610603464133, 1042.3016578892161, 1043.5512729526376, 19717.0, 20136.295229666892, 20224.59550808946, 20427.4893127673, 20622.484437889172, 47573.76213118912, 52718.20922686086, 53757.0, 53818.73090634522, 54040.729796350766, 82904.0, 83524.16475835163, 84311.0, 84761.57619211865, 85352.1464785369, 8532.445391049561, 8612.698555550525, 8796.780080498038, 8861.0, 8906.688265910661, 7647.082350118021, 8220.095789463036, 9310.487923164292, 11273.0, 12805.935970320088, 11094.500747466222, 11303.660890173307, 11428.599998999995, 11510.48202830858, 11638.6508404748, 11501.022413094981, 11511.07911367072, 11532.308061516336, 11552.364619945984, 11568.47941842636, 9532.85700714476, 11602.47788849487, 11815.763684726086, 11909.642710718692, 12088.576899808464, 7937.801554961172, 8305.916940830755, 8598.65605375803, 8710.21608055278, 8724.0, 9365.391249568756, 11210.607628733282, 11521.711957200801, 11812.527498899948, 11894.762104758029], "value": 9388.084108194234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.0, 1424.750668632989, 1431.627776778038, 1441.7476941535233, 1450.187894778924, 7513.962430187841, 7764.728234511793, 8124.146964568717, 8586.484810911343, 8605.784855378619, 8084.15116412777, 8271.751847444571, 8303.958480207606, 8437.746867593967, 8453.535055571941, 1911.550785565391, 2358.599038163508, 2361.480474295652, 2364.6453032045247, 2375.5130198309307, 1729.7578339032482, 2136.540643761591, 2330.207729372013, 2371.4071482129466, 2372.9288121356385, 1961.695937129747, 2263.807576356012, 2344.109238489372, 2346.9647955280684, 2349.7767712067325, 2070.1098527633185, 2309.688192094071, 2329.939877355799, 2348.694669692929, 2348.8473249238746, 2144.970414201192, 2284.383216531544, 2311.202635090891, 2363.5391098735754, 2371.8814059296965, 7546.207648196915, 8068.878966815502, 8401.453905496122, 8512.319014478826, 8514.446560973578, 5130.820421285237, 5255.737213139328, 5293.86765330866, 5298.999999999962, 5309.283246761676, 3502.1944952660774, 3532.438981738245, 3546.0, 3581.6418358164237, 3628.818559072036, 1222.9633111006683, 1229.975400491985, 1269.7841366967639, 1284.9614511564669, 1290.135609141868, 10831.729206769895, 10920.453977301104, 10938.835917461245, 10950.945245273882, 10971.615993440271, 4350.1734670412525, 4430.357598148251, 4470.374147619336, 4472.0832229393545, 4779.880502987384, 9523.238140948708, 9639.566219520138, 9653.0, 9654.082862128087, 9656.71029869105, 5234.26720259164, 5315.176147697036, 5315.176147697113, 5320.0, 5325.4674532547215, 4654.813807447732, 4850.514948505192, 4852.51474852519, 4862.978774457403, 4871.244957031595, 3900.726949113535, 3931.8230679619487, 3964.0684439156776, 4000.0599859033105, 4037.6164264394833, 1177.776222517719, 1217.3487184356327, 1273.726148877977, 1277.9488820447077, 1300.856905740368, 724.6774636288794, 751.4289140253446, 775.8254392761584, 789.2975252025702, 822.5352675738188, 4865.318855360181, 5514.420985796514, 5537.861553461115, 5662.122371032497, 5712.80005199816, 966.4201479112477, 978.1929907826072, 990.5542505872386, 1004.1765752083368, 1019.8929112443235, 3732.6080761519647, 3771.73597848148, 3784.6026167252044, 3866.439366291872, 3891.3968334908136, 9638.855417168748, 10151.593936242616, 10156.339837910513, 10166.339187952759, 10185.796284074277, 9742.805143897082, 9927.801443971224, 10063.19494440443, 10152.23858210637, 10168.034036766496, 7824.804379890548, 7914.366850651934, 8014.559199244098, 8020.318272946864, 8026.197380261927, 5431.185322201543, 5453.972730136324, 5533.170024496358, 5570.6657600544095, 5584.832455026356, 9202.309826762885, 9207.447553146832, 9290.349675522648, 9398.577064032272, 9406.95296523513, 9049.954750226207, 9282.62869485213, 9343.626254949726, 9381.624735010522, 9464.19554337889, 6947.826304342432, 7076.0, 7275.417966562768, 7365.668544915385, 7379.114506259283, 8047.678092876454, 8068.1528439513, 8144.918550814653, 8145.42981991255, 8163.306118979954, 6214.9067763984485, 7096.929030709834, 7170.211276759656, 7175.067241258603, 7201.531900426456, 5895.764169433346, 6906.447484201151, 7029.191642961125, 7083.893741593984, 7099.219085900443, 5796.536277097738, 6361.2048493938255, 6400.615963042233, 6489.1888513935755, 6504.219493660791, 3888.766673999569, 4078.5105787305715, 4875.414950205856, 4979.701217926936, 4988.102141614544, 4948.554630083309, 4987.800487980585, 4992.750362481789, 5088.211327244283, 5101.7704203310195], "value": 4412.332488283565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.8501229483617, 358.0708062577611, 362.6228722128986, 365.67637640688, 375.5962340483979, 4486.596206341429, 4546.840860569877, 4722.527747225276, 5094.490550944904, 5246.711430871301, 5039.773210205541, 5199.194124910645, 5237.397699264586, 5243.318368612085, 5270.49930256626, 3496.2483066140776, 4147.7926103694845, 4162.833486660537, 4181.665466762667, 4193.81127849246, 3497.720182385403, 3829.3872980323013, 4054.97972510137, 4188.81150348235, 4195.538490766014, 4043.3126368517273, 4052.007258221725, 4053.6351728344443, 4073.714839961204, 4075.4294398784195, 4067.1052368478886, 4077.7961101944784, 4081.9591804082024, 4083.4487344208746, 4097.672186225095, 3484.8257587120797, 3519.483569247974, 3528.6824185823143, 3536.2397084626673, 3549.2369140634887, 4704.576588107053, 4981.825636102755, 5065.848024559269, 5155.0358543837065, 5162.805807531784, 4605.30920361945, 4642.792873852789, 4644.883877903079, 4654.767261636905, 4682.518265319352, 5351.331083614548, 5683.772649094031, 5694.0, 5708.915306091871, 5712.685802280873, 3775.414810704345, 3863.053551879779, 3890.649841514249, 3904.39481880309, 3908.511436070491, 5349.812756553502, 5895.170318247266, 5939.970300148515, 5965.46467751204, 6012.278526576839, 3305.5372247885316, 3904.7852368120025, 3929.31237033518, 3962.3660214365564, 3974.2647610192207, 3190.3938251732097, 3411.880584179542, 3524.718022558189, 3702.33357995558, 3810.123671555558, 4623.53764623535, 4650.488446270908, 4652.278896771006, 4665.393498845128, 4699.788509517011, 4577.542245775396, 4777.300825033844, 5283.996040752321, 5716.371199168088, 5745.299709136699, 1126.318577260762, 1202.8392601139942, 1249.8250244965711, 1253.573784913134, 1286.7169222770976, 741.9390271911219, 871.9956400218085, 887.0907319996926, 889.1686273334453, 889.58634235081, 5044.344235249394, 5062.860856307301, 5071.695698258116, 5079.644424890223, 5096.745162741848, 4758.857234282977, 4972.8756781080765, 5020.748962551931, 5417.3770016447825, 5580.804671836548, 4212.0, 4491.730496170175, 4560.879191176119, 4580.702254353457, 4700.130475861976, 2425.4300239443714, 2510.221831232324, 2698.257979055775, 2759.889604415801, 2772.9445411091665, 4573.085382923428, 5404.91892621611, 5419.647722897999, 5488.780448782004, 5567.66594004361, 4277.807498662568, 5555.500004999489, 5767.279090113736, 5768.942310576925, 6050.90923636137, 5095.031943930641, 5218.060749065129, 5559.8888022240135, 5972.805438912235, 6026.5178785697035, 4760.714357138583, 4956.859922217838, 5864.856353011121, 5915.70421478933, 5923.911141332969, 5442.231274835774, 5775.314478767394, 5828.883422331614, 5830.125481177857, 5863.296404431496, 6089.421504957022, 6105.358937311518, 6123.357047510125, 6128.9693551531955, 6131.294901086254, 3530.0524062408176, 3812.790296533717, 3945.861894833667, 3953.102510794777, 3967.3057214986684, 5110.488951105009, 5565.5825813063375, 5713.971430142823, 5775.0, 5843.853903652443, 5187.533122019036, 5549.0289199389135, 5562.888742225214, 5685.374608793112, 5693.857653558694, 4987.102321582005, 5388.892222155457, 5645.717714114196, 5679.460451257124, 5688.488036076607, 5314.813981510629, 5513.924784666951, 5545.944540554543, 5577.3028371453565, 5612.691301978431, 4757.740947451007, 5693.5445164387575, 5715.599908006399, 5717.113847353667, 5742.942570574241, 4668.85993420198, 4907.2393778964315, 5558.555315574825, 5567.331920169606, 5581.0], "value": 4068.868974931781, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6329885574379, 635.7457017193125, 669.4677731203692, 760.9543427394357, 790.2374208888423, 14695.33870975806, 15197.316120774563, 15681.843181568182, 15727.056376617411, 15831.208439578018, 14211.502597409093, 14366.425342986295, 14505.492307769204, 14522.636934076627, 14523.709525809478, 812.2446125103636, 832.1678321678322, 849.8342823149488, 851.6976473351964, 852.0669866496177, 670.9329067093277, 692.2800287700785, 831.8128421105233, 854.4318028511033, 860.42781550269, 897.3942588752599, 911.7994041310934, 912.5938957164065, 913.9086091390874, 916.9908300916973, 897.5243121145803, 903.3405613901889, 903.3495882964255, 905.1446383167909, 906.5331354352546, 667.2060248304502, 671.781670956941, 675.7736158386946, 676.1075380497745, 678.1049015299807, 14956.62608434787, 15436.845631543652, 16056.357745690158, 16121.0, 16188.271527781279, 14248.786268205986, 14467.421303147861, 14677.633059173606, 14685.48600798967, 14742.410303587843, 11293.265937714023, 11380.317180969168, 11524.539018439253, 11755.764884702257, 11954.940225298906, 3651.5618125824803, 3703.777773333609, 3736.7010639148803, 3878.0111071676824, 3878.534575850916, 93897.0, 104364.47817760939, 109209.0, 109376.45311773391, 110128.9999999992, 10844.13246940243, 10952.780944381067, 11225.158113141548, 11437.656870293904, 11503.309801411775, 22992.88503557505, 23014.079436822674, 23337.0, 23528.529429411316, 23554.646680299807, 7405.3463181953475, 7461.0, 7468.663910124057, 7541.095068591804, 7656.081270247606, 4096.651784598283, 4176.2900306947895, 4182.1008483176265, 4215.57844215576, 4235.97882010588, 3027.666956634768, 3533.0, 3604.6395360463744, 3649.361361761681, 3651.1967367179177, 624.622103627308, 633.8954072577973, 636.4431122767578, 640.4620119099978, 658.275896513831, 649.4122818848949, 669.3139531979759, 686.2485578291762, 704.2218348724688, 715.5563550598662, 9612.375195612263, 10385.792284154426, 10389.480525973822, 10391.84412233817, 10586.89413105859, 675.1054852320694, 695.4644923408947, 696.1646024770296, 697.083335413929, 697.1982220446425, 4746.240601503743, 4952.380952380952, 5017.147084995559, 5017.172166592544, 5018.172001619692, 75481.11297217614, 90097.0, 106855.46572267244, 107069.0, 107652.0, 72827.0, 78863.60568197122, 80279.0, 85652.0, 96882.54676179722, 74965.62517187488, 75411.73764787066, 76528.0, 78466.21533784589, 79253.60373198097, 10486.423246721504, 10991.725206869573, 11044.723881903017, 11044.779104417707, 11191.0, 51031.744841275555, 52438.0, 52580.0, 53841.46158538521, 54578.454215457336, 52291.0, 65728.34271657413, 66042.66978665076, 69195.65402173158, 72228.0, 12608.936955315165, 12615.0, 12656.17734847232, 13057.412416441093, 13880.0, 12967.675808104872, 13565.321733913068, 14466.20435876037, 14920.7761883574, 15324.927255092036, 13536.59390218295, 13639.522616708367, 13701.794473082713, 13916.930415347859, 14181.929090354482, 13545.353322463849, 13570.253636050113, 13649.795253071014, 13719.1082579632, 13735.656608584864, 13289.734205316034, 13370.264635445144, 13389.732205355644, 13741.931290343484, 13772.724545509234, 11411.828822567833, 11416.257943233662, 11428.71428214268, 11638.5344586219, 11830.585929492427, 10836.620718274822, 11021.559137634726, 11032.889671103187, 11054.281471704313, 11081.501332439899], "value": 7527.996940244722, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 173.0, 125.0, 120.0, 119.0, 120.0, 118.0, 116.0, 117.0, 120.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 113.0, 111.0, 140.0, 113.0, 117.0, 139.0, 144.0, 144.0, 114.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 197.0, 200.0, 201.0, 197.0, 197.0, 197.0, 260.0, 278.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 86.0, 60.0, 62.0, 59.0, 59.0, 71.0, 63.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 86.0, 73.0, 73.0, 101.0, 112.0, 104.0, 78.0, 81.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 88.0, 91.0, 87.0, 102.0, 88.0, 91.0, 87.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 98.0, 98.0, 120.0, 154.0, 112.0, 154.0, 154.0], "value": 118.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 77.0, 85.0, 144.0, 151.0, 103.0, 92.0, 77.0, 152.0, 133.0], "value": 115.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 58.0, 58.0, 59.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 71.0, 79.0, 79.0, 72.0, 73.0, 74.0, 74.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 86.0, 84.0, 83.0, 82.0, 84.0, 84.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 175.0, 152.0, 151.0, 142.0, 143.0, 144.0, 195.0, 148.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 179.0, 171.0, 174.0, 176.0, 172.0, 202.0, 251.0, 179.0, 170.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 88.0, 89.0, 79.0, 61.0, 64.0, 65.0, 75.0, 84.0, 95.0], "value": 77.8, "unit": "score"}]}]} 13:55:30 INFO - Return code: 0 13:55:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:55:30 ERROR - # TBPL SUCCESS # 13:55:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:55:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:55:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:55:30 INFO - 2017-02-10 13:55:30.643 screenresolution[1654:10379] starting screenresolution argv=screenresolution get 13:55:30 INFO - 2017-02-10 13:55:30.646 screenresolution[1654:10379] Display 0: 1600x1200x32@60 13:55:30 INFO - 2017-02-10 13:55:30.652 screenresolution[1655:10382] starting screenresolution argv=screenresolution list 13:55:30 INFO - Available Modes on Display 0 13:55:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:55:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:55:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:55:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:55:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:55:30 INFO - Intel Iris: 13:55:30 INFO - Chipset Model: Intel Iris 13:55:30 INFO - Type: GPU 13:55:30 INFO - Bus: Built-In 13:55:30 INFO - VRAM (Dynamic, Max): 1536 MB 13:55:30 INFO - Vendor: Intel (0x8086) 13:55:30 INFO - Device ID: 0x0a2e 13:55:30 INFO - Revision ID: 0x0009 13:55:30 INFO - Displays: 13:55:30 INFO - Display: 13:55:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:55:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:55:30 INFO - Display Serial Number: 1600x1200 60 13:55:30 INFO - Main Display: Yes 13:55:30 INFO - Mirror: Off 13:55:30 INFO - Online: Yes 13:55:30 INFO - Rotation: Supported 13:55:30 INFO - Return code: 0 13:55:30 INFO - Running post-action listener: _resource_record_post_action 13:55:30 INFO - [mozharness: 2017-02-10 21:55:30.886937Z] Finished run-tests step (success) 13:55:30 INFO - Running post-run listener: _resource_record_post_run 13:55:30 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38722048; Write bytes: 510274560; Read time: 244; Write time: 1600 13:55:30 INFO - TinderboxPrint: CPU usage
54.3% 13:55:30 INFO - TinderboxPrint: I/O read bytes / time
38,722,048 / 244 13:55:30 INFO - TinderboxPrint: I/O write bytes / time
510,274,560 / 1,600 13:55:30 INFO - TinderboxPrint: CPU idle
2,187.3 (45.7%) 13:55:30 INFO - TinderboxPrint: CPU system
962.2 (20.1%) 13:55:30 INFO - TinderboxPrint: CPU user
1,640.2 (34.2%) 13:55:30 INFO - TinderboxPrint: Swap in / out
246,493,184 / 0 13:55:30 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205386240; Write bytes: 200361984; Read time: 15716; Write time: 439 13:55:30 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36657664; Write bytes: 298947584; Read time: 225; Write time: 1125 13:55:31 INFO - Running post-run listener: _upload_blobber_files 13:55:31 INFO - Blob upload gear active. 13:55:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:55:31 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 13:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:55:31 INFO - (blobuploader) - INFO - Open directory for files ... 13:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:33 INFO - (blobuploader) - INFO - Done attempting. 13:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:34 INFO - (blobuploader) - INFO - Done attempting. 13:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:35 INFO - (blobuploader) - INFO - Done attempting. 13:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:37 INFO - (blobuploader) - INFO - Done attempting. 13:55:37 INFO - (blobuploader) - INFO - Iteration through files over. 13:55:37 INFO - Return code: 0 13:55:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:55:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:55:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/500d563cbcbb6dc99ad14412a85fc687eb3db9a13c13c4fdb41a9c7b1348ceaa89a533d7c766bcc54e9070f237178e7f78b215cefbba9e5869b3913900177730", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d092c084c7691846a8c0d4ace3154739f98ea2e663ddf70504e7edd0d048d297084fc6a9ad2c44ef8f8ad969f76dbc9db1d1bb48f2427bee962677c229eca56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9566d0ebf1ec32908eec208739c9644a6ec69caa9598e06ee1eecd9e3c4c44688391af6c04ceadd990a8f0eed91757a1427d3d1c3957492032547277654c2394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07d9af80d6ba7731d1b23f492e224eb44b86246c95ede0abdc83ce8f8308a5bef0e6912d2dcaa92975ef8e0004be0a3f17c0e563a477ee8c5ddef0b4dd76eb9d"} 13:55:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:55:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:55:37 INFO - Contents: 13:55:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/500d563cbcbb6dc99ad14412a85fc687eb3db9a13c13c4fdb41a9c7b1348ceaa89a533d7c766bcc54e9070f237178e7f78b215cefbba9e5869b3913900177730", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d092c084c7691846a8c0d4ace3154739f98ea2e663ddf70504e7edd0d048d297084fc6a9ad2c44ef8f8ad969f76dbc9db1d1bb48f2427bee962677c229eca56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9566d0ebf1ec32908eec208739c9644a6ec69caa9598e06ee1eecd9e3c4c44688391af6c04ceadd990a8f0eed91757a1427d3d1c3957492032547277654c2394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07d9af80d6ba7731d1b23f492e224eb44b86246c95ede0abdc83ce8f8308a5bef0e6912d2dcaa92975ef8e0004be0a3f17c0e563a477ee8c5ddef0b4dd76eb9d"} 13:55:37 INFO - Running post-run listener: copy_logs_to_upload_dir 13:55:37 INFO - Copying logs to upload dir... 13:55:37 INFO - mkdir: /builds/slave/test/build/upload/logs 13:55:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.756997 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-10 13:55:37.587655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 13:55:37.590835) ========= 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.2DoigI45lw/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.Wk7A0o5amG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/500d563cbcbb6dc99ad14412a85fc687eb3db9a13c13c4fdb41a9c7b1348ceaa89a533d7c766bcc54e9070f237178e7f78b215cefbba9e5869b3913900177730", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d092c084c7691846a8c0d4ace3154739f98ea2e663ddf70504e7edd0d048d297084fc6a9ad2c44ef8f8ad969f76dbc9db1d1bb48f2427bee962677c229eca56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9566d0ebf1ec32908eec208739c9644a6ec69caa9598e06ee1eecd9e3c4c44688391af6c04ceadd990a8f0eed91757a1427d3d1c3957492032547277654c2394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07d9af80d6ba7731d1b23f492e224eb44b86246c95ede0abdc83ce8f8308a5bef0e6912d2dcaa92975ef8e0004be0a3f17c0e563a477ee8c5ddef0b4dd76eb9d"} build_url:https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011002 build_url: 'https://queue.taskcluster.net/v1/task/fOu0DOGSSJ2KCmGnPR_uIQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/500d563cbcbb6dc99ad14412a85fc687eb3db9a13c13c4fdb41a9c7b1348ceaa89a533d7c766bcc54e9070f237178e7f78b215cefbba9e5869b3913900177730", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d092c084c7691846a8c0d4ace3154739f98ea2e663ddf70504e7edd0d048d297084fc6a9ad2c44ef8f8ad969f76dbc9db1d1bb48f2427bee962677c229eca56f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9566d0ebf1ec32908eec208739c9644a6ec69caa9598e06ee1eecd9e3c4c44688391af6c04ceadd990a8f0eed91757a1427d3d1c3957492032547277654c2394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07d9af80d6ba7731d1b23f492e224eb44b86246c95ede0abdc83ce8f8308a5bef0e6912d2dcaa92975ef8e0004be0a3f17c0e563a477ee8c5ddef0b4dd76eb9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 13:55:37.626490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:55:37.626849) ========= 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.2DoigI45lw/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.Wk7A0o5amG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.005071 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:55:37.674457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 13:55:37.674793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 13:55:37.675184) ========= ========= Total master_lag: 0.19 =========