builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0081 starttime: 1485323926.73 results: success (0) buildid: 20170124193347 builduid: 4112813809f74e4caa2725cd22ceadc8 revision: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.726021) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.726463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.726753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.753241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.753594) ========= 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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 21:58:46-- 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% 53.8M=0s 2017-01-24 21:58:46 (53.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150855 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.931670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.932393) ========= 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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.028129 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:46.982234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 21:58:46.982563) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YvMWE8IQbl/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.MGG0KPMYx6/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 21:58:47,088 truncating revision to first 12 chars 2017-01-24 21:58:47,088 Setting DEBUG logging. 2017-01-24 21:58:47,089 attempt 1/10 2017-01-24 21:58:47,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9c78f6d58ab9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 21:58:48,650 unpacking tar archive at: mozilla-beta-9c78f6d58ab9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.835330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 21:58:48.841822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:48.842194) ========= script_repo_revision: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:48.842649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:48.842978) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 21:58:48.860347) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-24 21:58:48.860692) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YvMWE8IQbl/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.MGG0KPMYx6/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:58:49 INFO - MultiFileLogger online at 20170124 21:58:49 in /builds/slave/test 21:58:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:58:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:58:49 INFO - {'append_to_log': False, 21:58:49 INFO - 'base_work_dir': '/builds/slave/test', 21:58:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:58:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:58:49 INFO - 'branch': 'Mozilla-Beta', 21:58:49 INFO - 'buildbot_json_path': 'buildprops.json', 21:58:49 INFO - 'config_files': ('talos/mac_config.py',), 21:58:49 INFO - 'default_actions': ('clobber', 21:58:49 INFO - 'read-buildbot-config', 21:58:49 INFO - 'download-and-extract', 21:58:49 INFO - 'populate-webroot', 21:58:49 INFO - 'create-virtualenv', 21:58:49 INFO - 'install', 21:58:49 INFO - 'run-tests'), 21:58:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:58:49 INFO - 'download_minidump_stackwalk': True, 21:58:49 INFO - 'download_symbols': 'ondemand', 21:58:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:58:49 INFO - 'tooltool.py': '/tools/tooltool.py', 21:58:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:58:49 INFO - '/tools/misc-python/virtualenv.py')}, 21:58:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:58:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:58:49 INFO - 'installer_path': 'installer.exe', 21:58:49 INFO - 'log_level': 'info', 21:58:49 INFO - 'log_name': 'talos', 21:58:49 INFO - 'log_to_console': True, 21:58:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:58:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:58:49 INFO - 'opt_config_files': (), 21:58:49 INFO - 'pip_index': False, 21:58:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:58:49 INFO - 'cmd': ('bash', 21:58:49 INFO - '-c', 21:58:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:58:49 INFO - 'enabled': True, 21:58:49 INFO - 'halt_on_failure': False, 21:58:49 INFO - 'name': 'check_screen_resolution'},), 21:58:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:58:49 INFO - 'cmd': ('bash', 21:58:49 INFO - '-c', 21:58:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:58:49 INFO - 'enabled': True, 21:58:49 INFO - 'halt_on_failure': False, 21:58:49 INFO - 'name': 'check_screen_resolution'},), 21:58:49 INFO - 'run_cmd_checks_enabled': True, 21:58:49 INFO - 'sps_profile': False, 21:58:49 INFO - 'sps_profile_interval': 0, 21:58:49 INFO - 'suite': 'dromaeojs-e10s', 21:58:49 INFO - 'system_bits': '32', 21:58:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:58:49 INFO - 'title': 't-yosemite-r7-0081', 21:58:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:58:49 INFO - 'use_talos_json': True, 21:58:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:58:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:58:49 INFO - 'work_dir': 'build'} 21:58:49 INFO - [mozharness: 2017-01-25 05:58:49.075058Z] Running clobber step. 21:58:49 INFO - Running pre-action listener: _resource_record_pre_action 21:58:49 INFO - Running main action method: clobber 21:58:49 INFO - rmtree: /builds/slave/test/build 21:58:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:58:51 INFO - Running post-action listener: _resource_record_post_action 21:58:51 INFO - [mozharness: 2017-01-25 05:58:51.606684Z] Finished clobber step (success) 21:58:51 INFO - [mozharness: 2017-01-25 05:58:51.606814Z] Running read-buildbot-config step. 21:58:51 INFO - Running pre-action listener: _resource_record_pre_action 21:58:51 INFO - Running main action method: read_buildbot_config 21:58:51 INFO - Using buildbot properties: 21:58:51 INFO - { 21:58:51 INFO - "project": "", 21:58:51 INFO - "product": "firefox", 21:58:51 INFO - "script_repo_revision": "production", 21:58:51 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 21:58:51 INFO - "repository": "", 21:58:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 21:58:51 INFO - "buildid": "20170124193347", 21:58:51 INFO - "pgo_build": "False", 21:58:51 INFO - "basedir": "/builds/slave/test", 21:58:51 INFO - "buildnumber": 14, 21:58:51 INFO - "slavename": "t-yosemite-r7-0081", 21:58:51 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:58:51 INFO - "platform": "yosemite_r7", 21:58:51 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:58:51 INFO - "branch": "mozilla-beta", 21:58:51 INFO - "repo_path": "releases/mozilla-beta", 21:58:51 INFO - "revision": "9c78f6d58ab9691a46f640ff3a81d7a55ad7a848", 21:58:51 INFO - "stage_platform": "macosx64", 21:58:51 INFO - "builduid": "4112813809f74e4caa2725cd22ceadc8", 21:58:51 INFO - "slavebuilddir": "test" 21:58:51 INFO - } 21:58:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 21:58:51 INFO - Running post-action listener: _resource_record_post_action 21:58:51 INFO - [mozharness: 2017-01-25 05:58:51.610010Z] Finished read-buildbot-config step (success) 21:58:51 INFO - [mozharness: 2017-01-25 05:58:51.610129Z] Running download-and-extract step. 21:58:51 INFO - Running pre-action listener: _resource_record_pre_action 21:58:51 INFO - Running main action method: download_and_extract 21:58:51 INFO - mkdir: /builds/slave/test/build/tests 21:58:51 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')]} 21:58:51 INFO - trying https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 21:58:51 INFO - Downloading https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 21:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 21:58:52 INFO - Downloaded 1165 bytes. 21:58:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 21:58:52 INFO - Using the following test package requirements: 21:58:52 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 21:58:52 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 21:58:52 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 21:58:52 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:58:52 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 21:58:52 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 21:58:52 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 21:58:52 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 21:58:52 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 21:58:52 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:58:52 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 21:58:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 21:58:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 21:58:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 21:58:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 21:58:53 INFO - Http code: 200 21:58:53 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 21:58:53 INFO - x-amz-cf-id: 1_thZ7ELMpQTK71G_MwlPMb54kurPRpCkVQpDooN_CwYZiesx_b38w== 21:58:53 INFO - x-amz-version-id: 1WxjECT9NhxFE6pYgHle.iC5GmWIDCnw 21:58:53 INFO - Expected file size: 16086201 21:58:53 INFO - Obtained file size: 16086201 21:59:00 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 21:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 21:59:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 21:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 21:59:00 INFO - Http code: 200 21:59:00 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 21:59:00 INFO - x-amz-cf-id: Opk9x5GOuVhisSSprMDKpuw4tHlNucMJpu5TTr4HoQH23JCzH01hFw== 21:59:00 INFO - x-amz-version-id: 1WxjECT9NhxFE6pYgHle.iC5GmWIDCnw 21:59:01 INFO - Expected file size: 16086201 21:59:01 INFO - Obtained file size: 16086201 21:59:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 21:59:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 21:59:07 INFO - Fetch https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 21:59:08 INFO - Http code: 200 21:59:08 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 21:59:08 INFO - x-amz-cf-id: 8UDB4bWlmaW5FvslKVR1OV8jDdqYdCzGva3MvKaq3mgrHPFCOiFtOg== 21:59:08 INFO - x-amz-version-id: tZdzzCgzER_.G4lMnlAaAVoIRut.jHq2 21:59:08 INFO - Expected file size: 14402992 21:59:08 INFO - Obtained file size: 14402992 21:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:09 INFO - trying https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 21:59:09 INFO - Downloading https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 21:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 21:59:11 INFO - Downloaded 82123167 bytes. 21:59:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 21:59:11 INFO - mkdir: /builds/slave/test/properties 21:59:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:11 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:11 INFO - Contents: 21:59:11 INFO - build_url:https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 21:59:12 INFO - Running post-action listener: _resource_record_post_action 21:59:12 INFO - Running post-action listener: set_extra_try_arguments 21:59:12 INFO - [mozharness: 2017-01-25 05:59:12.145443Z] Finished download-and-extract step (success) 21:59:12 INFO - [mozharness: 2017-01-25 05:59:12.145560Z] Running populate-webroot step. 21:59:12 INFO - Running pre-action listener: _resource_record_pre_action 21:59:12 INFO - Running main action method: populate_webroot 21:59:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:12 INFO - '--tppagecycles', 21:59:12 INFO - '7'], 21:59:12 INFO - 'tests': ['tsvgm']}}, 21:59:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['damp', 'tps']}, 21:59:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'tests': ['damp', 'tps']}, 21:59:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['dromaeo_dom']}, 21:59:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['basic_compositor_video']}, 21:59:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['a11yr', 21:59:12 INFO - 'ts_paint', 21:59:12 INFO - 'tpaint', 21:59:12 INFO - 'sessionrestore', 21:59:12 INFO - 'sessionrestore_no_auto_restore', 21:59:12 INFO - 'tabpaint']}, 21:59:12 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:12 INFO - 'ts_paint', 21:59:12 INFO - 'tpaint', 21:59:12 INFO - 'sessionrestore', 21:59:12 INFO - 'sessionrestore_no_auto_restore', 21:59:12 INFO - 'tabpaint']}, 21:59:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:12 INFO - 'ts_paint', 21:59:12 INFO - 'tpaint', 21:59:12 INFO - 'sessionrestore', 21:59:12 INFO - 'sessionrestore_no_auto_restore', 21:59:12 INFO - 'tabpaint']}, 21:59:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:12 INFO - 'ts_paint', 21:59:12 INFO - 'tpaint', 21:59:12 INFO - 'sessionrestore', 21:59:12 INFO - 'sessionrestore_no_auto_restore', 21:59:12 INFO - 'tabpaint']}, 21:59:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['a11yr', 21:59:12 INFO - 'ts_paint', 21:59:12 INFO - 'tpaint', 21:59:12 INFO - 'sessionrestore', 21:59:12 INFO - 'sessionrestore_no_auto_restore', 21:59:12 INFO - 'tabpaint']}, 21:59:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['a11yr', 21:59:12 INFO - 'ts_paint', 21:59:12 INFO - 'tpaint', 21:59:12 INFO - 'sessionrestore', 21:59:12 INFO - 'sessionrestore_no_auto_restore', 21:59:12 INFO - 'tabpaint']}, 21:59:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['tsvgx', 21:59:12 INFO - 'tsvgr_opacity', 21:59:12 INFO - 'tart', 21:59:12 INFO - 'tscrollx', 21:59:12 INFO - 'cart']}, 21:59:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:12 INFO - 'tsvgr_opacity', 21:59:12 INFO - 'tart', 21:59:12 INFO - 'tscrollx', 21:59:12 INFO - 'cart']}, 21:59:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'talos_options': ['--disable-e10s'], 21:59:12 INFO - 'tests': ['tp5o']}, 21:59:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'tests': ['tp5o']}, 21:59:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'talos_options': ['--disable-e10s', 21:59:12 INFO - '--xperf_path', 21:59:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:12 INFO - 'tests': ['tp5n']}, 21:59:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:12 INFO - 'talos_options': ['--xperf_path', 21:59:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:12 INFO - 'tests': ['tp5n']}}, 21:59:12 INFO - 'talos.zip': {'path': '', 21:59:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:12 INFO - Running post-action listener: _resource_record_post_action 21:59:12 INFO - [mozharness: 2017-01-25 05:59:12.164269Z] Finished populate-webroot step (success) 21:59:12 INFO - [mozharness: 2017-01-25 05:59:12.164390Z] Running create-virtualenv step. 21:59:12 INFO - Running pre-action listener: _resource_record_pre_action 21:59:12 INFO - Running main action method: create_virtualenv 21:59:12 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:12 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 21:59:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:12 INFO - Using real prefix '/tools/python27' 21:59:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:13 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:15 INFO - Installing pip.................done. 21:59:15 INFO - Return code: 0 21:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:59:16 INFO - Reading from file tmpfile_stdout 21:59:16 INFO - Output received: 21:59:16 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) 21:59:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:16 INFO - 'HOME': '/Users/cltbld', 21:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:16 INFO - 'LOGNAME': 'cltbld', 21:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:16 INFO - 'MOZ_NO_REMOTE': '1', 21:59:16 INFO - 'NO_EM_RESTART': '1', 21:59:16 INFO - 'PAGER': '/bin/cat', 21:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:16 INFO - 'PWD': '/builds/slave/test', 21:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:16 INFO - 'SHELL': '/bin/bash', 21:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:16 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:16 INFO - 'USER': 'cltbld', 21:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:16 INFO - 'XPC_FLAGS': '0x0', 21:59:16 INFO - 'XPC_SERVICE_NAME': '0', 21:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:16 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 21:59:16 INFO - Cleaning up... 21:59:16 INFO - Return code: 0 21:59:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:16 INFO - 'HOME': '/Users/cltbld', 21:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:16 INFO - 'LOGNAME': 'cltbld', 21:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:16 INFO - 'MOZ_NO_REMOTE': '1', 21:59:16 INFO - 'NO_EM_RESTART': '1', 21:59:16 INFO - 'PAGER': '/bin/cat', 21:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:16 INFO - 'PWD': '/builds/slave/test', 21:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:16 INFO - 'SHELL': '/bin/bash', 21:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:16 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:16 INFO - 'USER': 'cltbld', 21:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:16 INFO - 'XPC_FLAGS': '0x0', 21:59:16 INFO - 'XPC_SERVICE_NAME': '0', 21:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:16 INFO - Downloading/unpacking psutil>=3.1.1 21:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:20 INFO - Installing collected packages: psutil 21:59:20 INFO - Running setup.py install for psutil 21:59:20 INFO - building 'psutil._psutil_osx' extension 21:59:20 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 21:59:20 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 21:59:20 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 21:59:20 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 21:59:21 INFO - building 'psutil._psutil_posix' extension 21:59:21 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 21:59:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:59:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:59:21 INFO - ^ 21:59:21 INFO - 1 warning generated. 21:59:21 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 21:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:21 INFO - Successfully installed psutil 21:59:21 INFO - Cleaning up... 21:59:21 INFO - Return code: 0 21:59:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:21 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:21 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 21:59:21 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 21:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:21 INFO - 'HOME': '/Users/cltbld', 21:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:21 INFO - 'LOGNAME': 'cltbld', 21:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:21 INFO - 'MOZ_NO_REMOTE': '1', 21:59:21 INFO - 'NO_EM_RESTART': '1', 21:59:21 INFO - 'PAGER': '/bin/cat', 21:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:21 INFO - 'PWD': '/builds/slave/test', 21:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:21 INFO - 'SHELL': '/bin/bash', 21:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:21 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:21 INFO - 'USER': 'cltbld', 21:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:21 INFO - 'XPC_FLAGS': '0x0', 21:59:21 INFO - 'XPC_SERVICE_NAME': '0', 21:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:21 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 21:59:21 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 21:59:21 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 21:59:21 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 21:59:21 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 21:59:21 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 21:59:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:24 INFO - Installing collected packages: mozsystemmonitor 21:59:24 INFO - Running setup.py install for mozsystemmonitor 21:59:24 INFO - Successfully installed mozsystemmonitor 21:59:24 INFO - Cleaning up... 21:59:24 INFO - Return code: 0 21:59:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:24 INFO - 'HOME': '/Users/cltbld', 21:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:24 INFO - 'LOGNAME': 'cltbld', 21:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:24 INFO - 'MOZ_NO_REMOTE': '1', 21:59:24 INFO - 'NO_EM_RESTART': '1', 21:59:24 INFO - 'PAGER': '/bin/cat', 21:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:24 INFO - 'PWD': '/builds/slave/test', 21:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:24 INFO - 'SHELL': '/bin/bash', 21:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:24 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:24 INFO - 'USER': 'cltbld', 21:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:24 INFO - 'XPC_FLAGS': '0x0', 21:59:24 INFO - 'XPC_SERVICE_NAME': '0', 21:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:24 INFO - Downloading/unpacking jsonschema==2.5.1 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59:27 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 21:59:27 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 21:59:27 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 21:59:27 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 21:59:27 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 21:59:27 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 21:59:27 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:28 INFO - warning: no files found matching '*.txt' 21:59:28 INFO - no previously-included directories found matching 'build' 21:59:28 INFO - no previously-included directories found matching 'dist' 21:59:28 INFO - no previously-included directories found matching '.git*' 21:59:28 INFO - Installing collected packages: jsonschema, functools32 21:59:28 INFO - Running setup.py install for functools32 21:59:28 INFO - warning: no files found matching '*.txt' 21:59:28 INFO - no previously-included directories found matching 'build' 21:59:28 INFO - no previously-included directories found matching 'dist' 21:59:28 INFO - no previously-included directories found matching '.git*' 21:59:28 INFO - Successfully installed jsonschema functools32 21:59:28 INFO - Cleaning up... 21:59:28 INFO - Return code: 0 21:59:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:28 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:28 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 21:59:28 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 21:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:28 INFO - 'HOME': '/Users/cltbld', 21:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:28 INFO - 'LOGNAME': 'cltbld', 21:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:28 INFO - 'MOZ_NO_REMOTE': '1', 21:59:28 INFO - 'NO_EM_RESTART': '1', 21:59:28 INFO - 'PAGER': '/bin/cat', 21:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:28 INFO - 'PWD': '/builds/slave/test', 21:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:28 INFO - 'SHELL': '/bin/bash', 21:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:28 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:28 INFO - 'USER': 'cltbld', 21:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:28 INFO - 'XPC_FLAGS': '0x0', 21:59:28 INFO - 'XPC_SERVICE_NAME': '0', 21:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:59:28 INFO - Cleaning up... 21:59:28 INFO - Return code: 0 21:59:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:28 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:28 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 21:59:28 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 21:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:28 INFO - 'HOME': '/Users/cltbld', 21:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:28 INFO - 'LOGNAME': 'cltbld', 21:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:28 INFO - 'MOZ_NO_REMOTE': '1', 21:59:28 INFO - 'NO_EM_RESTART': '1', 21:59:28 INFO - 'PAGER': '/bin/cat', 21:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:28 INFO - 'PWD': '/builds/slave/test', 21:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:28 INFO - 'SHELL': '/bin/bash', 21:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:28 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:28 INFO - 'USER': 'cltbld', 21:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:28 INFO - 'XPC_FLAGS': '0x0', 21:59:28 INFO - 'XPC_SERVICE_NAME': '0', 21:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:28 INFO - Downloading/unpacking blobuploader==1.2.4 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:31 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:31 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 21:59:31 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 21:59:31 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 21:59:31 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 21:59:31 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 21:59:31 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 21:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 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 21:59:32 INFO - Downloading docopt-0.6.1.tar.gz 21:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:32 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:32 INFO - Running setup.py install for blobuploader 21:59:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:32 INFO - Running setup.py install for requests 21:59:33 INFO - Running setup.py install for docopt 21:59:33 INFO - Successfully installed blobuploader requests docopt 21:59:33 INFO - Cleaning up... 21:59:33 INFO - Return code: 0 21:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:33 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:33 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 21:59:33 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 21:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:33 INFO - 'HOME': '/Users/cltbld', 21:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:33 INFO - 'LOGNAME': 'cltbld', 21:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:33 INFO - 'MOZ_NO_REMOTE': '1', 21:59:33 INFO - 'NO_EM_RESTART': '1', 21:59:33 INFO - 'PAGER': '/bin/cat', 21:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:33 INFO - 'PWD': '/builds/slave/test', 21:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:33 INFO - 'SHELL': '/bin/bash', 21:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:33 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:33 INFO - 'USER': 'cltbld', 21:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:33 INFO - 'XPC_FLAGS': '0x0', 21:59:33 INFO - 'XPC_SERVICE_NAME': '0', 21:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:33 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-hB30f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ElEhKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-AhqCzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-06v3Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-xfoig1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-u24qer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Ytz0m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-tVwdoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-MQMlqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-XQxInR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:34 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-GPAbmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:35 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-_3HQyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:35 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-O9IPze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:35 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-zsTvdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:35 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-vaeF4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:35 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-lrNhmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:35 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-BGqAz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:35 INFO - Running setup.py install for manifestparser 21:59:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:35 INFO - Running setup.py install for mozcrash 21:59:36 INFO - Running setup.py install for mozdebug 21:59:36 INFO - Running setup.py install for mozdevice 21:59:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Running setup.py install for mozfile 21:59:36 INFO - Running setup.py install for mozhttpd 21:59:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Running setup.py install for mozinfo 21:59:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Running setup.py install for mozInstall 21:59:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:36 INFO - Running setup.py install for mozleak 21:59:37 INFO - Running setup.py install for mozlog 21:59:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:37 INFO - Running setup.py install for moznetwork 21:59:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:37 INFO - Running setup.py install for mozprocess 21:59:37 INFO - Running setup.py install for mozprofile 21:59:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:37 INFO - Running setup.py install for mozrunner 21:59:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:37 INFO - Running setup.py install for mozscreenshot 21:59:38 INFO - Running setup.py install for moztest 21:59:38 INFO - Running setup.py install for mozversion 21:59:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:38 INFO - Cleaning up... 21:59:38 INFO - Return code: 0 21:59:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:38 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:38 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 21:59:38 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 21:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:38 INFO - 'HOME': '/Users/cltbld', 21:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:38 INFO - 'LOGNAME': 'cltbld', 21:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:38 INFO - 'MOZ_NO_REMOTE': '1', 21:59:38 INFO - 'NO_EM_RESTART': '1', 21:59:38 INFO - 'PAGER': '/bin/cat', 21:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:38 INFO - 'PWD': '/builds/slave/test', 21:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:38 INFO - 'SHELL': '/bin/bash', 21:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:38 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:38 INFO - 'USER': 'cltbld', 21:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:38 INFO - 'XPC_FLAGS': '0x0', 21:59:38 INFO - 'XPC_SERVICE_NAME': '0', 21:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:38 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-9UzBhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:38 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)) 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:38 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-g7pTWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:38 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-4bZcEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:38 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)) 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:38 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-92pk9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-O96t8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Jyxibd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-cJFnUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-inTLnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-4Aqld6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-LGyGk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-DQxWU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-WIVn_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-PhLfS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:39 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)) 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:39 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-xwhwSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-2SgoNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:40 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)) 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-KYeWqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:40 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-q26CTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:40 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)) 21:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:40 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)) 21:59:40 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)) 21:59:40 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)) 21:59:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:42 INFO - Downloading blessings-1.6.tar.gz 21:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:43 INFO - Installing collected packages: blessings 21:59:43 INFO - Running setup.py install for blessings 21:59:43 INFO - Successfully installed blessings 21:59:43 INFO - Cleaning up... 21:59:43 INFO - Return code: 0 21:59:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:59:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:43 INFO - Reading from file tmpfile_stdout 21:59:43 INFO - Current package versions: 21:59:43 INFO - blessings == 1.6 21:59:43 INFO - blobuploader == 1.2.4 21:59:43 INFO - docopt == 0.6.1 21:59:43 INFO - functools32 == 3.2.3-2 21:59:43 INFO - jsonschema == 2.5.1 21:59:43 INFO - manifestparser == 1.1 21:59:43 INFO - mozInstall == 1.12 21:59:43 INFO - mozcrash == 1.0 21:59:43 INFO - mozdebug == 0.1 21:59:43 INFO - mozdevice == 0.48 21:59:43 INFO - mozfile == 1.2 21:59:43 INFO - mozhttpd == 0.7 21:59:43 INFO - mozinfo == 0.9 21:59:43 INFO - mozleak == 0.1 21:59:43 INFO - mozlog == 3.4 21:59:43 INFO - moznetwork == 0.27 21:59:43 INFO - mozprocess == 0.23 21:59:43 INFO - mozprofile == 0.28 21:59:43 INFO - mozrunner == 6.13 21:59:43 INFO - mozscreenshot == 0.1 21:59:43 INFO - mozsystemmonitor == 0.3 21:59:43 INFO - moztest == 0.8 21:59:43 INFO - mozversion == 1.4 21:59:43 INFO - psutil == 3.1.1 21:59:43 INFO - requests == 1.2.3 21:59:43 INFO - wsgiref == 0.1.2 21:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:43 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 21:59:43 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 21:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:43 INFO - 'HOME': '/Users/cltbld', 21:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PAGER': '/bin/cat', 21:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test', 21:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:43 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - 'XPC_FLAGS': '0x0', 21:59:43 INFO - 'XPC_SERVICE_NAME': '0', 21:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 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)) 21:59:44 INFO - Cleaning up... 21:59:44 INFO - Return code: 0 21:59:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:59:44 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')]} 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:44 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')]} 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:44 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 0x10c5f0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c566570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc32cc13c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, '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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 21:59:44 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 21:59:44 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 21:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 21:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:44 INFO - 'HOME': '/Users/cltbld', 21:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:44 INFO - 'LOGNAME': 'cltbld', 21:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:44 INFO - 'MOZ_NO_REMOTE': '1', 21:59:44 INFO - 'NO_EM_RESTART': '1', 21:59:44 INFO - 'PAGER': '/bin/cat', 21:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:44 INFO - 'PWD': '/builds/slave/test', 21:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:44 INFO - 'SHELL': '/bin/bash', 21:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 21:59:44 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 21:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:44 INFO - 'USER': 'cltbld', 21:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:44 INFO - 'XPC_FLAGS': '0x0', 21:59:44 INFO - 'XPC_SERVICE_NAME': '0', 21:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:59:44 INFO - Cleaning up... 21:59:44 INFO - Return code: 0 21:59:44 INFO - Running post-action listener: _resource_record_post_action 21:59:44 INFO - Running post-action listener: _start_resource_monitoring 21:59:44 INFO - Starting resource monitoring. 21:59:44 INFO - [mozharness: 2017-01-25 05:59:44.848701Z] Finished create-virtualenv step (success) 21:59:44 INFO - [mozharness: 2017-01-25 05:59:44.849669Z] Running install step. 21:59:44 INFO - Running pre-action listener: _resource_record_pre_action 21:59:44 INFO - Running main action method: install 21:59:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:45 INFO - Reading from file tmpfile_stdout 21:59:45 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:59:45 INFO - Reading from file tmpfile_stdout 21:59:45 INFO - Output received: 21:59:45 INFO - Usage: mozinstall [options] installer 21:59:45 INFO - Options: 21:59:45 INFO - -h, --help show this help message and exit 21:59:45 INFO - -d DEST, --destination=DEST 21:59:45 INFO - Directory to install application into. [default: 21:59:45 INFO - "/builds/slave/test"] 21:59:45 INFO - --app=APP Application being installed. [default: firefox] 21:59:45 INFO - mkdir: /builds/slave/test/build/application 21:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:00:07 INFO - Reading from file tmpfile_stdout 22:00:07 INFO - Output received: 22:00:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:00:07 INFO - Running post-action listener: _resource_record_post_action 22:00:07 INFO - [mozharness: 2017-01-25 06:00:07.127492Z] Finished install step (success) 22:00:07 INFO - [mozharness: 2017-01-25 06:00:07.127592Z] Running run-tests step. 22:00:07 INFO - Running pre-action listener: _resource_record_pre_action 22:00:07 INFO - Running main action method: run_tests 22:00:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:07 INFO - 2017-01-24 22:00:07.140 screenresolution[1622:7507] starting screenresolution argv=screenresolution get 22:00:07 INFO - 2017-01-24 22:00:07.143 screenresolution[1622:7507] Display 0: 1600x1200x32@60 22:00:07 INFO - 2017-01-24 22:00:07.148 screenresolution[1623:7510] starting screenresolution argv=screenresolution list 22:00:07 INFO - Available Modes on Display 0 22:00:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:07 INFO - Intel Iris: 22:00:07 INFO - Chipset Model: Intel Iris 22:00:07 INFO - Type: GPU 22:00:07 INFO - Bus: Built-In 22:00:07 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:07 INFO - Vendor: Intel (0x8086) 22:00:07 INFO - Device ID: 0x0a2e 22:00:07 INFO - Revision ID: 0x0009 22:00:07 INFO - Displays: 22:00:07 INFO - Display: 22:00:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:07 INFO - Display Serial Number: 1600x1200 60 22:00:07 INFO - Main Display: Yes 22:00:07 INFO - Mirror: Off 22:00:07 INFO - Online: Yes 22:00:07 INFO - Rotation: Supported 22:00:07 INFO - Return code: 0 22:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:07 INFO - Python 2.7.3 22:00:07 INFO - Return code: 0 22:00:07 INFO - grabbing minidump binary from tooltool 22:00:07 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')]} 22:00:07 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 0x10c404d30>, '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 0x10c26adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:07 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 22:00:07 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 22:00:07 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 22:00:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:07 INFO - Return code: 0 22:00:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:00:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:00:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 22:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0081 --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 22:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvMWE8IQbl/Render', 22:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:07 INFO - 'HOME': '/Users/cltbld', 22:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:07 INFO - 'LOGNAME': 'cltbld', 22:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:07 INFO - 'MOZ_NO_REMOTE': '1', 22:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:07 INFO - 'NO_EM_RESTART': '1', 22:00:07 INFO - 'PAGER': '/bin/cat', 22:00:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:07 INFO - 'PWD': '/builds/slave/test', 22:00:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:07 INFO - 'SHELL': '/bin/bash', 22:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MGG0KPMYx6/Listeners', 22:00:07 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 22:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:07 INFO - 'USER': 'cltbld', 22:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:07 INFO - 'XPC_FLAGS': '0x0', 22:00:07 INFO - 'XPC_SERVICE_NAME': '0', 22:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 22:00:07 INFO - mozversion application_buildid: 20170124193347 22:00:07 INFO - mozversion application_changeset: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 22:00:07 INFO - mozversion application_display_name: Firefox 22:00:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:07 INFO - mozversion application_name: Firefox 22:00:07 INFO - mozversion application_remotingname: firefox 22:00:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:00:07 INFO - mozversion application_vendor: Mozilla 22:00:07 INFO - mozversion application_version: 52.0 22:00:07 INFO - mozversion platform_buildid: 20170124193347 22:00:07 INFO - mozversion platform_changeset: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 22:00:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:00:07 INFO - mozversion platform_version: 52.0 22:00:07 INFO - using testdate: 1485324007 22:00:07 INFO - actual date: 1485324007 22:00:07 INFO - starting webserver on 'localhost:49245' 22:00:07 INFO - SUITE-START | Running 2 tests 22:00:07 INFO - TEST-START | dromaeo_css 22:00:07 INFO - operating with platform_type : mac_ 22:00:07 INFO - Initialising browser for dromaeo_css test... 22:00:07 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpa4_GZZ/profile http://localhost:49245/getInfo.html) 22:00:10 INFO - PROCESS | 1633 | 2017-01-24 22:00:10.818 plugin-container[1636:7682] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 22:00:10 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:10 INFO - PROCESS | 1633 | 2017-01-24 22:00:10.819 plugin-container[1636:7682] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 22:00:10 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:10 INFO - PROCESS | 1633 | 2017-01-24 22:00:10.819 plugin-container[1636:7682] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:00:10 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 22:00:10 INFO - PROCESS | 1633 | colorDepth:24 22:00:10 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 22:00:10 INFO - PROCESS | 1633 | __metrics 22:00:10 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 22:00:11 INFO - TEST-INFO | 1633: exit 0 22:00:11 INFO - Browser initialized. 22:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:11 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpa4_GZZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:14 INFO - PROCESS | 1637 | 2017-01-24 22:00:14.163 plugin-container[1638:7808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 22:00:14 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:14 INFO - PROCESS | 1637 | 2017-01-24 22:00:14.165 plugin-container[1638:7808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 22:00:14 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:14 INFO - PROCESS | 1637 | 2017-01-24 22:00:14.165 plugin-container[1638:7808] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:00:23 INFO - PROCESS | 1637 | RSS: Main: 177102848 22:00:23 INFO - PROCESS | 1637 | 22:03:27 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 22:03:29 INFO - PROCESS | 1637 | RSS: Main: 181211136 22:03:29 INFO - PROCESS | 1637 | 22:06:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 22:06:31 INFO - PROCESS | 1637 | RSS: Main: 191385600 22:06:31 INFO - PROCESS | 1637 | 22:09:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 22:09:34 INFO - PROCESS | 1637 | RSS: Main: 193667072 22:09:34 INFO - PROCESS | 1637 | 22:12:36 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 22:12:36 INFO - PROCESS | 1637 | RSS: Main: 196517888 22:12:36 INFO - PROCESS | 1637 | 22:15:39 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 22:15:40 INFO - PROCESS | 1637 | RSS: Main: 199495680 22:15:40 INFO - PROCESS | 1637 | 22:18:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 22:18:43 INFO - PROCESS | 1637 | RSS: Main: 199376896 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | __start_tp_report 22:18:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 22:18:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 22:18:43 INFO - PROCESS | 1637 | |i|pagename|runs| 22:18:43 INFO - PROCESS | 1637 | |0;dojo.html;3565.0909018200364;3613.8977611828414;3633.454981752737;3638.9272214555695;3639.599644039155;5984.970075149624;5989.790357337494;6011.458968692822;6031.396860313977;6063.09053641954;6056.515478761699;6062.484688801457;6084.421979911913;6129.172561704168;6130.3256641769485;3696.7966761828225;5370.167624018264;5394.298741163643;5433.212184233284;5516.979358818611;5449.509544141027;5494.5054945054935;5496.945030549703;5499.642523235997;5501.339839219299;4715.528447155291;4828.17920953437;5354.063038968185;5487.725613719318;5493.670379777206;5416.783328666848;5429.619926605139;5434.538064264542;5454.781808727646;5472.069748142825;5309.3894202166475;5365.543928766059;5403.945960540384;5414.810481633124;5425.457454254582;6019.578629495937;6028.125921741367;6069.605475644069;6091.817245482643;6134.78528251509;5685.431456854281;5897.292324920994;6183.536234782409;6310.810675679737;6313.116163737081;5039.672421292605;6118.021116621319;6241.438270555626;6358.618482891041;6410.0705397717065;6053.3946605339115;6068.57519973602;6085.148079268906;6095.08573713942;6128.258691089361;6447;6478.740850366027;6556.311587283267;6558.901616475757;6572.605643661395;6212.502999760009;6265.655388953652;6275.937240627535;6283.96858015707;6294.559380843297;6263.937360626426;6363.9045414318825;6382.808515744535;6388.361163883575;6407.070974708734;6315.621062736159;6318.62088274705;6323.399277068671;6336.081268216083;6354.682265886687;6179.783707570214;6204.255489341218;6262.029385445263;6330.923742963707;6344.429001389897;5144.408393034774;5189.896202075937;5190.844274671766;5198.480151984847;5244.475552444725;4642.628589712815;4650.093231819763;4670.182718024332;4684.063187362473;4685.906281874343;5679.148127780783;6029.155918171459;6213.2233470816145;6219.191505104308;6228.844278892973;6194.442500175006;6262.718177682015;6333.429991300805;6365.777197798147;6383.265924418658;6160.784372547029;6180.536459765535;6191.9690401547705;6192.442680158807;6210.192674952227;5550.4449555044175;5618.578606604521;5668.229573242002;5697.401772813795;5741.913871291934;6509.934900650933;6538;6607.9669601651685;6643.236027856665;6645.867082658417;6332.905006424815;6383.616982981036;6394.840128996812;6399;6400.55196136266;6417.96791016042;6549.869002619826;6636.435902948304;6643.734250629921;6650.035744817072;6230.283517395557;6253.687315634109;6263.467605253422;6274.058891166362;6280.560360774702;6409.134766806608;6413.551051426355;6414.61512309263;6417;6418.518611104279;6121.47967422774;6142.262928448615;6259.812205633838;6280.963640999184;6305.653189074645;6168.537359697951;6198.2252218472695;6199.845003874939;6206.06908963659;6255.874882502416;6173.228346456693;6213.5339849512375;6268.247810262797;6280.717367718555;6297.590656607489;6242.406971337716;6242.750289988349;6273.874522509433;6280.937190628035;6296.244450665949;6110.450059494667;6141.271221159593;6148.385161483816;6243.313235543996;6327.905081423874 22:18:43 INFO - PROCESS | 1637 | |1;ext.html;497.487587784582;504.33176041744696;529.2114749023956;536.6163193316778;537.1727539589033;31281.68718312816;41422;41502.79248603753;43369.56630433695;43420.565794342045;42013.36979945303;42502;42586.78706606463;42597.574024259746;42801.57198428023;9737.805243895136;9916.801663966717;9939.40363578184;10001.749956251078;10008.999100090006;9785.902140978606;9882.604695812159;9892.109710126088;9894.307398482073;9913.950430247838;8384.8742268866;9897.950510247474;9904.55429505674;9936.453495057769;9949.701508954708;9812.656557020506;9879.209663226924;9904.752381190456;9917.008299170098;9926.702198934043;9791.559379827924;9849.852252216222;9880.703578892644;9930.354526955725;9958;40120.79637610847;40211.79894100511;40514.39228411576;40606.39090413646;40687;3392.4741665041956;3406.829658517064;3423.640517745651;3478.0435380270374;3512.385332566816;28021.299467513272;30694.079177624706;30861.228469288224;31236.68763312383;31315.843420782978;3237.546743455918;3277.5411442398085;3315.535824984504;3321.485169798685;3343.2477692519233;486664.8333791648;488713;489116;492146;498559;57094.71452642793;57115.42884571101;57412.42587574071;57721;57790.8441831161;59785.804283914076;60044.699776501715;60700.69649651724;60809.695951519956;60853.39146608566;16263.918680406523;16450.588735281475;16492.83507164937;16709.41517046922;16710.832891671173;12163.939180304218;12249.387530623433;12283.01735861129;12289.385530723428;12338.321392323329;15126.39494420211;15427.30577124032;15563.144027078393;15569.634167058111;15702.76445853313;3274.345130973815;6448.581781831813;6620.8344791380605;6646.60120392778;6678.098456708282;872.6771094695004;992.2954702161546;1132.2696860524916;1138.7267055906689;1165.0854079547685;29531.55702664462;29631.25921851971;29829.552556711667;30413.543796843063;30670.233244168627;1085.0993675249524;1120.3166068698088;1125.3810404277615;1130.5477808876515;1132.943352832355;15526.689466210613;15654.843451565566;15765.527034188992;15865.20673966297;16078.954867933548;654214;655421.7228913825;663547;664246;665640;57439.71280143572;57504.71247643819;57850.710746446;57913;58151;1386.7503849307222;1394.2819447984295;1421.232534431416;1421.6019514535947;1428.2144820348767;29236.415271694023;29767.404651907273;30045.54931675983;30105;30459.847700761355;48546;49118.75440622917;49380.25929610987;49448.76378090576;49597.504024959286;491326;491771;492282.53858730476;559573;559784;26293.605595915695;26639.600405993537;26915.327116822235;26920.730792691822;27018.324541885824;33572;45442;46196.76901615471;46616;46991;31649;37466.438003430514;37822.62177378191;38092.80953595214;38383.80808096053;30738.692613073585;38585;38728.61271387363;39049;39131.41302880402;37260.81369593135;38294.042648934;38677.2264554713;38729.806350968065;38905.80547097247;33053.834730826195;34522;34821.651783481844;35111.64888351084;35332.29335413329;25865;26140.60789088127;26148;26211.475770484863;26546.203613891616 22:18:43 INFO - PROCESS | 1637 | |2;jquery.html;380.7905651891459;384.57120310853406;386.41657472109847;400.2974779262395;417.9707420480566;16885;20435.386938391854;20852.37442876712;21713.24003659874;21722.89138554309;21050.89474552629;21331.146754129815;21498.925053747327;21762.782372176272;21913;5889.116632505115;6246.781362652308;6255.499560035186;6258.374162583751;6266.874662506747;5271.578273738091;6021.638701677914;6116.296625888035;6186.536009799261;6226.906596401035;6183.412575805291;6190.0405437157315;6193.225846769154;6193.969030154843;6208.72060757267;5975.163477113208;6154.230721159877;6164.260288765332;6200.410960958701;6203.1005504202085;5421.105517589593;5427.891442171174;5428.864278393033;5432.483914028161;5433.320834895638;26444.338891527674;26562.33594160142;26933.84529237656;27131.91472341104;27342.453150937068;1975.0815870620088;2463.4703538739077;2961.3336999175012;3166.319241363095;3243.7729358944885;10073.647422340257;10282.023207795248;10305.793884122351;10643.733906652318;10816.621418250403;1689.8225686302885;1768.5578605348662;1924.0956750327323;1985.8113479219596;2022.9291974780813;76316;90682.54658726664;117264;121112;121427.39286303511;8369.707060252862;10336.483175841178;10597.099246563974;10757.085647720032;12071.818922716166;10481.790364192673;11971;12619.621411357673;12703.428345724464;12817.871821281668;8227.712030079038;8416.747497575083;8495.1080136586;8505.31957443403;8581.399302048922;7332.633368331669;8908.73273801787;8921.01868794432;8993.55032248385;9146.314026448043;3963.147923196527;4066.9796651016554;4073.8574149905203;4130.545639979599;4132.297509423405;1974.3780709076595;2021.242034237161;2029.7361343025311;2030.2285131649878;2054.085931760352;814.3810703865105;845.9238668519739;910.1808372464702;959.1559427703576;991.3556188477403;16755.91622041882;22170.88914555449;22188.57137145539;22200.777992220195;22235.444113897283;902.8669020379382;923.1829830599968;1016.755978565139;1019.5420548615402;1044.1698849414734;9758.365706229073;11209.439528023566;11646.301221926711;11858.584949526898;11862.169648124549;547605;630054;644200;644294.7785261044;644703;93272.53363733273;114146.4292678548;133508;138732;144195.2790236042;997.3517213810936;1018.4093225928943;1050.7058023753361;1061.1033676543464;1065.674969134406;19883.403497895088;20132;20345.89827050855;20527.28154514585;20546;58074.419255806904;58154.418455816594;59420.70289648524;60484;61593;63283;81198;85241;85495;85600.57199713962;8242.290969063826;8254.42219044661;8306.468037334876;8360.540170290693;8832.823343533222;9406.811863762823;12747.61757147287;12793.680157996125;13565.253911034988;13668.453261869414;11222.10223182127;11468.426578670866;11717.88282117168;11725;11868.465919033491;11317.547298108313;11358.318500889973;11561.942190288995;11713.941430293135;12013.579524716593;11118.110551155727;11182.273152245078;11572.132090093444;11888.702782430508;12079.456424461096;8309.709160179365;8412.747617571482;8720.389572729848;8749.212570868653;8779.692710755093;11063.557457701923;11762.882371176178;11969.64091077269;12016.038716902802;12127.332996685267 22:18:43 INFO - PROCESS | 1637 | |3;mootools.html;1396.7416028034813;1516.476815498653;1687.3082036365092;1803.7204233343837;1840.1075478392977;7674.46278760487;7929.92070079299;8180.222878826509;8587.270082043025;8605.225529702326;6924.3421874921805;8062.71780487683;8307.709230176944;8437.114103019187;8470.78823029423;2395.9281221563338;2419.346776370379;2420.031987205123;2420.467497150633;2431.1369463840347;2423.9151629692965;2439.731629520751;2461.2616215135477;2468.753124687526;2475.616279476675;2406.5066661334386;2420.298113547078;2432.7080750309988;2434.20888211332;2436.2204094689705;2376.9881150594224;2385.6898603181476;2405.8195635327247;2408.7832095111526;2453.472503411766;2409.6506006628942;2415.649730789043;2436;2452.982012464825;2453.4847681986803;8514.403991720583;8514.74455766328;8550;8568.914310856873;8569.228769410784;5212.55693266069;5357.4106848246665;5417.377001644822;5419.5393391561765;5441.537469315113;3489.180042689966;3508.1755787389943;3622.981885090584;3631.5460567429072;3674.4855720199193;1056.7199692081604;1059.607945060325;1088.35786885737;1111.3831823338044;1117.4245263689206;10914.454277286104;10955.780884382348;11013.2841365311;11032.44837758109;11081.501332440059;4557.316402539645;4690.9765451172525;4771.5467030632035;4821.325014497973;4837.975810120927;9574.234061275221;9583.233341332676;9591.42451452915;9598.32811703188;9625.855612165824;5322.0952438085615;5322.92015619766;5330.600204984642;5331.813386531453;5354.3574771027725;3867.187890542961;4389.978050109729;4764.595009424169;4868.756562171877;4895.975520122448;3881.2237552489614;3899.1811719538646;3977.54258260298;4043.8584649537715;4061.7969101544804;1090.798202332571;1098.6594155811724;1108.6396921000708;1310.1353106949368;1314.1261061394257;896.8968568614563;944.974702447838;945.7304668169538;948.3503799897093;971.4122955611895;5620.4098569649595;5781.335146458127;5889.116632505073;5935.910961335583;6038.094285857069;401.199606784461;451.4695233101093;455.31929765001536;455.5717625432083;462.68768581208224;3954.130091379892;3962.3660214365564;3987.142764305688;4018.859339923147;4099.159672267178;8362.54006029662;9842.557084931195;10220.131288840383;10268.281220314506;10283.280170388001;8743.431676940978;9263.583138758771;9537.807774028246;9938.403695778277;10200.3369780964;7587.772366829004;7835.255650713173;8018.879716804253;8026.237507436784;8177.223163799429;5623.746931388179;5770.2498675171955;5794.856518717075;5822.534197264124;5951.077582974646;9427.057294270518;9483.478408687588;9539.47532885698;9549.283803714889;9558.95220523893;9359.625614975597;9544;9628.66299679508;9767.413955162712;9770.658026969022;7235.782926512213;7240.8913866290995;7254.274572542704;7299.452541059548;7327.487075904635;7906.486078404885;7996.880046799186;8002.119766825761;8002.9599852000365;8016.078151012708;6103.206583144163;7203.71185152609;7450.292222238879;7452.03123593951;7536.171021187774;7265.7093716252875;7327.780166595011;7336.4130869529245;7419.517731347445;7458.627068646654;6739.494537909578;6766.15423072116;6856.211535673262;6856.280090590616;6898.034275201376;5064.822731204537;5076.771545280398;5128.666636668605;5150.201718733602;5268.341457317835;5100.260462232881;5123.89836185222;5299.41706412302;5370.865728356823;5386.353637563518 22:18:43 INFO - PROCESS | 1637 | |4;prototype.html;302.8455487701272;322.4534414167986;322.95317179009044;325.79637726420987;326.54936188060475;5469.425710300416;5547.278853749012;5559.136400201862;5590.804321848736;5598.356189038262;3999.460072890159;5164.199549069891;5419.3225846769155;5500.42245564216;5507.752151153198;3327.1848397142735;3403.982980085096;3409.3010932758725;3797.582265950743;3982.7411218270863;3634.727395445339;3917.5103112110987;4019.77891215983;4217.283061879488;4219.831206751726;3992.029922746185;4176.728512646669;4208.726432781875;4218;4237;3364.4112280350964;4125.246770122716;4152.024274295538;4198.538160802309;4256.021115143519;3527.7177825773874;3631;3633.5821380541047;3653.324135035027;3661.743677942545;4010.498687664042;5397.302847549402;5407.432219616962;5415.729213539346;5445.618806683534;3989.5810939851476;4675.602573781232;4856.955754512796;4887.871762072276;4913.582345500637;4724.5984091352275;5826.7377967991115;5843.941560584382;5854.736536855852;5866.823995280149;3697.149655579205;3777.924441511182;4062.415657893424;4079.4492743479545;4095.9180816383805;5859.2090067841145;6077.301110372319;6098.908516372302;6140.9385906140815;6190.938090619081;3765.6799172070682;4094.877153685394;4106.357457017158;4120.299549076664;4124.845043387856;3762.736608437383;4046.6964977626208;4194.790260486963;4207.305794543927;4207.5161356444405;4593.678442509059;4853.141752306925;4867.123917694849;4870.512948705101;4882.487338829372;4849.466558678542;5844.736986835603;5880.323762767251;5895.852603684856;5915.733791979371;1220.7924652809045;1223.9020878329711;1347.4812197304109;1357.497725841445;1363.7886127650231;805.9556724380099;885.3758100539104;887.6804350433839;940.2431043010306;954.0840792838952;4806.94247265601;5427.810026649127;5636.408177141423;5641.379448260688;5684.607271218495;5073.771680274396;5815.127730840323;6117.541184411187;6131;6132.17215675878;5485.725713714299;5565.523342112721;5581.348859291804;5625.774969001276;5708.600397972185;2840.8437535935723;2899.7084315213183;3039.6656367799524;3045.9086227413213;3064.923376915595;5161.509656582619;5310.362756469249;5533.861653458615;5712.971665100322;6030.547708921848;4852.805887764521;5595.608307418523;5703.17303990919;6006.939930600638;6020.69896505173;5490.725463726718;5869.530437564985;5933.673647949404;6096.329403765582;6104.24588877837;4872.731999740048;5017.598592112695;5453.7818487260065;5620.4660557247;5793.725380416302;5763.4756715977755;5781.265620313973;5784.50831679312;5804.73878675469;5834.899436202879;5417.647852889707;5467.72661366938;6139.3553676863285;6155.569110162246;6229.937700622936;3071.7559388447717;3738.5980257403476;3930.685545156438;4037.4145748866836;4075.857344992911;5168.01807656544;5852.4440178183;6081.331053584191;6090.817275481742;6187.668631957557;5221.556167725786;5270.49930256625;5867.9413205867395;5946.970265148647;5964.642121472725;5341.4925582069645;5568;5740.350316243856;5868.5305175585;5953.970230148821;4841.927371089507;5715.942550628147;5856.180134781219;5857.26784151981;5861.32594751609;4178.519470260959;5334.146536554133;5729.598928075162;5852.4440178183;5971.387310677152;5543.6396634218645;5823.70881455934;5849.327327357239;5853.707314634336;5856.594417339893 22:18:43 INFO - PROCESS | 1637 | |5;yui.html;666.3935818405251;718.6227230703884;768.6041688530404;784.8940393046938;811.1685522339604;15470.38118475261;15751;15974.121423321712;16030.43893463729;16087.59781005474;14069.366878490468;14170.92914535426;14233;14319.57041288763;14337.996340256186;822.8313195794877;823.9711610093648;844.6030365728097;845.5729856422529;847.809242920341;829.5561874397199;846.8391005708895;851.7146755836802;857.1685465098875;857.7855536115972;856.9485830850169;885.7298523950193;892.0143241717906;892.4823602310677;894.7494701483595;860.0625318402939;875.7022612311845;879.309741852649;881.2289246908955;881.5371929736875;660.3495556876472;667.142721602743;668.7124536449325;670.1890712238197;673.5285300289817;12915.547955821501;12921.160124591965;12935.935320323431;12992.545260915822;12996.350182490838;11678.6496405108;11954.58158964432;11965.162438629299;12184.329861857594;12388.070894682845;10716.196285278558;10918.727031824188;11091.445427728662;11160.776784464346;11363.431828408546;3673.981630091859;3696.2607478504406;3706.4810926470313;3741.1021354874906;3775.244951009809;102613.46079808808;103287.45068823898;104438;104557.4772126142;105118;7700.806375011882;9245.815083698422;9253.907460925304;9489.762755931019;9507.001764814595;18781.812181878006;18832;19122.235110595422;19205.90397048006;19335.033248337528;7989;8104.473209241381;8108.75673729789;8114.959425202955;8181.550014749127;4234.978825105916;4260.829566817292;4333.783310834446;4393.253146964959;4427.380166776654;3364.327134573095;3485.721142308609;3668.614795446493;3829.80850957451;3838.7120965927666;693.0920494152676;694.1150033707064;701.6912558474255;704.2499737779249;708.1396103733885;462.95601917818425;473.15777915310804;484.2204051477119;530.5304805247384;564.6696682440736;9326.580303886341;9574.94675585685;9633.90366096344;9872.35829671069;10046.47443905849;671.6138220523219;678.2505331608502;698.5110422704128;707.5224223649017;711.4201925430757;3602.3875941090078;4454.420925279757;4632.328312394751;4664.836730714409;4677.251639737626;95681.5215923916;106530;108397;113113;117241.65516689619;63565.72868542603;81139;86492.13507864841;87430;95391.52304238573;44797;57787;65488.34511654918;83272;85341.57329213314;9782;9787.608495660379;9828.213742900407;9832.60669573209;9934.105930466292;41774.79112604539;48013.5198648009;51188.48811511837;52891.94216115579;53480;72902.63548682435;73153.6342318285;74048;75474.24525754672;76025.61987190029;12882.549110781078;13510.79733803974;13612.25132617676;13665.726685466434;13766.31168441554;14629.63425914318;14654.487092951695;14735.92632036833;14799.704005919606;14896.925515372353;12971.5459958901;13304.667383315495;13308.800367994294;13966.930165349107;14600.634984125481;13502.189868607915;13576.1854288743;13579.86420135786;13878.722425551634;14040.227787471787;13160.539381121614;13316.46734130624;13676.31618419095;13703.657408564866;14024.298785060502;11351.772964540498;11558.30650160993;11572.305661660328;11710.590129345432;11848.407579620813;9605.03949605034;10588.229414968706;11531;11785.528578856749;11822.881771182178 22:18:43 INFO - PROCESS | 1637 | __end_tp_report 22:18:43 INFO - PROCESS | 1637 | __start_cc_report 22:18:43 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,353 22:18:43 INFO - PROCESS | 1637 | __end_cc_report 22:18:43 INFO - PROCESS | 1637 | __startTimestamp1485325123026__endTimestamp 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | ------- Summary: start ------- 22:18:43 INFO - PROCESS | 1637 | Number of tests: 6 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5932.00 Median:6191.97 stddev:646.37 (10.4%) stddev-sans-first:621.11 22:18:43 INFO - PROCESS | 1637 | Values: 3565.1 3613.9 3633.5 3638.9 3639.6 5985.0 5989.8 6011.5 6031.4 6063.1 6056.5 6062.5 6084.4 6129.2 6130.3 3696.8 5370.2 5394.3 5433.2 5517.0 5449.5 5494.5 5496.9 5499.6 5501.3 4715.5 4828.2 5354.1 5487.7 5493.7 5416.8 5429.6 5434.5 5454.8 5472.1 5309.4 5365.5 5403.9 5414.8 5425.5 6019.6 6028.1 6069.6 6091.8 6134.8 5685.4 5897.3 6183.5 6310.8 6313.1 5039.7 6118.0 6241.4 6358.6 6410.1 6053.4 6068.6 6085.1 6095.1 6128.3 6447.0 6478.7 6556.3 6558.9 6572.6 6212.5 6265.7 6275.9 6284.0 6294.6 6263.9 6363.9 6382.8 6388.4 6407.1 6315.6 6318.6 6323.4 6336.1 6354.7 6179.8 6204.3 6262.0 6330.9 6344.4 5144.4 5189.9 5190.8 5198.5 5244.5 4642.6 4650.1 4670.2 4684.1 4685.9 5679.1 6029.2 6213.2 6219.2 6228.8 6194.4 6262.7 6333.4 6365.8 6383.3 6160.8 6180.5 6192.0 6192.4 6210.2 5550.4 5618.6 5668.2 5697.4 5741.9 6509.9 6538.0 6608.0 6643.2 6645.9 6332.9 6383.6 6394.8 6399.0 6400.6 6418.0 6549.9 6636.4 6643.7 6650.0 6230.3 6253.7 6263.5 6274.1 6280.6 6409.1 6413.6 6414.6 6417.0 6418.5 6121.5 6142.3 6259.8 6281.0 6305.7 6168.5 6198.2 6199.8 6206.1 6255.9 6173.2 6213.5 6268.2 6280.7 6297.6 6242.4 6242.8 6273.9 6280.9 6296.2 6110.5 6141.3 6148.4 6243.3 6327.9 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:68848.19 Median:38977.40 stddev:150239.60 (385.5%) stddev-sans-first:150573.41 22:18:43 INFO - PROCESS | 1637 | Values: 497.5 504.3 529.2 536.6 537.2 31281.7 41422.0 41502.8 43369.6 43420.6 42013.4 42502.0 42586.8 42597.6 42801.6 9737.8 9916.8 9939.4 10001.7 10009.0 9785.9 9882.6 9892.1 9894.3 9914.0 8384.9 9898.0 9904.6 9936.5 9949.7 9812.7 9879.2 9904.8 9917.0 9926.7 9791.6 9849.9 9880.7 9930.4 9958.0 40120.8 40211.8 40514.4 40606.4 40687.0 3392.5 3406.8 3423.6 3478.0 3512.4 28021.3 30694.1 30861.2 31236.7 31315.8 3237.5 3277.5 3315.5 3321.5 3343.2 486664.8 488713.0 489116.0 492146.0 498559.0 57094.7 57115.4 57412.4 57721.0 57790.8 59785.8 60044.7 60700.7 60809.7 60853.4 16263.9 16450.6 16492.8 16709.4 16710.8 12163.9 12249.4 12283.0 12289.4 12338.3 15126.4 15427.3 15563.1 15569.6 15702.8 3274.3 6448.6 6620.8 6646.6 6678.1 872.7 992.3 1132.3 1138.7 1165.1 29531.6 29631.3 29829.6 30413.5 30670.2 1085.1 1120.3 1125.4 1130.5 1132.9 15526.7 15654.8 15765.5 15865.2 16079.0 654214.0 655421.7 663547.0 664246.0 665640.0 57439.7 57504.7 57850.7 57913.0 58151.0 1386.8 1394.3 1421.2 1421.6 1428.2 29236.4 29767.4 30045.5 30105.0 30459.8 48546.0 49118.8 49380.3 49448.8 49597.5 491326.0 491771.0 492282.5 559573.0 559784.0 26293.6 26639.6 26915.3 26920.7 27018.3 33572.0 45442.0 46196.8 46616.0 46991.0 31649.0 37466.4 37822.6 38092.8 38383.8 30738.7 38585.0 38728.6 39049.0 39131.4 37260.8 38294.0 38677.2 38729.8 38905.8 33053.8 34522.0 34821.7 35111.6 35332.3 25865.0 26140.6 26148.0 26211.5 26546.2 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:35650.28 Median:27032.88 stddev:103612.88 (383.3%) stddev-sans-first:103869.70 22:18:43 INFO - PROCESS | 1637 | Values: 380.8 384.6 386.4 400.3 418.0 16885.0 20435.4 20852.4 21713.2 21722.9 21050.9 21331.1 21498.9 21762.8 21913.0 5889.1 6246.8 6255.5 6258.4 6266.9 5271.6 6021.6 6116.3 6186.5 6226.9 6183.4 6190.0 6193.2 6194.0 6208.7 5975.2 6154.2 6164.3 6200.4 6203.1 5421.1 5427.9 5428.9 5432.5 5433.3 26444.3 26562.3 26933.8 27131.9 27342.5 1975.1 2463.5 2961.3 3166.3 3243.8 10073.6 10282.0 10305.8 10643.7 10816.6 1689.8 1768.6 1924.1 1985.8 2022.9 76316.0 90682.5 117264.0 121112.0 121427.4 8369.7 10336.5 10597.1 10757.1 12071.8 10481.8 11971.0 12619.6 12703.4 12817.9 8227.7 8416.7 8495.1 8505.3 8581.4 7332.6 8908.7 8921.0 8993.6 9146.3 3963.1 4067.0 4073.9 4130.5 4132.3 1974.4 2021.2 2029.7 2030.2 2054.1 814.4 845.9 910.2 959.2 991.4 16755.9 22170.9 22188.6 22200.8 22235.4 902.9 923.2 1016.8 1019.5 1044.2 9758.4 11209.4 11646.3 11858.6 11862.2 547605.0 630054.0 644200.0 644294.8 644703.0 93272.5 114146.4 133508.0 138732.0 144195.3 997.4 1018.4 1050.7 1061.1 1065.7 19883.4 20132.0 20345.9 20527.3 20546.0 58074.4 58154.4 59420.7 60484.0 61593.0 63283.0 81198.0 85241.0 85495.0 85600.6 8242.3 8254.4 8306.5 8360.5 8832.8 9406.8 12747.6 12793.7 13565.3 13668.5 11222.1 11468.4 11717.9 11725.0 11868.5 11317.5 11358.3 11561.9 11713.9 12013.6 11118.1 11182.3 11572.1 11888.7 12079.5 8309.7 8412.7 8720.4 8749.2 8779.7 11063.6 11762.9 11969.6 12016.0 12127.3 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5538.65 Median:5331.21 stddev:2986.87 (56.0%) stddev-sans-first:2979.03 22:18:43 INFO - PROCESS | 1637 | Values: 1396.7 1516.5 1687.3 1803.7 1840.1 7674.5 7929.9 8180.2 8587.3 8605.2 6924.3 8062.7 8307.7 8437.1 8470.8 2395.9 2419.3 2420.0 2420.5 2431.1 2423.9 2439.7 2461.3 2468.8 2475.6 2406.5 2420.3 2432.7 2434.2 2436.2 2377.0 2385.7 2405.8 2408.8 2453.5 2409.7 2415.6 2436.0 2453.0 2453.5 8514.4 8514.7 8550.0 8568.9 8569.2 5212.6 5357.4 5417.4 5419.5 5441.5 3489.2 3508.2 3623.0 3631.5 3674.5 1056.7 1059.6 1088.4 1111.4 1117.4 10914.5 10955.8 11013.3 11032.4 11081.5 4557.3 4691.0 4771.5 4821.3 4838.0 9574.2 9583.2 9591.4 9598.3 9625.9 5322.1 5322.9 5330.6 5331.8 5354.4 3867.2 4390.0 4764.6 4868.8 4896.0 3881.2 3899.2 3977.5 4043.9 4061.8 1090.8 1098.7 1108.6 1310.1 1314.1 896.9 945.0 945.7 948.4 971.4 5620.4 5781.3 5889.1 5935.9 6038.1 401.2 451.5 455.3 455.6 462.7 3954.1 3962.4 3987.1 4018.9 4099.2 8362.5 9842.6 10220.1 10268.3 10283.3 8743.4 9263.6 9537.8 9938.4 10200.3 7587.8 7835.3 8018.9 8026.2 8177.2 5623.7 5770.2 5794.9 5822.5 5951.1 9427.1 9483.5 9539.5 9549.3 9559.0 9359.6 9544.0 9628.7 9767.4 9770.7 7235.8 7240.9 7254.3 7299.5 7327.5 7906.5 7996.9 8002.1 8003.0 8016.1 6103.2 7203.7 7450.3 7452.0 7536.2 7265.7 7327.8 7336.4 7419.5 7458.6 6739.5 6766.2 6856.2 6856.3 6898.0 5064.8 5076.8 5128.7 5150.2 5268.3 5100.3 5123.9 5299.4 5370.9 5386.4 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4678.78 Median:5411.58 stddev:1464.57 (27.1%) stddev-sans-first:1431.38 22:18:43 INFO - PROCESS | 1637 | Values: 302.8 322.5 323.0 325.8 326.5 5469.4 5547.3 5559.1 5590.8 5598.4 3999.5 5164.2 5419.3 5500.4 5507.8 3327.2 3404.0 3409.3 3797.6 3982.7 3634.7 3917.5 4019.8 4217.3 4219.8 3992.0 4176.7 4208.7 4218.0 4237.0 3364.4 4125.2 4152.0 4198.5 4256.0 3527.7 3631.0 3633.6 3653.3 3661.7 4010.5 5397.3 5407.4 5415.7 5445.6 3989.6 4675.6 4857.0 4887.9 4913.6 4724.6 5826.7 5843.9 5854.7 5866.8 3697.1 3777.9 4062.4 4079.4 4095.9 5859.2 6077.3 6098.9 6140.9 6190.9 3765.7 4094.9 4106.4 4120.3 4124.8 3762.7 4046.7 4194.8 4207.3 4207.5 4593.7 4853.1 4867.1 4870.5 4882.5 4849.5 5844.7 5880.3 5895.9 5915.7 1220.8 1223.9 1347.5 1357.5 1363.8 806.0 885.4 887.7 940.2 954.1 4806.9 5427.8 5636.4 5641.4 5684.6 5073.8 5815.1 6117.5 6131.0 6132.2 5485.7 5565.5 5581.3 5625.8 5708.6 2840.8 2899.7 3039.7 3045.9 3064.9 5161.5 5310.4 5533.9 5713.0 6030.5 4852.8 5595.6 5703.2 6006.9 6020.7 5490.7 5869.5 5933.7 6096.3 6104.2 4872.7 5017.6 5453.8 5620.5 5793.7 5763.5 5781.3 5784.5 5804.7 5834.9 5417.6 5467.7 6139.4 6155.6 6229.9 3071.8 3738.6 3930.7 4037.4 4075.9 5168.0 5852.4 6081.3 6090.8 6187.7 5221.6 5270.5 5867.9 5947.0 5964.6 5341.5 5568.0 5740.4 5868.5 5954.0 4841.9 5715.9 5856.2 5857.3 5861.3 4178.5 5334.1 5729.6 5852.4 5971.4 5543.6 5823.7 5849.3 5853.7 5856.6 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20073.65 Median:4440.90 stddev:29273.35 (659.2%) stddev-sans-first:29319.19 22:18:43 INFO - PROCESS | 1637 | Values: 666.4 718.6 768.6 784.9 811.2 15470.4 15751.0 15974.1 16030.4 16087.6 14069.4 14170.9 14233.0 14319.6 14338.0 822.8 824.0 844.6 845.6 847.8 829.6 846.8 851.7 857.2 857.8 856.9 885.7 892.0 892.5 894.7 860.1 875.7 879.3 881.2 881.5 660.3 667.1 668.7 670.2 673.5 12915.5 12921.2 12935.9 12992.5 12996.4 11678.6 11954.6 11965.2 12184.3 12388.1 10716.2 10918.7 11091.4 11160.8 11363.4 3674.0 3696.3 3706.5 3741.1 3775.2 102613.5 103287.5 104438.0 104557.5 105118.0 7700.8 9245.8 9253.9 9489.8 9507.0 18781.8 18832.0 19122.2 19205.9 19335.0 7989.0 8104.5 8108.8 8115.0 8181.6 4235.0 4260.8 4333.8 4393.3 4427.4 3364.3 3485.7 3668.6 3829.8 3838.7 693.1 694.1 701.7 704.2 708.1 463.0 473.2 484.2 530.5 564.7 9326.6 9574.9 9633.9 9872.4 10046.5 671.6 678.3 698.5 707.5 711.4 3602.4 4454.4 4632.3 4664.8 4677.3 95681.5 106530.0 108397.0 113113.0 117241.7 63565.7 81139.0 86492.1 87430.0 95391.5 44797.0 57787.0 65488.3 83272.0 85341.6 9782.0 9787.6 9828.2 9832.6 9934.1 41774.8 48013.5 51188.5 52891.9 53480.0 72902.6 73153.6 74048.0 75474.2 76025.6 12882.5 13510.8 13612.3 13665.7 13766.3 14629.6 14654.5 14735.9 14799.7 14896.9 12971.5 13304.7 13308.8 13966.9 14600.6 13502.2 13576.2 13579.9 13878.7 14040.2 13160.5 13316.5 13676.3 13703.7 14024.3 11351.8 11558.3 11572.3 11710.6 11848.4 9605.0 10588.2 11531.0 11785.5 11822.9 22:18:43 INFO - PROCESS | 1637 | -------- Summary: end -------- 22:18:43 INFO - PROCESS | 1637 | 22:18:43 INFO - TEST-INFO | 1637: exit 0 22:18:43 INFO - TEST-OK | dromaeo_css | took 1115877ms 22:18:43 INFO - TEST-START | kraken 22:18:43 INFO - operating with platform_type : mac_ 22:18:43 INFO - Initialising browser for kraken test... 22:18:43 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpebh4T5/profile http://localhost:49245/getInfo.html) 22:18:46 INFO - PROCESS | 1650 | 2017-01-24 22:18:46.261 plugin-container[1652:10152] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 22:18:46 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:46 INFO - PROCESS | 1650 | 2017-01-24 22:18:46.262 plugin-container[1652:10152] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8923, name = 'com.apple.CFPasteboardClient' 22:18:46 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:46 INFO - PROCESS | 1650 | 2017-01-24 22:18:46.262 plugin-container[1652:10152] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:18:46 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 22:18:46 INFO - PROCESS | 1650 | colorDepth:24 22:18:46 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 22:18:46 INFO - PROCESS | 1650 | __metrics 22:18:46 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 22:18:47 INFO - TEST-INFO | 1650: exit 0 22:18:47 INFO - Browser initialized. 22:18:47 INFO - Running cycle 1/1 for kraken test... 22:18:47 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpebh4T5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:49 INFO - PROCESS | 1653 | 2017-01-24 22:18:49.651 plugin-container[1654:10279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 22:18:49 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:49 INFO - PROCESS | 1653 | 2017-01-24 22:18:49.652 plugin-container[1654:10279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 22:18:49 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:49 INFO - PROCESS | 1653 | 2017-01-24 22:18:49.652 plugin-container[1654:10279] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:18:59 INFO - PROCESS | 1653 | RSS: Main: 177086464 22:18:59 INFO - PROCESS | 1653 | 22:19:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:03 INFO - PROCESS | 1653 | RSS: Main: 190054400 22:19:03 INFO - PROCESS | 1653 | 22:19:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 22:19:06 INFO - PROCESS | 1653 | RSS: Main: 199077888 22:19:06 INFO - PROCESS | 1653 | 22:19:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 22:19:10 INFO - PROCESS | 1653 | RSS: Main: 201953280 22:19:10 INFO - PROCESS | 1653 | 22:19:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 22:19:12 INFO - PROCESS | 1653 | RSS: Main: 202063872 22:19:12 INFO - PROCESS | 1653 | 22:19:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:15 INFO - PROCESS | 1653 | RSS: Main: 203325440 22:19:15 INFO - PROCESS | 1653 | 22:19:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:18 INFO - PROCESS | 1653 | RSS: Main: 207245312 22:19:18 INFO - PROCESS | 1653 | 22:19:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:22 INFO - PROCESS | 1653 | RSS: Main: 207499264 22:19:22 INFO - PROCESS | 1653 | 22:19:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 22:19:25 INFO - PROCESS | 1653 | RSS: Main: 206782464 22:19:25 INFO - PROCESS | 1653 | 22:19:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:27 INFO - PROCESS | 1653 | RSS: Main: 205901824 22:19:27 INFO - PROCESS | 1653 | 22:19:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:30 INFO - PROCESS | 1653 | RSS: Main: 205971456 22:19:30 INFO - PROCESS | 1653 | 22:19:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:33 INFO - PROCESS | 1653 | RSS: Main: 205930496 22:19:33 INFO - PROCESS | 1653 | 22:19:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:36 INFO - PROCESS | 1653 | RSS: Main: 206028800 22:19:36 INFO - PROCESS | 1653 | 22:19:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:40 INFO - PROCESS | 1653 | RSS: Main: 206389248 22:19:40 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 22:19:42 INFO - PROCESS | 1653 | RSS: Main: 208310272 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | __start_tp_report 22:19:42 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 22:19:42 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 22:19:42 INFO - PROCESS | 1653 | |i|pagename|runs| 22:19:42 INFO - PROCESS | 1653 | |0;ai-astar;106;117;117;118;118;117;116;117;117;117 22:19:42 INFO - PROCESS | 1653 | |1;audio-beat-detection;164;142;139;128;141;142;141;116;135;109 22:19:42 INFO - PROCESS | 1653 | |2;audio-dft;190;204;195;195;195;194;193;195;198;189 22:19:42 INFO - PROCESS | 1653 | |3;audio-fft;80;60;60;82;78;83;58;60;78;58 22:19:42 INFO - PROCESS | 1653 | |4;audio-oscillator;85;71;90;71;68;69;75;58;99;119 22:19:42 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;87;87;90;129;85;89;88;93;86 22:19:42 INFO - PROCESS | 1653 | |6;imaging-darkroom;98;98;98;98;100;98;98;128;172;121 22:19:42 INFO - PROCESS | 1653 | |7;imaging-desaturate;93;90;88;86;88;97;88;91;86;125 22:19:42 INFO - PROCESS | 1653 | |8;json-parse-financial;56;57;55;57;58;60;59;58;58;58 22:19:42 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;72;66;73;72;75;65;85;70;70;70 22:19:42 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;82;82;86;84;83;83;83;84;84;90 22:19:42 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;134;154;155;138;141;139;147;151;188;159 22:19:42 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;165;172;162;166;221;154;219;213;164;162 22:19:42 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;73;81;87;87;85;84;77;66;70 22:19:42 INFO - PROCESS | 1653 | __end_tp_report 22:19:42 INFO - PROCESS | 1653 | __start_cc_report 22:19:42 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,899 22:19:42 INFO - PROCESS | 1653 | __end_cc_report 22:19:42 INFO - PROCESS | 1653 | __startTimestamp1485325182466__endTimestamp 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | ------- Summary: start ------- 22:19:42 INFO - PROCESS | 1653 | Number of tests: 14 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:116.00 Median:117.00 stddev:3.56 (3.0%) stddev-sans-first:0.60 22:19:42 INFO - PROCESS | 1653 | Values: 106.0 117.0 117.0 118.0 118.0 117.0 116.0 117.0 117.0 117.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:141.00 stddev:15.30 (10.9%) stddev-sans-first:12.34 22:19:42 INFO - PROCESS | 1653 | Values: 164.0 142.0 139.0 128.0 141.0 142.0 141.0 116.0 135.0 109.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:194.80 Median:195.00 stddev:4.16 (2.1%) stddev-sans-first:4.03 22:19:42 INFO - PROCESS | 1653 | Values: 190.0 204.0 195.0 195.0 195.0 194.0 193.0 195.0 198.0 189.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:69.70 Median:78.00 stddev:11.20 (14.4%) stddev-sans-first:11.24 22:19:42 INFO - PROCESS | 1653 | Values: 80.0 60.0 60.0 82.0 78.0 83.0 58.0 60.0 78.0 58.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:73.00 stddev:18.08 (24.8%) stddev-sans-first:19.10 22:19:42 INFO - PROCESS | 1653 | Values: 85.0 71.0 90.0 71.0 68.0 69.0 75.0 58.0 99.0 119.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:88.50 stddev:13.09 (14.8%) stddev-sans-first:13.83 22:19:42 INFO - PROCESS | 1653 | Values: 89.0 87.0 87.0 90.0 129.0 85.0 89.0 88.0 93.0 86.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:98.00 stddev:24.14 (24.6%) stddev-sans-first:25.15 22:19:42 INFO - PROCESS | 1653 | Values: 98.0 98.0 98.0 98.0 100.0 98.0 98.0 128.0 172.0 121.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:89.00 stddev:11.67 (13.1%) stddev-sans-first:12.38 22:19:42 INFO - PROCESS | 1653 | Values: 93.0 90.0 88.0 86.0 88.0 97.0 88.0 91.0 86.0 125.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.43 (2.5%) stddev-sans-first:1.39 22:19:42 INFO - PROCESS | 1653 | Values: 56.0 57.0 55.0 57.0 58.0 60.0 59.0 58.0 58.0 58.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:5.53 (7.7%) stddev-sans-first:5.87 22:19:42 INFO - PROCESS | 1653 | Values: 72.0 66.0 73.0 72.0 75.0 65.0 85.0 70.0 70.0 70.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.38 (2.8%) stddev-sans-first:2.40 22:19:42 INFO - PROCESS | 1653 | Values: 82.0 82.0 86.0 84.0 83.0 83.0 83.0 84.0 84.0 90.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:152.50 stddev:15.54 (10.2%) stddev-sans-first:15.28 22:19:42 INFO - PROCESS | 1653 | Values: 134.0 154.0 155.0 138.0 141.0 139.0 147.0 151.0 188.0 159.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:169.00 stddev:26.57 (15.7%) stddev-sans-first:27.64 22:19:42 INFO - PROCESS | 1653 | Values: 165.0 172.0 162.0 166.0 221.0 154.0 219.0 213.0 164.0 162.0 22:19:42 INFO - PROCESS | 1653 | 22:19:42 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:82.50 stddev:8.23 (10.0%) stddev-sans-first:7.77 22:19:42 INFO - PROCESS | 1653 | Values: 67.0 73.0 81.0 87.0 87.0 85.0 84.0 77.0 66.0 70.0 22:19:42 INFO - PROCESS | 1653 | -------- Summary: end -------- 22:19:42 INFO - PROCESS | 1653 | 22:19:43 INFO - TEST-INFO | 1653: exit 0 22:19:43 INFO - TEST-OK | kraken | took 59816ms 22:19:43 INFO - SUITE-END | took 1175s 22:19:43 INFO - Completed test suite (00:19:35) 22:19:43 INFO - javascript benchmark 22:19:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7336.707942695653, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3565.0909018200364, 3613.8977611828414, 3633.454981752737, 3638.9272214555695, 3639.599644039155, 5984.970075149624, 5989.790357337494, 6011.458968692822, 6031.396860313977, 6063.09053641954, 6056.515478761699, 6062.484688801457, 6084.421979911913, 6129.172561704168, 6130.3256641769485, 3696.7966761828225, 5370.167624018264, 5394.298741163643, 5433.212184233284, 5516.979358818611, 5449.509544141027, 5494.5054945054935, 5496.945030549703, 5499.642523235997, 5501.339839219299, 4715.528447155291, 4828.17920953437, 5354.063038968185, 5487.725613719318, 5493.670379777206, 5416.783328666848, 5429.619926605139, 5434.538064264542, 5454.781808727646, 5472.069748142825, 5309.3894202166475, 5365.543928766059, 5403.945960540384, 5414.810481633124, 5425.457454254582, 6019.578629495937, 6028.125921741367, 6069.605475644069, 6091.817245482643, 6134.78528251509, 5685.431456854281, 5897.292324920994, 6183.536234782409, 6310.810675679737, 6313.116163737081, 5039.672421292605, 6118.021116621319, 6241.438270555626, 6358.618482891041, 6410.0705397717065, 6053.3946605339115, 6068.57519973602, 6085.148079268906, 6095.08573713942, 6128.258691089361, 6447.0, 6478.740850366027, 6556.311587283267, 6558.901616475757, 6572.605643661395, 6212.502999760009, 6265.655388953652, 6275.937240627535, 6283.96858015707, 6294.559380843297, 6263.937360626426, 6363.9045414318825, 6382.808515744535, 6388.361163883575, 6407.070974708734, 6315.621062736159, 6318.62088274705, 6323.399277068671, 6336.081268216083, 6354.682265886687, 6179.783707570214, 6204.255489341218, 6262.029385445263, 6330.923742963707, 6344.429001389897, 5144.408393034774, 5189.896202075937, 5190.844274671766, 5198.480151984847, 5244.475552444725, 4642.628589712815, 4650.093231819763, 4670.182718024332, 4684.063187362473, 4685.906281874343, 5679.148127780783, 6029.155918171459, 6213.2233470816145, 6219.191505104308, 6228.844278892973, 6194.442500175006, 6262.718177682015, 6333.429991300805, 6365.777197798147, 6383.265924418658, 6160.784372547029, 6180.536459765535, 6191.9690401547705, 6192.442680158807, 6210.192674952227, 5550.4449555044175, 5618.578606604521, 5668.229573242002, 5697.401772813795, 5741.913871291934, 6509.934900650933, 6538.0, 6607.9669601651685, 6643.236027856665, 6645.867082658417, 6332.905006424815, 6383.616982981036, 6394.840128996812, 6399.0, 6400.55196136266, 6417.96791016042, 6549.869002619826, 6636.435902948304, 6643.734250629921, 6650.035744817072, 6230.283517395557, 6253.687315634109, 6263.467605253422, 6274.058891166362, 6280.560360774702, 6409.134766806608, 6413.551051426355, 6414.61512309263, 6417.0, 6418.518611104279, 6121.47967422774, 6142.262928448615, 6259.812205633838, 6280.963640999184, 6305.653189074645, 6168.537359697951, 6198.2252218472695, 6199.845003874939, 6206.06908963659, 6255.874882502416, 6173.228346456693, 6213.5339849512375, 6268.247810262797, 6280.717367718555, 6297.590656607489, 6242.406971337716, 6242.750289988349, 6273.874522509433, 6280.937190628035, 6296.244450665949, 6110.450059494667, 6141.271221159593, 6148.385161483816, 6243.313235543996, 6327.905081423874], "value": 5893.749902796651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.487587784582, 504.33176041744696, 529.2114749023956, 536.6163193316778, 537.1727539589033, 31281.68718312816, 41422.0, 41502.79248603753, 43369.56630433695, 43420.565794342045, 42013.36979945303, 42502.0, 42586.78706606463, 42597.574024259746, 42801.57198428023, 9737.805243895136, 9916.801663966717, 9939.40363578184, 10001.749956251078, 10008.999100090006, 9785.902140978606, 9882.604695812159, 9892.109710126088, 9894.307398482073, 9913.950430247838, 8384.8742268866, 9897.950510247474, 9904.55429505674, 9936.453495057769, 9949.701508954708, 9812.656557020506, 9879.209663226924, 9904.752381190456, 9917.008299170098, 9926.702198934043, 9791.559379827924, 9849.852252216222, 9880.703578892644, 9930.354526955725, 9958.0, 40120.79637610847, 40211.79894100511, 40514.39228411576, 40606.39090413646, 40687.0, 3392.4741665041956, 3406.829658517064, 3423.640517745651, 3478.0435380270374, 3512.385332566816, 28021.299467513272, 30694.079177624706, 30861.228469288224, 31236.68763312383, 31315.843420782978, 3237.546743455918, 3277.5411442398085, 3315.535824984504, 3321.485169798685, 3343.2477692519233, 486664.8333791648, 488713.0, 489116.0, 492146.0, 498559.0, 57094.71452642793, 57115.42884571101, 57412.42587574071, 57721.0, 57790.8441831161, 59785.804283914076, 60044.699776501715, 60700.69649651724, 60809.695951519956, 60853.39146608566, 16263.918680406523, 16450.588735281475, 16492.83507164937, 16709.41517046922, 16710.832891671173, 12163.939180304218, 12249.387530623433, 12283.01735861129, 12289.385530723428, 12338.321392323329, 15126.39494420211, 15427.30577124032, 15563.144027078393, 15569.634167058111, 15702.76445853313, 3274.345130973815, 6448.581781831813, 6620.8344791380605, 6646.60120392778, 6678.098456708282, 872.6771094695004, 992.2954702161546, 1132.2696860524916, 1138.7267055906689, 1165.0854079547685, 29531.55702664462, 29631.25921851971, 29829.552556711667, 30413.543796843063, 30670.233244168627, 1085.0993675249524, 1120.3166068698088, 1125.3810404277615, 1130.5477808876515, 1132.943352832355, 15526.689466210613, 15654.843451565566, 15765.527034188992, 15865.20673966297, 16078.954867933548, 654214.0, 655421.7228913825, 663547.0, 664246.0, 665640.0, 57439.71280143572, 57504.71247643819, 57850.710746446, 57913.0, 58151.0, 1386.7503849307222, 1394.2819447984295, 1421.232534431416, 1421.6019514535947, 1428.2144820348767, 29236.415271694023, 29767.404651907273, 30045.54931675983, 30105.0, 30459.847700761355, 48546.0, 49118.75440622917, 49380.25929610987, 49448.76378090576, 49597.504024959286, 491326.0, 491771.0, 492282.53858730476, 559573.0, 559784.0, 26293.605595915695, 26639.600405993537, 26915.327116822235, 26920.730792691822, 27018.324541885824, 33572.0, 45442.0, 46196.76901615471, 46616.0, 46991.0, 31649.0, 37466.438003430514, 37822.62177378191, 38092.80953595214, 38383.80808096053, 30738.692613073585, 38585.0, 38728.61271387363, 39049.0, 39131.41302880402, 37260.81369593135, 38294.042648934, 38677.2264554713, 38729.806350968065, 38905.80547097247, 33053.834730826195, 34522.0, 34821.651783481844, 35111.64888351084, 35332.29335413329, 25865.0, 26140.60789088127, 26148.0, 26211.475770484863, 26546.203613891616], "value": 19788.211323315096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7905651891459, 384.57120310853406, 386.41657472109847, 400.2974779262395, 417.9707420480566, 16885.0, 20435.386938391854, 20852.37442876712, 21713.24003659874, 21722.89138554309, 21050.89474552629, 21331.146754129815, 21498.925053747327, 21762.782372176272, 21913.0, 5889.116632505115, 6246.781362652308, 6255.499560035186, 6258.374162583751, 6266.874662506747, 5271.578273738091, 6021.638701677914, 6116.296625888035, 6186.536009799261, 6226.906596401035, 6183.412575805291, 6190.0405437157315, 6193.225846769154, 6193.969030154843, 6208.72060757267, 5975.163477113208, 6154.230721159877, 6164.260288765332, 6200.410960958701, 6203.1005504202085, 5421.105517589593, 5427.891442171174, 5428.864278393033, 5432.483914028161, 5433.320834895638, 26444.338891527674, 26562.33594160142, 26933.84529237656, 27131.91472341104, 27342.453150937068, 1975.0815870620088, 2463.4703538739077, 2961.3336999175012, 3166.319241363095, 3243.7729358944885, 10073.647422340257, 10282.023207795248, 10305.793884122351, 10643.733906652318, 10816.621418250403, 1689.8225686302885, 1768.5578605348662, 1924.0956750327323, 1985.8113479219596, 2022.9291974780813, 76316.0, 90682.54658726664, 117264.0, 121112.0, 121427.39286303511, 8369.707060252862, 10336.483175841178, 10597.099246563974, 10757.085647720032, 12071.818922716166, 10481.790364192673, 11971.0, 12619.621411357673, 12703.428345724464, 12817.871821281668, 8227.712030079038, 8416.747497575083, 8495.1080136586, 8505.31957443403, 8581.399302048922, 7332.633368331669, 8908.73273801787, 8921.01868794432, 8993.55032248385, 9146.314026448043, 3963.147923196527, 4066.9796651016554, 4073.8574149905203, 4130.545639979599, 4132.297509423405, 1974.3780709076595, 2021.242034237161, 2029.7361343025311, 2030.2285131649878, 2054.085931760352, 814.3810703865105, 845.9238668519739, 910.1808372464702, 959.1559427703576, 991.3556188477403, 16755.91622041882, 22170.88914555449, 22188.57137145539, 22200.777992220195, 22235.444113897283, 902.8669020379382, 923.1829830599968, 1016.755978565139, 1019.5420548615402, 1044.1698849414734, 9758.365706229073, 11209.439528023566, 11646.301221926711, 11858.584949526898, 11862.169648124549, 547605.0, 630054.0, 644200.0, 644294.7785261044, 644703.0, 93272.53363733273, 114146.4292678548, 133508.0, 138732.0, 144195.2790236042, 997.3517213810936, 1018.4093225928943, 1050.7058023753361, 1061.1033676543464, 1065.674969134406, 19883.403497895088, 20132.0, 20345.89827050855, 20527.28154514585, 20546.0, 58074.419255806904, 58154.418455816594, 59420.70289648524, 60484.0, 61593.0, 63283.0, 81198.0, 85241.0, 85495.0, 85600.57199713962, 8242.290969063826, 8254.42219044661, 8306.468037334876, 8360.540170290693, 8832.823343533222, 9406.811863762823, 12747.61757147287, 12793.680157996125, 13565.253911034988, 13668.453261869414, 11222.10223182127, 11468.426578670866, 11717.88282117168, 11725.0, 11868.465919033491, 11317.547298108313, 11358.318500889973, 11561.942190288995, 11713.941430293135, 12013.579524716593, 11118.110551155727, 11182.273152245078, 11572.132090093444, 11888.702782430508, 12079.456424461096, 8309.709160179365, 8412.747617571482, 8720.389572729848, 8749.212570868653, 8779.692710755093, 11063.557457701923, 11762.882371176178, 11969.64091077269, 12016.038716902802, 12127.332996685267], "value": 9760.113696057655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.7416028034813, 1516.476815498653, 1687.3082036365092, 1803.7204233343837, 1840.1075478392977, 7674.46278760487, 7929.92070079299, 8180.222878826509, 8587.270082043025, 8605.225529702326, 6924.3421874921805, 8062.71780487683, 8307.709230176944, 8437.114103019187, 8470.78823029423, 2395.9281221563338, 2419.346776370379, 2420.031987205123, 2420.467497150633, 2431.1369463840347, 2423.9151629692965, 2439.731629520751, 2461.2616215135477, 2468.753124687526, 2475.616279476675, 2406.5066661334386, 2420.298113547078, 2432.7080750309988, 2434.20888211332, 2436.2204094689705, 2376.9881150594224, 2385.6898603181476, 2405.8195635327247, 2408.7832095111526, 2453.472503411766, 2409.6506006628942, 2415.649730789043, 2436.0, 2452.982012464825, 2453.4847681986803, 8514.403991720583, 8514.74455766328, 8550.0, 8568.914310856873, 8569.228769410784, 5212.55693266069, 5357.4106848246665, 5417.377001644822, 5419.5393391561765, 5441.537469315113, 3489.180042689966, 3508.1755787389943, 3622.981885090584, 3631.5460567429072, 3674.4855720199193, 1056.7199692081604, 1059.607945060325, 1088.35786885737, 1111.3831823338044, 1117.4245263689206, 10914.454277286104, 10955.780884382348, 11013.2841365311, 11032.44837758109, 11081.501332440059, 4557.316402539645, 4690.9765451172525, 4771.5467030632035, 4821.325014497973, 4837.975810120927, 9574.234061275221, 9583.233341332676, 9591.42451452915, 9598.32811703188, 9625.855612165824, 5322.0952438085615, 5322.92015619766, 5330.600204984642, 5331.813386531453, 5354.3574771027725, 3867.187890542961, 4389.978050109729, 4764.595009424169, 4868.756562171877, 4895.975520122448, 3881.2237552489614, 3899.1811719538646, 3977.54258260298, 4043.8584649537715, 4061.7969101544804, 1090.798202332571, 1098.6594155811724, 1108.6396921000708, 1310.1353106949368, 1314.1261061394257, 896.8968568614563, 944.974702447838, 945.7304668169538, 948.3503799897093, 971.4122955611895, 5620.4098569649595, 5781.335146458127, 5889.116632505073, 5935.910961335583, 6038.094285857069, 401.199606784461, 451.4695233101093, 455.31929765001536, 455.5717625432083, 462.68768581208224, 3954.130091379892, 3962.3660214365564, 3987.142764305688, 4018.859339923147, 4099.159672267178, 8362.54006029662, 9842.557084931195, 10220.131288840383, 10268.281220314506, 10283.280170388001, 8743.431676940978, 9263.583138758771, 9537.807774028246, 9938.403695778277, 10200.3369780964, 7587.772366829004, 7835.255650713173, 8018.879716804253, 8026.237507436784, 8177.223163799429, 5623.746931388179, 5770.2498675171955, 5794.856518717075, 5822.534197264124, 5951.077582974646, 9427.057294270518, 9483.478408687588, 9539.47532885698, 9549.283803714889, 9558.95220523893, 9359.625614975597, 9544.0, 9628.66299679508, 9767.413955162712, 9770.658026969022, 7235.782926512213, 7240.8913866290995, 7254.274572542704, 7299.452541059548, 7327.487075904635, 7906.486078404885, 7996.880046799186, 8002.119766825761, 8002.9599852000365, 8016.078151012708, 6103.206583144163, 7203.71185152609, 7450.292222238879, 7452.03123593951, 7536.171021187774, 7265.7093716252875, 7327.780166595011, 7336.4130869529245, 7419.517731347445, 7458.627068646654, 6739.494537909578, 6766.15423072116, 6856.211535673262, 6856.280090590616, 6898.034275201376, 5064.822731204537, 5076.771545280398, 5128.666636668605, 5150.201718733602, 5268.341457317835, 5100.260462232881, 5123.89836185222, 5299.41706412302, 5370.865728356823, 5386.353637563518], "value": 4440.941054709297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8455487701272, 322.4534414167986, 322.95317179009044, 325.79637726420987, 326.54936188060475, 5469.425710300416, 5547.278853749012, 5559.136400201862, 5590.804321848736, 5598.356189038262, 3999.460072890159, 5164.199549069891, 5419.3225846769155, 5500.42245564216, 5507.752151153198, 3327.1848397142735, 3403.982980085096, 3409.3010932758725, 3797.582265950743, 3982.7411218270863, 3634.727395445339, 3917.5103112110987, 4019.77891215983, 4217.283061879488, 4219.831206751726, 3992.029922746185, 4176.728512646669, 4208.726432781875, 4218.0, 4237.0, 3364.4112280350964, 4125.246770122716, 4152.024274295538, 4198.538160802309, 4256.021115143519, 3527.7177825773874, 3631.0, 3633.5821380541047, 3653.324135035027, 3661.743677942545, 4010.498687664042, 5397.302847549402, 5407.432219616962, 5415.729213539346, 5445.618806683534, 3989.5810939851476, 4675.602573781232, 4856.955754512796, 4887.871762072276, 4913.582345500637, 4724.5984091352275, 5826.7377967991115, 5843.941560584382, 5854.736536855852, 5866.823995280149, 3697.149655579205, 3777.924441511182, 4062.415657893424, 4079.4492743479545, 4095.9180816383805, 5859.2090067841145, 6077.301110372319, 6098.908516372302, 6140.9385906140815, 6190.938090619081, 3765.6799172070682, 4094.877153685394, 4106.357457017158, 4120.299549076664, 4124.845043387856, 3762.736608437383, 4046.6964977626208, 4194.790260486963, 4207.305794543927, 4207.5161356444405, 4593.678442509059, 4853.141752306925, 4867.123917694849, 4870.512948705101, 4882.487338829372, 4849.466558678542, 5844.736986835603, 5880.323762767251, 5895.852603684856, 5915.733791979371, 1220.7924652809045, 1223.9020878329711, 1347.4812197304109, 1357.497725841445, 1363.7886127650231, 805.9556724380099, 885.3758100539104, 887.6804350433839, 940.2431043010306, 954.0840792838952, 4806.94247265601, 5427.810026649127, 5636.408177141423, 5641.379448260688, 5684.607271218495, 5073.771680274396, 5815.127730840323, 6117.541184411187, 6131.0, 6132.17215675878, 5485.725713714299, 5565.523342112721, 5581.348859291804, 5625.774969001276, 5708.600397972185, 2840.8437535935723, 2899.7084315213183, 3039.6656367799524, 3045.9086227413213, 3064.923376915595, 5161.509656582619, 5310.362756469249, 5533.861653458615, 5712.971665100322, 6030.547708921848, 4852.805887764521, 5595.608307418523, 5703.17303990919, 6006.939930600638, 6020.69896505173, 5490.725463726718, 5869.530437564985, 5933.673647949404, 6096.329403765582, 6104.24588877837, 4872.731999740048, 5017.598592112695, 5453.7818487260065, 5620.4660557247, 5793.725380416302, 5763.4756715977755, 5781.265620313973, 5784.50831679312, 5804.73878675469, 5834.899436202879, 5417.647852889707, 5467.72661366938, 6139.3553676863285, 6155.569110162246, 6229.937700622936, 3071.7559388447717, 3738.5980257403476, 3930.685545156438, 4037.4145748866836, 4075.857344992911, 5168.01807656544, 5852.4440178183, 6081.331053584191, 6090.817275481742, 6187.668631957557, 5221.556167725786, 5270.49930256625, 5867.9413205867395, 5946.970265148647, 5964.642121472725, 5341.4925582069645, 5568.0, 5740.350316243856, 5868.5305175585, 5953.970230148821, 4841.927371089507, 5715.942550628147, 5856.180134781219, 5857.26784151981, 5861.32594751609, 4178.519470260959, 5334.146536554133, 5729.598928075162, 5852.4440178183, 5971.387310677152, 5543.6396634218645, 5823.70881455934, 5849.327327357239, 5853.707314634336, 5856.594417339893], "value": 4211.63679028911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.3935818405251, 718.6227230703884, 768.6041688530404, 784.8940393046938, 811.1685522339604, 15470.38118475261, 15751.0, 15974.121423321712, 16030.43893463729, 16087.59781005474, 14069.366878490468, 14170.92914535426, 14233.0, 14319.57041288763, 14337.996340256186, 822.8313195794877, 823.9711610093648, 844.6030365728097, 845.5729856422529, 847.809242920341, 829.5561874397199, 846.8391005708895, 851.7146755836802, 857.1685465098875, 857.7855536115972, 856.9485830850169, 885.7298523950193, 892.0143241717906, 892.4823602310677, 894.7494701483595, 860.0625318402939, 875.7022612311845, 879.309741852649, 881.2289246908955, 881.5371929736875, 660.3495556876472, 667.142721602743, 668.7124536449325, 670.1890712238197, 673.5285300289817, 12915.547955821501, 12921.160124591965, 12935.935320323431, 12992.545260915822, 12996.350182490838, 11678.6496405108, 11954.58158964432, 11965.162438629299, 12184.329861857594, 12388.070894682845, 10716.196285278558, 10918.727031824188, 11091.445427728662, 11160.776784464346, 11363.431828408546, 3673.981630091859, 3696.2607478504406, 3706.4810926470313, 3741.1021354874906, 3775.244951009809, 102613.46079808808, 103287.45068823898, 104438.0, 104557.4772126142, 105118.0, 7700.806375011882, 9245.815083698422, 9253.907460925304, 9489.762755931019, 9507.001764814595, 18781.812181878006, 18832.0, 19122.235110595422, 19205.90397048006, 19335.033248337528, 7989.0, 8104.473209241381, 8108.75673729789, 8114.959425202955, 8181.550014749127, 4234.978825105916, 4260.829566817292, 4333.783310834446, 4393.253146964959, 4427.380166776654, 3364.327134573095, 3485.721142308609, 3668.614795446493, 3829.80850957451, 3838.7120965927666, 693.0920494152676, 694.1150033707064, 701.6912558474255, 704.2499737779249, 708.1396103733885, 462.95601917818425, 473.15777915310804, 484.2204051477119, 530.5304805247384, 564.6696682440736, 9326.580303886341, 9574.94675585685, 9633.90366096344, 9872.35829671069, 10046.47443905849, 671.6138220523219, 678.2505331608502, 698.5110422704128, 707.5224223649017, 711.4201925430757, 3602.3875941090078, 4454.420925279757, 4632.328312394751, 4664.836730714409, 4677.251639737626, 95681.5215923916, 106530.0, 108397.0, 113113.0, 117241.65516689619, 63565.72868542603, 81139.0, 86492.13507864841, 87430.0, 95391.52304238573, 44797.0, 57787.0, 65488.34511654918, 83272.0, 85341.57329213314, 9782.0, 9787.608495660379, 9828.213742900407, 9832.60669573209, 9934.105930466292, 41774.79112604539, 48013.5198648009, 51188.48811511837, 52891.94216115579, 53480.0, 72902.63548682435, 73153.6342318285, 74048.0, 75474.24525754672, 76025.61987190029, 12882.549110781078, 13510.79733803974, 13612.25132617676, 13665.726685466434, 13766.31168441554, 14629.63425914318, 14654.487092951695, 14735.92632036833, 14799.704005919606, 14896.925515372353, 12971.5459958901, 13304.667383315495, 13308.800367994294, 13966.930165349107, 14600.634984125481, 13502.189868607915, 13576.1854288743, 13579.86420135786, 13878.722425551634, 14040.227787471787, 13160.539381121614, 13316.46734130624, 13676.31618419095, 13703.657408564866, 14024.298785060502, 11351.772964540498, 11558.30650160993, 11572.305661660328, 11710.590129345432, 11848.407579620813, 9605.03949605034, 10588.229414968706, 11531.0, 11785.528578856749, 11822.881771182178], "value": 7324.5878730051545, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 117.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 142.0, 139.0, 128.0, 141.0, 142.0, 141.0, 116.0, 135.0, 109.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 204.0, 195.0, 195.0, 195.0, 194.0, 193.0, 195.0, 198.0, 189.0], "value": 194.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 82.0, 78.0, 83.0, 58.0, 60.0, 78.0, 58.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 90.0, 71.0, 68.0, 69.0, 75.0, 58.0, 99.0, 119.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 90.0, 129.0, 85.0, 89.0, 88.0, 93.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 98.0, 100.0, 98.0, 98.0, 128.0, 172.0, 121.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 88.0, 86.0, 88.0, 97.0, 88.0, 91.0, 86.0, 125.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 57.0, 58.0, 60.0, 59.0, 58.0, 58.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 73.0, 72.0, 75.0, 65.0, 85.0, 70.0, 70.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 86.0, 84.0, 83.0, 83.0, 83.0, 84.0, 84.0, 90.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 154.0, 155.0, 138.0, 141.0, 139.0, 147.0, 151.0, 188.0, 159.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 172.0, 162.0, 166.0, 221.0, 154.0, 219.0, 213.0, 164.0, 162.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 81.0, 87.0, 87.0, 85.0, 84.0, 77.0, 66.0, 70.0], "value": 77.7, "unit": "score"}]}]} 22:19:43 INFO - Return code: 0 22:19:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:19:43 ERROR - # TBPL SUCCESS # 22:19:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:19:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:19:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:19:43 INFO - 2017-01-24 22:19:43.791 screenresolution[1658:10667] starting screenresolution argv=screenresolution get 22:19:43 INFO - 2017-01-24 22:19:43.794 screenresolution[1658:10667] Display 0: 1600x1200x32@60 22:19:43 INFO - 2017-01-24 22:19:43.800 screenresolution[1659:10670] starting screenresolution argv=screenresolution list 22:19:43 INFO - Available Modes on Display 0 22:19:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:19:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:19:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:19:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:19:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:19:44 INFO - Intel Iris: 22:19:44 INFO - Chipset Model: Intel Iris 22:19:44 INFO - Type: GPU 22:19:44 INFO - Bus: Built-In 22:19:44 INFO - VRAM (Dynamic, Max): 1536 MB 22:19:44 INFO - Vendor: Intel (0x8086) 22:19:44 INFO - Device ID: 0x0a2e 22:19:44 INFO - Revision ID: 0x0009 22:19:44 INFO - Displays: 22:19:44 INFO - Display: 22:19:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:19:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:19:44 INFO - Display Serial Number: 1600x1200 60 22:19:44 INFO - Main Display: Yes 22:19:44 INFO - Mirror: Off 22:19:44 INFO - Online: Yes 22:19:44 INFO - Rotation: Supported 22:19:44 INFO - Return code: 0 22:19:44 INFO - Running post-action listener: _resource_record_post_action 22:19:44 INFO - [mozharness: 2017-01-25 06:19:44.040724Z] Finished run-tests step (success) 22:19:44 INFO - Running post-run listener: _resource_record_post_run 22:19:44 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40425472; Write bytes: 499782656; Read time: 396; Write time: 1539 22:19:44 INFO - TinderboxPrint: CPU usage
54.1% 22:19:44 INFO - TinderboxPrint: I/O read bytes / time
40,425,472 / 396 22:19:44 INFO - TinderboxPrint: I/O write bytes / time
499,782,656 / 1,539 22:19:44 INFO - TinderboxPrint: CPU idle
2,198.6 (45.9%) 22:19:44 INFO - TinderboxPrint: CPU system
962.4 (20.1%) 22:19:44 INFO - TinderboxPrint: CPU user
1,632.6 (34.1%) 22:19:44 INFO - TinderboxPrint: Swap in / out
231,718,912 / 0 22:19:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 188559872; Write bytes: 187348992; Read time: 18077; Write time: 369 22:19:44 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 38311936; Write bytes: 305130496; Read time: 373; Write time: 1140 22:19:44 INFO - Running post-run listener: _upload_blobber_files 22:19:44 INFO - Blob upload gear active. 22:19:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:19:44 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 22:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:19:44 INFO - (blobuploader) - INFO - Open directory for files ... 22:19:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:19:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:19:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:46 INFO - (blobuploader) - INFO - Done attempting. 22:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:19:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:46 INFO - (blobuploader) - INFO - Done attempting. 22:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:49 INFO - (blobuploader) - INFO - Done attempting. 22:19:49 INFO - (blobuploader) - INFO - Iteration through files over. 22:19:49 INFO - Return code: 0 22:19:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:19:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:19:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046e41520d16855c3a44456019e9eef909046d5504c5d03abf59670dcc0fce21f7f2fbc5f85c4410f1709b3085277b9e211d8aab0ea9ca210f85fad11762a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c586d33cfd163b6072b2c6ae2a4c12c5714bed90f5eb2134bcb59a3673e839c494d9876c4362fc16eec04526fee03cb2dc0b9cd0f3cbaa179d1200caa924df24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b1ade6d9fb71efd621735436e7260c2dd318ab783749f52efbfbfdae3aa827625f0cb9273d53a8643ee8a699e3bfe5150cfb52faedc4b7a71b7a7dd72583c53"} 22:19:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:19:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:19:49 INFO - Contents: 22:19:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046e41520d16855c3a44456019e9eef909046d5504c5d03abf59670dcc0fce21f7f2fbc5f85c4410f1709b3085277b9e211d8aab0ea9ca210f85fad11762a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c586d33cfd163b6072b2c6ae2a4c12c5714bed90f5eb2134bcb59a3673e839c494d9876c4362fc16eec04526fee03cb2dc0b9cd0f3cbaa179d1200caa924df24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b1ade6d9fb71efd621735436e7260c2dd318ab783749f52efbfbfdae3aa827625f0cb9273d53a8643ee8a699e3bfe5150cfb52faedc4b7a71b7a7dd72583c53"} 22:19:49 INFO - Running post-run listener: copy_logs_to_upload_dir 22:19:49 INFO - Copying logs to upload dir... 22:19:49 INFO - mkdir: /builds/slave/test/build/upload/logs 22:19:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.291005 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-24 22:19:49.194916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 22:19:49.198148) ========= 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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046e41520d16855c3a44456019e9eef909046d5504c5d03abf59670dcc0fce21f7f2fbc5f85c4410f1709b3085277b9e211d8aab0ea9ca210f85fad11762a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c586d33cfd163b6072b2c6ae2a4c12c5714bed90f5eb2134bcb59a3673e839c494d9876c4362fc16eec04526fee03cb2dc0b9cd0f3cbaa179d1200caa924df24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b1ade6d9fb71efd621735436e7260c2dd318ab783749f52efbfbfdae3aa827625f0cb9273d53a8643ee8a699e3bfe5150cfb52faedc4b7a71b7a7dd72583c53"} build_url:https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/046e41520d16855c3a44456019e9eef909046d5504c5d03abf59670dcc0fce21f7f2fbc5f85c4410f1709b3085277b9e211d8aab0ea9ca210f85fad11762a2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c586d33cfd163b6072b2c6ae2a4c12c5714bed90f5eb2134bcb59a3673e839c494d9876c4362fc16eec04526fee03cb2dc0b9cd0f3cbaa179d1200caa924df24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3b1ade6d9fb71efd621735436e7260c2dd318ab783749f52efbfbfdae3aa827625f0cb9273d53a8643ee8a699e3bfe5150cfb52faedc4b7a71b7a7dd72583c53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 22:19:49.233344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:19:49.233693) ========= 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.YvMWE8IQbl/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.MGG0KPMYx6/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005223 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:19:49.282664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 22:19:49.283074) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 22:19:49.283392) ========= ========= Total master_lag: 0.18 =========