builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0080 starttime: 1477465192.56 results: success (0) buildid: 20161025220526 builduid: de2c6007ba4a4f1b838428b27b94ca09 revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.558028) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.559008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.559687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.583289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.583565) ========= 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.vx5hh5PAIL/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.48MXuz6olZ/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-25 23:59:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.1M=0s 2016-10-25 23:59:52 (39.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133936 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.761248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.761559) ========= 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.vx5hh5PAIL/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.48MXuz6olZ/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.020067 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:52.812989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 23:59:52.813812) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vx5hh5PAIL/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.48MXuz6olZ/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-25 23:59:52,889 truncating revision to first 12 chars 2016-10-25 23:59:52,890 Setting DEBUG logging. 2016-10-25 23:59:52,890 attempt 1/10 2016-10-25 23:59:52,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 23:59:54,015 unpacking tar archive at: mozilla-central-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385466 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 23:59:54.426541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:54.426919) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:54.427370) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:54.427670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 23:59:54.452292) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-25 23:59:54.452741) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vx5hh5PAIL/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.48MXuz6olZ/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 23:59:54 INFO - MultiFileLogger online at 20161025 23:59:54 in /builds/slave/test 23:59:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:59:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:59:54 INFO - {'append_to_log': False, 23:59:54 INFO - 'base_work_dir': '/builds/slave/test', 23:59:54 INFO - 'blob_upload_branch': 'Firefox', 23:59:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:59:54 INFO - 'branch': 'Firefox', 23:59:54 INFO - 'buildbot_json_path': 'buildprops.json', 23:59:54 INFO - 'config_files': ('talos/mac_config.py',), 23:59:54 INFO - 'default_actions': ('clobber', 23:59:54 INFO - 'read-buildbot-config', 23:59:54 INFO - 'download-and-extract', 23:59:54 INFO - 'populate-webroot', 23:59:54 INFO - 'create-virtualenv', 23:59:54 INFO - 'install', 23:59:54 INFO - 'run-tests'), 23:59:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:59:54 INFO - 'download_minidump_stackwalk': True, 23:59:54 INFO - 'download_symbols': 'ondemand', 23:59:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:59:54 INFO - 'tooltool.py': '/tools/tooltool.py', 23:59:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:59:54 INFO - '/tools/misc-python/virtualenv.py')}, 23:59:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:59:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:59:54 INFO - 'installer_path': 'installer.exe', 23:59:54 INFO - 'log_level': 'info', 23:59:54 INFO - 'log_name': 'talos', 23:59:54 INFO - 'log_to_console': True, 23:59:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:59:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:59:54 INFO - 'opt_config_files': (), 23:59:54 INFO - 'pip_index': False, 23:59:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:59:54 INFO - 'cmd': ('bash', 23:59:54 INFO - '-c', 23:59:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:59:54 INFO - 'enabled': True, 23:59:54 INFO - 'halt_on_failure': False, 23:59:54 INFO - 'name': 'check_screen_resolution'},), 23:59:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:59:54 INFO - 'cmd': ('bash', 23:59:54 INFO - '-c', 23:59:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:59:54 INFO - 'enabled': True, 23:59:54 INFO - 'halt_on_failure': False, 23:59:54 INFO - 'name': 'check_screen_resolution'},), 23:59:54 INFO - 'run_cmd_checks_enabled': True, 23:59:54 INFO - 'sps_profile': False, 23:59:54 INFO - 'sps_profile_interval': 0, 23:59:54 INFO - 'suite': 'dromaeojs-e10s', 23:59:54 INFO - 'system_bits': '32', 23:59:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:59:54 INFO - 'title': 't-yosemite-r7-0080', 23:59:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:59:54 INFO - 'use_talos_json': True, 23:59:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:59:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:59:54 INFO - 'work_dir': 'build'} 23:59:54 INFO - [mozharness: 2016-10-26 06:59:54.656211Z] Running clobber step. 23:59:54 INFO - Running pre-action listener: _resource_record_pre_action 23:59:54 INFO - Running main action method: clobber 23:59:54 INFO - rmtree: /builds/slave/test/build 23:59:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:59:56 INFO - Running post-action listener: _resource_record_post_action 23:59:56 INFO - [mozharness: 2016-10-26 06:59:56.243810Z] Finished clobber step (success) 23:59:56 INFO - [mozharness: 2016-10-26 06:59:56.243975Z] Running read-buildbot-config step. 23:59:56 INFO - Running pre-action listener: _resource_record_pre_action 23:59:56 INFO - Running main action method: read_buildbot_config 23:59:56 INFO - Using buildbot properties: 23:59:56 INFO - { 23:59:56 INFO - "project": "", 23:59:56 INFO - "product": "firefox", 23:59:56 INFO - "script_repo_revision": "production", 23:59:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 23:59:56 INFO - "repository": "", 23:59:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 23:59:56 INFO - "buildid": "20161025220526", 23:59:56 INFO - "pgo_build": "False", 23:59:56 INFO - "basedir": "/builds/slave/test", 23:59:56 INFO - "buildnumber": 48, 23:59:56 INFO - "slavename": "t-yosemite-r7-0080", 23:59:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:59:56 INFO - "platform": "yosemite_r7", 23:59:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:59:56 INFO - "branch": "mozilla-central", 23:59:56 INFO - "repo_path": "mozilla-central", 23:59:56 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 23:59:56 INFO - "stage_platform": "macosx64", 23:59:56 INFO - "builduid": "de2c6007ba4a4f1b838428b27b94ca09", 23:59:56 INFO - "slavebuilddir": "test" 23:59:56 INFO - } 23:59:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 23:59:56 INFO - Running post-action listener: _resource_record_post_action 23:59:56 INFO - [mozharness: 2016-10-26 06:59:56.249735Z] Finished read-buildbot-config step (success) 23:59:56 INFO - [mozharness: 2016-10-26 06:59:56.249942Z] Running download-and-extract step. 23:59:56 INFO - Running pre-action listener: _resource_record_pre_action 23:59:56 INFO - Running main action method: download_and_extract 23:59:56 INFO - mkdir: /builds/slave/test/build/tests 23:59:56 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')]} 23:59:56 INFO - trying https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 23:59:56 INFO - Downloading https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 23:59:57 INFO - Downloaded 1199 bytes. 23:59:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 23:59:57 INFO - Using the following test package requirements: 23:59:57 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:59:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 23:59:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 23:59:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'jsshell-mac.zip'], 23:59:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 23:59:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 23:59:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 23:59:57 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 23:59:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 23:59:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 23:59:57 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 23:59:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 23:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 23:59:58 INFO - Http code: 200 23:59:58 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 23:59:58 INFO - x-amz-cf-id: gZKkKGENbtMiMc0GgzVFcgZOidMYQo6Dqv-gDfjkYVKe87VtUcUI0w== 23:59:58 INFO - x-amz-version-id: rM2FxZjjD_JXTn0HCtvXdDIXrJvVV.Qn 23:59:58 INFO - Expected file size: 16438203 23:59:58 INFO - Obtained file size: 16438203 00:00:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:00:06 INFO - Http code: 200 00:00:06 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 00:00:06 INFO - x-amz-cf-id: L7GYdOYWCCZtlbUZ7mN6dDaMpHTax8qFydOm81-8o48Xw02Ox-CYEA== 00:00:06 INFO - x-amz-version-id: rM2FxZjjD_JXTn0HCtvXdDIXrJvVV.Qn 00:00:06 INFO - Expected file size: 16438203 00:00:06 INFO - Obtained file size: 16438203 00:00:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:00:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:00:13 INFO - Fetch https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:00:13 INFO - Http code: 200 00:00:13 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 00:00:13 INFO - x-amz-cf-id: 8TxpttroIvAVC8FySpcBmsQ7EiNumDvG--1Hk4d2S_txZjMMHFna8g== 00:00:13 INFO - x-amz-version-id: XWd1RHFKjQ5Ib.WadZraEniDbWykf_i0 00:00:13 INFO - Expected file size: 14409028 00:00:13 INFO - Obtained file size: 14409028 00:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:00:14 INFO - trying https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:00:14 INFO - Downloading https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 00:00:17 INFO - Downloaded 111655175 bytes. 00:00:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:00:17 INFO - mkdir: /builds/slave/test/properties 00:00:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:00:17 INFO - Writing to file /builds/slave/test/properties/build_url 00:00:17 INFO - Contents: 00:00:17 INFO - build_url:https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:00:17 INFO - Running post-action listener: _resource_record_post_action 00:00:17 INFO - Running post-action listener: set_extra_try_arguments 00:00:17 INFO - [mozharness: 2016-10-26 07:00:17.834322Z] Finished download-and-extract step (success) 00:00:17 INFO - [mozharness: 2016-10-26 07:00:17.834448Z] Running populate-webroot step. 00:00:17 INFO - Running pre-action listener: _resource_record_pre_action 00:00:17 INFO - Running main action method: populate_webroot 00:00:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:00:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:00:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:00:17 INFO - '--tppagecycles', 00:00:17 INFO - '7'], 00:00:17 INFO - 'tests': ['tsvgm']}}, 00:00:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:00:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:00:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:00:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:00:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:00:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:00:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['damp', 'tps']}, 00:00:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'tests': ['damp', 'tps']}, 00:00:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['dromaeo_dom']}, 00:00:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:00:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['basic_compositor_video']}, 00:00:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:00:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['a11yr', 00:00:17 INFO - 'ts_paint', 00:00:17 INFO - 'tpaint', 00:00:17 INFO - 'sessionrestore', 00:00:17 INFO - 'sessionrestore_no_auto_restore', 00:00:17 INFO - 'tabpaint']}, 00:00:17 INFO - 'other-e10s': {'tests': ['a11yr', 00:00:17 INFO - 'ts_paint', 00:00:17 INFO - 'tpaint', 00:00:17 INFO - 'sessionrestore', 00:00:17 INFO - 'sessionrestore_no_auto_restore', 00:00:17 INFO - 'tabpaint']}, 00:00:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:00:17 INFO - 'ts_paint', 00:00:17 INFO - 'tpaint', 00:00:17 INFO - 'sessionrestore', 00:00:17 INFO - 'sessionrestore_no_auto_restore', 00:00:17 INFO - 'tabpaint']}, 00:00:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:00:17 INFO - 'ts_paint', 00:00:17 INFO - 'tpaint', 00:00:17 INFO - 'sessionrestore', 00:00:17 INFO - 'sessionrestore_no_auto_restore', 00:00:17 INFO - 'tabpaint']}, 00:00:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['a11yr', 00:00:17 INFO - 'ts_paint', 00:00:17 INFO - 'tpaint', 00:00:17 INFO - 'sessionrestore', 00:00:17 INFO - 'sessionrestore_no_auto_restore', 00:00:17 INFO - 'tabpaint']}, 00:00:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['a11yr', 00:00:17 INFO - 'ts_paint', 00:00:17 INFO - 'tpaint', 00:00:17 INFO - 'sessionrestore', 00:00:17 INFO - 'sessionrestore_no_auto_restore', 00:00:17 INFO - 'tabpaint']}, 00:00:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['tsvgx', 00:00:17 INFO - 'tsvgr_opacity', 00:00:17 INFO - 'tart', 00:00:17 INFO - 'tscrollx', 00:00:17 INFO - 'cart']}, 00:00:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:00:17 INFO - 'tsvgr_opacity', 00:00:17 INFO - 'tart', 00:00:17 INFO - 'tscrollx', 00:00:17 INFO - 'cart']}, 00:00:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'talos_options': ['--disable-e10s'], 00:00:17 INFO - 'tests': ['tp5o']}, 00:00:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'tests': ['tp5o']}, 00:00:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'talos_options': ['--disable-e10s', 00:00:17 INFO - '--xperf_path', 00:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:00:17 INFO - 'tests': ['tp5n']}, 00:00:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:00:17 INFO - 'talos_options': ['--xperf_path', 00:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:00:17 INFO - 'tests': ['tp5n']}}, 00:00:17 INFO - 'talos.zip': {'path': '', 00:00:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:00:17 INFO - Running post-action listener: _resource_record_post_action 00:00:17 INFO - [mozharness: 2016-10-26 07:00:17.853460Z] Finished populate-webroot step (success) 00:00:17 INFO - [mozharness: 2016-10-26 07:00:17.853568Z] Running create-virtualenv step. 00:00:17 INFO - Running pre-action listener: _resource_record_pre_action 00:00:17 INFO - Running main action method: create_virtualenv 00:00:17 INFO - Creating virtualenv /builds/slave/test/build/venv 00:00:17 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 00:00:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:00:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:00:17 INFO - Using real prefix '/tools/python27' 00:00:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:00:18 INFO - Installing distribute.............................................................................................................................................................................................done. 00:00:21 INFO - Installing pip.................done. 00:00:21 INFO - Return code: 0 00:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:00:21 INFO - Reading from file tmpfile_stdout 00:00:21 INFO - Output received: 00:00:21 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) 00:00:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00: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', 'pip>=1.5'] in /builds/slave/test/build 00:00: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 pip>=1.5 00:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:21 INFO - 'HOME': '/Users/cltbld', 00:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:21 INFO - 'LOGNAME': 'cltbld', 00:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:21 INFO - 'MOZ_NO_REMOTE': '1', 00:00:21 INFO - 'NO_EM_RESTART': '1', 00:00:21 INFO - 'PAGER': '/bin/cat', 00:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:21 INFO - 'PWD': '/builds/slave/test', 00:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:21 INFO - 'SHELL': '/bin/bash', 00:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:21 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:21 INFO - 'USER': 'cltbld', 00:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:21 INFO - 'XPC_FLAGS': '0x0', 00:00:21 INFO - 'XPC_SERVICE_NAME': '0', 00:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:22 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 00:00:22 INFO - Cleaning up... 00:00:22 INFO - Return code: 0 00:00:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:00:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:22 INFO - 'HOME': '/Users/cltbld', 00:00:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:22 INFO - 'LOGNAME': 'cltbld', 00:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:22 INFO - 'MOZ_NO_REMOTE': '1', 00:00:22 INFO - 'NO_EM_RESTART': '1', 00:00:22 INFO - 'PAGER': '/bin/cat', 00:00:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:22 INFO - 'PWD': '/builds/slave/test', 00:00:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:22 INFO - 'SHELL': '/bin/bash', 00:00:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:22 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:22 INFO - 'USER': 'cltbld', 00:00:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:22 INFO - 'XPC_FLAGS': '0x0', 00:00:22 INFO - 'XPC_SERVICE_NAME': '0', 00:00:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:22 INFO - Downloading/unpacking psutil>=3.1.1 00:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:00:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:00:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:00:25 INFO - Installing collected packages: psutil 00:00:25 INFO - Running setup.py install for psutil 00:00:25 INFO - building 'psutil._psutil_osx' extension 00:00:25 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 00:00:26 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 00:00:26 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 00:00:26 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 00:00:26 INFO - building 'psutil._psutil_posix' extension 00:00:26 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 00:00:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:00:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:00:26 INFO - ^ 00:00:26 INFO - 1 warning generated. 00:00:26 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 00:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:00:26 INFO - Successfully installed psutil 00:00:26 INFO - Cleaning up... 00:00:26 INFO - Return code: 0 00:00:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:26 INFO - 'HOME': '/Users/cltbld', 00:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:26 INFO - 'LOGNAME': 'cltbld', 00:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:26 INFO - 'MOZ_NO_REMOTE': '1', 00:00:26 INFO - 'NO_EM_RESTART': '1', 00:00:26 INFO - 'PAGER': '/bin/cat', 00:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:26 INFO - 'PWD': '/builds/slave/test', 00:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:26 INFO - 'SHELL': '/bin/bash', 00:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:26 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:26 INFO - 'USER': 'cltbld', 00:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:26 INFO - 'XPC_FLAGS': '0x0', 00:00:26 INFO - 'XPC_SERVICE_NAME': '0', 00:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:00:29 INFO - Installing collected packages: mozsystemmonitor 00:00:29 INFO - Running setup.py install for mozsystemmonitor 00:00:29 INFO - Successfully installed mozsystemmonitor 00:00:29 INFO - Cleaning up... 00:00:29 INFO - Return code: 0 00:00:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:00:29 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')]} 00:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:29 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')]} 00:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:29 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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:29 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 00:00:29 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 00:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:29 INFO - 'HOME': '/Users/cltbld', 00:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:29 INFO - 'LOGNAME': 'cltbld', 00:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:29 INFO - 'MOZ_NO_REMOTE': '1', 00:00:29 INFO - 'NO_EM_RESTART': '1', 00:00:29 INFO - 'PAGER': '/bin/cat', 00:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:29 INFO - 'PWD': '/builds/slave/test', 00:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:29 INFO - 'SHELL': '/bin/bash', 00:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:29 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:29 INFO - 'USER': 'cltbld', 00:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:29 INFO - 'XPC_FLAGS': '0x0', 00:00:29 INFO - 'XPC_SERVICE_NAME': '0', 00:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:30 INFO - Downloading/unpacking jsonschema==2.5.1 00:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:00:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00: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 00:00:33 INFO - Downloading functools32-3.2.3-2.tar.gz 00:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:00:33 INFO - warning: no files found matching '*.txt' 00:00:33 INFO - no previously-included directories found matching 'build' 00:00:33 INFO - no previously-included directories found matching 'dist' 00:00:33 INFO - no previously-included directories found matching '.git*' 00:00:33 INFO - Installing collected packages: jsonschema, functools32 00:00:33 INFO - Running setup.py install for functools32 00:00:33 INFO - warning: no files found matching '*.txt' 00:00:33 INFO - no previously-included directories found matching 'build' 00:00:33 INFO - no previously-included directories found matching 'dist' 00:00:33 INFO - no previously-included directories found matching '.git*' 00:00:33 INFO - Successfully installed jsonschema functools32 00:00:33 INFO - Cleaning up... 00:00:33 INFO - Return code: 0 00:00:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:33 INFO - 'HOME': '/Users/cltbld', 00:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:33 INFO - 'LOGNAME': 'cltbld', 00:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:33 INFO - 'MOZ_NO_REMOTE': '1', 00:00:33 INFO - 'NO_EM_RESTART': '1', 00:00:33 INFO - 'PAGER': '/bin/cat', 00:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:33 INFO - 'PWD': '/builds/slave/test', 00:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:33 INFO - 'SHELL': '/bin/bash', 00:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:33 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:33 INFO - 'USER': 'cltbld', 00:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:33 INFO - 'XPC_FLAGS': '0x0', 00:00:33 INFO - 'XPC_SERVICE_NAME': '0', 00:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:00:33 INFO - Cleaning up... 00:00:33 INFO - Return code: 0 00:00:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:33 INFO - 'HOME': '/Users/cltbld', 00:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:33 INFO - 'LOGNAME': 'cltbld', 00:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:33 INFO - 'MOZ_NO_REMOTE': '1', 00:00:33 INFO - 'NO_EM_RESTART': '1', 00:00:33 INFO - 'PAGER': '/bin/cat', 00:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:33 INFO - 'PWD': '/builds/slave/test', 00:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:33 INFO - 'SHELL': '/bin/bash', 00:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:33 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:33 INFO - 'USER': 'cltbld', 00:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:33 INFO - 'XPC_FLAGS': '0x0', 00:00:33 INFO - 'XPC_SERVICE_NAME': '0', 00:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:34 INFO - Downloading/unpacking blobuploader==1.2.4 00:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:36 INFO - Downloading blobuploader-1.2.4.tar.gz 00:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:00:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:00:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:00:37 INFO - Downloading docopt-0.6.1.tar.gz 00:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:00:37 INFO - Installing collected packages: blobuploader, requests, docopt 00:00:37 INFO - Running setup.py install for blobuploader 00:00:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:00:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:00:38 INFO - Running setup.py install for requests 00:00:38 INFO - Running setup.py install for docopt 00:00:38 INFO - Successfully installed blobuploader requests docopt 00:00:38 INFO - Cleaning up... 00:00:38 INFO - Return code: 0 00:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:38 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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:38 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 00:00:38 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 00:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:38 INFO - 'HOME': '/Users/cltbld', 00:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:38 INFO - 'LOGNAME': 'cltbld', 00:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:38 INFO - 'MOZ_NO_REMOTE': '1', 00:00:38 INFO - 'NO_EM_RESTART': '1', 00:00:38 INFO - 'PAGER': '/bin/cat', 00:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:38 INFO - 'PWD': '/builds/slave/test', 00:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:38 INFO - 'SHELL': '/bin/bash', 00:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:38 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:38 INFO - 'USER': 'cltbld', 00:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:38 INFO - 'XPC_FLAGS': '0x0', 00:00:38 INFO - 'XPC_SERVICE_NAME': '0', 00:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-GQnzCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-oMhQ_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-EdKjOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-mjMeRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Nr8hAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-5hA_uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-D3iVUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-gvwDwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Da7ZRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:00:39 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-OANdZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-lRdLQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-WC8p67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-a1QS6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-gEE5ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-McahZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-KI60Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:00:40 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-RFCWPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:00:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:00:40 INFO - Running setup.py install for manifestparser 00:00:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:00:40 INFO - Running setup.py install for mozcrash 00:00:41 INFO - Running setup.py install for mozdebug 00:00:41 INFO - Running setup.py install for mozdevice 00:00:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Running setup.py install for mozfile 00:00:41 INFO - Running setup.py install for mozhttpd 00:00:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Running setup.py install for mozinfo 00:00:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Running setup.py install for mozInstall 00:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Running setup.py install for mozleak 00:00:42 INFO - Running setup.py install for mozlog 00:00:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Running setup.py install for moznetwork 00:00:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Running setup.py install for mozprocess 00:00:42 INFO - Running setup.py install for mozprofile 00:00:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Running setup.py install for mozrunner 00:00:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:00:42 INFO - Running setup.py install for mozscreenshot 00:00:43 INFO - Running setup.py install for moztest 00:00:43 INFO - Running setup.py install for mozversion 00:00:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:00:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:00:43 INFO - Cleaning up... 00:00:43 INFO - Return code: 0 00:00:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:00: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')]} 00:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00: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')]} 00:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:43 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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:43 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 00:00:43 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 00:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:43 INFO - 'HOME': '/Users/cltbld', 00:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:43 INFO - 'LOGNAME': 'cltbld', 00:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:43 INFO - 'MOZ_NO_REMOTE': '1', 00:00:43 INFO - 'NO_EM_RESTART': '1', 00:00:43 INFO - 'PAGER': '/bin/cat', 00:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:43 INFO - 'PWD': '/builds/slave/test', 00:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:43 INFO - 'SHELL': '/bin/bash', 00:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:43 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:43 INFO - 'USER': 'cltbld', 00:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:43 INFO - 'XPC_FLAGS': '0x0', 00:00:43 INFO - 'XPC_SERVICE_NAME': '0', 00:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:00:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-fzSkSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:00:43 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)) 00:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:00:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-YZVbSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:00:43 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-T9Lkhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-eSqpfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-29TvV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Vvcd3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ZNbo8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-WnSWpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-KWaJIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-gXRIoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-WJN2nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:00:44 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-6fQ0cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:00:44 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)) 00:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:00:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-z2T8Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:00:45 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)) 00:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:00:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-KXmGS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-btm6QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:00:45 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)) 00:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:00:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-nFrqwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:00:45 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-XtBoEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:00:45 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)) 00:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:00:45 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)) 00:00:45 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)) 00:00:45 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)) 00:00:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:00:45 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 00:00:45 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 00:00:45 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 00:00:45 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 00:00:45 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 00:00:45 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 00:00:48 INFO - Downloading blessings-1.6.tar.gz 00:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:00:48 INFO - Installing collected packages: blessings 00:00:48 INFO - Running setup.py install for blessings 00:00:48 INFO - Successfully installed blessings 00:00:48 INFO - Cleaning up... 00:00:48 INFO - Return code: 0 00:00:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:00:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:00:48 INFO - Reading from file tmpfile_stdout 00:00:48 INFO - Current package versions: 00:00:48 INFO - blessings == 1.6 00:00:48 INFO - blobuploader == 1.2.4 00:00:48 INFO - docopt == 0.6.1 00:00:48 INFO - functools32 == 3.2.3-2 00:00:48 INFO - jsonschema == 2.5.1 00:00:48 INFO - manifestparser == 1.1 00:00:48 INFO - mozInstall == 1.12 00:00:48 INFO - mozcrash == 0.17 00:00:48 INFO - mozdebug == 0.1 00:00:48 INFO - mozdevice == 0.48 00:00:48 INFO - mozfile == 1.2 00:00:48 INFO - mozhttpd == 0.7 00:00:48 INFO - mozinfo == 0.9 00:00:48 INFO - mozleak == 0.1 00:00:48 INFO - mozlog == 3.4 00:00:48 INFO - moznetwork == 0.27 00:00:48 INFO - mozprocess == 0.23 00:00:48 INFO - mozprofile == 0.28 00:00:48 INFO - mozrunner == 6.12 00:00:48 INFO - mozscreenshot == 0.1 00:00:48 INFO - mozsystemmonitor == 0.3 00:00:48 INFO - moztest == 0.7 00:00:48 INFO - mozversion == 1.4 00:00:48 INFO - psutil == 3.1.1 00:00:48 INFO - requests == 1.2.3 00:00:48 INFO - wsgiref == 0.1.2 00:00:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:00:48 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')]} 00:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:48 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')]} 00:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:48 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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:48 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 00:00:48 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 00:00:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:48 INFO - 'HOME': '/Users/cltbld', 00:00:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:48 INFO - 'LOGNAME': 'cltbld', 00:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:48 INFO - 'MOZ_NO_REMOTE': '1', 00:00:48 INFO - 'NO_EM_RESTART': '1', 00:00:48 INFO - 'PAGER': '/bin/cat', 00:00:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:48 INFO - 'PWD': '/builds/slave/test', 00:00:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:48 INFO - 'SHELL': '/bin/bash', 00:00:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:48 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:48 INFO - 'USER': 'cltbld', 00:00:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:48 INFO - 'XPC_FLAGS': '0x0', 00:00:48 INFO - 'XPC_SERVICE_NAME': '0', 00:00:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 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)) 00:00:48 INFO - Cleaning up... 00:00:48 INFO - Return code: 0 00:00:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:00:48 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')]} 00:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:48 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')]} 00:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:00:48 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 0x10184c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90b2d87510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, '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.vx5hh5PAIL/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.48MXuz6olZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 00:00:48 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 00:00:48 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 00:00:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:00:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:48 INFO - 'HOME': '/Users/cltbld', 00:00:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:48 INFO - 'LOGNAME': 'cltbld', 00:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:48 INFO - 'MOZ_NO_REMOTE': '1', 00:00:48 INFO - 'NO_EM_RESTART': '1', 00:00:48 INFO - 'PAGER': '/bin/cat', 00:00:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:48 INFO - 'PWD': '/builds/slave/test', 00:00:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:48 INFO - 'SHELL': '/bin/bash', 00:00:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:00:48 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:00:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:48 INFO - 'USER': 'cltbld', 00:00:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:48 INFO - 'XPC_FLAGS': '0x0', 00:00:48 INFO - 'XPC_SERVICE_NAME': '0', 00:00:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:00:49 INFO - Cleaning up... 00:00:49 INFO - Return code: 0 00:00:49 INFO - Running post-action listener: _resource_record_post_action 00:00:49 INFO - Running post-action listener: _start_resource_monitoring 00:00:49 INFO - Starting resource monitoring. 00:00:49 INFO - [mozharness: 2016-10-26 07:00:49.273671Z] Finished create-virtualenv step (success) 00:00:49 INFO - [mozharness: 2016-10-26 07:00:49.274708Z] Running install step. 00:00:49 INFO - Running pre-action listener: _resource_record_pre_action 00:00:49 INFO - Running main action method: install 00:00:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:00:49 INFO - Reading from file tmpfile_stdout 00:00:49 INFO - Detecting whether we're running mozinstall >=1.0... 00:00:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:00:49 INFO - Reading from file tmpfile_stdout 00:00:49 INFO - Output received: 00:00:49 INFO - Usage: mozinstall [options] installer 00:00:49 INFO - Options: 00:00:49 INFO - -h, --help show this help message and exit 00:00:49 INFO - -d DEST, --destination=DEST 00:00:49 INFO - Directory to install application into. [default: 00:00:49 INFO - "/builds/slave/test"] 00:00:49 INFO - --app=APP Application being installed. [default: firefox] 00:00:49 INFO - mkdir: /builds/slave/test/build/application 00:00:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:01:23 INFO - Reading from file tmpfile_stdout 00:01:23 INFO - Output received: 00:01:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:01:23 INFO - Running post-action listener: _resource_record_post_action 00:01:23 INFO - [mozharness: 2016-10-26 07:01:23.961703Z] Finished install step (success) 00:01:23 INFO - [mozharness: 2016-10-26 07:01:23.961854Z] Running run-tests step. 00:01:23 INFO - Running pre-action listener: _resource_record_pre_action 00:01:23 INFO - Running main action method: run_tests 00:01:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:01:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:01:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:01:23 INFO - 2016-10-26 00:01:23.976 screenresolution[2220:18366] starting screenresolution argv=screenresolution get 00:01:23 INFO - 2016-10-26 00:01:23.979 screenresolution[2220:18366] Display 0: 1600x1200x32@60 00:01:23 INFO - 2016-10-26 00:01:23.985 screenresolution[2221:18368] starting screenresolution argv=screenresolution list 00:01:23 INFO - Available Modes on Display 0 00:01:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:01:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:01:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:01:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:01:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:01:24 INFO - Intel Iris: 00:01:24 INFO - Chipset Model: Intel Iris 00:01:24 INFO - Type: GPU 00:01:24 INFO - Bus: Built-In 00:01:24 INFO - VRAM (Dynamic, Max): 1536 MB 00:01:24 INFO - Vendor: Intel (0x8086) 00:01:24 INFO - Device ID: 0x0a2e 00:01:24 INFO - Revision ID: 0x0009 00:01:24 INFO - Displays: 00:01:24 INFO - Display: 00:01:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:01:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:01:24 INFO - Display Serial Number: 1600x1200 60 00:01:24 INFO - Main Display: Yes 00:01:24 INFO - Mirror: Off 00:01:24 INFO - Online: Yes 00:01:24 INFO - Rotation: Supported 00:01:24 INFO - Return code: 0 00:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:01:24 INFO - Python 2.7.3 00:01:24 INFO - Return code: 0 00:01:24 INFO - grabbing minidump binary from tooltool 00:01: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')]} 00:01:24 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 0x101660d30>, '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 0x101486db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101658b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:01:24 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 00:01:24 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 00:01:24 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 00:01:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:01:24 INFO - Return code: 0 00:01:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:01:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:01:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:01:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:01:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--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 00:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --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 00:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vx5hh5PAIL/Render', 00:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:01:24 INFO - 'HOME': '/Users/cltbld', 00:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:01:24 INFO - 'LOGNAME': 'cltbld', 00:01:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:01:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:24 INFO - 'MOZ_NO_REMOTE': '1', 00:01:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:01:24 INFO - 'NO_EM_RESTART': '1', 00:01:24 INFO - 'PAGER': '/bin/cat', 00:01:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:24 INFO - 'PWD': '/builds/slave/test', 00:01:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:01:24 INFO - 'SHELL': '/bin/bash', 00:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.48MXuz6olZ/Listeners', 00:01:24 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 00:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:01:24 INFO - 'USER': 'cltbld', 00:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:24 INFO - 'XPC_FLAGS': '0x0', 00:01:24 INFO - 'XPC_SERVICE_NAME': '0', 00:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:01:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--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 00:01:24 INFO - mozversion application_buildid: 20161025220526 00:01:24 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 00:01:24 INFO - mozversion application_display_name: Nightly 00:01:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:01:24 INFO - mozversion application_name: Firefox 00:01:24 INFO - mozversion application_remotingname: firefox 00:01:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:01:24 INFO - mozversion application_vendor: Mozilla 00:01:24 INFO - mozversion application_version: 52.0a1 00:01:24 INFO - mozversion platform_buildid: 20161025220526 00:01:24 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 00:01:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:01:24 INFO - mozversion platform_version: 52.0a1 00:01:24 INFO - using testdate: 1477465284 00:01:24 INFO - actual date: 1477465284 00:01:24 INFO - starting webserver on 'localhost:51715' 00:01:24 INFO - SUITE-START | Running 2 tests 00:01:24 INFO - TEST-START | dromaeo_css 00:01:24 INFO - operating with platform_type : mac_ 00:01:24 INFO - Initialising browser for dromaeo_css test... 00:01:24 INFO - TEST-INFO | started process 2231 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmp9yBpQQ/profile http://localhost:51715/getInfo.html) 00:01:27 INFO - PROCESS | 2231 | 2016-10-26 00:01:27.191 plugin-container[2233:18525] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3b, name = 'com.apple.tsm.portname' 00:01:27 INFO - PROCESS | 2231 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:01:27 INFO - PROCESS | 2231 | 2016-10-26 00:01:27.195 plugin-container[2233:18525] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 00:01:27 INFO - PROCESS | 2231 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:01:27 INFO - PROCESS | 2231 | 2016-10-26 00:01:27.195 plugin-container[2233:18525] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:01:27 INFO - PROCESS | 2231 | __metrics Screen width/height:1600/1200 00:01:27 INFO - PROCESS | 2231 | colorDepth:24 00:01:27 INFO - PROCESS | 2231 | Browser inner width/height: 1024/689 00:01:27 INFO - PROCESS | 2231 | __metrics 00:01:27 ERROR - PROCESS | 2231 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 00:01:28 INFO - TEST-INFO | 2231: exit 0 00:01:28 INFO - Browser initialized. 00:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 00:01:28 INFO - TEST-INFO | started process 2234 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmp9yBpQQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:01:30 INFO - PROCESS | 2234 | 2016-10-26 00:01:30.515 plugin-container[2235:18643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 00:01:30 INFO - PROCESS | 2234 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:01:30 INFO - PROCESS | 2234 | 2016-10-26 00:01:30.516 plugin-container[2235:18643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 00:01:30 INFO - PROCESS | 2234 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:01:30 INFO - PROCESS | 2234 | 2016-10-26 00:01:30.516 plugin-container[2235:18643] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:01:40 INFO - PROCESS | 2234 | RSS: Main: 236670976 00:01:40 INFO - PROCESS | 2234 | 00:02:29 INFO - PROCESS | 2234 | 1477465349770 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:04:43 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51715/tests/dromaeo/cssquery-ext.html) 00:04:44 INFO - PROCESS | 2234 | RSS: Main: 245870592 00:04:44 INFO - PROCESS | 2234 | 00:07:46 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51715/tests/dromaeo/cssquery-ext.html (next: http://localhost:51715/tests/dromaeo/cssquery-jquery.html) 00:07:47 INFO - PROCESS | 2234 | RSS: Main: 259919872 00:07:47 INFO - PROCESS | 2234 | 00:10:49 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51715/tests/dromaeo/cssquery-mootools.html) 00:10:49 INFO - PROCESS | 2234 | RSS: Main: 262135808 00:10:49 INFO - PROCESS | 2234 | 00:13:51 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51715/tests/dromaeo/cssquery-prototype.html) 00:13:52 INFO - PROCESS | 2234 | RSS: Main: 267718656 00:13:52 INFO - PROCESS | 2234 | 00:16:55 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51715/tests/dromaeo/cssquery-yui.html) 00:16:55 INFO - PROCESS | 2234 | RSS: Main: 266989568 00:16:55 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51715/tests/dromaeo/cssquery-yui.html (next: http://localhost:51715/tests/dromaeo/cssquery-dojo.html) 00:19:58 INFO - PROCESS | 2234 | RSS: Main: 268226560 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | __start_tp_report 00:19:58 INFO - PROCESS | 2234 | _x_x_mozilla_page_load 00:19:58 INFO - PROCESS | 2234 | _x_x_mozilla_page_load_details 00:19:58 INFO - PROCESS | 2234 | |i|pagename|runs| 00:19:58 INFO - PROCESS | 2234 | |0;dojo.html;3367.680070393312;3371.123507887949;3407.8296085195734;3410.164509695125;3424.126847653848;5705.771769129235;5723.656580605167;5735.627184233022;5757.654540727559;5790.623609465392;5685.431456854312;5768.250127483421;5781.19063331134;5865.5014323782425;5888.558358123137;5154.350607805503;5202.453742357055;5240;5275.235090911816;5278.419373868891;5143.074246635604;5244.685318880879;5254.789808407659;5308.601854860882;5350.732463376835;3865.7487263328076;4252.978735106336;4752.928706069394;5159;5195.454477279907;4228.450301460821;5188.325517682677;5199.766010529535;5244.973775131138;5314.627976041678;4920.8031678732805;5226.320578324831;5235.685858848481;5242.816501422432;5287.841364759063;5524.06090964537;5677.744501497443;5776.364599894008;5794.333651630074;5813.360530341659;6093.238345206849;6165.876682466371;6167.691615419211;6180.721867515973;6208.689565521706;6113.541484388688;6132.049587189136;6189.133521307021;6261.027776250467;6264.373562643745;5893.057110862242;5944.108383742473;5949.524038076944;5959.642421454727;6009;6286.872236142003;6316.021016742412;6320.083587879732;6349.682515874188;6359.554831161774;6043.969780151071;6145.170401995673;6168.8766224675255;6179.814605561751;6197.163382943335;5351.117065684119;6029.673471836189;6158.692065396713;6193.81418557444;6239.0953311770445;6159.722812473449;6169.2288463942;6232.158658581034;6236.126942228092;6255.624662520263;6255.186825712628;6257.311695713468;6261.624302541862;6279.717412716439;6290.370962903765;4827.662063655511;4883.877903052381;4886.951130488721;4925.2119660854805;4928.482509336468;4425.336199570091;4462.776861156929;4465.665075119379;4471.35165401015;4528.796204170821;5853.239078919798;5953.791617293374;5970.552208584373;5985.132155837379;5991.4308140727435;6147.569670123048;6202.069689546604;6220.098085777628;6234.3453937336835;6265;5942.61373010753;5977.252843394575;5978.790742324085;5985.25184351956;6023.156758053876;5395.2986111806;5398.757055932492;5417.160340147283;5423.132298832168;5443.42844001382;6201.875962480815;6206.162168107428;6209.130721698875;6339.841503962438;6341.904871427025;6185.072239164161;6254.186955695731;6259.812205633838;6260.436560709376;6263.185785847811;6298.433141017331;6305.621662700252;6307.30619631831;6317.115603815561;6334.113224148531;6076.939230607637;6130.948521379913;6227.750889964351;6268.843278918063;6277.843053923689;4567.748773817472;6119.441623354662;6200.689965501617;6202.472789812917;6248.5313601479165;5100.770465328995;6064.787732429344;6141.201643786279;6176.413240742122;6180.567360284737;6073.5748497604745;6162.722677479614;6169.691515424301;6199.380061993945;6201.534884883742;5862.032764593794;5921.940780592139;5944.64332140073;6046.27444706638;6059.909216341101;6123.357047509948;6191.473724733448;6203.658798766111;6210.7515699371515;6237.220347456568;5864.530837533072;5924.9927512323875;5935.673537955281;6052.757889684363;6070.18052562916 00:19:58 INFO - PROCESS | 2234 | |1;ext.html;469.6501106675526;476.63681869852195;524.908141075312;525.6478159633044;527.833732374302;26444.867775661118;31450.99999999997;35239.471407928904;40708.18583628326;40708.18583628329;32455.67544324556;33069.66930330696;34785.65214347856;39181.21637567247;42142.367864482054;8032.959835200845;8615.439996400246;9034.006259311454;9572.569234384435;9611.086946740083;7977.481463704869;9522.666706665234;9600.471974041426;9610.90389096107;9648.951755241214;9593.80812383752;9643.180329671986;9650.179734722557;9658.517074146264;9690.70927872165;9539;9578.233741300679;9618.470984095871;9626.518674066268;9630.27772917034;9396.389234699722;9474;9491.525423728855;9516.904830951671;9517.095875891779;40004;40129;40238.396424053666;40341.59658403408;40552;3403.7617366784334;3431.365197438457;3462.9134271643156;3846.442265871461;4075.9796201018803;30159.341236231998;30633;30830.84584577085;31665;31890.043298700843;3185.2036990752313;3189.984050079758;3193.9041828745176;3201.807891526516;3237.0308408855644;493278;495617.52191238815;495676.0432395702;497239.5138024323;497769.5111524455;57067.71466142643;57138.714306429036;57508.71245643745;57704.42295576991;57762;60415;60563;61071.38928610657;61120;61196.38803611996;16018.279177437043;16212.918935405247;16265.837341626433;16287.02277863332;16324.265408056666;12485.750284994248;12635.557755478514;12642.55751048709;12650.367481626066;12677.619671409873;15417.612414882715;15702.528924132293;15736.134512601917;15741.560058190998;15760.054396736003;6304.329352721533;6377.840553986188;6403.583767055126;6407.775727849503;6414.294427613052;670.2974444909986;924.8196601662611;979.1872745621117;1064.3454275620438;1069.8234791259356;26479.86760066226;28119.500879859534;28679.283017924718;29333.41333173367;30351.544726829114;1073.9624113156;1080.6757972608186;1096.4188979840696;1143.7598104398003;1150.6548035589458;14816.851831481546;15320.387184512718;15479;15483.30325135349;15734.134622595639;619843;623996;627463;628148;632651;55673.443265567636;55709;55729;55814.16278755822;55898.72050639721;1339.8191244182105;1385.300423286254;1406.9085509441854;1411.5553600615774;1414.731201071793;23046.193383232177;29153.562696559144;29299.363057324943;29435.822567097075;30213.244668882573;48429.75785121193;48785.756071220836;48922.510774891794;48956.75521622369;49081;564663;567477;567964;569882;570696;25211;26022;39244.41133382944;39353.40969885397;39477.802610987914;45225.773871130434;45951.77024114858;46967.530324696316;47309.7634511839;47357.52642473669;30686.772529098587;32750.672493274764;35609.46585801267;38394;38831.61168388393;31818.84090579532;33712.49431258582;37992.810035949646;38195;39123;26935;31834.52248216325;37997.620023799405;38249.61750382461;38323;28250.43499130047;29828.552571711876;30338;34310.82844585861;34608;24922.750772492767;25115;25311.709477767774;25572.702859667974;26113.563753993712 00:19:58 INFO - PROCESS | 2234 | |2;jquery.html;374.87066961898154;378.3719026416149;383.23162060069563;384.8479850459067;401.3177598083257;18765.343212987533;19859.404217873453;21348.679769803464;21435.356939291847;21527.784722152774;20181.899090504565;20282;20827;21010.36968890932;21129.837858917752;5174.818881339153;5294.055928333378;5912.17229587858;6014.819555413323;6031.517478601701;3855.132595166079;4093.1813637272517;5907.5864689471755;6028.6081404708775;6053.667048312341;5725.398833122525;5989.820305390824;6033.456988871001;6100.7864724734645;6107.633541987495;5563.221149039137;5876.588638795286;5918.7928422505;6050.2437195350585;6087.452129308362;5738.82783516491;5759.164921086419;5759.366469688331;5760.222369980041;5783.306003279633;12730.681732956658;12901;12955.287459189742;13182;13288;2091.8012788785195;2136.5406437615834;2165.675148727688;2449.742777008424;2606.687197536308;9261.72214833556;10268.589256429734;10318;12360.072994525357;15453.459128930546;1837.8897266164072;1849.280169442418;1895.3745264062827;1932.294712429967;1969.8325642320276;120303;134259.32870335685;135135;140185.299073505;154667;20962.580748384946;21085.367438976547;21456.78543214548;21533.13867445316;21600.463323547483;35864.82067589645;36245.45631815525;36261.91214263576;36282.455763163576;36395.454068189;8705;10612.840807387742;11022.118230541537;11029.227954043301;11068.944655276671;8917.821643567093;8922.86615700765;9029.097090290918;9173.44959302444;9185.265178785681;10017.549210285555;10055.64805231828;10106.797864042677;10218.927012663711;10230.386176829414;1612.9758053629205;3345.9330813383594;3855.0747820522874;3909.257241124177;3960.7029472789654;790.8971833661587;797.0594698256114;868.7779223542055;967.8112768010311;1043.6712435582767;19535.925524096026;20997.47506312324;21196.894015529822;21271.956028199333;21278;798.2655956520016;890.528020149322;932.4032619123766;960.8606752020918;1027.342500799489;10912.56349746017;10930.289531180448;11012.229143960007;11143.442827858575;11190.888091119148;475963;475985;479203.60398197785;564598;583292;110770;139077;140872.59127408595;143331;146553;971.9416834990064;973.7127547373542;1012.9088382045651;1017.2675673515057;1017.6336518853207;17861.73207401864;18190.90904545469;18574.814251857308;18601.53496162607;18837.340693075676;55257.723711381186;56547.434525654215;57515.137272940105;57699.71150144222;58062.54843628943;81931;82066.58966705129;82475.5876220615;83147;84153;7753.612319383896;7937.404694647809;7969.840603187788;8124.675012999413;8145.533803915352;9516.333856630246;12684.87315126837;12743.681407964876;13179.538716144889;13451.865481345452;7572.4699271050495;10997.010269075501;11190.104791616814;11203.663890083311;11682.94158529236;9269.6292148316;11083.168762343017;11210.943945280222;11360.261582997078;11705.005074568757;11587.768244635228;11640;11673.540807399075;11826.586069487526;11951.22317049389;7147.499675022698;7237.674304656409;7368.778936631909;8202.876956845532;8370.455920365157;11253.381064041556;11438.256513326607;11510.769784604428;11682.299062056303;11726.003289720127 00:19:58 INFO - PROCESS | 2234 | |3;mootools.html;1298.4676282724079;1410.6473381654587;1438.9784153237704;1933.9903300483495;1941.5437372217527;7900.367970562355;8133.2680058794695;8434.831303373936;8946.971098323695;8953.865692014617;8410.453320534161;8751.693690720826;8768.254698350633;8907.554622268894;8908.777280567989;2321.651752237165;2346.800521955627;2347.225415612852;2348.5537747827857;2350.74141844397;2198.8131008864266;2352.7882490575844;2371.4308565944134;2379.583572874749;2380.666706661069;2311.05246848792;2325.8953347099423;2337.5091230841545;2342.320726989171;2360.4334959609655;2038.8980550972467;2316.1893337331885;2324.8721320327377;2349.953000939972;2359.1742889988536;2356.5404746074523;2364.869932153731;2371.8458300210605;2380.1193558383334;2381.7975472084895;7386.446016548781;7480.364169045638;8749.825003499895;8892.822143557092;8918.019017908025;5191.402988656315;5314.468553144693;5334.386545547273;5376;5379.623426360156;3368.79787212768;3439.0886415100017;3684.5946945835935;3699.6300369963055;3713.535808023997;1012.1346248957109;1022.560299071399;1069.5989004123453;1083.631565267805;1088.1675518228562;9957.302988790787;11784.939355457964;11827.763444731057;11842.348670823101;11903.642890713292;4506.211413002711;4617.630589552828;4683.227267500893;4717.952820471752;4732.006278681447;9767;9894.505274736235;9896.60413583463;9913.80172396548;9925.751856203507;4639.9536004640195;5307.761150748225;5344.652597581145;5359.981603495324;5402.243685883979;4368.847090351886;4399.274119770266;4851.611871050378;4870.8782280442565;4903.362562866804;3779.244151169777;3853.807309634507;3879.903002424962;3929.0766669832565;3942.7240093193773;1282.5254655777421;1286.1447137653543;1290.7289469211382;1291.9612411627666;1296.9157004794658;817.5626040068535;866.9869951950726;927.9025702301296;934.6261495401893;958.9020571445656;5706.885862282731;5729.598928075078;5902.61632993854;5997.580169388101;6026.698665066817;429.4524481286322;435.95858393453204;436.1843352930041;825.3191117328108;921.824853277875;3298.3568204200433;3858.2991905666145;3879.437481565157;3908.5700572936953;3916.7649941003633;10317.9484102579;10621.309614875008;10669.146468282519;10672.30630009047;10684.519196636014;10550.947245263724;10596.682099537025;10649;10700.250982431155;10705.250632455809;5986.5210783137245;7662.5785581792425;8140.918590814016;8224.424290299621;8278.875816862752;5083.491650834887;5457.5361094305845;5558.944410556004;5836.854078648068;6060.2424696912885;9592.328537002622;9610.135087842127;9746.707598772047;9785.510724463606;9927.851082233918;9849.113579777855;9921.305508614329;9924.553395097382;10002.44986525719;10085.596576136872;6810.489213308922;7100.289971002859;7404.592747398729;7498.437617178624;7626.8855967159425;8132.75601731949;8148.266656000988;8276.131006244257;8294.212049855254;8308.958455207685;7221.4222862169845;7297.890531641923;7330.413566914741;7448.99438575807;7458.067741532309;7117.82205444868;7213.350798428167;7221.566705997657;7245.5652660840515;7397.297256760599;6758.560693554903;6880.174379074543;6880.621565813928;6913.10129683138;6922.930770692228;4774.618030557477;4935.210366341368;4956.975215123901;4978.352814134139;4983.6511444200005;4931.7040977541465;4958.528939750718;5054.19132938728;5099.898002039864;5139.460356662496 00:19:58 INFO - PROCESS | 2234 | |4;prototype.html;273.68494384482557;294.24232601052296;307.701529516369;311.14125014958705;312.83888797269395;4991.801967527795;5337.386200586924;5353.08256999935;5574.581906357019;5648.011597970354;4743.932615161587;5334.986352593014;5348.144296912495;5490.972545137269;5546.835164615436;3682.208325210086;3840.7311488195837;3866.439366291886;4247.25673007224;4254.765987870666;3494.4059509883255;3890.688744900401;3925.5878132796074;4148.56440073791;4261.424707664472;4102.302608556538;4102.917941641165;4107.691923105764;4125.752454852718;4132.752034877902;3518.8416521256604;3586.856525738954;3882.990422490173;4122.113745544707;4129.504459464853;2955.689652586469;3432.9828350858334;3568.50040994261;3580.534530511043;3587.443946188345;4451.043025749447;4714.514927797767;4970.304157417964;5258.553897678131;5415.431379705114;4205.3481710334945;4293.29160688486;4367;4717.43390793107;4812.398450193726;4983.6760610560195;5323.9884421959705;5596.153269421122;5601.411851755548;5788.913166302509;3920.5099362579676;3921.156951255494;3923.6664883484937;3928.3910993796007;3937.625925537069;6065.5450841187085;6128.161551534522;6163.537734669918;6167.198264225667;6169.7532098716;3250.756193285513;3702.6667599916136;3959.8416063357718;3967.7420967637013;3972.7020473464604;3360.781549199294;4018.216447792711;4025.798710064485;4034.5677284564144;4063.695222858238;3721.7953012584026;4637.652176086807;4724.275639391666;4743.6717719038725;4786.95213047865;4860.708357498562;5344.26311448773;5936.406359364116;5944.940550594439;5970.522358211333;1164.7612239491054;1191.5233906437495;1297.8254679515053;1383.3429121167364;1414.2363123912971;808.3735105293445;872.7294538693026;902.3007169443733;904.5251243097294;919.5586118662945;4790.8323208687525;4814.518548145227;5518.972405138029;5554.50009499147;5576.470235327637;5952.821415357546;5981.970090149522;5983.679058122783;6034.547408944259;6042;4337.587929146726;4597.287420449836;5197.558207552401;5493.7802487900035;5506.449355064461;2425.987870060638;2447.889844956981;2701.6896805049537;2707.4161615454786;2716.2122984334715;4175.039740859619;4560.931586026212;4978.452370239271;5043;5256.031696069443;4492.865214043584;4664.836730714476;4808.762373338065;4884.3650325457465;5167.548236610337;4237.178013454182;4374.300111982131;4534.727916325031;5000.224965130411;5293.682379057192;4749.886300596201;5050.469700681376;5086.54221120101;5144.717040562805;5196.844094677014;4495.865124046284;4618.30725391194;5012.674176178537;5028.59771218309;5069.9746501267255;4276.978615106905;5179.896402072013;5227.973860130675;5228.503292187236;5259.947400525945;3350.564426624523;3464.411050121536;3759.8308076137187;3854.460375547482;3865.845366185321;4711.175544279668;5301.973490132525;5580.888382232414;5798.739056742541;6013.759449621966;4454.5990860821385;4945.208766597327;5712.457956209447;5719.8570035749435;5854.531637468907;4529.773511324354;4602.9643330251765;4787.95212047889;5357;5665.093585026376;5644.322681278273;5680.431956804452;5704.914426283692;5714.399988001366;5718.370979192368;4484.663650226311;5808.796692115756;5817.272840894888;5835.503982161564;5881.911771323348;4851.927221091757;4954.405471343318;5784.797532086357;5805.738741756547;5840.386759390372 00:19:58 INFO - PROCESS | 2234 | |5;yui.html;721.1130309719045;735.283098978496;782.8121250899782;806.7216810200479;826.8015676237701;15285.159316237603;15864.84135158651;15865.04809711418;15889.2849821758;15936.203189840506;14447.566573002801;14556.636084097903;14570;14573.708525829477;14580.854191458082;705.5555000349773;728.1771598094147;874.64576846377;880.8370451466499;900.522722956834;883.1786438612088;885.1060428966725;901.0898992018076;903.6249956268141;905.0044950554403;950.092661508258;952.8189643967625;956.0009789769673;957.750984743968;958.7507248115505;948.9240860731124;952.6094301336419;954.6181527389031;955.8566215067726;956.2445667922333;680.3672584496417;704.4118161335291;704.5420476690192;708.2598684374841;709.9964500177517;14568.635784105481;14692.191929443876;14697.485588004369;14745.189014604193;15309.540713778493;14161.29193540319;14424.567262982127;14488.365237117305;14499.492517761828;14582.197979111144;11489.310641361544;11637.185397022211;11763.7059073523;11766;12083.214591051641;3750.587435382106;3756.830942607562;3773.3019391412404;3808.5810560838286;3907.0427745202605;88473.55763221142;96433.03566964381;96742.51628741881;97037.51481242549;100672.48991265136;10883.564657413615;10938.070264027647;10944;11047.060999814945;11358.375289359165;22659.886700566392;22678.433039174153;22689.659655105188;22699.978500967496;22749.772502275096;7347.742829001067;7541.622918854145;7841.882371764428;8069.596520173968;8114.756557303291;4332.285172946428;4347.065380943112;4371.388005679208;4383.1452866691325;4457.955420445754;3384.4754063120254;3483.6168021517615;3483.773554718986;3492.5983511895947;3495.615482296945;600.3966014155745;611.2847967877594;622.6793201501231;664.1631544254178;678.9137380191654;427.3568279739035;478.7866772402841;554.1549137565245;557.9358373786986;625.3683779382856;9151.45091294511;9928.404295742279;9990.550425230882;10009.799804003878;10284.845727314096;602.734796689464;607.5807692692028;660.6531570925303;662.8508585568305;678.511471740356;3839.232153569297;3872.9612703873163;4519.412476378116;4526.977365113219;4548.567886050886;87436.5628171855;105478;110761.44619277013;110766.44616776865;114493.85506144832;64608;81961.21368469986;86717;95853;97748.04503909883;83687.32625347459;83801;86662.70005949916;86851.56574217089;88269;9568;9714.222862170867;9746.025397460196;9764.218862490841;9765.65820196318;51863.74068129786;54111.72944135254;56416.153757692846;58155.709221453624;58327.12509312279;43583.56416435795;54241;54311.72844135912;55052.449475504734;76439.61780191063;11348.886511134782;12179.634610961686;12591.370431478572;12767;12891.419886105336;14023.649408764863;14223.573292801233;14286.571402857931;14309.35607897668;14716.926415368283;11170.776584468103;12491;13235.735285294048;13548.525801596898;13705.177689338672;13345.532906348231;13378.732425351633;13891.861081389461;13912.860871391156;14049.36777844979;13124.475020999053;13125.278109704059;13391.86608133945;13628.727425451634;13962;10425.843612345669;10841.454552694426;11034.503447344729;11113.333200007703;11136.665900023012;9084.954575227082;9480.905190948002;9849.45827979468;10186.879443261087;10773 00:19:58 INFO - PROCESS | 2234 | __end_tp_report 00:19:58 INFO - PROCESS | 2234 | __start_cc_report 00:19:58 INFO - PROCESS | 2234 | _x_x_mozilla_cycle_collect,369 00:19:58 INFO - PROCESS | 2234 | __end_cc_report 00:19:58 INFO - PROCESS | 2234 | __startTimestamp1477466398744__endTimestamp 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | ------- Summary: start ------- 00:19:58 INFO - PROCESS | 2234 | Number of tests: 6 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | [#0] dojo.html Cycles:165 Average:5736.03 Median:6009.00 stddev:678.34 (11.3%) stddev-sans-first:654.48 00:19:58 INFO - PROCESS | 2234 | Values: 3367.7 3371.1 3407.8 3410.2 3424.1 5705.8 5723.7 5735.6 5757.7 5790.6 5685.4 5768.3 5781.2 5865.5 5888.6 5154.4 5202.5 5240.0 5275.2 5278.4 5143.1 5244.7 5254.8 5308.6 5350.7 3865.7 4253.0 4752.9 5159.0 5195.5 4228.5 5188.3 5199.8 5245.0 5314.6 4920.8 5226.3 5235.7 5242.8 5287.8 5524.1 5677.7 5776.4 5794.3 5813.4 6093.2 6165.9 6167.7 6180.7 6208.7 6113.5 6132.0 6189.1 6261.0 6264.4 5893.1 5944.1 5949.5 5959.6 6009.0 6286.9 6316.0 6320.1 6349.7 6359.6 6044.0 6145.2 6168.9 6179.8 6197.2 5351.1 6029.7 6158.7 6193.8 6239.1 6159.7 6169.2 6232.2 6236.1 6255.6 6255.2 6257.3 6261.6 6279.7 6290.4 4827.7 4883.9 4887.0 4925.2 4928.5 4425.3 4462.8 4465.7 4471.4 4528.8 5853.2 5953.8 5970.6 5985.1 5991.4 6147.6 6202.1 6220.1 6234.3 6265.0 5942.6 5977.3 5978.8 5985.3 6023.2 5395.3 5398.8 5417.2 5423.1 5443.4 6201.9 6206.2 6209.1 6339.8 6341.9 6185.1 6254.2 6259.8 6260.4 6263.2 6298.4 6305.6 6307.3 6317.1 6334.1 6076.9 6130.9 6227.8 6268.8 6277.8 4567.7 6119.4 6200.7 6202.5 6248.5 5100.8 6064.8 6141.2 6176.4 6180.6 6073.6 6162.7 6169.7 6199.4 6201.5 5862.0 5921.9 5944.6 6046.3 6059.9 6123.4 6191.5 6203.7 6210.8 6237.2 5864.5 5925.0 5935.7 6052.8 6070.2 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | [#1] ext.html Cycles:180 Average:68892.86 Median:39298.91 stddev:151323.25 (385.1%) stddev-sans-first:151660.55 00:19:58 INFO - PROCESS | 2234 | Values: 469.7 476.6 524.9 525.6 527.8 26444.9 31451.0 35239.5 40708.2 40708.2 32455.7 33069.7 34785.7 39181.2 42142.4 8033.0 8615.4 9034.0 9572.6 9611.1 7977.5 9522.7 9600.5 9610.9 9649.0 9593.8 9643.2 9650.2 9658.5 9690.7 9539.0 9578.2 9618.5 9626.5 9630.3 9396.4 9474.0 9491.5 9516.9 9517.1 40004.0 40129.0 40238.4 40341.6 40552.0 3403.8 3431.4 3462.9 3846.4 4076.0 30159.3 30633.0 30830.8 31665.0 31890.0 3185.2 3190.0 3193.9 3201.8 3237.0 493278.0 495617.5 495676.0 497239.5 497769.5 57067.7 57138.7 57508.7 57704.4 57762.0 60415.0 60563.0 61071.4 61120.0 61196.4 16018.3 16212.9 16265.8 16287.0 16324.3 12485.8 12635.6 12642.6 12650.4 12677.6 15417.6 15702.5 15736.1 15741.6 15760.1 6304.3 6377.8 6403.6 6407.8 6414.3 670.3 924.8 979.2 1064.3 1069.8 26479.9 28119.5 28679.3 29333.4 30351.5 1074.0 1080.7 1096.4 1143.8 1150.7 14816.9 15320.4 15479.0 15483.3 15734.1 619843.0 623996.0 627463.0 628148.0 632651.0 55673.4 55709.0 55729.0 55814.2 55898.7 1339.8 1385.3 1406.9 1411.6 1414.7 23046.2 29153.6 29299.4 29435.8 30213.2 48429.8 48785.8 48922.5 48956.8 49081.0 564663.0 567477.0 567964.0 569882.0 570696.0 25211.0 26022.0 39244.4 39353.4 39477.8 45225.8 45951.8 46967.5 47309.8 47357.5 30686.8 32750.7 35609.5 38394.0 38831.6 31818.8 33712.5 37992.8 38195.0 39123.0 26935.0 31834.5 37997.6 38249.6 38323.0 28250.4 29828.6 30338.0 34310.8 34608.0 24922.8 25115.0 25311.7 25572.7 26113.6 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | [#2] jquery.html Cycles:180 Average:34551.61 Median:21530.46 stddev:88140.35 (409.4%) stddev-sans-first:88350.25 00:19:58 INFO - PROCESS | 2234 | Values: 374.9 378.4 383.2 384.8 401.3 18765.3 19859.4 21348.7 21435.4 21527.8 20181.9 20282.0 20827.0 21010.4 21129.8 5174.8 5294.1 5912.2 6014.8 6031.5 3855.1 4093.2 5907.6 6028.6 6053.7 5725.4 5989.8 6033.5 6100.8 6107.6 5563.2 5876.6 5918.8 6050.2 6087.5 5738.8 5759.2 5759.4 5760.2 5783.3 12730.7 12901.0 12955.3 13182.0 13288.0 2091.8 2136.5 2165.7 2449.7 2606.7 9261.7 10268.6 10318.0 12360.1 15453.5 1837.9 1849.3 1895.4 1932.3 1969.8 120303.0 134259.3 135135.0 140185.3 154667.0 20962.6 21085.4 21456.8 21533.1 21600.5 35864.8 36245.5 36261.9 36282.5 36395.5 8705.0 10612.8 11022.1 11029.2 11068.9 8917.8 8922.9 9029.1 9173.4 9185.3 10017.5 10055.6 10106.8 10218.9 10230.4 1613.0 3345.9 3855.1 3909.3 3960.7 790.9 797.1 868.8 967.8 1043.7 19535.9 20997.5 21196.9 21272.0 21278.0 798.3 890.5 932.4 960.9 1027.3 10912.6 10930.3 11012.2 11143.4 11190.9 475963.0 475985.0 479203.6 564598.0 583292.0 110770.0 139077.0 140872.6 143331.0 146553.0 971.9 973.7 1012.9 1017.3 1017.6 17861.7 18190.9 18574.8 18601.5 18837.3 55257.7 56547.4 57515.1 57699.7 58062.5 81931.0 82066.6 82475.6 83147.0 84153.0 7753.6 7937.4 7969.8 8124.7 8145.5 9516.3 12684.9 12743.7 13179.5 13451.9 7572.5 10997.0 11190.1 11203.7 11682.9 9269.6 11083.2 11210.9 11360.3 11705.0 11587.8 11640.0 11673.5 11826.6 11951.2 7147.5 7237.7 7368.8 8202.9 8370.5 11253.4 11438.3 11510.8 11682.3 11726.0 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | [#3] mootools.html Cycles:180 Average:5612.89 Median:4981.00 stddev:3159.27 (63.4%) stddev-sans-first:3151.49 00:19:58 INFO - PROCESS | 2234 | Values: 1298.5 1410.6 1439.0 1934.0 1941.5 7900.4 8133.3 8434.8 8947.0 8953.9 8410.5 8751.7 8768.3 8907.6 8908.8 2321.7 2346.8 2347.2 2348.6 2350.7 2198.8 2352.8 2371.4 2379.6 2380.7 2311.1 2325.9 2337.5 2342.3 2360.4 2038.9 2316.2 2324.9 2350.0 2359.2 2356.5 2364.9 2371.8 2380.1 2381.8 7386.4 7480.4 8749.8 8892.8 8918.0 5191.4 5314.5 5334.4 5376.0 5379.6 3368.8 3439.1 3684.6 3699.6 3713.5 1012.1 1022.6 1069.6 1083.6 1088.2 9957.3 11784.9 11827.8 11842.3 11903.6 4506.2 4617.6 4683.2 4718.0 4732.0 9767.0 9894.5 9896.6 9913.8 9925.8 4640.0 5307.8 5344.7 5360.0 5402.2 4368.8 4399.3 4851.6 4870.9 4903.4 3779.2 3853.8 3879.9 3929.1 3942.7 1282.5 1286.1 1290.7 1292.0 1296.9 817.6 867.0 927.9 934.6 958.9 5706.9 5729.6 5902.6 5997.6 6026.7 429.5 436.0 436.2 825.3 921.8 3298.4 3858.3 3879.4 3908.6 3916.8 10317.9 10621.3 10669.1 10672.3 10684.5 10550.9 10596.7 10649.0 10700.3 10705.3 5986.5 7662.6 8140.9 8224.4 8278.9 5083.5 5457.5 5558.9 5836.9 6060.2 9592.3 9610.1 9746.7 9785.5 9927.9 9849.1 9921.3 9924.6 10002.4 10085.6 6810.5 7100.3 7404.6 7498.4 7626.9 8132.8 8148.3 8276.1 8294.2 8309.0 7221.4 7297.9 7330.4 7449.0 7458.1 7117.8 7213.4 7221.6 7245.6 7397.3 6758.6 6880.2 6880.6 6913.1 6922.9 4774.6 4935.2 4957.0 4978.4 4983.7 4931.7 4958.5 5054.2 5099.9 5139.5 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | [#4] prototype.html Cycles:180 Average:4430.39 Median:4789.39 stddev:1377.25 (28.8%) stddev-sans-first:1345.31 00:19:58 INFO - PROCESS | 2234 | Values: 273.7 294.2 307.7 311.1 312.8 4991.8 5337.4 5353.1 5574.6 5648.0 4743.9 5335.0 5348.1 5491.0 5546.8 3682.2 3840.7 3866.4 4247.3 4254.8 3494.4 3890.7 3925.6 4148.6 4261.4 4102.3 4102.9 4107.7 4125.8 4132.8 3518.8 3586.9 3883.0 4122.1 4129.5 2955.7 3433.0 3568.5 3580.5 3587.4 4451.0 4714.5 4970.3 5258.6 5415.4 4205.3 4293.3 4367.0 4717.4 4812.4 4983.7 5324.0 5596.2 5601.4 5788.9 3920.5 3921.2 3923.7 3928.4 3937.6 6065.5 6128.2 6163.5 6167.2 6169.8 3250.8 3702.7 3959.8 3967.7 3972.7 3360.8 4018.2 4025.8 4034.6 4063.7 3721.8 4637.7 4724.3 4743.7 4787.0 4860.7 5344.3 5936.4 5944.9 5970.5 1164.8 1191.5 1297.8 1383.3 1414.2 808.4 872.7 902.3 904.5 919.6 4790.8 4814.5 5519.0 5554.5 5576.5 5952.8 5982.0 5983.7 6034.5 6042.0 4337.6 4597.3 5197.6 5493.8 5506.4 2426.0 2447.9 2701.7 2707.4 2716.2 4175.0 4560.9 4978.5 5043.0 5256.0 4492.9 4664.8 4808.8 4884.4 5167.5 4237.2 4374.3 4534.7 5000.2 5293.7 4749.9 5050.5 5086.5 5144.7 5196.8 4495.9 4618.3 5012.7 5028.6 5070.0 4277.0 5179.9 5228.0 5228.5 5259.9 3350.6 3464.4 3759.8 3854.5 3865.8 4711.2 5302.0 5580.9 5798.7 6013.8 4454.6 4945.2 5712.5 5719.9 5854.5 4529.8 4603.0 4788.0 5357.0 5665.1 5644.3 5680.4 5704.9 5714.4 5718.4 4484.7 5808.8 5817.3 5835.5 5881.9 4851.9 4954.4 5784.8 5805.7 5840.4 00:19:58 INFO - PROCESS | 2234 | 00:19:58 INFO - PROCESS | 2234 | [#5] yui.html Cycles:180 Average:20223.39 Median:4377.27 stddev:29004.20 (662.6%) stddev-sans-first:29048.59 00:19:58 INFO - PROCESS | 2234 | Values: 721.1 735.3 782.8 806.7 826.8 15285.2 15864.8 15865.0 15889.3 15936.2 14447.6 14556.6 14570.0 14573.7 14580.9 705.6 728.2 874.6 880.8 900.5 883.2 885.1 901.1 903.6 905.0 950.1 952.8 956.0 957.8 958.8 948.9 952.6 954.6 955.9 956.2 680.4 704.4 704.5 708.3 710.0 14568.6 14692.2 14697.5 14745.2 15309.5 14161.3 14424.6 14488.4 14499.5 14582.2 11489.3 11637.2 11763.7 11766.0 12083.2 3750.6 3756.8 3773.3 3808.6 3907.0 88473.6 96433.0 96742.5 97037.5 100672.5 10883.6 10938.1 10944.0 11047.1 11358.4 22659.9 22678.4 22689.7 22700.0 22749.8 7347.7 7541.6 7841.9 8069.6 8114.8 4332.3 4347.1 4371.4 4383.1 4458.0 3384.5 3483.6 3483.8 3492.6 3495.6 600.4 611.3 622.7 664.2 678.9 427.4 478.8 554.2 557.9 625.4 9151.5 9928.4 9990.6 10009.8 10284.8 602.7 607.6 660.7 662.9 678.5 3839.2 3873.0 4519.4 4527.0 4548.6 87436.6 105478.0 110761.4 110766.4 114493.9 64608.0 81961.2 86717.0 95853.0 97748.0 83687.3 83801.0 86662.7 86851.6 88269.0 9568.0 9714.2 9746.0 9764.2 9765.7 51863.7 54111.7 56416.2 58155.7 58327.1 43583.6 54241.0 54311.7 55052.4 76439.6 11348.9 12179.6 12591.4 12767.0 12891.4 14023.6 14223.6 14286.6 14309.4 14716.9 11170.8 12491.0 13235.7 13548.5 13705.2 13345.5 13378.7 13891.9 13912.9 14049.4 13124.5 13125.3 13391.9 13628.7 13962.0 10425.8 10841.5 11034.5 11113.3 11136.7 9085.0 9480.9 9849.5 10186.9 10773.0 00:19:58 INFO - PROCESS | 2234 | -------- Summary: end -------- 00:19:58 INFO - PROCESS | 2234 | 00:19:59 INFO - TEST-INFO | 2234: exit 0 00:19:59 INFO - TEST-OK | dromaeo_css | took 1114830ms 00:19:59 INFO - TEST-START | kraken 00:19:59 INFO - operating with platform_type : mac_ 00:19:59 INFO - Initialising browser for kraken test... 00:19:59 INFO - TEST-INFO | started process 2239 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpLn3zCw/profile http://localhost:51715/getInfo.html) 00:20:02 INFO - PROCESS | 2239 | 2016-10-26 00:20:02.270 plugin-container[2240:20769] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 00:20:02 INFO - PROCESS | 2239 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:20:02 INFO - PROCESS | 2239 | 2016-10-26 00:20:02.273 plugin-container[2240:20769] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 00:20:02 INFO - PROCESS | 2239 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:20:02 INFO - PROCESS | 2239 | 2016-10-26 00:20:02.273 plugin-container[2240:20769] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:20:02 INFO - PROCESS | 2239 | __metrics Screen width/height:1600/1200 00:20:02 INFO - PROCESS | 2239 | colorDepth:24 00:20:02 INFO - PROCESS | 2239 | Browser inner width/height: 1024/689 00:20:02 INFO - PROCESS | 2239 | __metrics 00:20:02 ERROR - PROCESS | 2239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 00:20:03 INFO - TEST-INFO | 2239: exit 0 00:20:03 INFO - Browser initialized. 00:20:03 INFO - Running cycle 1/1 for kraken test... 00:20:03 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpLn3zCw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:20:05 INFO - PROCESS | 2241 | 2016-10-26 00:20:05.548 plugin-container[2242:20888] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 00:20:05 INFO - PROCESS | 2241 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:20:05 INFO - PROCESS | 2241 | 2016-10-26 00:20:05.549 plugin-container[2242:20888] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 00:20:05 INFO - PROCESS | 2241 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:20:05 INFO - PROCESS | 2241 | 2016-10-26 00:20:05.549 plugin-container[2242:20888] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:20:15 INFO - PROCESS | 2241 | RSS: Main: 236969984 00:20:15 INFO - PROCESS | 2241 | 00:20:17 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51715/tests/kraken/driver.html?testName=audio-beat-detection) 00:20:18 INFO - PROCESS | 2241 | RSS: Main: 249262080 00:20:18 INFO - PROCESS | 2241 | 00:20:21 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51715/tests/kraken/driver.html?testName=audio-dft) 00:20:21 INFO - PROCESS | 2241 | RSS: Main: 256880640 00:20:21 INFO - PROCESS | 2241 | 00:20:25 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51715/tests/kraken/driver.html?testName=audio-fft) 00:20:26 INFO - PROCESS | 2241 | RSS: Main: 259723264 00:20:26 INFO - PROCESS | 2241 | 00:20:27 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51715/tests/kraken/driver.html?testName=audio-oscillator) 00:20:28 INFO - PROCESS | 2241 | RSS: Main: 262193152 00:20:28 INFO - PROCESS | 2241 | 00:20:30 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:20:31 INFO - PROCESS | 2241 | RSS: Main: 262295552 00:20:31 INFO - PROCESS | 2241 | 00:20:34 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51715/tests/kraken/driver.html?testName=imaging-darkroom) 00:20:34 INFO - PROCESS | 2241 | RSS: Main: 263331840 00:20:34 INFO - PROCESS | 2241 | 00:20:37 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51715/tests/kraken/driver.html?testName=imaging-desaturate) 00:20:38 INFO - PROCESS | 2241 | RSS: Main: 263626752 00:20:38 INFO - PROCESS | 2241 | 00:20:41 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51715/tests/kraken/driver.html?testName=json-parse-financial) 00:20:42 INFO - PROCESS | 2241 | RSS: Main: 264110080 00:20:42 INFO - PROCESS | 2241 | 00:20:43 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:20:44 INFO - PROCESS | 2241 | RSS: Main: 263065600 00:20:44 INFO - PROCESS | 2241 | 00:20:46 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:20:47 INFO - PROCESS | 2241 | RSS: Main: 263057408 00:20:47 INFO - PROCESS | 2241 | 00:20:49 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:20:50 INFO - PROCESS | 2241 | RSS: Main: 263131136 00:20:50 INFO - PROCESS | 2241 | 00:20:53 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:20:54 INFO - PROCESS | 2241 | RSS: Main: 263512064 00:20:54 INFO - PROCESS | 2241 | 00:20:57 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:20:57 INFO - PROCESS | 2241 | RSS: Main: 263532544 00:20:57 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:51715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51715/tests/kraken/driver.html?testName=ai-astar) 00:20:59 INFO - PROCESS | 2241 | RSS: Main: 265236480 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | __start_tp_report 00:20:59 INFO - PROCESS | 2241 | _x_x_mozilla_page_load 00:20:59 INFO - PROCESS | 2241 | _x_x_mozilla_page_load_details 00:20:59 INFO - PROCESS | 2241 | |i|pagename|runs| 00:20:59 INFO - PROCESS | 2241 | |0;ai-astar;107;119;118;119;118;123;177;175;123;119 00:20:59 INFO - PROCESS | 2241 | |1;audio-beat-detection;162;116;115;152;121;116;118;114;143;119 00:20:59 INFO - PROCESS | 2241 | |2;audio-dft;195;199;223;281;204;196;198;194;198;231 00:20:59 INFO - PROCESS | 2241 | |3;audio-fft;81;59;58;84;59;59;51;70;111;81 00:20:59 INFO - PROCESS | 2241 | |4;audio-oscillator;84;56;74;76;85;104;125;86;69;84 00:20:59 INFO - PROCESS | 2241 | |5;imaging-gaussian-blur;92;89;92;88;91;87;127;111;137;135 00:20:59 INFO - PROCESS | 2241 | |6;imaging-darkroom;132;99;127;155;91;153;155;95;95;96 00:20:59 INFO - PROCESS | 2241 | |7;imaging-desaturate;116;82;119;145;117;92;149;90;88;89 00:20:59 INFO - PROCESS | 2241 | |8;json-parse-financial;57;55;55;56;56;57;67;74;57;53 00:20:59 INFO - PROCESS | 2241 | |9;json-stringify-tinderbox;74;68;75;75;70;94;105;105;108;95 00:20:59 INFO - PROCESS | 2241 | |10;stanford-crypto-aes;88;88;88;86;88;89;86;88;110;106 00:20:59 INFO - PROCESS | 2241 | |11;stanford-crypto-ccm;139;140;183;164;166;166;164;153;187;176 00:20:59 INFO - PROCESS | 2241 | |12;stanford-crypto-pbkdf2;204;174;239;206;173;172;184;189;173;174 00:20:59 INFO - PROCESS | 2241 | |13;stanford-crypto-sha256-iterative;69;69;82;71;73;68;70;70;71;68 00:20:59 INFO - PROCESS | 2241 | __end_tp_report 00:20:59 INFO - PROCESS | 2241 | __start_cc_report 00:20:59 INFO - PROCESS | 2241 | _x_x_mozilla_cycle_collect,963 00:20:59 INFO - PROCESS | 2241 | __end_cc_report 00:20:59 INFO - PROCESS | 2241 | __startTimestamp1477466459718__endTimestamp 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | ------- Summary: start ------- 00:20:59 INFO - PROCESS | 2241 | Number of tests: 14 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#0] ai-astar Cycles:10 Average:129.80 Median:121.00 stddev:24.75 (20.5%) stddev-sans-first:24.83 00:20:59 INFO - PROCESS | 2241 | Values: 107.0 119.0 118.0 119.0 118.0 123.0 177.0 175.0 123.0 119.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:120.00 stddev:17.76 (14.8%) stddev-sans-first:13.80 00:20:59 INFO - PROCESS | 2241 | Values: 162.0 116.0 115.0 152.0 121.0 116.0 118.0 114.0 143.0 119.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#2] audio-dft Cycles:10 Average:211.90 Median:201.50 stddev:27.36 (13.6%) stddev-sans-first:28.33 00:20:59 INFO - PROCESS | 2241 | Values: 195.0 199.0 223.0 281.0 204.0 196.0 198.0 194.0 198.0 231.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#3] audio-fft Cycles:10 Average:71.30 Median:64.50 stddev:18.17 (28.2%) stddev-sans-first:18.93 00:20:59 INFO - PROCESS | 2241 | Values: 81.0 59.0 58.0 84.0 59.0 59.0 51.0 70.0 111.0 81.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:80.00 stddev:19.03 (23.8%) stddev-sans-first:20.18 00:20:59 INFO - PROCESS | 2241 | Values: 84.0 56.0 74.0 76.0 85.0 104.0 125.0 86.0 69.0 84.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#5] imaging-gaussian-blur Cycles:10 Average:104.90 Median:88.50 stddev:20.67 (23.4%) stddev-sans-first:21.40 00:20:59 INFO - PROCESS | 2241 | Values: 92.0 89.0 92.0 88.0 91.0 87.0 127.0 111.0 137.0 135.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#6] imaging-darkroom Cycles:10 Average:119.80 Median:93.00 stddev:27.57 (29.6%) stddev-sans-first:28.88 00:20:59 INFO - PROCESS | 2241 | Values: 132.0 99.0 127.0 155.0 91.0 153.0 155.0 95.0 95.0 96.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#7] imaging-desaturate Cycles:10 Average:108.70 Median:85.00 stddev:24.33 (28.6%) stddev-sans-first:25.66 00:20:59 INFO - PROCESS | 2241 | Values: 116.0 82.0 119.0 145.0 117.0 92.0 149.0 90.0 88.0 89.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:6.55 (11.5%) stddev-sans-first:6.92 00:20:59 INFO - PROCESS | 2241 | Values: 57.0 55.0 55.0 56.0 56.0 57.0 67.0 74.0 57.0 53.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#9] json-stringify-tinderbox Cycles:10 Average:86.90 Median:74.50 stddev:16.02 (21.5%) stddev-sans-first:16.29 00:20:59 INFO - PROCESS | 2241 | Values: 74.0 68.0 75.0 75.0 70.0 94.0 105.0 105.0 108.0 95.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:88.00 stddev:8.69 (9.9%) stddev-sans-first:9.12 00:20:59 INFO - PROCESS | 2241 | Values: 88.0 88.0 88.0 86.0 88.0 89.0 86.0 88.0 110.0 106.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#11] stanford-crypto-ccm Cycles:10 Average:163.80 Median:166.00 stddev:16.21 (9.8%) stddev-sans-first:14.49 00:20:59 INFO - PROCESS | 2241 | Values: 139.0 140.0 183.0 164.0 166.0 166.0 164.0 153.0 187.0 176.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.80 Median:186.50 stddev:21.83 (11.7%) stddev-sans-first:22.45 00:20:59 INFO - PROCESS | 2241 | Values: 204.0 174.0 239.0 206.0 173.0 172.0 184.0 189.0 173.0 174.0 00:20:59 INFO - PROCESS | 2241 | 00:20:59 INFO - PROCESS | 2241 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:4.12 (5.8%) stddev-sans-first:4.30 00:20:59 INFO - PROCESS | 2241 | Values: 69.0 69.0 82.0 71.0 73.0 68.0 70.0 70.0 71.0 68.0 00:20:59 INFO - PROCESS | 2241 | -------- Summary: end -------- 00:20:59 INFO - PROCESS | 2241 | 00:21:00 INFO - TEST-INFO | 2241: exit 0 00:21:00 INFO - TEST-OK | kraken | took 61154ms 00:21:00 INFO - SUITE-END | took 1175s 00:21:00 INFO - Completed test suite (00:19:36) 00:21:00 INFO - javascript benchmark 00:21:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7300.301796163909, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.680070393312, 3371.123507887949, 3407.8296085195734, 3410.164509695125, 3424.126847653848, 5705.771769129235, 5723.656580605167, 5735.627184233022, 5757.654540727559, 5790.623609465392, 5685.431456854312, 5768.250127483421, 5781.19063331134, 5865.5014323782425, 5888.558358123137, 5154.350607805503, 5202.453742357055, 5240.0, 5275.235090911816, 5278.419373868891, 5143.074246635604, 5244.685318880879, 5254.789808407659, 5308.601854860882, 5350.732463376835, 3865.7487263328076, 4252.978735106336, 4752.928706069394, 5159.0, 5195.454477279907, 4228.450301460821, 5188.325517682677, 5199.766010529535, 5244.973775131138, 5314.627976041678, 4920.8031678732805, 5226.320578324831, 5235.685858848481, 5242.816501422432, 5287.841364759063, 5524.06090964537, 5677.744501497443, 5776.364599894008, 5794.333651630074, 5813.360530341659, 6093.238345206849, 6165.876682466371, 6167.691615419211, 6180.721867515973, 6208.689565521706, 6113.541484388688, 6132.049587189136, 6189.133521307021, 6261.027776250467, 6264.373562643745, 5893.057110862242, 5944.108383742473, 5949.524038076944, 5959.642421454727, 6009.0, 6286.872236142003, 6316.021016742412, 6320.083587879732, 6349.682515874188, 6359.554831161774, 6043.969780151071, 6145.170401995673, 6168.8766224675255, 6179.814605561751, 6197.163382943335, 5351.117065684119, 6029.673471836189, 6158.692065396713, 6193.81418557444, 6239.0953311770445, 6159.722812473449, 6169.2288463942, 6232.158658581034, 6236.126942228092, 6255.624662520263, 6255.186825712628, 6257.311695713468, 6261.624302541862, 6279.717412716439, 6290.370962903765, 4827.662063655511, 4883.877903052381, 4886.951130488721, 4925.2119660854805, 4928.482509336468, 4425.336199570091, 4462.776861156929, 4465.665075119379, 4471.35165401015, 4528.796204170821, 5853.239078919798, 5953.791617293374, 5970.552208584373, 5985.132155837379, 5991.4308140727435, 6147.569670123048, 6202.069689546604, 6220.098085777628, 6234.3453937336835, 6265.0, 5942.61373010753, 5977.252843394575, 5978.790742324085, 5985.25184351956, 6023.156758053876, 5395.2986111806, 5398.757055932492, 5417.160340147283, 5423.132298832168, 5443.42844001382, 6201.875962480815, 6206.162168107428, 6209.130721698875, 6339.841503962438, 6341.904871427025, 6185.072239164161, 6254.186955695731, 6259.812205633838, 6260.436560709376, 6263.185785847811, 6298.433141017331, 6305.621662700252, 6307.30619631831, 6317.115603815561, 6334.113224148531, 6076.939230607637, 6130.948521379913, 6227.750889964351, 6268.843278918063, 6277.843053923689, 4567.748773817472, 6119.441623354662, 6200.689965501617, 6202.472789812917, 6248.5313601479165, 5100.770465328995, 6064.787732429344, 6141.201643786279, 6176.413240742122, 6180.567360284737, 6073.5748497604745, 6162.722677479614, 6169.691515424301, 6199.380061993945, 6201.534884883742, 5862.032764593794, 5921.940780592139, 5944.64332140073, 6046.27444706638, 6059.909216341101, 6123.357047509948, 6191.473724733448, 6203.658798766111, 6210.7515699371515, 6237.220347456568, 5864.530837533072, 5924.9927512323875, 5935.673537955281, 6052.757889684363, 6070.18052562916], "value": 5692.6424655652245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.6501106675526, 476.63681869852195, 524.908141075312, 525.6478159633044, 527.833732374302, 26444.867775661118, 31450.99999999997, 35239.471407928904, 40708.18583628326, 40708.18583628329, 32455.67544324556, 33069.66930330696, 34785.65214347856, 39181.21637567247, 42142.367864482054, 8032.959835200845, 8615.439996400246, 9034.006259311454, 9572.569234384435, 9611.086946740083, 7977.481463704869, 9522.666706665234, 9600.471974041426, 9610.90389096107, 9648.951755241214, 9593.80812383752, 9643.180329671986, 9650.179734722557, 9658.517074146264, 9690.70927872165, 9539.0, 9578.233741300679, 9618.470984095871, 9626.518674066268, 9630.27772917034, 9396.389234699722, 9474.0, 9491.525423728855, 9516.904830951671, 9517.095875891779, 40004.0, 40129.0, 40238.396424053666, 40341.59658403408, 40552.0, 3403.7617366784334, 3431.365197438457, 3462.9134271643156, 3846.442265871461, 4075.9796201018803, 30159.341236231998, 30633.0, 30830.84584577085, 31665.0, 31890.043298700843, 3185.2036990752313, 3189.984050079758, 3193.9041828745176, 3201.807891526516, 3237.0308408855644, 493278.0, 495617.52191238815, 495676.0432395702, 497239.5138024323, 497769.5111524455, 57067.71466142643, 57138.714306429036, 57508.71245643745, 57704.42295576991, 57762.0, 60415.0, 60563.0, 61071.38928610657, 61120.0, 61196.38803611996, 16018.279177437043, 16212.918935405247, 16265.837341626433, 16287.02277863332, 16324.265408056666, 12485.750284994248, 12635.557755478514, 12642.55751048709, 12650.367481626066, 12677.619671409873, 15417.612414882715, 15702.528924132293, 15736.134512601917, 15741.560058190998, 15760.054396736003, 6304.329352721533, 6377.840553986188, 6403.583767055126, 6407.775727849503, 6414.294427613052, 670.2974444909986, 924.8196601662611, 979.1872745621117, 1064.3454275620438, 1069.8234791259356, 26479.86760066226, 28119.500879859534, 28679.283017924718, 29333.41333173367, 30351.544726829114, 1073.9624113156, 1080.6757972608186, 1096.4188979840696, 1143.7598104398003, 1150.6548035589458, 14816.851831481546, 15320.387184512718, 15479.0, 15483.30325135349, 15734.134622595639, 619843.0, 623996.0, 627463.0, 628148.0, 632651.0, 55673.443265567636, 55709.0, 55729.0, 55814.16278755822, 55898.72050639721, 1339.8191244182105, 1385.300423286254, 1406.9085509441854, 1411.5553600615774, 1414.731201071793, 23046.193383232177, 29153.562696559144, 29299.363057324943, 29435.822567097075, 30213.244668882573, 48429.75785121193, 48785.756071220836, 48922.510774891794, 48956.75521622369, 49081.0, 564663.0, 567477.0, 567964.0, 569882.0, 570696.0, 25211.0, 26022.0, 39244.41133382944, 39353.40969885397, 39477.802610987914, 45225.773871130434, 45951.77024114858, 46967.530324696316, 47309.7634511839, 47357.52642473669, 30686.772529098587, 32750.672493274764, 35609.46585801267, 38394.0, 38831.61168388393, 31818.84090579532, 33712.49431258582, 37992.810035949646, 38195.0, 39123.0, 26935.0, 31834.52248216325, 37997.620023799405, 38249.61750382461, 38323.0, 28250.43499130047, 29828.552571711876, 30338.0, 34310.82844585861, 34608.0, 24922.750772492767, 25115.0, 25311.709477767774, 25572.702859667974, 26113.563753993712], "value": 19416.540687018805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.87066961898154, 378.3719026416149, 383.23162060069563, 384.8479850459067, 401.3177598083257, 18765.343212987533, 19859.404217873453, 21348.679769803464, 21435.356939291847, 21527.784722152774, 20181.899090504565, 20282.0, 20827.0, 21010.36968890932, 21129.837858917752, 5174.818881339153, 5294.055928333378, 5912.17229587858, 6014.819555413323, 6031.517478601701, 3855.132595166079, 4093.1813637272517, 5907.5864689471755, 6028.6081404708775, 6053.667048312341, 5725.398833122525, 5989.820305390824, 6033.456988871001, 6100.7864724734645, 6107.633541987495, 5563.221149039137, 5876.588638795286, 5918.7928422505, 6050.2437195350585, 6087.452129308362, 5738.82783516491, 5759.164921086419, 5759.366469688331, 5760.222369980041, 5783.306003279633, 12730.681732956658, 12901.0, 12955.287459189742, 13182.0, 13288.0, 2091.8012788785195, 2136.5406437615834, 2165.675148727688, 2449.742777008424, 2606.687197536308, 9261.72214833556, 10268.589256429734, 10318.0, 12360.072994525357, 15453.459128930546, 1837.8897266164072, 1849.280169442418, 1895.3745264062827, 1932.294712429967, 1969.8325642320276, 120303.0, 134259.32870335685, 135135.0, 140185.299073505, 154667.0, 20962.580748384946, 21085.367438976547, 21456.78543214548, 21533.13867445316, 21600.463323547483, 35864.82067589645, 36245.45631815525, 36261.91214263576, 36282.455763163576, 36395.454068189, 8705.0, 10612.840807387742, 11022.118230541537, 11029.227954043301, 11068.944655276671, 8917.821643567093, 8922.86615700765, 9029.097090290918, 9173.44959302444, 9185.265178785681, 10017.549210285555, 10055.64805231828, 10106.797864042677, 10218.927012663711, 10230.386176829414, 1612.9758053629205, 3345.9330813383594, 3855.0747820522874, 3909.257241124177, 3960.7029472789654, 790.8971833661587, 797.0594698256114, 868.7779223542055, 967.8112768010311, 1043.6712435582767, 19535.925524096026, 20997.47506312324, 21196.894015529822, 21271.956028199333, 21278.0, 798.2655956520016, 890.528020149322, 932.4032619123766, 960.8606752020918, 1027.342500799489, 10912.56349746017, 10930.289531180448, 11012.229143960007, 11143.442827858575, 11190.888091119148, 475963.0, 475985.0, 479203.60398197785, 564598.0, 583292.0, 110770.0, 139077.0, 140872.59127408595, 143331.0, 146553.0, 971.9416834990064, 973.7127547373542, 1012.9088382045651, 1017.2675673515057, 1017.6336518853207, 17861.73207401864, 18190.90904545469, 18574.814251857308, 18601.53496162607, 18837.340693075676, 55257.723711381186, 56547.434525654215, 57515.137272940105, 57699.71150144222, 58062.54843628943, 81931.0, 82066.58966705129, 82475.5876220615, 83147.0, 84153.0, 7753.612319383896, 7937.404694647809, 7969.840603187788, 8124.675012999413, 8145.533803915352, 9516.333856630246, 12684.87315126837, 12743.681407964876, 13179.538716144889, 13451.865481345452, 7572.4699271050495, 10997.010269075501, 11190.104791616814, 11203.663890083311, 11682.94158529236, 9269.6292148316, 11083.168762343017, 11210.943945280222, 11360.261582997078, 11705.005074568757, 11587.768244635228, 11640.0, 11673.540807399075, 11826.586069487526, 11951.22317049389, 7147.499675022698, 7237.674304656409, 7368.778936631909, 8202.876956845532, 8370.455920365157, 11253.381064041556, 11438.256513326607, 11510.769784604428, 11682.299062056303, 11726.003289720127], "value": 10306.169957765305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.4676282724079, 1410.6473381654587, 1438.9784153237704, 1933.9903300483495, 1941.5437372217527, 7900.367970562355, 8133.2680058794695, 8434.831303373936, 8946.971098323695, 8953.865692014617, 8410.453320534161, 8751.693690720826, 8768.254698350633, 8907.554622268894, 8908.777280567989, 2321.651752237165, 2346.800521955627, 2347.225415612852, 2348.5537747827857, 2350.74141844397, 2198.8131008864266, 2352.7882490575844, 2371.4308565944134, 2379.583572874749, 2380.666706661069, 2311.05246848792, 2325.8953347099423, 2337.5091230841545, 2342.320726989171, 2360.4334959609655, 2038.8980550972467, 2316.1893337331885, 2324.8721320327377, 2349.953000939972, 2359.1742889988536, 2356.5404746074523, 2364.869932153731, 2371.8458300210605, 2380.1193558383334, 2381.7975472084895, 7386.446016548781, 7480.364169045638, 8749.825003499895, 8892.822143557092, 8918.019017908025, 5191.402988656315, 5314.468553144693, 5334.386545547273, 5376.0, 5379.623426360156, 3368.79787212768, 3439.0886415100017, 3684.5946945835935, 3699.6300369963055, 3713.535808023997, 1012.1346248957109, 1022.560299071399, 1069.5989004123453, 1083.631565267805, 1088.1675518228562, 9957.302988790787, 11784.939355457964, 11827.763444731057, 11842.348670823101, 11903.642890713292, 4506.211413002711, 4617.630589552828, 4683.227267500893, 4717.952820471752, 4732.006278681447, 9767.0, 9894.505274736235, 9896.60413583463, 9913.80172396548, 9925.751856203507, 4639.9536004640195, 5307.761150748225, 5344.652597581145, 5359.981603495324, 5402.243685883979, 4368.847090351886, 4399.274119770266, 4851.611871050378, 4870.8782280442565, 4903.362562866804, 3779.244151169777, 3853.807309634507, 3879.903002424962, 3929.0766669832565, 3942.7240093193773, 1282.5254655777421, 1286.1447137653543, 1290.7289469211382, 1291.9612411627666, 1296.9157004794658, 817.5626040068535, 866.9869951950726, 927.9025702301296, 934.6261495401893, 958.9020571445656, 5706.885862282731, 5729.598928075078, 5902.61632993854, 5997.580169388101, 6026.698665066817, 429.4524481286322, 435.95858393453204, 436.1843352930041, 825.3191117328108, 921.824853277875, 3298.3568204200433, 3858.2991905666145, 3879.437481565157, 3908.5700572936953, 3916.7649941003633, 10317.9484102579, 10621.309614875008, 10669.146468282519, 10672.30630009047, 10684.519196636014, 10550.947245263724, 10596.682099537025, 10649.0, 10700.250982431155, 10705.250632455809, 5986.5210783137245, 7662.5785581792425, 8140.918590814016, 8224.424290299621, 8278.875816862752, 5083.491650834887, 5457.5361094305845, 5558.944410556004, 5836.854078648068, 6060.2424696912885, 9592.328537002622, 9610.135087842127, 9746.707598772047, 9785.510724463606, 9927.851082233918, 9849.113579777855, 9921.305508614329, 9924.553395097382, 10002.44986525719, 10085.596576136872, 6810.489213308922, 7100.289971002859, 7404.592747398729, 7498.437617178624, 7626.8855967159425, 8132.75601731949, 8148.266656000988, 8276.131006244257, 8294.212049855254, 8308.958455207685, 7221.4222862169845, 7297.890531641923, 7330.413566914741, 7448.99438575807, 7458.067741532309, 7117.82205444868, 7213.350798428167, 7221.566705997657, 7245.5652660840515, 7397.297256760599, 6758.560693554903, 6880.174379074543, 6880.621565813928, 6913.10129683138, 6922.930770692228, 4774.618030557477, 4935.210366341368, 4956.975215123901, 4978.352814134139, 4983.6511444200005, 4931.7040977541465, 4958.528939750718, 5054.19132938728, 5099.898002039864, 5139.460356662496], "value": 4477.447021763395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.68494384482557, 294.24232601052296, 307.701529516369, 311.14125014958705, 312.83888797269395, 4991.801967527795, 5337.386200586924, 5353.08256999935, 5574.581906357019, 5648.011597970354, 4743.932615161587, 5334.986352593014, 5348.144296912495, 5490.972545137269, 5546.835164615436, 3682.208325210086, 3840.7311488195837, 3866.439366291886, 4247.25673007224, 4254.765987870666, 3494.4059509883255, 3890.688744900401, 3925.5878132796074, 4148.56440073791, 4261.424707664472, 4102.302608556538, 4102.917941641165, 4107.691923105764, 4125.752454852718, 4132.752034877902, 3518.8416521256604, 3586.856525738954, 3882.990422490173, 4122.113745544707, 4129.504459464853, 2955.689652586469, 3432.9828350858334, 3568.50040994261, 3580.534530511043, 3587.443946188345, 4451.043025749447, 4714.514927797767, 4970.304157417964, 5258.553897678131, 5415.431379705114, 4205.3481710334945, 4293.29160688486, 4367.0, 4717.43390793107, 4812.398450193726, 4983.6760610560195, 5323.9884421959705, 5596.153269421122, 5601.411851755548, 5788.913166302509, 3920.5099362579676, 3921.156951255494, 3923.6664883484937, 3928.3910993796007, 3937.625925537069, 6065.5450841187085, 6128.161551534522, 6163.537734669918, 6167.198264225667, 6169.7532098716, 3250.756193285513, 3702.6667599916136, 3959.8416063357718, 3967.7420967637013, 3972.7020473464604, 3360.781549199294, 4018.216447792711, 4025.798710064485, 4034.5677284564144, 4063.695222858238, 3721.7953012584026, 4637.652176086807, 4724.275639391666, 4743.6717719038725, 4786.95213047865, 4860.708357498562, 5344.26311448773, 5936.406359364116, 5944.940550594439, 5970.522358211333, 1164.7612239491054, 1191.5233906437495, 1297.8254679515053, 1383.3429121167364, 1414.2363123912971, 808.3735105293445, 872.7294538693026, 902.3007169443733, 904.5251243097294, 919.5586118662945, 4790.8323208687525, 4814.518548145227, 5518.972405138029, 5554.50009499147, 5576.470235327637, 5952.821415357546, 5981.970090149522, 5983.679058122783, 6034.547408944259, 6042.0, 4337.587929146726, 4597.287420449836, 5197.558207552401, 5493.7802487900035, 5506.449355064461, 2425.987870060638, 2447.889844956981, 2701.6896805049537, 2707.4161615454786, 2716.2122984334715, 4175.039740859619, 4560.931586026212, 4978.452370239271, 5043.0, 5256.031696069443, 4492.865214043584, 4664.836730714476, 4808.762373338065, 4884.3650325457465, 5167.548236610337, 4237.178013454182, 4374.300111982131, 4534.727916325031, 5000.224965130411, 5293.682379057192, 4749.886300596201, 5050.469700681376, 5086.54221120101, 5144.717040562805, 5196.844094677014, 4495.865124046284, 4618.30725391194, 5012.674176178537, 5028.59771218309, 5069.9746501267255, 4276.978615106905, 5179.896402072013, 5227.973860130675, 5228.503292187236, 5259.947400525945, 3350.564426624523, 3464.411050121536, 3759.8308076137187, 3854.460375547482, 3865.845366185321, 4711.175544279668, 5301.973490132525, 5580.888382232414, 5798.739056742541, 6013.759449621966, 4454.5990860821385, 4945.208766597327, 5712.457956209447, 5719.8570035749435, 5854.531637468907, 4529.773511324354, 4602.9643330251765, 4787.95212047889, 5357.0, 5665.093585026376, 5644.322681278273, 5680.431956804452, 5704.914426283692, 5714.399988001366, 5718.370979192368, 4484.663650226311, 5808.796692115756, 5817.272840894888, 5835.503982161564, 5881.911771323348, 4851.927221091757, 4954.405471343318, 5784.797532086357, 5805.738741756547, 5840.386759390372], "value": 3996.4331662074187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1130309719045, 735.283098978496, 782.8121250899782, 806.7216810200479, 826.8015676237701, 15285.159316237603, 15864.84135158651, 15865.04809711418, 15889.2849821758, 15936.203189840506, 14447.566573002801, 14556.636084097903, 14570.0, 14573.708525829477, 14580.854191458082, 705.5555000349773, 728.1771598094147, 874.64576846377, 880.8370451466499, 900.522722956834, 883.1786438612088, 885.1060428966725, 901.0898992018076, 903.6249956268141, 905.0044950554403, 950.092661508258, 952.8189643967625, 956.0009789769673, 957.750984743968, 958.7507248115505, 948.9240860731124, 952.6094301336419, 954.6181527389031, 955.8566215067726, 956.2445667922333, 680.3672584496417, 704.4118161335291, 704.5420476690192, 708.2598684374841, 709.9964500177517, 14568.635784105481, 14692.191929443876, 14697.485588004369, 14745.189014604193, 15309.540713778493, 14161.29193540319, 14424.567262982127, 14488.365237117305, 14499.492517761828, 14582.197979111144, 11489.310641361544, 11637.185397022211, 11763.7059073523, 11766.0, 12083.214591051641, 3750.587435382106, 3756.830942607562, 3773.3019391412404, 3808.5810560838286, 3907.0427745202605, 88473.55763221142, 96433.03566964381, 96742.51628741881, 97037.51481242549, 100672.48991265136, 10883.564657413615, 10938.070264027647, 10944.0, 11047.060999814945, 11358.375289359165, 22659.886700566392, 22678.433039174153, 22689.659655105188, 22699.978500967496, 22749.772502275096, 7347.742829001067, 7541.622918854145, 7841.882371764428, 8069.596520173968, 8114.756557303291, 4332.285172946428, 4347.065380943112, 4371.388005679208, 4383.1452866691325, 4457.955420445754, 3384.4754063120254, 3483.6168021517615, 3483.773554718986, 3492.5983511895947, 3495.615482296945, 600.3966014155745, 611.2847967877594, 622.6793201501231, 664.1631544254178, 678.9137380191654, 427.3568279739035, 478.7866772402841, 554.1549137565245, 557.9358373786986, 625.3683779382856, 9151.45091294511, 9928.404295742279, 9990.550425230882, 10009.799804003878, 10284.845727314096, 602.734796689464, 607.5807692692028, 660.6531570925303, 662.8508585568305, 678.511471740356, 3839.232153569297, 3872.9612703873163, 4519.412476378116, 4526.977365113219, 4548.567886050886, 87436.5628171855, 105478.0, 110761.44619277013, 110766.44616776865, 114493.85506144832, 64608.0, 81961.21368469986, 86717.0, 95853.0, 97748.04503909883, 83687.32625347459, 83801.0, 86662.70005949916, 86851.56574217089, 88269.0, 9568.0, 9714.222862170867, 9746.025397460196, 9764.218862490841, 9765.65820196318, 51863.74068129786, 54111.72944135254, 56416.153757692846, 58155.709221453624, 58327.12509312279, 43583.56416435795, 54241.0, 54311.72844135912, 55052.449475504734, 76439.61780191063, 11348.886511134782, 12179.634610961686, 12591.370431478572, 12767.0, 12891.419886105336, 14023.649408764863, 14223.573292801233, 14286.571402857931, 14309.35607897668, 14716.926415368283, 11170.776584468103, 12491.0, 13235.735285294048, 13548.525801596898, 13705.177689338672, 13345.532906348231, 13378.732425351633, 13891.861081389461, 13912.860871391156, 14049.36777844979, 13124.475020999053, 13125.278109704059, 13391.86608133945, 13628.727425451634, 13962.0, 10425.843612345669, 10841.454552694426, 11034.503447344729, 11113.333200007703, 11136.665900023012, 9084.954575227082, 9480.905190948002, 9849.45827979468, 10186.879443261087, 10773.0], "value": 7425.245385340429, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 118.0, 119.0, 118.0, 123.0, 177.0, 175.0, 123.0, 119.0], "value": 129.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 116.0, 115.0, 152.0, 121.0, 116.0, 118.0, 114.0, 143.0, 119.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 223.0, 281.0, 204.0, 196.0, 198.0, 194.0, 198.0, 231.0], "value": 211.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 84.0, 59.0, 59.0, 51.0, 70.0, 111.0, 81.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 56.0, 74.0, 76.0, 85.0, 104.0, 125.0, 86.0, 69.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 88.0, 91.0, 87.0, 127.0, 111.0, 137.0, 135.0], "value": 104.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 99.0, 127.0, 155.0, 91.0, 153.0, 155.0, 95.0, 95.0, 96.0], "value": 119.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 82.0, 119.0, 145.0, 117.0, 92.0, 149.0, 90.0, 88.0, 89.0], "value": 108.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 56.0, 57.0, 67.0, 74.0, 57.0, 53.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 75.0, 75.0, 70.0, 94.0, 105.0, 105.0, 108.0, 95.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 86.0, 88.0, 89.0, 86.0, 88.0, 110.0, 106.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 183.0, 164.0, 166.0, 166.0, 164.0, 153.0, 187.0, 176.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 174.0, 239.0, 206.0, 173.0, 172.0, 184.0, 189.0, 173.0, 174.0], "value": 188.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 82.0, 71.0, 73.0, 68.0, 70.0, 70.0, 71.0, 68.0], "value": 71.1, "unit": "score"}]}]} 00:21:00 INFO - Return code: 0 00:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:21:01 ERROR - # TBPL SUCCESS # 00:21:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:21:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:21:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:21:01 INFO - 2016-10-26 00:21:01.057 screenresolution[2246:21270] starting screenresolution argv=screenresolution get 00:21:01 INFO - 2016-10-26 00:21:01.059 screenresolution[2246:21270] Display 0: 1600x1200x32@60 00:21:01 INFO - 2016-10-26 00:21:01.065 screenresolution[2247:21273] starting screenresolution argv=screenresolution list 00:21:01 INFO - Available Modes on Display 0 00:21:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:21:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:21:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:21:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:21:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:21:01 INFO - Intel Iris: 00:21:01 INFO - Chipset Model: Intel Iris 00:21:01 INFO - Type: GPU 00:21:01 INFO - Bus: Built-In 00:21:01 INFO - VRAM (Dynamic, Max): 1536 MB 00:21:01 INFO - Vendor: Intel (0x8086) 00:21:01 INFO - Device ID: 0x0a2e 00:21:01 INFO - Revision ID: 0x0009 00:21:01 INFO - Displays: 00:21:01 INFO - Display: 00:21:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:21:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:21:01 INFO - Display Serial Number: 1600x1200 60 00:21:01 INFO - Main Display: Yes 00:21:01 INFO - Mirror: Off 00:21:01 INFO - Online: Yes 00:21:01 INFO - Rotation: Supported 00:21:01 INFO - Return code: 0 00:21:01 INFO - Running post-action listener: _resource_record_post_action 00:21:01 INFO - [mozharness: 2016-10-26 07:21:01.302767Z] Finished run-tests step (success) 00:21:01 INFO - Running post-run listener: _resource_record_post_run 00:21:01 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 557056; Write bytes: 711578112; Read time: 4; Write time: 2206 00:21:01 INFO - TinderboxPrint: CPU usage
54.5% 00:21:01 INFO - TinderboxPrint: I/O read bytes / time
557,056 / 4 00:21:01 INFO - TinderboxPrint: I/O write bytes / time
711,578,112 / 2,206 00:21:01 INFO - TinderboxPrint: CPU idle
2,204.6 (45.5%) 00:21:01 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 00:21:01 INFO - TinderboxPrint: CPU user
1,660.8 (34.3%) 00:21:01 INFO - TinderboxPrint: Swap in / out
406,163,456 / 0 00:21:01 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392829440; Write bytes: 386987520; Read time: 29478; Write time: 746 00:21:01 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 557056; Write bytes: 302914560; Read time: 4; Write time: 1411 00:21:01 INFO - Running post-run listener: _upload_blobber_files 00:21:01 INFO - Blob upload gear active. 00:21:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:21:01 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 00:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:21:02 INFO - (blobuploader) - INFO - Open directory for files ... 00:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:21:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:21:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:21:03 INFO - (blobuploader) - INFO - Done attempting. 00:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:21:04 INFO - (blobuploader) - INFO - Done attempting. 00:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:21:06 INFO - (blobuploader) - INFO - Done attempting. 00:21:06 INFO - (blobuploader) - INFO - Iteration through files over. 00:21:06 INFO - Return code: 0 00:21:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:21:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:21:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b98202c4ecc782b2b798b8eed8110a3113f14b3a7a1a2d2df262d83e55be333d69946f54024f8c1d3d9d954b84895f89e47fc826c481f698dbda1627c69e2f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/915061bc90b5798275325ed2a08ed59f0912477db5f5b9171c4bfa5154e262ae4f270c40709037f2a47b415411d7f4dac2e1a0079ed4f8ab04d9044a3c39a54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f4563003951991c7d8f8848f78fe432a8bbd1c189d5302f72ccf742ce6089ed38632c52b918768ad19f490bc9abb6c43886f755f9b8efbf14de3174e90c1921"} 00:21:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:21:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:21:06 INFO - Contents: 00:21:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b98202c4ecc782b2b798b8eed8110a3113f14b3a7a1a2d2df262d83e55be333d69946f54024f8c1d3d9d954b84895f89e47fc826c481f698dbda1627c69e2f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/915061bc90b5798275325ed2a08ed59f0912477db5f5b9171c4bfa5154e262ae4f270c40709037f2a47b415411d7f4dac2e1a0079ed4f8ab04d9044a3c39a54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f4563003951991c7d8f8848f78fe432a8bbd1c189d5302f72ccf742ce6089ed38632c52b918768ad19f490bc9abb6c43886f755f9b8efbf14de3174e90c1921"} 00:21:06 INFO - Running post-run listener: copy_logs_to_upload_dir 00:21:06 INFO - Copying logs to upload dir... 00:21:06 INFO - mkdir: /builds/slave/test/build/upload/logs 00:21:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.014129 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-26 00:21:06.508065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 00:21:06.511689) ========= 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.vx5hh5PAIL/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.48MXuz6olZ/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b98202c4ecc782b2b798b8eed8110a3113f14b3a7a1a2d2df262d83e55be333d69946f54024f8c1d3d9d954b84895f89e47fc826c481f698dbda1627c69e2f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/915061bc90b5798275325ed2a08ed59f0912477db5f5b9171c4bfa5154e262ae4f270c40709037f2a47b415411d7f4dac2e1a0079ed4f8ab04d9044a3c39a54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f4563003951991c7d8f8848f78fe432a8bbd1c189d5302f72ccf742ce6089ed38632c52b918768ad19f490bc9abb6c43886f755f9b8efbf14de3174e90c1921"} build_url:https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/erufOjVdTciSfZSQp0JJXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b98202c4ecc782b2b798b8eed8110a3113f14b3a7a1a2d2df262d83e55be333d69946f54024f8c1d3d9d954b84895f89e47fc826c481f698dbda1627c69e2f88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/915061bc90b5798275325ed2a08ed59f0912477db5f5b9171c4bfa5154e262ae4f270c40709037f2a47b415411d7f4dac2e1a0079ed4f8ab04d9044a3c39a54f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f4563003951991c7d8f8848f78fe432a8bbd1c189d5302f72ccf742ce6089ed38632c52b918768ad19f490bc9abb6c43886f755f9b8efbf14de3174e90c1921"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 00:21:06.544781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:21:06.545111) ========= 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.vx5hh5PAIL/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.48MXuz6olZ/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:21:06.594646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 00:21:06.594956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 00:21:06.595305) ========= ========= Total master_lag: 0.41 =========