builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0271 starttime: 1476972585.44 results: success (0) buildid: 20161020061049 builduid: 3989b9eae63f42e582365eaacaabd433 revision: b04e95606673fff324ef0ddb09de846f7b7eaf82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.439446) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.439950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.440246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.464850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.465236) ========= 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.qVUBEawOtN/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.PgGmA2kBvd/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 --2016-10-20 07:09:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-10-20 07:09:45 (40.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.627341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.627667) ========= 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.qVUBEawOtN/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.PgGmA2kBvd/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.023999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:45.676700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 07:09:45.677054) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b04e95606673fff324ef0ddb09de846f7b7eaf82 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b04e95606673fff324ef0ddb09de846f7b7eaf82 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qVUBEawOtN/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.PgGmA2kBvd/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 2016-10-20 07:09:45,747 truncating revision to first 12 chars 2016-10-20 07:09:45,747 Setting DEBUG logging. 2016-10-20 07:09:45,747 attempt 1/10 2016-10-20 07:09:45,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b04e95606673?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 07:09:46,490 unpacking tar archive at: mozilla-central-b04e95606673/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 07:09:46.693156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:46.693493) ========= script_repo_revision: b04e95606673fff324ef0ddb09de846f7b7eaf82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:46.693961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:46.694227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:46.713188) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-20 07:09:46.713563) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qVUBEawOtN/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.PgGmA2kBvd/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:09:46 INFO - MultiFileLogger online at 20161020 07:09:46 in /builds/slave/test 07:09:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:09:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:46 INFO - {'append_to_log': False, 07:09:46 INFO - 'base_work_dir': '/builds/slave/test', 07:09:46 INFO - 'blob_upload_branch': 'Firefox', 07:09:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:46 INFO - 'branch': 'Firefox', 07:09:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:46 INFO - 'config_files': ('talos/mac_config.py',), 07:09:46 INFO - 'default_actions': ('clobber', 07:09:46 INFO - 'read-buildbot-config', 07:09:46 INFO - 'download-and-extract', 07:09:46 INFO - 'populate-webroot', 07:09:46 INFO - 'create-virtualenv', 07:09:46 INFO - 'install', 07:09:46 INFO - 'run-tests'), 07:09:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:46 INFO - 'download_minidump_stackwalk': True, 07:09:46 INFO - 'download_symbols': 'ondemand', 07:09:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:46 INFO - 'installer_path': 'installer.exe', 07:09:46 INFO - 'log_level': 'info', 07:09:46 INFO - 'log_name': 'talos', 07:09:46 INFO - 'log_to_console': True, 07:09:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:09:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:09:46 INFO - 'opt_config_files': (), 07:09:46 INFO - 'pip_index': False, 07:09:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:09:46 INFO - 'cmd': ('bash', 07:09:46 INFO - '-c', 07:09:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:09:46 INFO - 'enabled': True, 07:09:46 INFO - 'halt_on_failure': False, 07:09:46 INFO - 'name': 'check_screen_resolution'},), 07:09:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:09:46 INFO - 'cmd': ('bash', 07:09:46 INFO - '-c', 07:09:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:09:46 INFO - 'enabled': True, 07:09:46 INFO - 'halt_on_failure': False, 07:09:46 INFO - 'name': 'check_screen_resolution'},), 07:09:46 INFO - 'run_cmd_checks_enabled': True, 07:09:46 INFO - 'sps_profile': False, 07:09:46 INFO - 'sps_profile_interval': 0, 07:09:46 INFO - 'suite': 'dromaeojs-e10s', 07:09:46 INFO - 'system_bits': '32', 07:09:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:46 INFO - 'title': 't-yosemite-r7-0271', 07:09:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:46 INFO - 'use_talos_json': True, 07:09:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:46 INFO - 'work_dir': 'build'} 07:09:46 INFO - [mozharness: 2016-10-20 14:09:46.919512Z] Running clobber step. 07:09:46 INFO - Running pre-action listener: _resource_record_pre_action 07:09:46 INFO - Running main action method: clobber 07:09:46 INFO - rmtree: /builds/slave/test/build 07:09:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:49 INFO - Running post-action listener: _resource_record_post_action 07:09:49 INFO - [mozharness: 2016-10-20 14:09:49.039079Z] Finished clobber step (success) 07:09:49 INFO - [mozharness: 2016-10-20 14:09:49.039199Z] Running read-buildbot-config step. 07:09:49 INFO - Running pre-action listener: _resource_record_pre_action 07:09:49 INFO - Running main action method: read_buildbot_config 07:09:49 INFO - Using buildbot properties: 07:09:49 INFO - { 07:09:49 INFO - "project": "", 07:09:49 INFO - "product": "firefox", 07:09:49 INFO - "script_repo_revision": "production", 07:09:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:09:49 INFO - "repository": "", 07:09:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:09:49 INFO - "buildid": "20161020061049", 07:09:49 INFO - "pgo_build": "False", 07:09:49 INFO - "basedir": "/builds/slave/test", 07:09:49 INFO - "buildnumber": 12, 07:09:49 INFO - "slavename": "t-yosemite-r7-0271", 07:09:49 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:09:49 INFO - "platform": "yosemite_r7", 07:09:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:09:49 INFO - "branch": "mozilla-central", 07:09:49 INFO - "repo_path": "mozilla-central", 07:09:49 INFO - "revision": "b04e95606673fff324ef0ddb09de846f7b7eaf82", 07:09:49 INFO - "stage_platform": "macosx64", 07:09:49 INFO - "builduid": "3989b9eae63f42e582365eaacaabd433", 07:09:49 INFO - "slavebuilddir": "test" 07:09:49 INFO - } 07:09:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 07:09:49 INFO - Running post-action listener: _resource_record_post_action 07:09:49 INFO - [mozharness: 2016-10-20 14:09:49.042461Z] Finished read-buildbot-config step (success) 07:09:49 INFO - [mozharness: 2016-10-20 14:09:49.042596Z] Running download-and-extract step. 07:09:49 INFO - Running pre-action listener: _resource_record_pre_action 07:09:49 INFO - Running main action method: download_and_extract 07:09:49 INFO - mkdir: /builds/slave/test/build/tests 07:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:49 INFO - trying https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 07:09:49 INFO - Downloading https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 07:09:50 INFO - Downloaded 1199 bytes. 07:09:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:09:50 INFO - Using the following test package requirements: 07:09:50 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:09:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 07:09:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 07:09:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'jsshell-mac.zip'], 07:09:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 07:09:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:09:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 07:09:50 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 07:09:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 07:09:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:09:50 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 07:09:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:09:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:09:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:09:50 INFO - Fetch https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:09:50 INFO - Http code: 200 07:09:50 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 07:09:50 INFO - x-amz-cf-id: XS8Fv4K5QTiS99dKTpCrz5HVEKT_XXNUcJMG577smbGnl2Li2JXxKA== 07:09:50 INFO - x-amz-version-id: TQFETOfSG.148ufpF5u_CjjQRxLZkTd7 07:09:50 INFO - Expected file size: 16504665 07:09:50 INFO - Obtained file size: 16504665 07:09:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:09:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:09:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:09:57 INFO - Fetch https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:09:58 INFO - Http code: 200 07:09:58 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 07:09:58 INFO - x-amz-cf-id: wxulLyqShfVuvD4gYvLCiNfkvrr96dJNtDkeynG-Uus3kqvZdls26Q== 07:09:58 INFO - x-amz-version-id: TQFETOfSG.148ufpF5u_CjjQRxLZkTd7 07:09:58 INFO - Expected file size: 16504665 07:09:58 INFO - Obtained file size: 16504665 07:10:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 07:10:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:10:04 INFO - Fetch https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 07:10:05 INFO - Http code: 200 07:10:05 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 07:10:05 INFO - x-amz-cf-id: kOg0J-1M87TTvObWt-87aQG5Pv3esI-GWLVsm2wqXD9woZX3xmLGaA== 07:10:05 INFO - x-amz-version-id: SNtYV7gD2LaEFZ.J4fmnsu_q6tAmIcbK 07:10:06 INFO - Expected file size: 14409028 07:10:06 INFO - Obtained file size: 14409028 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:06 INFO - trying https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 07:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 07:10:09 INFO - Downloaded 111637379 bytes. 07:10:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:10:09 INFO - mkdir: /builds/slave/test/properties 07:10:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:09 INFO - Contents: 07:10:09 INFO - build_url:https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:10:10 INFO - Running post-action listener: _resource_record_post_action 07:10:10 INFO - Running post-action listener: set_extra_try_arguments 07:10:10 INFO - [mozharness: 2016-10-20 14:10:10.014101Z] Finished download-and-extract step (success) 07:10:10 INFO - [mozharness: 2016-10-20 14:10:10.014235Z] Running populate-webroot step. 07:10:10 INFO - Running pre-action listener: _resource_record_pre_action 07:10:10 INFO - Running main action method: populate_webroot 07:10:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:10 INFO - '--tppagecycles', 07:10:10 INFO - '7'], 07:10:10 INFO - 'tests': ['tsvgm']}}, 07:10:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:10:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['damp', 'tps']}, 07:10:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'tests': ['damp', 'tps']}, 07:10:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['dromaeo_dom']}, 07:10:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['basic_compositor_video']}, 07:10:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:10:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['a11yr', 07:10:10 INFO - 'ts_paint', 07:10:10 INFO - 'tpaint', 07:10:10 INFO - 'sessionrestore', 07:10:10 INFO - 'sessionrestore_no_auto_restore', 07:10:10 INFO - 'tabpaint']}, 07:10:10 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:10 INFO - 'ts_paint', 07:10:10 INFO - 'tpaint', 07:10:10 INFO - 'sessionrestore', 07:10:10 INFO - 'sessionrestore_no_auto_restore', 07:10:10 INFO - 'tabpaint']}, 07:10:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:10:10 INFO - 'ts_paint', 07:10:10 INFO - 'tpaint', 07:10:10 INFO - 'sessionrestore', 07:10:10 INFO - 'sessionrestore_no_auto_restore', 07:10:10 INFO - 'tabpaint']}, 07:10:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:10:10 INFO - 'ts_paint', 07:10:10 INFO - 'tpaint', 07:10:10 INFO - 'sessionrestore', 07:10:10 INFO - 'sessionrestore_no_auto_restore', 07:10:10 INFO - 'tabpaint']}, 07:10:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['a11yr', 07:10:10 INFO - 'ts_paint', 07:10:10 INFO - 'tpaint', 07:10:10 INFO - 'sessionrestore', 07:10:10 INFO - 'sessionrestore_no_auto_restore', 07:10:10 INFO - 'tabpaint']}, 07:10:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['a11yr', 07:10:10 INFO - 'ts_paint', 07:10:10 INFO - 'tpaint', 07:10:10 INFO - 'sessionrestore', 07:10:10 INFO - 'sessionrestore_no_auto_restore', 07:10:10 INFO - 'tabpaint']}, 07:10:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['tsvgx', 07:10:10 INFO - 'tsvgr_opacity', 07:10:10 INFO - 'tart', 07:10:10 INFO - 'tscrollx', 07:10:10 INFO - 'cart']}, 07:10:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:10 INFO - 'tsvgr_opacity', 07:10:10 INFO - 'tart', 07:10:10 INFO - 'tscrollx', 07:10:10 INFO - 'cart']}, 07:10:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'talos_options': ['--disable-e10s'], 07:10:10 INFO - 'tests': ['tp5o']}, 07:10:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'tests': ['tp5o']}, 07:10:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'talos_options': ['--disable-e10s', 07:10:10 INFO - '--xperf_path', 07:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:10 INFO - 'tests': ['tp5n']}, 07:10:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:10 INFO - 'talos_options': ['--xperf_path', 07:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:10 INFO - 'tests': ['tp5n']}}, 07:10:10 INFO - 'talos.zip': {'path': '', 07:10:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:10 INFO - Running post-action listener: _resource_record_post_action 07:10:10 INFO - [mozharness: 2016-10-20 14:10:10.033188Z] Finished populate-webroot step (success) 07:10:10 INFO - [mozharness: 2016-10-20 14:10:10.033296Z] Running create-virtualenv step. 07:10:10 INFO - Running pre-action listener: _resource_record_pre_action 07:10:10 INFO - Running main action method: create_virtualenv 07:10:10 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:10:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:10 INFO - Using real prefix '/tools/python27' 07:10:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:13 INFO - Installing pip.................done. 07:10:13 INFO - Return code: 0 07:10:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:10:14 INFO - Reading from file tmpfile_stdout 07:10:14 INFO - Output received: 07:10:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:10:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:14 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:14 INFO - 'HOME': '/Users/cltbld', 07:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:14 INFO - 'LOGNAME': 'cltbld', 07:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:14 INFO - 'MOZ_NO_REMOTE': '1', 07:10:14 INFO - 'NO_EM_RESTART': '1', 07:10:14 INFO - 'PAGER': '/bin/cat', 07:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:14 INFO - 'PWD': '/builds/slave/test', 07:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:14 INFO - 'SHELL': '/bin/bash', 07:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:14 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:14 INFO - 'USER': 'cltbld', 07:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:14 INFO - 'XPC_FLAGS': '0x0', 07:10:14 INFO - 'XPC_SERVICE_NAME': '0', 07:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:10:14 INFO - Cleaning up... 07:10:14 INFO - Return code: 0 07:10:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:14 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:14 INFO - 'HOME': '/Users/cltbld', 07:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:14 INFO - 'LOGNAME': 'cltbld', 07:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:14 INFO - 'MOZ_NO_REMOTE': '1', 07:10:14 INFO - 'NO_EM_RESTART': '1', 07:10:14 INFO - 'PAGER': '/bin/cat', 07:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:14 INFO - 'PWD': '/builds/slave/test', 07:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:14 INFO - 'SHELL': '/bin/bash', 07:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:14 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:14 INFO - 'USER': 'cltbld', 07:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:14 INFO - 'XPC_FLAGS': '0x0', 07:10:14 INFO - 'XPC_SERVICE_NAME': '0', 07:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:14 INFO - Downloading/unpacking psutil>=3.1.1 07:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:18 INFO - Installing collected packages: psutil 07:10:18 INFO - Running setup.py install for psutil 07:10:18 INFO - building 'psutil._psutil_osx' extension 07:10:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:10:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:10:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:10:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:10:18 INFO - building 'psutil._psutil_posix' extension 07:10:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:10:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:10:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:10:19 INFO - ^ 07:10:19 INFO - 1 warning generated. 07:10:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:10:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:19 INFO - Successfully installed psutil 07:10:19 INFO - Cleaning up... 07:10:19 INFO - Return code: 0 07:10:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:19 INFO - 'HOME': '/Users/cltbld', 07:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:19 INFO - 'LOGNAME': 'cltbld', 07:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:19 INFO - 'MOZ_NO_REMOTE': '1', 07:10:19 INFO - 'NO_EM_RESTART': '1', 07:10:19 INFO - 'PAGER': '/bin/cat', 07:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:19 INFO - 'PWD': '/builds/slave/test', 07:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:19 INFO - 'SHELL': '/bin/bash', 07:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:19 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:19 INFO - 'USER': 'cltbld', 07:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:19 INFO - 'XPC_FLAGS': '0x0', 07:10:19 INFO - 'XPC_SERVICE_NAME': '0', 07:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:10:22 INFO - Installing collected packages: mozsystemmonitor 07:10:22 INFO - Running setup.py install for mozsystemmonitor 07:10:22 INFO - Successfully installed mozsystemmonitor 07:10:22 INFO - Cleaning up... 07:10:22 INFO - Return code: 0 07:10:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:22 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:22 INFO - 'HOME': '/Users/cltbld', 07:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:22 INFO - 'LOGNAME': 'cltbld', 07:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:22 INFO - 'MOZ_NO_REMOTE': '1', 07:10:22 INFO - 'NO_EM_RESTART': '1', 07:10:22 INFO - 'PAGER': '/bin/cat', 07:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:22 INFO - 'PWD': '/builds/slave/test', 07:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:22 INFO - 'SHELL': '/bin/bash', 07:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:22 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:22 INFO - 'USER': 'cltbld', 07:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:22 INFO - 'XPC_FLAGS': '0x0', 07:10:22 INFO - 'XPC_SERVICE_NAME': '0', 07:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:22 INFO - Downloading/unpacking jsonschema==2.5.1 07:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:25 INFO - warning: no files found matching '*.txt' 07:10:25 INFO - no previously-included directories found matching 'build' 07:10:25 INFO - no previously-included directories found matching 'dist' 07:10:25 INFO - no previously-included directories found matching '.git*' 07:10:25 INFO - Installing collected packages: jsonschema, functools32 07:10:25 INFO - Running setup.py install for functools32 07:10:25 INFO - warning: no files found matching '*.txt' 07:10:25 INFO - no previously-included directories found matching 'build' 07:10:25 INFO - no previously-included directories found matching 'dist' 07:10:25 INFO - no previously-included directories found matching '.git*' 07:10:25 INFO - Successfully installed jsonschema functools32 07:10:25 INFO - Cleaning up... 07:10:25 INFO - Return code: 0 07:10:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:25 INFO - 'HOME': '/Users/cltbld', 07:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:25 INFO - 'LOGNAME': 'cltbld', 07:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:25 INFO - 'MOZ_NO_REMOTE': '1', 07:10:25 INFO - 'NO_EM_RESTART': '1', 07:10:25 INFO - 'PAGER': '/bin/cat', 07:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:25 INFO - 'PWD': '/builds/slave/test', 07:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:25 INFO - 'SHELL': '/bin/bash', 07:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:25 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:25 INFO - 'USER': 'cltbld', 07:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:25 INFO - 'XPC_FLAGS': '0x0', 07:10:25 INFO - 'XPC_SERVICE_NAME': '0', 07:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:10:25 INFO - Cleaning up... 07:10:26 INFO - Return code: 0 07:10:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:26 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:26 INFO - 'HOME': '/Users/cltbld', 07:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:26 INFO - 'LOGNAME': 'cltbld', 07:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:26 INFO - 'MOZ_NO_REMOTE': '1', 07:10:26 INFO - 'NO_EM_RESTART': '1', 07:10:26 INFO - 'PAGER': '/bin/cat', 07:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:26 INFO - 'PWD': '/builds/slave/test', 07:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:26 INFO - 'SHELL': '/bin/bash', 07:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:26 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:26 INFO - 'USER': 'cltbld', 07:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:26 INFO - 'XPC_FLAGS': '0x0', 07:10:26 INFO - 'XPC_SERVICE_NAME': '0', 07:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:10:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:29 INFO - Downloading docopt-0.6.1.tar.gz 07:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:30 INFO - Running setup.py install for blobuploader 07:10:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:10:30 INFO - Running setup.py install for requests 07:10:30 INFO - Running setup.py install for docopt 07:10:30 INFO - Successfully installed blobuploader requests docopt 07:10:30 INFO - Cleaning up... 07:10:30 INFO - Return code: 0 07:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:30 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:30 INFO - 'HOME': '/Users/cltbld', 07:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:30 INFO - 'LOGNAME': 'cltbld', 07:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:30 INFO - 'MOZ_NO_REMOTE': '1', 07:10:30 INFO - 'NO_EM_RESTART': '1', 07:10:30 INFO - 'PAGER': '/bin/cat', 07:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:30 INFO - 'PWD': '/builds/slave/test', 07:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:30 INFO - 'SHELL': '/bin/bash', 07:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:30 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:30 INFO - 'USER': 'cltbld', 07:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:30 INFO - 'XPC_FLAGS': '0x0', 07:10:30 INFO - 'XPC_SERVICE_NAME': '0', 07:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-W9K_Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-lZ61CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ljOYy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ayEQFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-KMNydX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-x6KeZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-WQkJ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:31 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-aH2qle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-zYQ6TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Y8KIxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-m3ZX3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-98SUsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Ct5BY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-IwgO7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-RPAOgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-XffwEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:32 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-pWlAjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:32 INFO - Running setup.py install for manifestparser 07:10:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Running setup.py install for mozcrash 07:10:33 INFO - Running setup.py install for mozdebug 07:10:33 INFO - Running setup.py install for mozdevice 07:10:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Running setup.py install for mozfile 07:10:33 INFO - Running setup.py install for mozhttpd 07:10:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:10:33 INFO - Running setup.py install for mozinfo 07:10:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozInstall 07:10:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozleak 07:10:34 INFO - Running setup.py install for mozlog 07:10:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for moznetwork 07:10:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozprocess 07:10:34 INFO - Running setup.py install for mozprofile 07:10:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:10:34 INFO - Running setup.py install for mozrunner 07:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Running setup.py install for mozscreenshot 07:10:35 INFO - Running setup.py install for moztest 07:10:35 INFO - Running setup.py install for mozversion 07:10:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:10:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:35 INFO - Cleaning up... 07:10:35 INFO - Return code: 0 07:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:35 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:35 INFO - 'HOME': '/Users/cltbld', 07:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:35 INFO - 'LOGNAME': 'cltbld', 07:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:35 INFO - 'MOZ_NO_REMOTE': '1', 07:10:35 INFO - 'NO_EM_RESTART': '1', 07:10:35 INFO - 'PAGER': '/bin/cat', 07:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:35 INFO - 'PWD': '/builds/slave/test', 07:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:35 INFO - 'SHELL': '/bin/bash', 07:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:35 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:35 INFO - 'USER': 'cltbld', 07:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:35 INFO - 'XPC_FLAGS': '0x0', 07:10:35 INFO - 'XPC_SERVICE_NAME': '0', 07:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:10:35 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-CuGvAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:10:35 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-sXy4Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Nrw3QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-mLaqhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-twUHyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-rOkfPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-z_npLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-bzTEEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-HuGK86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-F5PYg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:10:36 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-fiADjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:10:37 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-6_c6B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:10:37 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-7lnl0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:10:37 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-TJyW1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:37 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ZFf6q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:10:37 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-acW2pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:10:37 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-s4vuYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:10:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:10:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:10:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:40 INFO - Downloading blessings-1.6.tar.gz 07:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:40 INFO - Installing collected packages: blessings 07:10:40 INFO - Running setup.py install for blessings 07:10:40 INFO - Successfully installed blessings 07:10:40 INFO - Cleaning up... 07:10:40 INFO - Return code: 0 07:10:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:40 INFO - Reading from file tmpfile_stdout 07:10:40 INFO - Current package versions: 07:10:40 INFO - blessings == 1.6 07:10:40 INFO - blobuploader == 1.2.4 07:10:40 INFO - docopt == 0.6.1 07:10:40 INFO - functools32 == 3.2.3-2 07:10:40 INFO - jsonschema == 2.5.1 07:10:40 INFO - manifestparser == 1.1 07:10:40 INFO - mozInstall == 1.12 07:10:40 INFO - mozcrash == 0.17 07:10:40 INFO - mozdebug == 0.1 07:10:40 INFO - mozdevice == 0.48 07:10:40 INFO - mozfile == 1.2 07:10:40 INFO - mozhttpd == 0.7 07:10:40 INFO - mozinfo == 0.9 07:10:40 INFO - mozleak == 0.1 07:10:40 INFO - mozlog == 3.4 07:10:40 INFO - moznetwork == 0.27 07:10:40 INFO - mozprocess == 0.23 07:10:40 INFO - mozprofile == 0.28 07:10:40 INFO - mozrunner == 6.12 07:10:40 INFO - mozscreenshot == 0.1 07:10:40 INFO - mozsystemmonitor == 0.3 07:10:40 INFO - moztest == 0.7 07:10:40 INFO - mozversion == 1.4 07:10:40 INFO - psutil == 3.1.1 07:10:40 INFO - requests == 1.2.3 07:10:40 INFO - wsgiref == 0.1.2 07:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:41 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:41 INFO - 'HOME': '/Users/cltbld', 07:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:41 INFO - 'LOGNAME': 'cltbld', 07:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:41 INFO - 'MOZ_NO_REMOTE': '1', 07:10:41 INFO - 'NO_EM_RESTART': '1', 07:10:41 INFO - 'PAGER': '/bin/cat', 07:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:41 INFO - 'PWD': '/builds/slave/test', 07:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:41 INFO - 'SHELL': '/bin/bash', 07:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:41 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:41 INFO - 'USER': 'cltbld', 07:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:41 INFO - 'XPC_FLAGS': '0x0', 07:10:41 INFO - 'XPC_SERVICE_NAME': '0', 07:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:10:41 INFO - Cleaning up... 07:10:41 INFO - Return code: 0 07:10:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:42 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 0x10e1f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90f1d5ee50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, '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.qVUBEawOtN/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.PgGmA2kBvd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:42 INFO - 'HOME': '/Users/cltbld', 07:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:42 INFO - 'LOGNAME': 'cltbld', 07:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:42 INFO - 'MOZ_NO_REMOTE': '1', 07:10:42 INFO - 'NO_EM_RESTART': '1', 07:10:42 INFO - 'PAGER': '/bin/cat', 07:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:42 INFO - 'PWD': '/builds/slave/test', 07:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:42 INFO - 'SHELL': '/bin/bash', 07:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:10:42 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:42 INFO - 'USER': 'cltbld', 07:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:42 INFO - 'XPC_FLAGS': '0x0', 07:10:42 INFO - 'XPC_SERVICE_NAME': '0', 07:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:42 INFO - Cleaning up... 07:10:42 INFO - Return code: 0 07:10:42 INFO - Running post-action listener: _resource_record_post_action 07:10:42 INFO - Running post-action listener: _start_resource_monitoring 07:10:42 INFO - Starting resource monitoring. 07:10:42 INFO - [mozharness: 2016-10-20 14:10:42.666015Z] Finished create-virtualenv step (success) 07:10:42 INFO - [mozharness: 2016-10-20 14:10:42.666983Z] Running install step. 07:10:42 INFO - Running pre-action listener: _resource_record_pre_action 07:10:42 INFO - Running main action method: install 07:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:42 INFO - Reading from file tmpfile_stdout 07:10:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:43 INFO - Reading from file tmpfile_stdout 07:10:43 INFO - Output received: 07:10:43 INFO - Usage: mozinstall [options] installer 07:10:43 INFO - Options: 07:10:43 INFO - -h, --help show this help message and exit 07:10:43 INFO - -d DEST, --destination=DEST 07:10:43 INFO - Directory to install application into. [default: 07:10:43 INFO - "/builds/slave/test"] 07:10:43 INFO - --app=APP Application being installed. [default: firefox] 07:10:43 INFO - mkdir: /builds/slave/test/build/application 07:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:11:17 INFO - Reading from file tmpfile_stdout 07:11:17 INFO - Output received: 07:11:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:11:17 INFO - Running post-action listener: _resource_record_post_action 07:11:17 INFO - [mozharness: 2016-10-20 14:11:17.475471Z] Finished install step (success) 07:11:17 INFO - [mozharness: 2016-10-20 14:11:17.475629Z] Running run-tests step. 07:11:17 INFO - Running pre-action listener: _resource_record_pre_action 07:11:17 INFO - Running main action method: run_tests 07:11:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:17 INFO - 2016-10-20 07:11:17.490 screenresolution[1642:7641] starting screenresolution argv=screenresolution get 07:11:17 INFO - 2016-10-20 07:11:17.493 screenresolution[1642:7641] Display 0: 1600x1200x32@60 07:11:17 INFO - 2016-10-20 07:11:17.498 screenresolution[1643:7643] starting screenresolution argv=screenresolution list 07:11:17 INFO - Available Modes on Display 0 07:11:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:17 INFO - Intel Iris: 07:11:17 INFO - Chipset Model: Intel Iris 07:11:17 INFO - Type: GPU 07:11:17 INFO - Bus: Built-In 07:11:17 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:17 INFO - Vendor: Intel (0x8086) 07:11:17 INFO - Device ID: 0x0a2e 07:11:17 INFO - Revision ID: 0x0009 07:11:17 INFO - Displays: 07:11:17 INFO - Display: 07:11:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:17 INFO - Display Serial Number: 1600x1200 60 07:11:17 INFO - Main Display: Yes 07:11:17 INFO - Mirror: Off 07:11:17 INFO - Online: Yes 07:11:17 INFO - Rotation: Supported 07:11:17 INFO - Return code: 0 07:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:17 INFO - Python 2.7.3 07:11:17 INFO - Return code: 0 07:11:17 INFO - grabbing minidump binary from tooltool 07:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:17 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 0x10e008d30>, '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 0x10de2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e000b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:11:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:11:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:11:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:17 INFO - Return code: 0 07:11:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:11:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:11:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0271 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVUBEawOtN/Render', 07:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:17 INFO - 'HOME': '/Users/cltbld', 07:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:17 INFO - 'LOGNAME': 'cltbld', 07:11:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:17 INFO - 'MOZ_NO_REMOTE': '1', 07:11:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:17 INFO - 'NO_EM_RESTART': '1', 07:11:17 INFO - 'PAGER': '/bin/cat', 07:11:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:17 INFO - 'PWD': '/builds/slave/test', 07:11:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:17 INFO - 'SHELL': '/bin/bash', 07:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PgGmA2kBvd/Listeners', 07:11:17 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 07:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:17 INFO - 'USER': 'cltbld', 07:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:17 INFO - 'XPC_FLAGS': '0x0', 07:11:17 INFO - 'XPC_SERVICE_NAME': '0', 07:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:11:18 INFO - mozversion application_buildid: 20161020061049 07:11:18 INFO - mozversion application_changeset: b04e95606673fff324ef0ddb09de846f7b7eaf82 07:11:18 INFO - mozversion application_display_name: Nightly 07:11:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:18 INFO - mozversion application_name: Firefox 07:11:18 INFO - mozversion application_remotingname: firefox 07:11:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:11:18 INFO - mozversion application_vendor: Mozilla 07:11:18 INFO - mozversion application_version: 52.0a1 07:11:18 INFO - mozversion platform_buildid: 20161020061049 07:11:18 INFO - mozversion platform_changeset: b04e95606673fff324ef0ddb09de846f7b7eaf82 07:11:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:11:18 INFO - mozversion platform_version: 52.0a1 07:11:18 INFO - using testdate: 1476972678 07:11:18 INFO - actual date: 1476972678 07:11:18 INFO - starting webserver on 'localhost:49281' 07:11:18 INFO - SUITE-START | Running 2 tests 07:11:18 INFO - TEST-START | dromaeo_css 07:11:18 INFO - operating with platform_type : mac_ 07:11:18 INFO - Initialising browser for dromaeo_css test... 07:11:18 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpj8hb4r/profile http://localhost:49281/getInfo.html) 07:11:21 INFO - PROCESS | 1653 | 2016-10-20 07:11:21.027 plugin-container[1655:7799] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e47, name = 'com.apple.tsm.portname' 07:11:21 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:21 INFO - PROCESS | 1653 | 2016-10-20 07:11:21.030 plugin-container[1655:7799] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 07:11:21 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:21 INFO - PROCESS | 1653 | 2016-10-20 07:11:21.030 plugin-container[1655:7799] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:11:21 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 07:11:21 INFO - PROCESS | 1653 | colorDepth:24 07:11:21 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 07:11:21 INFO - PROCESS | 1653 | __metrics 07:11:21 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 07:11:21 INFO - TEST-INFO | 1653: exit 0 07:11:21 INFO - Browser initialized. 07:11:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:21 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpj8hb4r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:24 INFO - PROCESS | 1656 | 2016-10-20 07:11:24.099 plugin-container[1657:7917] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 07:11:24 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:24 INFO - PROCESS | 1656 | 2016-10-20 07:11:24.101 plugin-container[1657:7917] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471f, name = 'com.apple.CFPasteboardClient' 07:11:24 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:24 INFO - PROCESS | 1656 | 2016-10-20 07:11:24.101 plugin-container[1657:7917] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:11:33 INFO - PROCESS | 1656 | RSS: Main: 237228032 07:11:33 INFO - PROCESS | 1656 | 07:12:23 INFO - PROCESS | 1656 | 1476972743405 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:14:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 07:14:38 INFO - PROCESS | 1656 | RSS: Main: 250286080 07:14:38 INFO - PROCESS | 1656 | 07:17:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 07:17:41 INFO - PROCESS | 1656 | RSS: Main: 264065024 07:17:41 INFO - PROCESS | 1656 | 07:20:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 07:20:43 INFO - PROCESS | 1656 | RSS: Main: 268476416 07:20:43 INFO - PROCESS | 1656 | 07:23:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 07:23:46 INFO - PROCESS | 1656 | RSS: Main: 268341248 07:23:46 INFO - PROCESS | 1656 | 07:26:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 07:26:50 INFO - PROCESS | 1656 | RSS: Main: 273678336 07:26:50 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 07:29:53 INFO - PROCESS | 1656 | RSS: Main: 277372928 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | __start_tp_report 07:29:53 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 07:29:53 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 07:29:53 INFO - PROCESS | 1656 | |i|pagename|runs| 07:29:53 INFO - PROCESS | 1656 | |0;dojo.html;3429.6055953565337;3431.4681224410224;3456.1877958679706;3463.601685806133;3466.2547552276255;4638.884027899304;5885.764569417223;5914.201582786328;5961.135635332874;5988.341282458937;5733.770649174038;5815.912761308584;5837.445442682938;5883.529317654588;5921.674307913063;4334.631556317717;5224.895502089956;5246.134387826014;5316.840494785162;5337.813176538822;5237.13587258102;5369.9463005370035;5377.843763590828;5378.596605254622;5413.242146099549;5193.8961220775755;5330.573554115662;5362.115250983583;5390.757415916273;5399.676019438846;5213.843584692465;5235.65968212065;5291.444398338158;5338;5386.569074474032;5226.477352264781;5239.502247286502;5277.736113194325;5305.283786688786;5316.149416093406;4953.554180123806;5481.369642491125;5675.801346952878;5906.232189815297;5915.260592425947;6107.735039974563;6132.722655450943;6212.65830379329;6227.657478838662;6236.812895613139;6263.373662633746;6268.341824108448;6270.561060725751;6280.78017269398;6295.307516173218;6015.789447369365;6019.428154325332;6020.127081573235;6034.6982650867285;6040.96979515104;6137.232845894263;6227.252729672377;6235.095911092866;6249.531285153632;6373.6175829450385;6101.368489499298;6123.234595675541;6151.8926593212755;6220.25356957159;6263.874722505524;6179.351168127372;6268.592541484789;6279.995200767855;6302.338254483305;6306.905396419057;6146.293176284785;6146.739918316824;6173.32093469718;6176.7838125665385;6229.190205273376;5558.888822223533;6093.908591371133;6154.169187159676;6200.441960223601;6238.033104868752;4999.900001999939;5022.397312322471;5054.1407960646775;5070.391553013662;5110.156824124052;4509.0080182359825;4535.455745310584;4543.727376357429;4562.931556026662;4593.885152871205;5875.559333049953;5930.051191809376;6049.364816694272;6088.695565221721;6103.633781973007;6154.015357542861;6189.8452538686;6200.720967556471;6206.937930620636;6291.245050593867;5126.69239845603;6008.939910600925;6034.969825150846;6037.486813620803;6063.939360606338;5556.388797232301;5564.4713752193475;5567.693776842231;5579.414161513064;5584.994700953786;6218.751249949952;6231.158793562901;6297.52768542352;6344.270408903035;6347;6213.471854892385;6264.561480696308;6265.216847894013;6269.655168965751;6283.37166283368;6417;6421.8715625688155;6422.518311126591;6448.419642232222;6460.741570337133;6028.8794224116145;6097.948168432722;6204.441600255998;6222.160008398808;6249.906251406142;6066.181065556093;6251.218597675291;6256.906146407899;6263.154474145932;6266.874662506815;6078.665673388006;6230.7819226326865;6231.3145553988115;6247.531435142291;6285.717142728497;6086.391360863879;6101.005087479836;6107.450329470191;6135.5695317960535;6150.60021098645;5952.464278214981;6093.451589356979;6162.291336496361;6174.228221472316;6179.660118693515;6210.627362358273;6251.71867265965;6266.185395898504;6266.749330026748;6271.74913003493;5920.940790592039;6072.271327440559;6130.877382452237;6136.2636483622255;6151.384861513813 07:29:53 INFO - PROCESS | 1656 | |1;ext.html;479.94000749906263;493.664308270376;508.7049511283455;514.5934711577852;526.4682670502791;39213.41179882304;40812.79593602035;40820.795896020514;40868.59131408692;40931.9767005825;42085.36871946923;42484.787576062074;42530.36204456936;42575.148497030044;42695;9469.857952130706;9611.567479463441;9660.227181825472;9676.854847177297;9710.41737495749;9558.522073896278;9643;9656.372335798185;9660.130588247092;9677.032296770301;9644.61421543141;9653.27600429967;9674.516274186297;9699.078587534208;9703.708888733314;7894.368450523944;8263.297619702333;9614.71155865325;9636.469994150319;9666.75833104171;7990.760277191694;8675.609597568062;8899.37704360695;9430.056994300583;9541.379810312377;32934.67065329364;40324.790256292355;40344.596554034375;40350;40361.59638403608;3369.393509168349;3524.242287908112;3967.4643923070594;4156.480439945007;4289.034967132401;30136;30810.84594577035;31339;31468.213294667818;31765.841170794;3081.3529158876663;3100.937981240385;3171.2864605463815;3209.3420848726187;3214.4696125139326;364286;425929;442338.9999999968;445567;447818;60990.69504652448;61173;61406;61593.46016349537;61675.691621541606;64187;64292;64386;64458;64533;13570;16106.597335066483;16229.026258424532;16247.268872900748;16254.18729063542;12430.627081187578;12454.190477618926;12495.062870284582;12548.874511254771;12559.811602825965;17149.828501714823;17586;17593.91203044002;17613.647727045645;17705.468835934942;6987.89518157228;7030.9766800276375;7121.857562848818;7152.892706609405;7193.280671932869;800.507687772016;978.3054031637474;988.0860204310984;1005.692599620505;1099.4502748625687;25627.743722562536;29855.552166717516;30027.099187024425;30413.69586304153;30736.231594209876;1017.1862509992125;1020.6835880876952;1074.908632766208;1115.938623375722;1120.1263014848432;15283.923580382027;15791.526254212393;15826.525204243891;15843.762343564857;16152.434664786912;646906;649203;652319.9072037066;654990;655044;58354;58759.412405876246;59190.11214831695;59296.70351648214;59478;1331.9200847949155;1370.6984463418232;1377.579838149354;1396.3506969259547;1396.9650758730909;29653;29785;30476.84761576178;30652;31395.529067063555;56207;56210.71894640501;56677.716611416676;56798.43201567931;56942.7152864233;477701;497690;546522.534774663;596335;599843;42209.36685949775;42236.36645450259;42557.36163957605;42876.78561607172;43205.783971079945;45969.49565823221;47207;47381.76309118432;47991.28013079876;48182.5181748178;38159.80920095493;39183.60816391914;39791.80104099461;40682.59317406788;41804.58195418129;33276.00171994844;37302.253954920205;38590.228195435375;38630.22739545249;40168;37672.62327376691;38667.613323866404;38773.80613096916;38916.63791767274;38947.610523895535;30896.84551577228;34078;34749.82625086959;34809.47785783165;34970.47544286888;25685.74314256908;25935.092271770398;26036.30764000334;26264;26376.604350935137 07:29:53 INFO - PROCESS | 1656 | |2;jquery.html;347.4094040131776;360.35496461334196;369.9130704284492;375.83275442428095;392.6297222692803;19172.904135479337;19627.803721962777;20142.69785953212;20906.686399703998;21081.051352689126;20378.490537736565;20526.589468210626;20664.89667551664;20961.475963100893;21053.05261263243;4492.707973981697;5746.511546518551;5913.822585322448;5996.370381109986;6028.095785632168;5831.504322132624;5900.940990590082;5924.763009479616;5945.227120474332;5963.344032156459;5618.943810561904;5790.305163380401;5864.501517371007;5890.381509941459;5937.228160339171;5836.854078648025;5858.297004359461;5868.735906884158;5909.645421274716;5909.734061967221;4976.353074100344;5139.922901156486;5248.239005344242;5319.627626066177;5360.865978350534;12462.065345099063;12754.10721249513;12809.295488748116;19599.90200049005;23426.06295748168;2087.84341174411;2100.0759665747173;2170.392290158758;2499.800015998716;2861.298981749464;9410.811783764286;9594.9520252399;9601.183899368492;9858.753531161707;10102.19182465401;1783.2599471219428;1832.7800663920416;1834.4313262888547;1855.313533992418;1892.280933245358;115232;120118;121407;122486;124032;9300.72097837066;11168.385738784282;11393.145514086476;11482;11648.88351116495;14049.578512644637;14180.716385672229;14189.716205676035;14203.431862725376;14256.928715356356;7978.162292959272;8266.380021498411;8304.501729896225;8375.078741338448;8398.412111152284;8121.390895682729;8211.302039326605;8251.546164960984;8354.916450835535;8373.330133589297;4017.859374921922;4370.650347972155;4381.277089280296;4396.934045989313;4472.2620767573635;1853.67560676881;1886.7735871695484;1886.867919245667;1889.2915156816193;1905.5136993145368;806.5322113174345;852.8166444214523;874.6851133592029;892.1346294094718;897.0849733272026;19921.302754403525;20504.077316520794;20532.58934821295;20566.794332056787;20672.379828604866;817.5503473089777;883.867419887022;910.3627460777482;919.3105171121658;924.9732796595773;7691.538507689556;8868.955655221682;9756.21950243993;10474;10826.18803589734;536897;554281;567730;568140.318596817;568583;87205.96615049355;98643;108027;119318;125638.3718081422;883.1257055515123;942.6512190489426;960.4381436859516;977.4819345746907;991.6479649724388;14685.192314422382;17153.656926861644;17266.827331727025;18117.09414529242;18144.45566633003;39100.80449597734;50753.98492030212;51768.48231517636;52479.95040099253;53399.733001336295;70878;72367;72920;73205.6339718298;75479.62260188884;7779;7781.06627204739;7929.563873986986;8053.959730201312;8095.919040809516;10065.547050382896;10737.46312684347;10813.189010824377;11510.07919366432;11956.58151964677;9985.1512621428;10696.946515267375;10705.625303114353;10960.835587466354;11119.610813621484;9767.804643907224;10768.0847127995;10908.290961087503;11152.776944461228;11212.27120237182;10960.232783705063;11002.394868282321;11317.434128293717;11396.544138234378;11410.201285910238;7792.493487923493;7967.601619919097;8002.919970800451;8147.307478864126;8178.5092894426525;10367;10766.946165269124;10837.403942783223;11073.83389249178;11252.66242012741 07:29:53 INFO - PROCESS | 1656 | |3;mootools.html;1314.8027795830624;1555.6733086051925;1757.815429379915;1866.1509013398904;1939.7769256535494;7607.429442791792;7912.367010639149;8208.83582328353;8489.36329775267;9008.369414141005;8395.160483951602;8724.651013959434;8732.650693972233;8826.293896488281;8828.867566986484;2376.95246095078;2403.098837935774;2404.471016376403;2405.482821193443;2407.265783935899;2356.15178535727;2381.392744850061;2400.8919598618018;2401.315625046862;2411.602085655865;2369.8578085314934;2374.2402431222017;2376.2158487699016;2403.4111642647576;2405.855648661086;2356.3166681662296;2368.017272831773;2372.3476044087843;2375.049980008002;2385.6063749481314;2358.6579945907747;2375.70303712036;2378.9643155352683;2381.0356805493802;2385.988070059656;7260.564366138048;8901.73294801157;8925.241354484877;8948.105189481064;8960.059193784624;5260.710660913648;5418.322709661293;5437.864053398657;5441.102218134003;5451.182322651594;3605.0987253186704;3608.855645774166;3655.4516822476576;3696.131409118855;3705.3330400527893;1055.841623756435;1061.8778840433372;1065.1638463805875;1071.839224116381;1072.5441687282873;11616;11635.767284654345;11720.179587428884;11765.941065304163;11809.23239989398;4515.254982927846;4627.838025669085;4782.713037217778;4817.590504807061;4844.685095468783;9714.077162669535;9844.310898237054;9920.900790991998;9947.35342202769;9947.651832185838;5325.733713314319;5330.760115794798;5346.572274218053;5379.946200537945;5387.4073851876265;4413.801378937956;4590.219662657356;4681.9297710534365;4766.737829419346;4929.605631549467;3386.7967921924765;3482.7039701625645;3868.3423817951016;3921.509811273591;4036.57615950321;1050.632278702448;1124.4265424633495;1320.6896379350844;1322.7288405876773;1324.0599174586152;780.5940910726504;882.7528292078229;903.20969151992;937.1799675284126;955.7658373698349;4477.529859364785;5892.381299963527;5958.910616340759;5966.76132954677;6092.147099406086;373.27957042906905;441.5496193882222;766.7508059880561;922.9353945223904;1055.2824079625927;3237.9838100809343;3933.8819835404984;3949.578151865326;4022.7988600569856;4038.1519880825354;10418.374897506174;10771.46142692878;10844.620438284623;10867.673969780919;10973.890261097447;10043.548040338203;10796.568137274578;10798.67603971882;10833.67498975032;10916.727081823017;7850.882236766453;8313.210245026712;8323.375746819134;8326.66693332272;8331.916680833236;5901.29184497863;5955.791547295824;6034.125051867367;6086.239220097488;6106.69466526663;9176.724698259062;9964.50177491137;10082.546285417027;10088.596456141966;10273.794524109626;10196.929322421336;10260.58957641686;10264.435456049989;10273.332233404804;10276.537555809857;6807.965960170168;6939;7180.066591343092;7262.527935684164;7339.89901514777;8120.269175774209;8438.156184381513;8449.83100338002;8460.915390846012;8482.745517634481;6645.202575690948;7469.1037075551285;7554.773356799305;7554.962225188839;7615.809604759926;7209.134903811367;7399.223081576357;7406.18531961473;7426.4058875288765;7436.553806771611;7027.121609798775;7045.894311585433;7124.928750712426;7129.251428599922;7136.4290856730295;4939;5012.624053195952;5028.949710502849;5048.545630893237;5081.212412076134;4888.5111488850835;4943.773074021659;5063.721495317793;5153.917677287812;5171.586273098068 07:29:53 INFO - PROCESS | 1656 | |4;prototype.html;271.65228507510386;286.54296397246395;300.6752707076357;310.35755985110814;310.3869857032363;5250.422453530114;5368.62419630626;5374.381946076202;5582.720863956796;5669.433056694334;4877.463598966323;5339.919901201485;5475.945240547593;5516.503514683678;5582.469665381782;3388.915277118067;3436.639152888948;3442.845071971767;3593.5984965863336;3823.483829682992;4123.783448909855;4227.3447615619625;4258.190943720699;4259.893502662428;4277.850275240367;3468.2543253200556;4167.666586673059;4172.687048471377;4174.186033723425;4177.310743727281;4077.4495443115097;4163.542010378841;4179.791010449465;4182.707210495267;4191.8532851350055;2994.595729576523;3065.371598822236;3657.3782456982376;3658.1951970566697;3663.7618554793853;4502.639788816887;4607.401037865056;5037.448598737881;5431.891362172734;5454.4545545445535;4303.655707543389;4532.365468834333;4813.857833264199;4815.821557771854;4820.565614364758;5127.461616530285;5495.807646732345;5562.9443705562835;5814.534837213013;5903.616264942808;2966.080515040323;3784.2620688965662;3906.277338692351;3908.355121404965;4016.0763024504527;5654.858628534237;6209.223847019122;6214.223222097238;6237.438630523229;6279.748810047593;3974.8608798691907;3987.541432735273;3994.1612261424843;4019.618136277049;4020.632984785187;3726.087108658342;4006.8397264109694;4007.2586571484367;4041.535223449282;4047.7737244515397;3651.7626354287418;4068.8372465101656;4364.5635436456105;4435.866923992286;4761.47623761386;5863.179154918314;5871.794487192928;5919.644821310649;5938.792142275;5971.55119436023;1258.1444617659897;1300.7983762516826;1352.931184364361;1361.9114757540729;1368.261138984937;808.7250334886166;811.0308181722785;824.5547404401556;828.7099515169763;837.2213841127688;4216.31347461012;4353.455818022747;4397.307036790795;4629.907401851944;4662.557057079572;4358.629516491071;4628.1256091283085;4889.801998510387;5087.720175390315;5088.440271570124;3947.5657677655436;4127.958720412757;4628.305754136906;4644.814207431665;4667.719936803803;2564.7819935305706;2646.986765066162;2664.533706601337;2695.447433276174;2719.4017316190407;4532.232429352555;4877.317175595419;5128.615353848476;5223.858218130625;5233.613092530482;4398.274284743045;4847.587955023792;4879.634027447955;5016.498350165028;5155.381354237516;5725.366331487479;6327.905081423783;6330.8417289567205;6340;6397.680115994275;6177.2587289525545;6197.349278325711;6216.471599913877;6236.844078898064;6296.716647750954;5066.06277838601;5619.722459414986;5825.50483208915;6102.328743838086;6114.755409783559;5486.890262194814;6322.557420980487;6337.207849018872;6388.840278993062;6441.323661015525;3974.28462876685;3975.688022952361;3985.820638071236;3994.2810294147334;4008.7594744315434;5787.7395517200985;6018;6054.3642917493025;6105.8168254952425;6158.907616385668;4666.416697912761;4766.713997160182;5786.276715410574;5824.165387902797;5948.345681974893;4478.328250762412;4536.841210557614;5096.133657278346;5953.851153721192;5971.373005834324;4692.085043416501;5222.529972302511;5464.508194262536;5727.198192253005;5823.534117270524;4893.828715994923;5163.380394352702;5606.018946684396;5868.38381969887;5962.940370596412;5547.805826796042;5692.829215123553;5795.652260864362;5843.328017278068;5860.677662728591 07:29:53 INFO - PROCESS | 1656 | |5;yui.html;703.9014537964682;712.9536580122292;729.7555318968147;773.8104164479699;830.2486249943803;13069.346532673364;13073.411696473659;15363.078215307061;15501.147436890966;16407.17964101793;10760.515776790044;14565.344559494823;14664.413423463075;14762.11427314362;14776.6305842354;864.0365991918997;871.4379225399614;886.5212785096072;888.0897080492482;890.2255038116847;712.4300559552363;897.0670502677208;901.4951627088818;902.2736696958946;905.2034209895315;857.2884505860121;925.0703043441332;953.5184731710511;953.9840070325116;956.5360800012023;775.5889378629336;936.3679516326521;937.1144268666113;945.3618807305076;948.3361646847235;697.7941507255372;700.5586480517242;703.8521910398822;704.799132247307;705.7141857547701;13324.733505329936;13461.326933653278;13568.525101621495;13603.31983400826;13626.591202263948;11553.595624153115;11776.11679124069;11886.465109070026;12102.394880255952;12107.39463026845;10616.57533698651;10846.837297440545;11026.338419694845;11230.887691123147;11474.94262528682;3542.36237477254;3579.266250418658;3583.623719509466;3597.8021208833766;3606.062423769839;103429;105459.47270263599;105802;106518.46740766247;110236;9035.503047332328;9140.360174787835;9161.404508706913;9478;9498.050194980447;19234.23063077489;19418.223271069;19446.70829937552;19460.90269548643;19738.60522789536;7854.567998760009;7888.1323054463965;7956.085050219183;8105.230003149692;8180.427370084156;4383.364412160219;4403.801828917706;4405.383246345515;4498.167838949805;4498.955010449919;3589.964100358963;3729.030452082478;3731.589525152231;3731.9813400933363;3737.4020156774786;632.8766439569708;648.5849056603778;678.1489231015144;690.4821383962028;700.5341447937167;520.7370278009581;587.3832475900288;611.984700382494;682.8566001139717;692.7090621938797;8170.673173073011;8285.751427457186;9040.367174297737;9652.581033612709;9706.369086009387;581.5928849805068;599.9850003749941;675.1122274209399;690.5649440852332;692.2696555134381;4254.574542545783;4697.295405689174;4725.10223057618;4843.716415149988;5017.835435722707;94210.0578994215;94775;117387;153515;163534;97081;135775.13798896063;136922;139148;141276.22132901402;89369;116547.41726291315;119139.99999999827;122399.77600224061;125072;9840.065193806577;9844.950775246365;9850;9856.21150307988;9921.55353009102;61658.38341616526;63263.6836815813;63739.300464893255;63739.362606375194;67054.99417508644;73144;76598.85101723367;88215.55892220755;92233.5388323054;97351;13113.541026064042;13140.145890517086;13308.068435209443;13588.45646174142;13792.241426721226;11068.612598559012;14828.703425931206;14886.330115144629;15062.472813451477;15311.310991005654;13546.525871594447;13573;13582.660433488847;13633;14122.858771412566;13438.395272212578;13674.794878076638;13695.657608559468;13732.244726539737;14206.21865797391;13315.267660278778;13350.998675099212;13620.18278903269;13977.720445590829;14053.297335133408;10460.47697615101;10729.731756705833;11161.72095697614;11313.604023859125;11569.88430115688;9006.50464224474;9743.561539730586;10535.447825936068;11400.258983166068;11534.769304613694 07:29:53 INFO - PROCESS | 1656 | __end_tp_report 07:29:53 INFO - PROCESS | 1656 | __start_cc_report 07:29:53 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,370 07:29:53 INFO - PROCESS | 1656 | __end_cc_report 07:29:53 INFO - PROCESS | 1656 | __startTimestamp1476973793434__endTimestamp 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | ------- Summary: start ------- 07:29:53 INFO - PROCESS | 1656 | Number of tests: 6 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5808.46 Median:6093.45 stddev:635.40 (10.4%) stddev-sans-first:609.33 07:29:53 INFO - PROCESS | 1656 | Values: 3429.6 3431.5 3456.2 3463.6 3466.3 4638.9 5885.8 5914.2 5961.1 5988.3 5733.8 5815.9 5837.4 5883.5 5921.7 4334.6 5224.9 5246.1 5316.8 5337.8 5237.1 5369.9 5377.8 5378.6 5413.2 5193.9 5330.6 5362.1 5390.8 5399.7 5213.8 5235.7 5291.4 5338.0 5386.6 5226.5 5239.5 5277.7 5305.3 5316.1 4953.6 5481.4 5675.8 5906.2 5915.3 6107.7 6132.7 6212.7 6227.7 6236.8 6263.4 6268.3 6270.6 6280.8 6295.3 6015.8 6019.4 6020.1 6034.7 6041.0 6137.2 6227.3 6235.1 6249.5 6373.6 6101.4 6123.2 6151.9 6220.3 6263.9 6179.4 6268.6 6280.0 6302.3 6306.9 6146.3 6146.7 6173.3 6176.8 6229.2 5558.9 6093.9 6154.2 6200.4 6238.0 4999.9 5022.4 5054.1 5070.4 5110.2 4509.0 4535.5 4543.7 4562.9 4593.9 5875.6 5930.1 6049.4 6088.7 6103.6 6154.0 6189.8 6200.7 6206.9 6291.2 5126.7 6008.9 6035.0 6037.5 6063.9 5556.4 5564.5 5567.7 5579.4 5585.0 6218.8 6231.2 6297.5 6344.3 6347.0 6213.5 6264.6 6265.2 6269.7 6283.4 6417.0 6421.9 6422.5 6448.4 6460.7 6028.9 6097.9 6204.4 6222.2 6249.9 6066.2 6251.2 6256.9 6263.2 6266.9 6078.7 6230.8 6231.3 6247.5 6285.7 6086.4 6101.0 6107.5 6135.6 6150.6 5952.5 6093.5 6162.3 6174.2 6179.7 6210.6 6251.7 6266.2 6266.7 6271.7 5920.9 6072.3 6130.9 6136.3 6151.4 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68526.17 Median:22980.53 stddev:146621.56 (638.0%) stddev-sans-first:146943.86 07:29:53 INFO - PROCESS | 1656 | Values: 479.9 493.7 508.7 514.6 526.5 39213.4 40812.8 40820.8 40868.6 40932.0 42085.4 42484.8 42530.4 42575.1 42695.0 9469.9 9611.6 9660.2 9676.9 9710.4 9558.5 9643.0 9656.4 9660.1 9677.0 9644.6 9653.3 9674.5 9699.1 9703.7 7894.4 8263.3 9614.7 9636.5 9666.8 7990.8 8675.6 8899.4 9430.1 9541.4 32934.7 40324.8 40344.6 40350.0 40361.6 3369.4 3524.2 3967.5 4156.5 4289.0 30136.0 30810.8 31339.0 31468.2 31765.8 3081.4 3100.9 3171.3 3209.3 3214.5 364286.0 425929.0 442339.0 445567.0 447818.0 60990.7 61173.0 61406.0 61593.5 61675.7 64187.0 64292.0 64386.0 64458.0 64533.0 13570.0 16106.6 16229.0 16247.3 16254.2 12430.6 12454.2 12495.1 12548.9 12559.8 17149.8 17586.0 17593.9 17613.6 17705.5 6987.9 7031.0 7121.9 7152.9 7193.3 800.5 978.3 988.1 1005.7 1099.5 25627.7 29855.6 30027.1 30413.7 30736.2 1017.2 1020.7 1074.9 1115.9 1120.1 15283.9 15791.5 15826.5 15843.8 16152.4 646906.0 649203.0 652319.9 654990.0 655044.0 58354.0 58759.4 59190.1 59296.7 59478.0 1331.9 1370.7 1377.6 1396.4 1397.0 29653.0 29785.0 30476.8 30652.0 31395.5 56207.0 56210.7 56677.7 56798.4 56942.7 477701.0 497690.0 546522.5 596335.0 599843.0 42209.4 42236.4 42557.4 42876.8 43205.8 45969.5 47207.0 47381.8 47991.3 48182.5 38159.8 39183.6 39791.8 40682.6 41804.6 33276.0 37302.3 38590.2 38630.2 40168.0 37672.6 38667.6 38773.8 38916.6 38947.6 30896.8 34078.0 34749.8 34809.5 34970.5 25685.7 25935.1 26036.3 26264.0 26376.6 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:32722.35 Median:4375.96 stddev:93324.89 (2132.7%) stddev-sans-first:93555.03 07:29:53 INFO - PROCESS | 1656 | Values: 347.4 360.4 369.9 375.8 392.6 19172.9 19627.8 20142.7 20906.7 21081.1 20378.5 20526.6 20664.9 20961.5 21053.1 4492.7 5746.5 5913.8 5996.4 6028.1 5831.5 5900.9 5924.8 5945.2 5963.3 5618.9 5790.3 5864.5 5890.4 5937.2 5836.9 5858.3 5868.7 5909.6 5909.7 4976.4 5139.9 5248.2 5319.6 5360.9 12462.1 12754.1 12809.3 19599.9 23426.1 2087.8 2100.1 2170.4 2499.8 2861.3 9410.8 9595.0 9601.2 9858.8 10102.2 1783.3 1832.8 1834.4 1855.3 1892.3 115232.0 120118.0 121407.0 122486.0 124032.0 9300.7 11168.4 11393.1 11482.0 11648.9 14049.6 14180.7 14189.7 14203.4 14256.9 7978.2 8266.4 8304.5 8375.1 8398.4 8121.4 8211.3 8251.5 8354.9 8373.3 4017.9 4370.7 4381.3 4396.9 4472.3 1853.7 1886.8 1886.9 1889.3 1905.5 806.5 852.8 874.7 892.1 897.1 19921.3 20504.1 20532.6 20566.8 20672.4 817.6 883.9 910.4 919.3 925.0 7691.5 8869.0 9756.2 10474.0 10826.2 536897.0 554281.0 567730.0 568140.3 568583.0 87206.0 98643.0 108027.0 119318.0 125638.4 883.1 942.7 960.4 977.5 991.6 14685.2 17153.7 17266.8 18117.1 18144.5 39100.8 50754.0 51768.5 52480.0 53399.7 70878.0 72367.0 72920.0 73205.6 75479.6 7779.0 7781.1 7929.6 8054.0 8095.9 10065.5 10737.5 10813.2 11510.1 11956.6 9985.2 10696.9 10705.6 10960.8 11119.6 9767.8 10768.1 10908.3 11152.8 11212.3 10960.2 11002.4 11317.4 11396.5 11410.2 7792.5 7967.6 8002.9 8147.3 8178.5 10367.0 10766.9 10837.4 11073.8 11252.7 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5693.47 Median:4866.60 stddev:3201.20 (65.8%) stddev-sans-first:3193.26 07:29:53 INFO - PROCESS | 1656 | Values: 1314.8 1555.7 1757.8 1866.2 1939.8 7607.4 7912.4 8208.8 8489.4 9008.4 8395.2 8724.7 8732.7 8826.3 8828.9 2377.0 2403.1 2404.5 2405.5 2407.3 2356.2 2381.4 2400.9 2401.3 2411.6 2369.9 2374.2 2376.2 2403.4 2405.9 2356.3 2368.0 2372.3 2375.0 2385.6 2358.7 2375.7 2379.0 2381.0 2386.0 7260.6 8901.7 8925.2 8948.1 8960.1 5260.7 5418.3 5437.9 5441.1 5451.2 3605.1 3608.9 3655.5 3696.1 3705.3 1055.8 1061.9 1065.2 1071.8 1072.5 11616.0 11635.8 11720.2 11765.9 11809.2 4515.3 4627.8 4782.7 4817.6 4844.7 9714.1 9844.3 9920.9 9947.4 9947.7 5325.7 5330.8 5346.6 5379.9 5387.4 4413.8 4590.2 4681.9 4766.7 4929.6 3386.8 3482.7 3868.3 3921.5 4036.6 1050.6 1124.4 1320.7 1322.7 1324.1 780.6 882.8 903.2 937.2 955.8 4477.5 5892.4 5958.9 5966.8 6092.1 373.3 441.5 766.8 922.9 1055.3 3238.0 3933.9 3949.6 4022.8 4038.2 10418.4 10771.5 10844.6 10867.7 10973.9 10043.5 10796.6 10798.7 10833.7 10916.7 7850.9 8313.2 8323.4 8326.7 8331.9 5901.3 5955.8 6034.1 6086.2 6106.7 9176.7 9964.5 10082.5 10088.6 10273.8 10196.9 10260.6 10264.4 10273.3 10276.5 6808.0 6939.0 7180.1 7262.5 7339.9 8120.3 8438.2 8449.8 8460.9 8482.7 6645.2 7469.1 7554.8 7555.0 7615.8 7209.1 7399.2 7406.2 7426.4 7436.6 7027.1 7045.9 7124.9 7129.3 7136.4 4939.0 5012.6 5028.9 5048.5 5081.2 4888.5 4943.8 5063.7 5153.9 5171.6 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4546.07 Median:4834.08 stddev:1464.96 (30.3%) stddev-sans-first:1433.51 07:29:53 INFO - PROCESS | 1656 | Values: 271.7 286.5 300.7 310.4 310.4 5250.4 5368.6 5374.4 5582.7 5669.4 4877.5 5339.9 5475.9 5516.5 5582.5 3388.9 3436.6 3442.8 3593.6 3823.5 4123.8 4227.3 4258.2 4259.9 4277.9 3468.3 4167.7 4172.7 4174.2 4177.3 4077.4 4163.5 4179.8 4182.7 4191.9 2994.6 3065.4 3657.4 3658.2 3663.8 4502.6 4607.4 5037.4 5431.9 5454.5 4303.7 4532.4 4813.9 4815.8 4820.6 5127.5 5495.8 5562.9 5814.5 5903.6 2966.1 3784.3 3906.3 3908.4 4016.1 5654.9 6209.2 6214.2 6237.4 6279.7 3974.9 3987.5 3994.2 4019.6 4020.6 3726.1 4006.8 4007.3 4041.5 4047.8 3651.8 4068.8 4364.6 4435.9 4761.5 5863.2 5871.8 5919.6 5938.8 5971.6 1258.1 1300.8 1352.9 1361.9 1368.3 808.7 811.0 824.6 828.7 837.2 4216.3 4353.5 4397.3 4629.9 4662.6 4358.6 4628.1 4889.8 5087.7 5088.4 3947.6 4128.0 4628.3 4644.8 4667.7 2564.8 2647.0 2664.5 2695.4 2719.4 4532.2 4877.3 5128.6 5223.9 5233.6 4398.3 4847.6 4879.6 5016.5 5155.4 5725.4 6327.9 6330.8 6340.0 6397.7 6177.3 6197.3 6216.5 6236.8 6296.7 5066.1 5619.7 5825.5 6102.3 6114.8 5486.9 6322.6 6337.2 6388.8 6441.3 3974.3 3975.7 3985.8 3994.3 4008.8 5787.7 6018.0 6054.4 6105.8 6158.9 4666.4 4766.7 5786.3 5824.2 5948.3 4478.3 4536.8 5096.1 5953.9 5971.4 4692.1 5222.5 5464.5 5727.2 5823.5 4893.8 5163.4 5606.0 5868.4 5962.9 5547.8 5692.8 5795.7 5843.3 5860.7 07:29:53 INFO - PROCESS | 1656 | 07:29:53 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:23864.46 Median:4393.58 stddev:38095.28 (867.1%) stddev-sans-first:38162.46 07:29:53 INFO - PROCESS | 1656 | Values: 703.9 713.0 729.8 773.8 830.2 13069.3 13073.4 15363.1 15501.1 16407.2 10760.5 14565.3 14664.4 14762.1 14776.6 864.0 871.4 886.5 888.1 890.2 712.4 897.1 901.5 902.3 905.2 857.3 925.1 953.5 954.0 956.5 775.6 936.4 937.1 945.4 948.3 697.8 700.6 703.9 704.8 705.7 13324.7 13461.3 13568.5 13603.3 13626.6 11553.6 11776.1 11886.5 12102.4 12107.4 10616.6 10846.8 11026.3 11230.9 11474.9 3542.4 3579.3 3583.6 3597.8 3606.1 103429.0 105459.5 105802.0 106518.5 110236.0 9035.5 9140.4 9161.4 9478.0 9498.1 19234.2 19418.2 19446.7 19460.9 19738.6 7854.6 7888.1 7956.1 8105.2 8180.4 4383.4 4403.8 4405.4 4498.2 4499.0 3590.0 3729.0 3731.6 3732.0 3737.4 632.9 648.6 678.1 690.5 700.5 520.7 587.4 612.0 682.9 692.7 8170.7 8285.8 9040.4 9652.6 9706.4 581.6 600.0 675.1 690.6 692.3 4254.6 4697.3 4725.1 4843.7 5017.8 94210.1 94775.0 117387.0 153515.0 163534.0 97081.0 135775.1 136922.0 139148.0 141276.2 89369.0 116547.4 119140.0 122399.8 125072.0 9840.1 9845.0 9850.0 9856.2 9921.6 61658.4 63263.7 63739.3 63739.4 67055.0 73144.0 76598.9 88215.6 92233.5 97351.0 13113.5 13140.1 13308.1 13588.5 13792.2 11068.6 14828.7 14886.3 15062.5 15311.3 13546.5 13573.0 13582.7 13633.0 14122.9 13438.4 13674.8 13695.7 13732.2 14206.2 13315.3 13351.0 13620.2 13977.7 14053.3 10460.5 10729.7 11161.7 11313.6 11569.9 9006.5 9743.6 10535.4 11400.3 11534.8 07:29:53 INFO - PROCESS | 1656 | -------- Summary: end -------- 07:29:53 INFO - PROCESS | 1656 | 07:29:54 INFO - TEST-INFO | 1656: exit 0 07:29:54 INFO - TEST-OK | dromaeo_css | took 1115983ms 07:29:54 INFO - TEST-START | kraken 07:29:54 INFO - operating with platform_type : mac_ 07:29:54 INFO - Initialising browser for kraken test... 07:29:54 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmp6Buh6W/profile http://localhost:49281/getInfo.html) 07:29:56 INFO - PROCESS | 1664 | 2016-10-20 07:29:56.917 plugin-container[1665:9981] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 07:29:56 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:29:56 INFO - PROCESS | 1664 | 2016-10-20 07:29:56.920 plugin-container[1665:9981] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 07:29:56 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:29:56 INFO - PROCESS | 1664 | 2016-10-20 07:29:56.920 plugin-container[1665:9981] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:29:57 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 07:29:57 INFO - PROCESS | 1664 | colorDepth:24 07:29:57 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 07:29:57 INFO - PROCESS | 1664 | __metrics 07:29:57 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 07:29:57 INFO - TEST-INFO | 1664: exit 0 07:29:57 INFO - Browser initialized. 07:29:57 INFO - Running cycle 1/1 for kraken test... 07:29:57 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmp6Buh6W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:00 INFO - PROCESS | 1666 | 2016-10-20 07:30:00.263 plugin-container[1667:10097] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 07:30:00 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:30:00 INFO - PROCESS | 1666 | 2016-10-20 07:30:00.263 plugin-container[1667:10097] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 07:30:00 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:30:00 INFO - PROCESS | 1666 | 2016-10-20 07:30:00.263 plugin-container[1667:10097] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:30:09 INFO - PROCESS | 1666 | RSS: Main: 236978176 07:30:09 INFO - PROCESS | 1666 | 07:30:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:13 INFO - PROCESS | 1666 | RSS: Main: 249491456 07:30:13 INFO - PROCESS | 1666 | 07:30:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 07:30:17 INFO - PROCESS | 1666 | RSS: Main: 257052672 07:30:17 INFO - PROCESS | 1666 | 07:30:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 07:30:21 INFO - PROCESS | 1666 | RSS: Main: 259985408 07:30:21 INFO - PROCESS | 1666 | 07:30:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 07:30:23 INFO - PROCESS | 1666 | RSS: Main: 261173248 07:30:23 INFO - PROCESS | 1666 | 07:30:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:26 INFO - PROCESS | 1666 | RSS: Main: 262844416 07:30:26 INFO - PROCESS | 1666 | 07:30:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:29 INFO - PROCESS | 1666 | RSS: Main: 263081984 07:30:29 INFO - PROCESS | 1666 | 07:30:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:33 INFO - PROCESS | 1666 | RSS: Main: 263270400 07:30:33 INFO - PROCESS | 1666 | 07:30:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 07:30:36 INFO - PROCESS | 1666 | RSS: Main: 263491584 07:30:36 INFO - PROCESS | 1666 | 07:30:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:39 INFO - PROCESS | 1666 | RSS: Main: 263204864 07:30:39 INFO - PROCESS | 1666 | 07:30:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:41 INFO - PROCESS | 1666 | RSS: Main: 263237632 07:30:41 INFO - PROCESS | 1666 | 07:30:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:44 INFO - PROCESS | 1666 | RSS: Main: 263274496 07:30:44 INFO - PROCESS | 1666 | 07:30:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:48 INFO - PROCESS | 1666 | RSS: Main: 263630848 07:30:48 INFO - PROCESS | 1666 | 07:30:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:52 INFO - PROCESS | 1666 | RSS: Main: 263667712 07:30:52 INFO - PROCESS | 1666 | 07:30:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 07:30:54 INFO - PROCESS | 1666 | RSS: Main: 265027584 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | __start_tp_report 07:30:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:30:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:30:54 INFO - PROCESS | 1666 | |i|pagename|runs| 07:30:54 INFO - PROCESS | 1666 | |0;ai-astar;160;173;117;149;173;145;117;111;119;119 07:30:54 INFO - PROCESS | 1666 | |1;audio-beat-detection;150;117;117;166;141;120;137;157;136;153 07:30:54 INFO - PROCESS | 1666 | |2;audio-dft;195;206;229;217;196;200;195;201;230;195 07:30:54 INFO - PROCESS | 1666 | |3;audio-fft;85;61;58;83;59;81;49;71;107;86 07:30:54 INFO - PROCESS | 1666 | |4;audio-oscillator;87;76;73;75;91;57;103;91;96;115 07:30:54 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;87;89;85;90;85;90;87;89;85 07:30:54 INFO - PROCESS | 1666 | |6;imaging-darkroom;96;97;98;134;148;117;95;95;95;95 07:30:54 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;88;86;87;90;118;97;147;73;140 07:30:54 INFO - PROCESS | 1666 | |8;json-parse-financial;56;65;64;84;85;86;84;86;87;65 07:30:54 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;99;70;75;82;78;69;69;70;73;72 07:30:54 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;91;93;97;83;108;105;80;96;108;93 07:30:54 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;153;150;150;151;150;150;149;147;181;184 07:30:54 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;176;178;176;177;196;208;175;173;177;173 07:30:54 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;77;90;89;75;69;73;72;71;81;88 07:30:54 INFO - PROCESS | 1666 | __end_tp_report 07:30:54 INFO - PROCESS | 1666 | __start_cc_report 07:30:54 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,953 07:30:54 INFO - PROCESS | 1666 | __end_cc_report 07:30:54 INFO - PROCESS | 1666 | __startTimestamp1476973854223__endTimestamp 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:30:54 INFO - PROCESS | 1666 | Number of tests: 14 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:138.30 Median:147.00 stddev:24.58 (16.7%) stddev-sans-first:24.78 07:30:54 INFO - PROCESS | 1666 | Values: 160.0 173.0 117.0 149.0 173.0 145.0 117.0 111.0 119.0 119.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:145.50 stddev:17.37 (11.9%) stddev-sans-first:17.99 07:30:54 INFO - PROCESS | 1666 | Values: 150.0 117.0 117.0 166.0 141.0 120.0 137.0 157.0 136.0 153.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:206.40 Median:203.50 stddev:13.94 (6.8%) stddev-sans-first:14.16 07:30:54 INFO - PROCESS | 1666 | Values: 195.0 206.0 229.0 217.0 196.0 200.0 195.0 201.0 230.0 195.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:74.00 Median:76.00 stddev:17.54 (23.1%) stddev-sans-first:18.14 07:30:54 INFO - PROCESS | 1666 | Values: 85.0 61.0 58.0 83.0 59.0 81.0 49.0 71.0 107.0 86.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:81.50 stddev:16.70 (20.5%) stddev-sans-first:17.71 07:30:54 INFO - PROCESS | 1666 | Values: 87.0 76.0 73.0 75.0 91.0 57.0 103.0 91.0 96.0 115.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:2.01 (2.3%) stddev-sans-first:2.13 07:30:54 INFO - PROCESS | 1666 | Values: 88.0 87.0 89.0 85.0 90.0 85.0 90.0 87.0 89.0 85.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:107.00 Median:95.00 stddev:19.40 (20.4%) stddev-sans-first:20.17 07:30:54 INFO - PROCESS | 1666 | Values: 96.0 97.0 98.0 134.0 148.0 117.0 95.0 95.0 95.0 95.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:86.50 stddev:25.08 (29.0%) stddev-sans-first:25.99 07:30:54 INFO - PROCESS | 1666 | Values: 86.0 88.0 86.0 87.0 90.0 118.0 97.0 147.0 73.0 140.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:76.20 Median:84.50 stddev:12.09 (14.3%) stddev-sans-first:10.38 07:30:54 INFO - PROCESS | 1666 | Values: 56.0 65.0 64.0 84.0 85.0 86.0 84.0 86.0 87.0 65.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:74.00 stddev:9.21 (12.5%) stddev-sans-first:4.48 07:30:54 INFO - PROCESS | 1666 | Values: 99.0 70.0 75.0 82.0 78.0 69.0 69.0 70.0 73.0 72.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:92.00 stddev:9.63 (10.5%) stddev-sans-first:10.08 07:30:54 INFO - PROCESS | 1666 | Values: 91.0 93.0 97.0 83.0 108.0 105.0 80.0 96.0 108.0 93.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:156.50 Median:150.50 stddev:13.80 (9.2%) stddev-sans-first:14.58 07:30:54 INFO - PROCESS | 1666 | Values: 153.0 150.0 150.0 151.0 150.0 150.0 149.0 147.0 181.0 184.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:177.00 stddev:11.59 (6.5%) stddev-sans-first:12.16 07:30:54 INFO - PROCESS | 1666 | Values: 176.0 178.0 176.0 177.0 196.0 208.0 175.0 173.0 177.0 173.0 07:30:54 INFO - PROCESS | 1666 | 07:30:54 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:79.00 stddev:7.98 (10.1%) stddev-sans-first:8.44 07:30:54 INFO - PROCESS | 1666 | Values: 77.0 90.0 89.0 75.0 69.0 73.0 72.0 71.0 81.0 88.0 07:30:54 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:30:54 INFO - PROCESS | 1666 | 07:30:55 INFO - TEST-INFO | 1666: exit 0 07:30:55 INFO - TEST-OK | kraken | took 61077ms 07:30:55 INFO - SUITE-END | took 1177s 07:30:55 INFO - Completed test suite (00:19:37) 07:30:55 INFO - javascript benchmark 07:30:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7295.720960961396, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.6055953565337, 3431.4681224410224, 3456.1877958679706, 3463.601685806133, 3466.2547552276255, 4638.884027899304, 5885.764569417223, 5914.201582786328, 5961.135635332874, 5988.341282458937, 5733.770649174038, 5815.912761308584, 5837.445442682938, 5883.529317654588, 5921.674307913063, 4334.631556317717, 5224.895502089956, 5246.134387826014, 5316.840494785162, 5337.813176538822, 5237.13587258102, 5369.9463005370035, 5377.843763590828, 5378.596605254622, 5413.242146099549, 5193.8961220775755, 5330.573554115662, 5362.115250983583, 5390.757415916273, 5399.676019438846, 5213.843584692465, 5235.65968212065, 5291.444398338158, 5338.0, 5386.569074474032, 5226.477352264781, 5239.502247286502, 5277.736113194325, 5305.283786688786, 5316.149416093406, 4953.554180123806, 5481.369642491125, 5675.801346952878, 5906.232189815297, 5915.260592425947, 6107.735039974563, 6132.722655450943, 6212.65830379329, 6227.657478838662, 6236.812895613139, 6263.373662633746, 6268.341824108448, 6270.561060725751, 6280.78017269398, 6295.307516173218, 6015.789447369365, 6019.428154325332, 6020.127081573235, 6034.6982650867285, 6040.96979515104, 6137.232845894263, 6227.252729672377, 6235.095911092866, 6249.531285153632, 6373.6175829450385, 6101.368489499298, 6123.234595675541, 6151.8926593212755, 6220.25356957159, 6263.874722505524, 6179.351168127372, 6268.592541484789, 6279.995200767855, 6302.338254483305, 6306.905396419057, 6146.293176284785, 6146.739918316824, 6173.32093469718, 6176.7838125665385, 6229.190205273376, 5558.888822223533, 6093.908591371133, 6154.169187159676, 6200.441960223601, 6238.033104868752, 4999.900001999939, 5022.397312322471, 5054.1407960646775, 5070.391553013662, 5110.156824124052, 4509.0080182359825, 4535.455745310584, 4543.727376357429, 4562.931556026662, 4593.885152871205, 5875.559333049953, 5930.051191809376, 6049.364816694272, 6088.695565221721, 6103.633781973007, 6154.015357542861, 6189.8452538686, 6200.720967556471, 6206.937930620636, 6291.245050593867, 5126.69239845603, 6008.939910600925, 6034.969825150846, 6037.486813620803, 6063.939360606338, 5556.388797232301, 5564.4713752193475, 5567.693776842231, 5579.414161513064, 5584.994700953786, 6218.751249949952, 6231.158793562901, 6297.52768542352, 6344.270408903035, 6347.0, 6213.471854892385, 6264.561480696308, 6265.216847894013, 6269.655168965751, 6283.37166283368, 6417.0, 6421.8715625688155, 6422.518311126591, 6448.419642232222, 6460.741570337133, 6028.8794224116145, 6097.948168432722, 6204.441600255998, 6222.160008398808, 6249.906251406142, 6066.181065556093, 6251.218597675291, 6256.906146407899, 6263.154474145932, 6266.874662506815, 6078.665673388006, 6230.7819226326865, 6231.3145553988115, 6247.531435142291, 6285.717142728497, 6086.391360863879, 6101.005087479836, 6107.450329470191, 6135.5695317960535, 6150.60021098645, 5952.464278214981, 6093.451589356979, 6162.291336496361, 6174.228221472316, 6179.660118693515, 6210.627362358273, 6251.71867265965, 6266.185395898504, 6266.749330026748, 6271.74913003493, 5920.940790592039, 6072.271327440559, 6130.877382452237, 6136.2636483622255, 6151.384861513813], "value": 5769.708426854693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.94000749906263, 493.664308270376, 508.7049511283455, 514.5934711577852, 526.4682670502791, 39213.41179882304, 40812.79593602035, 40820.795896020514, 40868.59131408692, 40931.9767005825, 42085.36871946923, 42484.787576062074, 42530.36204456936, 42575.148497030044, 42695.0, 9469.857952130706, 9611.567479463441, 9660.227181825472, 9676.854847177297, 9710.41737495749, 9558.522073896278, 9643.0, 9656.372335798185, 9660.130588247092, 9677.032296770301, 9644.61421543141, 9653.27600429967, 9674.516274186297, 9699.078587534208, 9703.708888733314, 7894.368450523944, 8263.297619702333, 9614.71155865325, 9636.469994150319, 9666.75833104171, 7990.760277191694, 8675.609597568062, 8899.37704360695, 9430.056994300583, 9541.379810312377, 32934.67065329364, 40324.790256292355, 40344.596554034375, 40350.0, 40361.59638403608, 3369.393509168349, 3524.242287908112, 3967.4643923070594, 4156.480439945007, 4289.034967132401, 30136.0, 30810.84594577035, 31339.0, 31468.213294667818, 31765.841170794, 3081.3529158876663, 3100.937981240385, 3171.2864605463815, 3209.3420848726187, 3214.4696125139326, 364286.0, 425929.0, 442338.9999999968, 445567.0, 447818.0, 60990.69504652448, 61173.0, 61406.0, 61593.46016349537, 61675.691621541606, 64187.0, 64292.0, 64386.0, 64458.0, 64533.0, 13570.0, 16106.597335066483, 16229.026258424532, 16247.268872900748, 16254.18729063542, 12430.627081187578, 12454.190477618926, 12495.062870284582, 12548.874511254771, 12559.811602825965, 17149.828501714823, 17586.0, 17593.91203044002, 17613.647727045645, 17705.468835934942, 6987.89518157228, 7030.9766800276375, 7121.857562848818, 7152.892706609405, 7193.280671932869, 800.507687772016, 978.3054031637474, 988.0860204310984, 1005.692599620505, 1099.4502748625687, 25627.743722562536, 29855.552166717516, 30027.099187024425, 30413.69586304153, 30736.231594209876, 1017.1862509992125, 1020.6835880876952, 1074.908632766208, 1115.938623375722, 1120.1263014848432, 15283.923580382027, 15791.526254212393, 15826.525204243891, 15843.762343564857, 16152.434664786912, 646906.0, 649203.0, 652319.9072037066, 654990.0, 655044.0, 58354.0, 58759.412405876246, 59190.11214831695, 59296.70351648214, 59478.0, 1331.9200847949155, 1370.6984463418232, 1377.579838149354, 1396.3506969259547, 1396.9650758730909, 29653.0, 29785.0, 30476.84761576178, 30652.0, 31395.529067063555, 56207.0, 56210.71894640501, 56677.716611416676, 56798.43201567931, 56942.7152864233, 477701.0, 497690.0, 546522.534774663, 596335.0, 599843.0, 42209.36685949775, 42236.36645450259, 42557.36163957605, 42876.78561607172, 43205.783971079945, 45969.49565823221, 47207.0, 47381.76309118432, 47991.28013079876, 48182.5181748178, 38159.80920095493, 39183.60816391914, 39791.80104099461, 40682.59317406788, 41804.58195418129, 33276.00171994844, 37302.253954920205, 38590.228195435375, 38630.22739545249, 40168.0, 37672.62327376691, 38667.613323866404, 38773.80613096916, 38916.63791767274, 38947.610523895535, 30896.84551577228, 34078.0, 34749.82625086959, 34809.47785783165, 34970.47544286888, 25685.74314256908, 25935.092271770398, 26036.30764000334, 26264.0, 26376.604350935137], "value": 20171.484125395145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.4094040131776, 360.35496461334196, 369.9130704284492, 375.83275442428095, 392.6297222692803, 19172.904135479337, 19627.803721962777, 20142.69785953212, 20906.686399703998, 21081.051352689126, 20378.490537736565, 20526.589468210626, 20664.89667551664, 20961.475963100893, 21053.05261263243, 4492.707973981697, 5746.511546518551, 5913.822585322448, 5996.370381109986, 6028.095785632168, 5831.504322132624, 5900.940990590082, 5924.763009479616, 5945.227120474332, 5963.344032156459, 5618.943810561904, 5790.305163380401, 5864.501517371007, 5890.381509941459, 5937.228160339171, 5836.854078648025, 5858.297004359461, 5868.735906884158, 5909.645421274716, 5909.734061967221, 4976.353074100344, 5139.922901156486, 5248.239005344242, 5319.627626066177, 5360.865978350534, 12462.065345099063, 12754.10721249513, 12809.295488748116, 19599.90200049005, 23426.06295748168, 2087.84341174411, 2100.0759665747173, 2170.392290158758, 2499.800015998716, 2861.298981749464, 9410.811783764286, 9594.9520252399, 9601.183899368492, 9858.753531161707, 10102.19182465401, 1783.2599471219428, 1832.7800663920416, 1834.4313262888547, 1855.313533992418, 1892.280933245358, 115232.0, 120118.0, 121407.0, 122486.0, 124032.0, 9300.72097837066, 11168.385738784282, 11393.145514086476, 11482.0, 11648.88351116495, 14049.578512644637, 14180.716385672229, 14189.716205676035, 14203.431862725376, 14256.928715356356, 7978.162292959272, 8266.380021498411, 8304.501729896225, 8375.078741338448, 8398.412111152284, 8121.390895682729, 8211.302039326605, 8251.546164960984, 8354.916450835535, 8373.330133589297, 4017.859374921922, 4370.650347972155, 4381.277089280296, 4396.934045989313, 4472.2620767573635, 1853.67560676881, 1886.7735871695484, 1886.867919245667, 1889.2915156816193, 1905.5136993145368, 806.5322113174345, 852.8166444214523, 874.6851133592029, 892.1346294094718, 897.0849733272026, 19921.302754403525, 20504.077316520794, 20532.58934821295, 20566.794332056787, 20672.379828604866, 817.5503473089777, 883.867419887022, 910.3627460777482, 919.3105171121658, 924.9732796595773, 7691.538507689556, 8868.955655221682, 9756.21950243993, 10474.0, 10826.18803589734, 536897.0, 554281.0, 567730.0, 568140.318596817, 568583.0, 87205.96615049355, 98643.0, 108027.0, 119318.0, 125638.3718081422, 883.1257055515123, 942.6512190489426, 960.4381436859516, 977.4819345746907, 991.6479649724388, 14685.192314422382, 17153.656926861644, 17266.827331727025, 18117.09414529242, 18144.45566633003, 39100.80449597734, 50753.98492030212, 51768.48231517636, 52479.95040099253, 53399.733001336295, 70878.0, 72367.0, 72920.0, 73205.6339718298, 75479.62260188884, 7779.0, 7781.06627204739, 7929.563873986986, 8053.959730201312, 8095.919040809516, 10065.547050382896, 10737.46312684347, 10813.189010824377, 11510.07919366432, 11956.58151964677, 9985.1512621428, 10696.946515267375, 10705.625303114353, 10960.835587466354, 11119.610813621484, 9767.804643907224, 10768.0847127995, 10908.290961087503, 11152.776944461228, 11212.27120237182, 10960.232783705063, 11002.394868282321, 11317.434128293717, 11396.544138234378, 11410.201285910238, 7792.493487923493, 7967.601619919097, 8002.919970800451, 8147.307478864126, 8178.5092894426525, 10367.0, 10766.946165269124, 10837.403942783223, 11073.83389249178, 11252.66242012741], "value": 9104.597757065018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.8027795830624, 1555.6733086051925, 1757.815429379915, 1866.1509013398904, 1939.7769256535494, 7607.429442791792, 7912.367010639149, 8208.83582328353, 8489.36329775267, 9008.369414141005, 8395.160483951602, 8724.651013959434, 8732.650693972233, 8826.293896488281, 8828.867566986484, 2376.95246095078, 2403.098837935774, 2404.471016376403, 2405.482821193443, 2407.265783935899, 2356.15178535727, 2381.392744850061, 2400.8919598618018, 2401.315625046862, 2411.602085655865, 2369.8578085314934, 2374.2402431222017, 2376.2158487699016, 2403.4111642647576, 2405.855648661086, 2356.3166681662296, 2368.017272831773, 2372.3476044087843, 2375.049980008002, 2385.6063749481314, 2358.6579945907747, 2375.70303712036, 2378.9643155352683, 2381.0356805493802, 2385.988070059656, 7260.564366138048, 8901.73294801157, 8925.241354484877, 8948.105189481064, 8960.059193784624, 5260.710660913648, 5418.322709661293, 5437.864053398657, 5441.102218134003, 5451.182322651594, 3605.0987253186704, 3608.855645774166, 3655.4516822476576, 3696.131409118855, 3705.3330400527893, 1055.841623756435, 1061.8778840433372, 1065.1638463805875, 1071.839224116381, 1072.5441687282873, 11616.0, 11635.767284654345, 11720.179587428884, 11765.941065304163, 11809.23239989398, 4515.254982927846, 4627.838025669085, 4782.713037217778, 4817.590504807061, 4844.685095468783, 9714.077162669535, 9844.310898237054, 9920.900790991998, 9947.35342202769, 9947.651832185838, 5325.733713314319, 5330.760115794798, 5346.572274218053, 5379.946200537945, 5387.4073851876265, 4413.801378937956, 4590.219662657356, 4681.9297710534365, 4766.737829419346, 4929.605631549467, 3386.7967921924765, 3482.7039701625645, 3868.3423817951016, 3921.509811273591, 4036.57615950321, 1050.632278702448, 1124.4265424633495, 1320.6896379350844, 1322.7288405876773, 1324.0599174586152, 780.5940910726504, 882.7528292078229, 903.20969151992, 937.1799675284126, 955.7658373698349, 4477.529859364785, 5892.381299963527, 5958.910616340759, 5966.76132954677, 6092.147099406086, 373.27957042906905, 441.5496193882222, 766.7508059880561, 922.9353945223904, 1055.2824079625927, 3237.9838100809343, 3933.8819835404984, 3949.578151865326, 4022.7988600569856, 4038.1519880825354, 10418.374897506174, 10771.46142692878, 10844.620438284623, 10867.673969780919, 10973.890261097447, 10043.548040338203, 10796.568137274578, 10798.67603971882, 10833.67498975032, 10916.727081823017, 7850.882236766453, 8313.210245026712, 8323.375746819134, 8326.66693332272, 8331.916680833236, 5901.29184497863, 5955.791547295824, 6034.125051867367, 6086.239220097488, 6106.69466526663, 9176.724698259062, 9964.50177491137, 10082.546285417027, 10088.596456141966, 10273.794524109626, 10196.929322421336, 10260.58957641686, 10264.435456049989, 10273.332233404804, 10276.537555809857, 6807.965960170168, 6939.0, 7180.066591343092, 7262.527935684164, 7339.89901514777, 8120.269175774209, 8438.156184381513, 8449.83100338002, 8460.915390846012, 8482.745517634481, 6645.202575690948, 7469.1037075551285, 7554.773356799305, 7554.962225188839, 7615.809604759926, 7209.134903811367, 7399.223081576357, 7406.18531961473, 7426.4058875288765, 7436.553806771611, 7027.121609798775, 7045.894311585433, 7124.928750712426, 7129.251428599922, 7136.4290856730295, 4939.0, 5012.624053195952, 5028.949710502849, 5048.545630893237, 5081.212412076134, 4888.5111488850835, 4943.773074021659, 5063.721495317793, 5153.917677287812, 5171.586273098068], "value": 4551.924131462544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.65228507510386, 286.54296397246395, 300.6752707076357, 310.35755985110814, 310.3869857032363, 5250.422453530114, 5368.62419630626, 5374.381946076202, 5582.720863956796, 5669.433056694334, 4877.463598966323, 5339.919901201485, 5475.945240547593, 5516.503514683678, 5582.469665381782, 3388.915277118067, 3436.639152888948, 3442.845071971767, 3593.5984965863336, 3823.483829682992, 4123.783448909855, 4227.3447615619625, 4258.190943720699, 4259.893502662428, 4277.850275240367, 3468.2543253200556, 4167.666586673059, 4172.687048471377, 4174.186033723425, 4177.310743727281, 4077.4495443115097, 4163.542010378841, 4179.791010449465, 4182.707210495267, 4191.8532851350055, 2994.595729576523, 3065.371598822236, 3657.3782456982376, 3658.1951970566697, 3663.7618554793853, 4502.639788816887, 4607.401037865056, 5037.448598737881, 5431.891362172734, 5454.4545545445535, 4303.655707543389, 4532.365468834333, 4813.857833264199, 4815.821557771854, 4820.565614364758, 5127.461616530285, 5495.807646732345, 5562.9443705562835, 5814.534837213013, 5903.616264942808, 2966.080515040323, 3784.2620688965662, 3906.277338692351, 3908.355121404965, 4016.0763024504527, 5654.858628534237, 6209.223847019122, 6214.223222097238, 6237.438630523229, 6279.748810047593, 3974.8608798691907, 3987.541432735273, 3994.1612261424843, 4019.618136277049, 4020.632984785187, 3726.087108658342, 4006.8397264109694, 4007.2586571484367, 4041.535223449282, 4047.7737244515397, 3651.7626354287418, 4068.8372465101656, 4364.5635436456105, 4435.866923992286, 4761.47623761386, 5863.179154918314, 5871.794487192928, 5919.644821310649, 5938.792142275, 5971.55119436023, 1258.1444617659897, 1300.7983762516826, 1352.931184364361, 1361.9114757540729, 1368.261138984937, 808.7250334886166, 811.0308181722785, 824.5547404401556, 828.7099515169763, 837.2213841127688, 4216.31347461012, 4353.455818022747, 4397.307036790795, 4629.907401851944, 4662.557057079572, 4358.629516491071, 4628.1256091283085, 4889.801998510387, 5087.720175390315, 5088.440271570124, 3947.5657677655436, 4127.958720412757, 4628.305754136906, 4644.814207431665, 4667.719936803803, 2564.7819935305706, 2646.986765066162, 2664.533706601337, 2695.447433276174, 2719.4017316190407, 4532.232429352555, 4877.317175595419, 5128.615353848476, 5223.858218130625, 5233.613092530482, 4398.274284743045, 4847.587955023792, 4879.634027447955, 5016.498350165028, 5155.381354237516, 5725.366331487479, 6327.905081423783, 6330.8417289567205, 6340.0, 6397.680115994275, 6177.2587289525545, 6197.349278325711, 6216.471599913877, 6236.844078898064, 6296.716647750954, 5066.06277838601, 5619.722459414986, 5825.50483208915, 6102.328743838086, 6114.755409783559, 5486.890262194814, 6322.557420980487, 6337.207849018872, 6388.840278993062, 6441.323661015525, 3974.28462876685, 3975.688022952361, 3985.820638071236, 3994.2810294147334, 4008.7594744315434, 5787.7395517200985, 6018.0, 6054.3642917493025, 6105.8168254952425, 6158.907616385668, 4666.416697912761, 4766.713997160182, 5786.276715410574, 5824.165387902797, 5948.345681974893, 4478.328250762412, 4536.841210557614, 5096.133657278346, 5953.851153721192, 5971.373005834324, 4692.085043416501, 5222.529972302511, 5464.508194262536, 5727.198192253005, 5823.534117270524, 4893.828715994923, 5163.380394352702, 5606.018946684396, 5868.38381969887, 5962.940370596412, 5547.805826796042, 5692.829215123553, 5795.652260864362, 5843.328017278068, 5860.677662728591], "value": 4075.2265378531656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.9014537964682, 712.9536580122292, 729.7555318968147, 773.8104164479699, 830.2486249943803, 13069.346532673364, 13073.411696473659, 15363.078215307061, 15501.147436890966, 16407.17964101793, 10760.515776790044, 14565.344559494823, 14664.413423463075, 14762.11427314362, 14776.6305842354, 864.0365991918997, 871.4379225399614, 886.5212785096072, 888.0897080492482, 890.2255038116847, 712.4300559552363, 897.0670502677208, 901.4951627088818, 902.2736696958946, 905.2034209895315, 857.2884505860121, 925.0703043441332, 953.5184731710511, 953.9840070325116, 956.5360800012023, 775.5889378629336, 936.3679516326521, 937.1144268666113, 945.3618807305076, 948.3361646847235, 697.7941507255372, 700.5586480517242, 703.8521910398822, 704.799132247307, 705.7141857547701, 13324.733505329936, 13461.326933653278, 13568.525101621495, 13603.31983400826, 13626.591202263948, 11553.595624153115, 11776.11679124069, 11886.465109070026, 12102.394880255952, 12107.39463026845, 10616.57533698651, 10846.837297440545, 11026.338419694845, 11230.887691123147, 11474.94262528682, 3542.36237477254, 3579.266250418658, 3583.623719509466, 3597.8021208833766, 3606.062423769839, 103429.0, 105459.47270263599, 105802.0, 106518.46740766247, 110236.0, 9035.503047332328, 9140.360174787835, 9161.404508706913, 9478.0, 9498.050194980447, 19234.23063077489, 19418.223271069, 19446.70829937552, 19460.90269548643, 19738.60522789536, 7854.567998760009, 7888.1323054463965, 7956.085050219183, 8105.230003149692, 8180.427370084156, 4383.364412160219, 4403.801828917706, 4405.383246345515, 4498.167838949805, 4498.955010449919, 3589.964100358963, 3729.030452082478, 3731.589525152231, 3731.9813400933363, 3737.4020156774786, 632.8766439569708, 648.5849056603778, 678.1489231015144, 690.4821383962028, 700.5341447937167, 520.7370278009581, 587.3832475900288, 611.984700382494, 682.8566001139717, 692.7090621938797, 8170.673173073011, 8285.751427457186, 9040.367174297737, 9652.581033612709, 9706.369086009387, 581.5928849805068, 599.9850003749941, 675.1122274209399, 690.5649440852332, 692.2696555134381, 4254.574542545783, 4697.295405689174, 4725.10223057618, 4843.716415149988, 5017.835435722707, 94210.0578994215, 94775.0, 117387.0, 153515.0, 163534.0, 97081.0, 135775.13798896063, 136922.0, 139148.0, 141276.22132901402, 89369.0, 116547.41726291315, 119139.99999999827, 122399.77600224061, 125072.0, 9840.065193806577, 9844.950775246365, 9850.0, 9856.21150307988, 9921.55353009102, 61658.38341616526, 63263.6836815813, 63739.300464893255, 63739.362606375194, 67054.99417508644, 73144.0, 76598.85101723367, 88215.55892220755, 92233.5388323054, 97351.0, 13113.541026064042, 13140.145890517086, 13308.068435209443, 13588.45646174142, 13792.241426721226, 11068.612598559012, 14828.703425931206, 14886.330115144629, 15062.472813451477, 15311.310991005654, 13546.525871594447, 13573.0, 13582.660433488847, 13633.0, 14122.858771412566, 13438.395272212578, 13674.794878076638, 13695.657608559468, 13732.244726539737, 14206.21865797391, 13315.267660278778, 13350.998675099212, 13620.18278903269, 13977.720445590829, 14053.297335133408, 10460.47697615101, 10729.731756705833, 11161.72095697614, 11313.604023859125, 11569.88430115688, 9006.50464224474, 9743.561539730586, 10535.447825936068, 11400.258983166068, 11534.769304613694], "value": 7671.214383693292, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 173.0, 117.0, 149.0, 173.0, 145.0, 117.0, 111.0, 119.0, 119.0], "value": 138.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 117.0, 166.0, 141.0, 120.0, 137.0, 157.0, 136.0, 153.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 206.0, 229.0, 217.0, 196.0, 200.0, 195.0, 201.0, 230.0, 195.0], "value": 206.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 61.0, 58.0, 83.0, 59.0, 81.0, 49.0, 71.0, 107.0, 86.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 76.0, 73.0, 75.0, 91.0, 57.0, 103.0, 91.0, 96.0, 115.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 85.0, 90.0, 85.0, 90.0, 87.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 98.0, 134.0, 148.0, 117.0, 95.0, 95.0, 95.0, 95.0], "value": 107.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 87.0, 90.0, 118.0, 97.0, 147.0, 73.0, 140.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 64.0, 84.0, 85.0, 86.0, 84.0, 86.0, 87.0, 65.0], "value": 76.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 70.0, 75.0, 82.0, 78.0, 69.0, 69.0, 70.0, 73.0, 72.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 97.0, 83.0, 108.0, 105.0, 80.0, 96.0, 108.0, 93.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 150.0, 151.0, 150.0, 150.0, 149.0, 147.0, 181.0, 184.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 176.0, 177.0, 196.0, 208.0, 175.0, 173.0, 177.0, 173.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 90.0, 89.0, 75.0, 69.0, 73.0, 72.0, 71.0, 81.0, 88.0], "value": 78.5, "unit": "score"}]}]} 07:30:55 INFO - Return code: 0 07:30:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:30:55 ERROR - # TBPL SUCCESS # 07:30:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:30:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:30:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:30:55 INFO - 2016-10-20 07:30:55.522 screenresolution[1672:10488] starting screenresolution argv=screenresolution get 07:30:55 INFO - 2016-10-20 07:30:55.526 screenresolution[1672:10488] Display 0: 1600x1200x32@60 07:30:55 INFO - 2016-10-20 07:30:55.533 screenresolution[1673:10491] starting screenresolution argv=screenresolution list 07:30:55 INFO - Available Modes on Display 0 07:30:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:30:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:30:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:30:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:30:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:30:55 INFO - Intel Iris: 07:30:55 INFO - Chipset Model: Intel Iris 07:30:55 INFO - Type: GPU 07:30:55 INFO - Bus: Built-In 07:30:55 INFO - VRAM (Dynamic, Max): 1536 MB 07:30:55 INFO - Vendor: Intel (0x8086) 07:30:55 INFO - Device ID: 0x0a2e 07:30:55 INFO - Revision ID: 0x0009 07:30:55 INFO - Displays: 07:30:55 INFO - Display: 07:30:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:30:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:30:55 INFO - Display Serial Number: 1600x1200 60 07:30:55 INFO - Main Display: Yes 07:30:55 INFO - Mirror: Off 07:30:55 INFO - Online: Yes 07:30:55 INFO - Rotation: Supported 07:30:55 INFO - Return code: 0 07:30:55 INFO - Running post-action listener: _resource_record_post_action 07:30:55 INFO - [mozharness: 2016-10-20 14:30:55.772889Z] Finished run-tests step (success) 07:30:55 INFO - Running post-run listener: _resource_record_post_run 07:30:55 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 38341120; Write bytes: 711980544; Read time: 246; Write time: 2026 07:30:55 INFO - TinderboxPrint: CPU usage
54.7% 07:30:55 INFO - TinderboxPrint: I/O read bytes / time
38,341,120 / 246 07:30:55 INFO - TinderboxPrint: I/O write bytes / time
711,980,544 / 2,026 07:30:55 INFO - TinderboxPrint: CPU idle
2,196.8 (45.3%) 07:30:55 INFO - TinderboxPrint: CPU system
984.2 (20.3%) 07:30:55 INFO - TinderboxPrint: CPU user
1,668.9 (34.4%) 07:30:55 INFO - TinderboxPrint: Swap in / out
444,448,768 / 0 07:30:55 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394144256; Write bytes: 382961664; Read time: 29090; Write time: 798 07:30:55 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 32150016; Write bytes: 301197312; Read time: 189; Write time: 1157 07:30:56 INFO - Running post-run listener: _upload_blobber_files 07:30:56 INFO - Blob upload gear active. 07:30:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:30:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:30:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:57 INFO - (blobuploader) - INFO - Done attempting. 07:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:58 INFO - (blobuploader) - INFO - Done attempting. 07:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:00 INFO - (blobuploader) - INFO - Done attempting. 07:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:00 INFO - Return code: 0 07:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aef54d876a4d4eb9ee885732c8d13b4ce0b3f999f33d91e98c241362b4afbc6f00f7f7b133c4b6b30b0a7909070630774acf96f9a4dea783ec8b12fbab05ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e62ade4b162492a1e0fa7a277df77bc1265ac9e0ea9de123ef3de7008ba1908d6a6a46c871c5602eb9dc0fe8ea0abca7cf785a199d964222967a9376776ecffc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e293f8c799fc5c2f3f7d4e5aabd88360f61af9e8707773510a21a7bb921bd7600243f3e52f8a58c46efa25fc8e5f4b8b4a92534b3b375da7be363ca9cfba659"} 07:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:00 INFO - Contents: 07:31:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aef54d876a4d4eb9ee885732c8d13b4ce0b3f999f33d91e98c241362b4afbc6f00f7f7b133c4b6b30b0a7909070630774acf96f9a4dea783ec8b12fbab05ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e62ade4b162492a1e0fa7a277df77bc1265ac9e0ea9de123ef3de7008ba1908d6a6a46c871c5602eb9dc0fe8ea0abca7cf785a199d964222967a9376776ecffc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e293f8c799fc5c2f3f7d4e5aabd88360f61af9e8707773510a21a7bb921bd7600243f3e52f8a58c46efa25fc8e5f4b8b4a92534b3b375da7be363ca9cfba659"} 07:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:00 INFO - Copying logs to upload dir... 07:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.724493 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-20 07:31:00.475446) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 07:31:00.479046) ========= 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.qVUBEawOtN/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.PgGmA2kBvd/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aef54d876a4d4eb9ee885732c8d13b4ce0b3f999f33d91e98c241362b4afbc6f00f7f7b133c4b6b30b0a7909070630774acf96f9a4dea783ec8b12fbab05ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e62ade4b162492a1e0fa7a277df77bc1265ac9e0ea9de123ef3de7008ba1908d6a6a46c871c5602eb9dc0fe8ea0abca7cf785a199d964222967a9376776ecffc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e293f8c799fc5c2f3f7d4e5aabd88360f61af9e8707773510a21a7bb921bd7600243f3e52f8a58c46efa25fc8e5f4b8b4a92534b3b375da7be363ca9cfba659"} build_url:https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/E6b5JuGfT_2Dd-V9-p0WSQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aef54d876a4d4eb9ee885732c8d13b4ce0b3f999f33d91e98c241362b4afbc6f00f7f7b133c4b6b30b0a7909070630774acf96f9a4dea783ec8b12fbab05ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e62ade4b162492a1e0fa7a277df77bc1265ac9e0ea9de123ef3de7008ba1908d6a6a46c871c5602eb9dc0fe8ea0abca7cf785a199d964222967a9376776ecffc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e293f8c799fc5c2f3f7d4e5aabd88360f61af9e8707773510a21a7bb921bd7600243f3e52f8a58c46efa25fc8e5f4b8b4a92534b3b375da7be363ca9cfba659"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 07:31:00.513981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:31:00.514334) ========= 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.qVUBEawOtN/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.PgGmA2kBvd/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.005364 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:31:00.562782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 07:31:00.563144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 07:31:00.563475) ========= ========= Total master_lag: 0.17 =========