builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0321 starttime: 1485890177.84 results: success (0) buildid: 20170131083709 builduid: 3c23e62267f54ccba0bac0521cf1889a revision: 4217fbc0d4feea059a47b6360c627061ab0dd451 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:17.835772) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:17.836220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:17.836500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:17.862849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:17.863208) ========= 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.be3p9U6tHC/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.c8VPXjwtFx/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-31 11:16:17-- 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% 132M=0s 2017-01-31 11:16:17 (132 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:18.001015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:18.001356) ========= 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.be3p9U6tHC/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.c8VPXjwtFx/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.040954 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:18.064321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-31 11:16:18.064676) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4217fbc0d4feea059a47b6360c627061ab0dd451 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4217fbc0d4feea059a47b6360c627061ab0dd451 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.be3p9U6tHC/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.c8VPXjwtFx/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-31 11:16:18,173 truncating revision to first 12 chars 2017-01-31 11:16:18,173 Setting DEBUG logging. 2017-01-31 11:16:18,173 attempt 1/10 2017-01-31 11:16:18,173 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4217fbc0d4fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 11:16:20,244 unpacking tar archive at: mozilla-beta-4217fbc0d4fe/testing/mozharness/ program finished with exit code 0 elapsedTime=2.333540 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-31 11:16:20.527957) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:20.528568) ========= script_repo_revision: 4217fbc0d4feea059a47b6360c627061ab0dd451 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:20.529366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:20.529886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 11:16:20.551919) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-31 11:16:20.552414) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.be3p9U6tHC/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.c8VPXjwtFx/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:16:20 INFO - MultiFileLogger online at 20170131 11:16:20 in /builds/slave/test 11:16:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:16:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:20 INFO - {'append_to_log': False, 11:16:20 INFO - 'base_work_dir': '/builds/slave/test', 11:16:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:16:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:20 INFO - 'branch': 'Mozilla-Beta', 11:16:20 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:20 INFO - 'config_files': ('talos/mac_config.py',), 11:16:20 INFO - 'default_actions': ('clobber', 11:16:20 INFO - 'read-buildbot-config', 11:16:20 INFO - 'download-and-extract', 11:16:20 INFO - 'populate-webroot', 11:16:20 INFO - 'create-virtualenv', 11:16:20 INFO - 'install', 11:16:20 INFO - 'run-tests'), 11:16:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:20 INFO - 'download_minidump_stackwalk': True, 11:16:20 INFO - 'download_symbols': 'ondemand', 11:16:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:20 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:20 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:20 INFO - 'installer_path': 'installer.exe', 11:16:20 INFO - 'log_level': 'info', 11:16:20 INFO - 'log_name': 'talos', 11:16:20 INFO - 'log_to_console': True, 11:16:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:16:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:16:20 INFO - 'opt_config_files': (), 11:16:20 INFO - 'pip_index': False, 11:16:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:16:20 INFO - 'cmd': ('bash', 11:16:20 INFO - '-c', 11:16:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:16:20 INFO - 'enabled': True, 11:16:20 INFO - 'halt_on_failure': False, 11:16:20 INFO - 'name': 'check_screen_resolution'},), 11:16:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:16:20 INFO - 'cmd': ('bash', 11:16:20 INFO - '-c', 11:16:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:16:20 INFO - 'enabled': True, 11:16:20 INFO - 'halt_on_failure': False, 11:16:20 INFO - 'name': 'check_screen_resolution'},), 11:16:20 INFO - 'run_cmd_checks_enabled': True, 11:16:20 INFO - 'sps_profile': False, 11:16:20 INFO - 'sps_profile_interval': 0, 11:16:20 INFO - 'suite': 'dromaeojs-e10s', 11:16:20 INFO - 'system_bits': '32', 11:16:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:20 INFO - 'title': 't-yosemite-r7-0321', 11:16:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:20 INFO - 'use_talos_json': True, 11:16:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:20 INFO - 'work_dir': 'build'} 11:16:20 INFO - [mozharness: 2017-01-31 19:16:20.767899Z] Running clobber step. 11:16:20 INFO - Running pre-action listener: _resource_record_pre_action 11:16:20 INFO - Running main action method: clobber 11:16:20 INFO - rmtree: /builds/slave/test/build 11:16:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:23 INFO - Running post-action listener: _resource_record_post_action 11:16:23 INFO - [mozharness: 2017-01-31 19:16:23.226263Z] Finished clobber step (success) 11:16:23 INFO - [mozharness: 2017-01-31 19:16:23.226418Z] Running read-buildbot-config step. 11:16:23 INFO - Running pre-action listener: _resource_record_pre_action 11:16:23 INFO - Running main action method: read_buildbot_config 11:16:23 INFO - Using buildbot properties: 11:16:23 INFO - { 11:16:23 INFO - "project": "", 11:16:23 INFO - "product": "firefox", 11:16:23 INFO - "script_repo_revision": "production", 11:16:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:16:23 INFO - "repository": "", 11:16:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:16:23 INFO - "buildid": "20170131083709", 11:16:23 INFO - "pgo_build": "False", 11:16:23 INFO - "basedir": "/builds/slave/test", 11:16:23 INFO - "buildnumber": 1, 11:16:23 INFO - "slavename": "t-yosemite-r7-0321", 11:16:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:16:23 INFO - "platform": "yosemite_r7", 11:16:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:16:23 INFO - "branch": "mozilla-beta", 11:16:23 INFO - "repo_path": "releases/mozilla-beta", 11:16:23 INFO - "revision": "4217fbc0d4feea059a47b6360c627061ab0dd451", 11:16:23 INFO - "stage_platform": "macosx64", 11:16:23 INFO - "builduid": "3c23e62267f54ccba0bac0521cf1889a", 11:16:23 INFO - "slavebuilddir": "test" 11:16:23 INFO - } 11:16:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:16:23 INFO - Running post-action listener: _resource_record_post_action 11:16:23 INFO - [mozharness: 2017-01-31 19:16:23.229785Z] Finished read-buildbot-config step (success) 11:16:23 INFO - [mozharness: 2017-01-31 19:16:23.229903Z] Running download-and-extract step. 11:16:23 INFO - Running pre-action listener: _resource_record_pre_action 11:16:23 INFO - Running main action method: download_and_extract 11:16:23 INFO - mkdir: /builds/slave/test/build/tests 11:16:23 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')]} 11:16:23 INFO - trying https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:16:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 11:16:23 INFO - Downloaded 1165 bytes. 11:16:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:16:23 INFO - Using the following test package requirements: 11:16:23 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:16:23 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:16:23 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:16:23 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:16:23 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:16:23 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:16:23 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:16:23 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:16:23 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:16:23 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:16:23 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:16:23 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:16:24 INFO - Http code: 200 11:16:24 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 11:16:24 INFO - x-amz-cf-id: BTgcaBmNl3vjo8ySV2fpGCm9E5F1zTRztZzHuHLn0vBhJdNmXVcYqQ== 11:16:24 INFO - x-amz-version-id: vKqe4Za6PxPUbEilL0RmAYmHn_1asX6q 11:16:24 INFO - Expected file size: 16089088 11:16:24 INFO - Obtained file size: 16089088 11:16:31 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:16:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:16:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:16:31 INFO - Fetch https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:16:31 INFO - Http code: 200 11:16:31 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 11:16:31 INFO - x-amz-cf-id: 30z6zOAwh8YTPAYLiE93p9zH6VdmumVt7JfFc-2sm2SvYnp3XqeOfQ== 11:16:31 INFO - x-amz-version-id: vKqe4Za6PxPUbEilL0RmAYmHn_1asX6q 11:16:32 INFO - Expected file size: 16089088 11:16:32 INFO - Obtained file size: 16089088 11:16:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:16:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:16:38 INFO - Fetch https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:16:39 INFO - Http code: 200 11:16:39 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 11:16:39 INFO - x-amz-cf-id: jYnPZxiZsHsjFPpFDsAqeq8lHq3iGBWI-3M-AHhy0Bh96VDuvltDYA== 11:16:39 INFO - x-amz-version-id: 5ApRhtAc_.UVQtIRZtnsclPGtmWfFnx7 11:16:40 INFO - Expected file size: 14402992 11:16:40 INFO - Obtained file size: 14402992 11:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:40 INFO - trying https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:16:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 11:16:42 INFO - Downloaded 82144948 bytes. 11:16:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:16:42 INFO - mkdir: /builds/slave/test/properties 11:16:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:42 INFO - Contents: 11:16:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:16:43 INFO - Running post-action listener: _resource_record_post_action 11:16:43 INFO - Running post-action listener: set_extra_try_arguments 11:16:43 INFO - [mozharness: 2017-01-31 19:16:43.610879Z] Finished download-and-extract step (success) 11:16:43 INFO - [mozharness: 2017-01-31 19:16:43.610973Z] Running populate-webroot step. 11:16:43 INFO - Running pre-action listener: _resource_record_pre_action 11:16:43 INFO - Running main action method: populate_webroot 11:16:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:43 INFO - '--tppagecycles', 11:16:43 INFO - '7'], 11:16:43 INFO - 'tests': ['tsvgm']}}, 11:16:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['damp', 'tps']}, 11:16:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'tests': ['damp', 'tps']}, 11:16:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['dromaeo_dom']}, 11:16:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['basic_compositor_video']}, 11:16:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:16:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['a11yr', 11:16:43 INFO - 'ts_paint', 11:16:43 INFO - 'tpaint', 11:16:43 INFO - 'sessionrestore', 11:16:43 INFO - 'sessionrestore_no_auto_restore', 11:16:43 INFO - 'tabpaint']}, 11:16:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:43 INFO - 'ts_paint', 11:16:43 INFO - 'tpaint', 11:16:43 INFO - 'sessionrestore', 11:16:43 INFO - 'sessionrestore_no_auto_restore', 11:16:43 INFO - 'tabpaint']}, 11:16:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:43 INFO - 'ts_paint', 11:16:43 INFO - 'tpaint', 11:16:43 INFO - 'sessionrestore', 11:16:43 INFO - 'sessionrestore_no_auto_restore', 11:16:43 INFO - 'tabpaint']}, 11:16:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:43 INFO - 'ts_paint', 11:16:43 INFO - 'tpaint', 11:16:43 INFO - 'sessionrestore', 11:16:43 INFO - 'sessionrestore_no_auto_restore', 11:16:43 INFO - 'tabpaint']}, 11:16:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['a11yr', 11:16:43 INFO - 'ts_paint', 11:16:43 INFO - 'tpaint', 11:16:43 INFO - 'sessionrestore', 11:16:43 INFO - 'sessionrestore_no_auto_restore', 11:16:43 INFO - 'tabpaint']}, 11:16:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['a11yr', 11:16:43 INFO - 'ts_paint', 11:16:43 INFO - 'tpaint', 11:16:43 INFO - 'sessionrestore', 11:16:43 INFO - 'sessionrestore_no_auto_restore', 11:16:43 INFO - 'tabpaint']}, 11:16:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['tsvgx', 11:16:43 INFO - 'tsvgr_opacity', 11:16:43 INFO - 'tart', 11:16:43 INFO - 'tscrollx', 11:16:43 INFO - 'cart']}, 11:16:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:43 INFO - 'tsvgr_opacity', 11:16:43 INFO - 'tart', 11:16:43 INFO - 'tscrollx', 11:16:43 INFO - 'cart']}, 11:16:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'talos_options': ['--disable-e10s'], 11:16:43 INFO - 'tests': ['tp5o']}, 11:16:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'tests': ['tp5o']}, 11:16:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'talos_options': ['--disable-e10s', 11:16:43 INFO - '--xperf_path', 11:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:43 INFO - 'tests': ['tp5n']}, 11:16:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:43 INFO - 'talos_options': ['--xperf_path', 11:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:43 INFO - 'tests': ['tp5n']}}, 11:16:43 INFO - 'talos.zip': {'path': '', 11:16:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:43 INFO - Running post-action listener: _resource_record_post_action 11:16:43 INFO - [mozharness: 2017-01-31 19:16:43.629784Z] Finished populate-webroot step (success) 11:16:43 INFO - [mozharness: 2017-01-31 19:16:43.629913Z] Running create-virtualenv step. 11:16:43 INFO - Running pre-action listener: _resource_record_pre_action 11:16:43 INFO - Running main action method: create_virtualenv 11:16:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:43 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 11:16:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:43 INFO - Using real prefix '/tools/python27' 11:16:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:47 INFO - Installing pip.................done. 11:16:47 INFO - Return code: 0 11:16:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:16:47 INFO - Reading from file tmpfile_stdout 11:16:47 INFO - Output received: 11:16:47 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) 11:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:47 INFO - 'HOME': '/Users/cltbld', 11:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PAGER': '/bin/cat', 11:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:16:47 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - 'XPC_FLAGS': '0x0', 11:16:47 INFO - 'XPC_SERVICE_NAME': '0', 11:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:47 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 11:16:47 INFO - Cleaning up... 11:16:47 INFO - Return code: 0 11:16:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:47 INFO - 'HOME': '/Users/cltbld', 11:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PAGER': '/bin/cat', 11:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:16:47 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - 'XPC_FLAGS': '0x0', 11:16:47 INFO - 'XPC_SERVICE_NAME': '0', 11:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:48 INFO - Downloading/unpacking psutil>=3.1.1 11:16:48 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 11:16:48 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 11:16:48 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 11:16:48 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 11:16:48 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 11:16:48 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 11:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:51 INFO - Installing collected packages: psutil 11:16:51 INFO - Running setup.py install for psutil 11:16:51 INFO - building 'psutil._psutil_osx' extension 11:16:51 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 INFO - building 'psutil._psutil_posix' extension 11:16:52 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 11:16:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:16:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:16:52 INFO - ^ 11:16:52 INFO - 1 warning generated. 11:16:52 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 11:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:52 INFO - Successfully installed psutil 11:16:52 INFO - Cleaning up... 11:16:52 INFO - Return code: 0 11:16:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16:52 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')]} 11:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:52 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')]} 11:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:52 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:16:52 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 11:16:52 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 11:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:52 INFO - 'HOME': '/Users/cltbld', 11:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:52 INFO - 'LOGNAME': 'cltbld', 11:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:52 INFO - 'MOZ_NO_REMOTE': '1', 11:16:52 INFO - 'NO_EM_RESTART': '1', 11:16:52 INFO - 'PAGER': '/bin/cat', 11:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:52 INFO - 'PWD': '/builds/slave/test', 11:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:52 INFO - 'SHELL': '/bin/bash', 11:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:16:52 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:52 INFO - 'USER': 'cltbld', 11:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:52 INFO - 'XPC_FLAGS': '0x0', 11:16:52 INFO - 'XPC_SERVICE_NAME': '0', 11:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:53 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 11:16:53 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 11:16:53 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 11:16:53 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 11:16:53 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 11:16:53 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 11:16:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:55 INFO - Installing collected packages: mozsystemmonitor 11:16:55 INFO - Running setup.py install for mozsystemmonitor 11:16:55 INFO - Successfully installed mozsystemmonitor 11:16:55 INFO - Cleaning up... 11:16:56 INFO - Return code: 0 11:16:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:16:56 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 11:16:56 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 11:16:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:16:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:56 INFO - 'HOME': '/Users/cltbld', 11:16:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:56 INFO - 'LOGNAME': 'cltbld', 11:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:56 INFO - 'MOZ_NO_REMOTE': '1', 11:16:56 INFO - 'NO_EM_RESTART': '1', 11:16:56 INFO - 'PAGER': '/bin/cat', 11:16:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:56 INFO - 'PWD': '/builds/slave/test', 11:16:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:56 INFO - 'SHELL': '/bin/bash', 11:16:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:16:56 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:16:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:56 INFO - 'USER': 'cltbld', 11:16:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:56 INFO - 'XPC_FLAGS': '0x0', 11:16:56 INFO - 'XPC_SERVICE_NAME': '0', 11:16:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:16:56 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 11:16:56 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 11:16:56 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 11:16:56 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 11:16:56 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 11:16:56 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 11:16:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16:58 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 11:16:58 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 11:16:58 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 11:16:58 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 11:16:58 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 11:16:58 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 11:16:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:59 INFO - warning: no files found matching '*.txt' 11:16:59 INFO - no previously-included directories found matching 'build' 11:16:59 INFO - no previously-included directories found matching 'dist' 11:16:59 INFO - no previously-included directories found matching '.git*' 11:16:59 INFO - Installing collected packages: jsonschema, functools32 11:16:59 INFO - Running setup.py install for functools32 11:16:59 INFO - warning: no files found matching '*.txt' 11:16:59 INFO - no previously-included directories found matching 'build' 11:16:59 INFO - no previously-included directories found matching 'dist' 11:16:59 INFO - no previously-included directories found matching '.git*' 11:16:59 INFO - Successfully installed jsonschema functools32 11:16:59 INFO - Cleaning up... 11:16:59 INFO - Return code: 0 11:16:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:16:59 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')]} 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:59 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')]} 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:59 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:16:59 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 11:16:59 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 11:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:59 INFO - 'HOME': '/Users/cltbld', 11:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:59 INFO - 'LOGNAME': 'cltbld', 11:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:59 INFO - 'MOZ_NO_REMOTE': '1', 11:16:59 INFO - 'NO_EM_RESTART': '1', 11:16:59 INFO - 'PAGER': '/bin/cat', 11:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:59 INFO - 'PWD': '/builds/slave/test', 11:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:59 INFO - 'SHELL': '/bin/bash', 11:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:16:59 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:59 INFO - 'USER': 'cltbld', 11:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:59 INFO - 'XPC_FLAGS': '0x0', 11:16:59 INFO - 'XPC_SERVICE_NAME': '0', 11:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:00 INFO - Cleaning up... 11:17:00 INFO - Return code: 0 11:17:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:00 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')]} 11:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:00 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')]} 11:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:00 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:17:00 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 11:17:00 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 11:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:00 INFO - 'HOME': '/Users/cltbld', 11:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:00 INFO - 'LOGNAME': 'cltbld', 11:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:00 INFO - 'MOZ_NO_REMOTE': '1', 11:17:00 INFO - 'NO_EM_RESTART': '1', 11:17:00 INFO - 'PAGER': '/bin/cat', 11:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:00 INFO - 'PWD': '/builds/slave/test', 11:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:00 INFO - 'SHELL': '/bin/bash', 11:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:17:00 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:00 INFO - 'USER': 'cltbld', 11:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:00 INFO - 'XPC_FLAGS': '0x0', 11:17:00 INFO - 'XPC_SERVICE_NAME': '0', 11:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:00 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 11:17:00 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 11:17:00 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 11:17:00 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 11:17:00 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 11:17:00 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 11:17:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:02 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 11:17:02 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 11:17:02 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 11:17:02 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 11:17:02 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 11:17:02 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 11:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:03 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 11:17:03 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 11:17:03 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 11:17:03 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 11:17:03 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 11:17:03 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 11:17:04 INFO - Downloading docopt-0.6.1.tar.gz 11:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:04 INFO - Running setup.py install for blobuploader 11:17:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:04 INFO - Running setup.py install for requests 11:17:04 INFO - Running setup.py install for docopt 11:17:04 INFO - Successfully installed blobuploader requests docopt 11:17:04 INFO - Cleaning up... 11:17:05 INFO - Return code: 0 11:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:05 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')]} 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 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')]} 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:17:05 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 11:17:05 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 11:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:05 INFO - 'HOME': '/Users/cltbld', 11:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:05 INFO - 'LOGNAME': 'cltbld', 11:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:05 INFO - 'MOZ_NO_REMOTE': '1', 11:17:05 INFO - 'NO_EM_RESTART': '1', 11:17:05 INFO - 'PAGER': '/bin/cat', 11:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:05 INFO - 'PWD': '/builds/slave/test', 11:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:05 INFO - 'SHELL': '/bin/bash', 11:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:17:05 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:05 INFO - 'USER': 'cltbld', 11:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:05 INFO - 'XPC_FLAGS': '0x0', 11:17:05 INFO - 'XPC_SERVICE_NAME': '0', 11:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RDCADe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-VeLX3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Rr5nMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZB0OGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-1uSnQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-w0pkc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:05 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-041dHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wtR2mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-MLJ5Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-buaeDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-jrWFzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-7L8z5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-JzzeEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-UdW15x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-1qS64d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-qwVe7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:06 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Tdq1yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:07 INFO - Running setup.py install for manifestparser 11:17:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for mozcrash 11:17:07 INFO - Running setup.py install for mozdebug 11:17:07 INFO - Running setup.py install for mozdevice 11:17:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for mozfile 11:17:07 INFO - Running setup.py install for mozhttpd 11:17:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for mozinfo 11:17:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for mozInstall 11:17:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for mozleak 11:17:08 INFO - Running setup.py install for mozlog 11:17:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for moznetwork 11:17:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for mozprocess 11:17:08 INFO - Running setup.py install for mozprofile 11:17:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:09 INFO - Running setup.py install for mozrunner 11:17:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:09 INFO - Running setup.py install for mozscreenshot 11:17:09 INFO - Running setup.py install for moztest 11:17:09 INFO - Running setup.py install for mozversion 11:17:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:09 INFO - Cleaning up... 11:17:09 INFO - Return code: 0 11:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:09 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:17:09 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 11:17:09 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 11:17:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:17:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:09 INFO - 'HOME': '/Users/cltbld', 11:17:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:09 INFO - 'LOGNAME': 'cltbld', 11:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:09 INFO - 'MOZ_NO_REMOTE': '1', 11:17:09 INFO - 'NO_EM_RESTART': '1', 11:17:09 INFO - 'PAGER': '/bin/cat', 11:17:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:09 INFO - 'PWD': '/builds/slave/test', 11:17:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:09 INFO - 'SHELL': '/bin/bash', 11:17:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:17:09 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:17:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:09 INFO - 'USER': 'cltbld', 11:17:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:09 INFO - 'XPC_FLAGS': '0x0', 11:17:09 INFO - 'XPC_SERVICE_NAME': '0', 11:17:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:09 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-bp2yrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Ese7lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-3QX9D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-9lVzdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CdqnsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-e7Aifc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZjEngx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-rEUwQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-QO3hVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:10 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-UEf0jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:11 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)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-d3utY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:11 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)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-X1DkJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:11 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)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-k8gBx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:11 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)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xRz3pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-WYqspw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:11 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)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-M1PJVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:11 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-XuI9El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:11 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)) 11:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:11 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)) 11:17:11 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)) 11:17:11 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)) 11:17:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:11 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 11:17:11 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 11:17:11 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 11:17:11 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 11:17:11 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 11:17:11 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 11:17:14 INFO - Downloading blessings-1.6.tar.gz 11:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:14 INFO - Installing collected packages: blessings 11:17:14 INFO - Running setup.py install for blessings 11:17:14 INFO - Successfully installed blessings 11:17:14 INFO - Cleaning up... 11:17:14 INFO - Return code: 0 11:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:15 INFO - Reading from file tmpfile_stdout 11:17:15 INFO - Current package versions: 11:17:15 INFO - blessings == 1.6 11:17:15 INFO - blobuploader == 1.2.4 11:17:15 INFO - docopt == 0.6.1 11:17:15 INFO - functools32 == 3.2.3-2 11:17:15 INFO - jsonschema == 2.5.1 11:17:15 INFO - manifestparser == 1.1 11:17:15 INFO - mozInstall == 1.12 11:17:15 INFO - mozcrash == 1.0 11:17:15 INFO - mozdebug == 0.1 11:17:15 INFO - mozdevice == 0.48 11:17:15 INFO - mozfile == 1.2 11:17:15 INFO - mozhttpd == 0.7 11:17:15 INFO - mozinfo == 0.9 11:17:15 INFO - mozleak == 0.1 11:17:15 INFO - mozlog == 3.4 11:17:15 INFO - moznetwork == 0.27 11:17:15 INFO - mozprocess == 0.23 11:17:15 INFO - mozprofile == 0.28 11:17:15 INFO - mozrunner == 6.13 11:17:15 INFO - mozscreenshot == 0.1 11:17:15 INFO - mozsystemmonitor == 0.3 11:17:15 INFO - moztest == 0.8 11:17:15 INFO - mozversion == 1.4 11:17:15 INFO - psutil == 3.1.1 11:17:15 INFO - requests == 1.2.3 11:17:15 INFO - wsgiref == 0.1.2 11:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:15 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')]} 11:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:15 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')]} 11:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:15 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 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:17:15 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 11:17:15 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 11:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:15 INFO - 'HOME': '/Users/cltbld', 11:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:15 INFO - 'LOGNAME': 'cltbld', 11:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:15 INFO - 'MOZ_NO_REMOTE': '1', 11:17:15 INFO - 'NO_EM_RESTART': '1', 11:17:15 INFO - 'PAGER': '/bin/cat', 11:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:15 INFO - 'PWD': '/builds/slave/test', 11:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:15 INFO - 'SHELL': '/bin/bash', 11:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:17:15 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:15 INFO - 'USER': 'cltbld', 11:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:15 INFO - 'XPC_FLAGS': '0x0', 11:17:15 INFO - 'XPC_SERVICE_NAME': '0', 11:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 INFO - Cleaning up... 11:17:16 INFO - Return code: 0 11:17:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106963490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c34d28f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, '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.be3p9U6tHC/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.c8VPXjwtFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 11:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:16 INFO - 'HOME': '/Users/cltbld', 11:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:16 INFO - 'LOGNAME': 'cltbld', 11:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:16 INFO - 'MOZ_NO_REMOTE': '1', 11:17:16 INFO - 'NO_EM_RESTART': '1', 11:17:16 INFO - 'PAGER': '/bin/cat', 11:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:16 INFO - 'PWD': '/builds/slave/test', 11:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:16 INFO - 'SHELL': '/bin/bash', 11:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:17:16 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:16 INFO - 'USER': 'cltbld', 11:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:16 INFO - 'XPC_FLAGS': '0x0', 11:17:16 INFO - 'XPC_SERVICE_NAME': '0', 11:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:16 INFO - Cleaning up... 11:17:16 INFO - Return code: 0 11:17:16 INFO - Running post-action listener: _resource_record_post_action 11:17:16 INFO - Running post-action listener: _start_resource_monitoring 11:17:16 INFO - Starting resource monitoring. 11:17:16 INFO - [mozharness: 2017-01-31 19:17:16.796810Z] Finished create-virtualenv step (success) 11:17:16 INFO - [mozharness: 2017-01-31 19:17:16.797798Z] Running install step. 11:17:16 INFO - Running pre-action listener: _resource_record_pre_action 11:17:16 INFO - Running main action method: install 11:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:17 INFO - Reading from file tmpfile_stdout 11:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:17 INFO - Reading from file tmpfile_stdout 11:17:17 INFO - Output received: 11:17:17 INFO - Usage: mozinstall [options] installer 11:17:17 INFO - Options: 11:17:17 INFO - -h, --help show this help message and exit 11:17:17 INFO - -d DEST, --destination=DEST 11:17:17 INFO - Directory to install application into. [default: 11:17:17 INFO - "/builds/slave/test"] 11:17:17 INFO - --app=APP Application being installed. [default: firefox] 11:17:17 INFO - mkdir: /builds/slave/test/build/application 11:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:17:38 INFO - Reading from file tmpfile_stdout 11:17:38 INFO - Output received: 11:17:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:17:38 INFO - Running post-action listener: _resource_record_post_action 11:17:38 INFO - [mozharness: 2017-01-31 19:17:38.556585Z] Finished install step (success) 11:17:38 INFO - [mozharness: 2017-01-31 19:17:38.556724Z] Running run-tests step. 11:17:38 INFO - Running pre-action listener: _resource_record_pre_action 11:17:38 INFO - Running main action method: run_tests 11:17:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:38 INFO - 2017-01-31 11:17:38.571 screenresolution[1626:7364] starting screenresolution argv=screenresolution get 11:17:38 INFO - 2017-01-31 11:17:38.573 screenresolution[1626:7364] Display 0: 1600x1200x32@60 11:17:38 INFO - 2017-01-31 11:17:38.579 screenresolution[1627:7366] starting screenresolution argv=screenresolution list 11:17:38 INFO - Available Modes on Display 0 11:17:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:38 INFO - Intel Iris: 11:17:38 INFO - Chipset Model: Intel Iris 11:17:38 INFO - Type: GPU 11:17:38 INFO - Bus: Built-In 11:17:38 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:38 INFO - Vendor: Intel (0x8086) 11:17:38 INFO - Device ID: 0x0a2e 11:17:38 INFO - Revision ID: 0x0009 11:17:38 INFO - Displays: 11:17:38 INFO - Display: 11:17:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:38 INFO - Display Serial Number: 1600x1200 60 11:17:38 INFO - Main Display: Yes 11:17:38 INFO - Mirror: Off 11:17:38 INFO - Online: Yes 11:17:38 INFO - Rotation: Supported 11:17:38 INFO - Return code: 0 11:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:38 INFO - Python 2.7.3 11:17:38 INFO - Return code: 0 11:17:38 INFO - grabbing minidump binary from tooltool 11:17: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')]} 11:17:38 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 0x106777d30>, '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 0x1065dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10676fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:38 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 11:17:38 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 11:17:38 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 11:17:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:38 INFO - Return code: 0 11:17:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:17:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:17:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 11:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 11:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.be3p9U6tHC/Render', 11:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:38 INFO - 'HOME': '/Users/cltbld', 11:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:38 INFO - 'LOGNAME': 'cltbld', 11:17:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:38 INFO - 'MOZ_NO_REMOTE': '1', 11:17:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:38 INFO - 'NO_EM_RESTART': '1', 11:17:38 INFO - 'PAGER': '/bin/cat', 11:17:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:38 INFO - 'PWD': '/builds/slave/test', 11:17:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:38 INFO - 'SHELL': '/bin/bash', 11:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8VPXjwtFx/Listeners', 11:17:38 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 11:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:38 INFO - 'USER': 'cltbld', 11:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:38 INFO - 'XPC_FLAGS': '0x0', 11:17:38 INFO - 'XPC_SERVICE_NAME': '0', 11:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 11:17:39 INFO - mozversion application_buildid: 20170131083709 11:17:39 INFO - mozversion application_changeset: 4217fbc0d4feea059a47b6360c627061ab0dd451 11:17:39 INFO - mozversion application_display_name: Firefox 11:17:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:39 INFO - mozversion application_name: Firefox 11:17:39 INFO - mozversion application_remotingname: firefox 11:17:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:17:39 INFO - mozversion application_vendor: Mozilla 11:17:39 INFO - mozversion application_version: 52.0 11:17:39 INFO - mozversion platform_buildid: 20170131083709 11:17:39 INFO - mozversion platform_changeset: 4217fbc0d4feea059a47b6360c627061ab0dd451 11:17:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:17:39 INFO - mozversion platform_version: 52.0 11:17:39 INFO - using testdate: 1485890259 11:17:39 INFO - actual date: 1485890259 11:17:39 INFO - starting webserver on 'localhost:49243' 11:17:39 INFO - SUITE-START | Running 2 tests 11:17:39 INFO - TEST-START | dromaeo_css 11:17:39 INFO - operating with platform_type : mac_ 11:17:39 INFO - Initialising browser for dromaeo_css test... 11:17:39 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpGMZnM8/profile http://localhost:49243/getInfo.html) 11:17:42 INFO - PROCESS | 1637 | 2017-01-31 11:17:42.607 plugin-container[1641:7549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904f, name = 'com.apple.tsm.portname' 11:17:42 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:17:42 INFO - PROCESS | 1637 | 2017-01-31 11:17:42.608 plugin-container[1641:7549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b23, name = 'com.apple.CFPasteboardClient' 11:17:42 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:17:42 INFO - PROCESS | 1637 | 2017-01-31 11:17:42.608 plugin-container[1641:7549] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:17:42 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 11:17:42 INFO - PROCESS | 1637 | colorDepth:24 11:17:42 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 11:17:42 INFO - PROCESS | 1637 | __metrics 11:17:42 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 11:17:43 INFO - TEST-INFO | 1637: exit 0 11:17:43 INFO - Browser initialized. 11:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:43 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpGMZnM8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:46 INFO - PROCESS | 1642 | 2017-01-31 11:17:46.071 plugin-container[1643:7676] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 11:17:46 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:17:46 INFO - PROCESS | 1642 | 2017-01-31 11:17:46.072 plugin-container[1643:7676] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 11:17:46 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:17:46 INFO - PROCESS | 1642 | 2017-01-31 11:17:46.072 plugin-container[1643:7676] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:17:55 INFO - PROCESS | 1642 | RSS: Main: 177143808 11:17:55 INFO - PROCESS | 1642 | 11:20:57 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 11:20:59 INFO - PROCESS | 1642 | RSS: Main: 182534144 11:20:59 INFO - PROCESS | 1642 | 11:24:01 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 11:24:01 INFO - PROCESS | 1642 | RSS: Main: 191205376 11:24:01 INFO - PROCESS | 1642 | 11:27:03 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 11:27:04 INFO - PROCESS | 1642 | RSS: Main: 197718016 11:27:04 INFO - PROCESS | 1642 | 11:30:06 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 11:30:06 INFO - PROCESS | 1642 | RSS: Main: 201084928 11:30:06 INFO - PROCESS | 1642 | 11:33:09 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 11:33:10 INFO - PROCESS | 1642 | RSS: Main: 202649600 11:33:10 INFO - PROCESS | 1642 | 11:36:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 11:36:12 INFO - PROCESS | 1642 | RSS: Main: 203350016 11:36:12 INFO - PROCESS | 1642 | 11:36:12 INFO - PROCESS | 1642 | __start_tp_report 11:36:12 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 11:36:12 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 11:36:12 INFO - PROCESS | 1642 | |i|pagename|runs| 11:36:12 INFO - PROCESS | 1642 | |0;dojo.html;3483.3729928612856;3527.5590551181117;3560.8041557714314;3570.1610121621416;3573.088862340103;5900.852478688035;5940.43565861243;5978.252718410199;5985.551083668721;5991.161237426758;5983.22218111646;6063.848403789896;6073.60521566099;6078.878422431549;6082.361352058037;4463.509014008457;5365.597580181482;5398;5437.673739575618;5468.3711373192;4500.347449619803;5495.945040549584;5505.284313039299;5515.972420137914;5521.972390138044;4456.8885777855485;4521.276595744682;5335.466453354653;5357.223202635615;5432.565394768429;5387.46125387464;5428.5928555358305;5441.59188060897;5453.291072160594;5480.205370221335;5330.466953304677;5356.866078348034;5357.812476563302;5433.7283135843445;5478.342598888119;6073.939260607382;6086.513078953673;6109.419605137505;6169.907451388232;6192.566520343577;5837.5913686041995;6263.31103578606;6335.493160547145;6370.299267080617;6391.552591318609;6470.7088181031495;6482.675866206718;6487.643179625119;6491.415772580443;6512.902306465407;5966.970165149147;6048.153258543719;6161.7227224775;6179.227596550431;6206.06908963659;6466.676666166767;6508.60948343101;6528.771492997722;6608.636524991171;6615.073889655452;6315.210598675166;6345.952917768609;6350.269718982377;6355.046742988497;6381.489480841522;6237.937620623827;6364.554481186273;6465.3857883501;6467.773627923;6478.870422591522;6255.624662520263;6271.717772700239;6319.9368006320265;6320.336364681642;6383.585066970632;5236;6268.279147897959;6336.112944187817;6350.555461117678;6394.136791533177;5151.6136289778415;5154.278401023859;5163.870903227375;5170.71561064145;5176.767045482962;4499.302608095751;4519.186546421675;4546.02260513991;4556.179887620194;4610.76946152691;5997.370276121032;6097.146399504073;6127.128444391265;6139.78118599196;6144.941444616014;6266.49868010558;6426.485881129592;6459.224893012774;6469.061986012002;6486.091947127406;5925.703714814242;6107.969460152671;6111.174991376196;6137.877242455126;6153.107799369156;5606.074997625427;5612.971935140298;5630.324361076697;5634.577406694514;5642.266505354278;6573.80278591643;6589.901151482732;6616.933830661632;6620.503462240351;6639.3692599203;6249.7187626557825;6278.968605156945;6282.780102696383;6299.244090709144;6342.016987366966;6550.901736474052;6593.307702691149;6620.602763834186;6621.1392518972225;6621.503387246072;6338.809835704937;6340.270868849957;6347.746090156342;6347.809565713036;6367.808965731036;6106.491003209229;6261.624302541862;6271.3728627136925;6322.589031712924;6358.332375100548;6248.750049997949;6267.2165979252595;6270.15352927349;6272.435480806749;6284.937150628435;5701.831124619526;6008.639481631116;6192;6233.75064997395;6262.655553944577;5580.437477506305;5598.468145526169;6083.057126145454;6124.356942520971;6127.342242870559;6188.535859810442;6251.53113516479;6288.723667905685;6322.778702745381;6330.746770129143;6178.969105154445;6224.253089629274;6227.346128656426;6256.092866534418;6263.498920086291 11:36:12 INFO - PROCESS | 1642 | |1;ext.html;476.87124476391375;485.65033176113207;521.1505246448289;546.8004178474857;587.5241054745653;32473.5128973065;34680.4797928031;37628.87113386599;40947.99999999996;40969.795151024206;41188.79405602968;41329.79335103328;42362.152756944844;42365;42377.15245695092;8345.873307103555;9505.00197479265;9629.374090684118;9694.36986595869;9716.61133554657;9547.474888881108;9575.569099390545;9581.712548623518;9659.90340096597;9683.322167448281;9553.856692149624;9620.374675646095;9633.08485693858;9643.035696430372;9691.127798498133;9530.761730956712;9588.760280992961;9617.086376794194;9632.61469541221;9638.566264518113;8421.747347579583;9617.855732164024;9619.326647134703;9651.903480965171;9786.902130978742;31767.84116079428;38317.808410958045;38995.805020975;39052.60947390547;39193.60806391928;3422.435298175823;3476.774009689362;3588;3609.350316942949;3908.0998359993887;30010.84994575013;30971.380572388425;31611.84194079038;31625.683743162735;31674.524882126556;3226;3228.2252259457796;3332.750043746729;3341.031100980713;3363.445031569788;509500;511382.4430877859;513922;515365.9999999963;516455;59785;60145.69927150336;60476.39523604796;60487;60601.696991514764;62843;63073.68463157655;63104.684476578244;63109.68445157745;63288.68355658192;16146;16152.838471615369;16587.66824663524;16625.3349866004;16866.578335541464;13044.804327935088;13084.803727944089;13121.409536570878;13152.473901043852;13166.605001849959;15760;16308.918455407647;16310.75533866993;16379.836201638069;16394.26225819841;5403.594730395236;6269.937300627026;6313.558050936482;6314.463270621956;6348.396902294275;865.8874346334936;925.754859713684;934.2806039349663;993.0813997052697;1103.2994048778924;30335.848320758698;30632.42286191747;30749.692503074682;31027.914023009085;31241.59412826428;1092.7158938676002;1093.868735751715;1141.5456767948976;1174.4890972427022;1189.3577468167266;15756.897017208914;15900.840991589936;15964.004499437571;16115.274812633459;16117;620802;631602;637796;638299;638470;59289.703551481965;59500.40499594949;59586.51033724192;59683.701581492685;59769.70115149483;1200.7572162811448;1341.3829638366265;1341.617638972888;1379.2483096712315;1386.3276310989363;29422.705772941998;30135.849320754132;30277.94027209037;30428.84785576058;30723.385532289674;49852;50123;50126.74936625294;50269;50302.4909252723;589752.051239741;596226;596398;597029;598454;39666.80166599149;40261.59738402579;41203.38194927138;41229.793851031754;41260.1747965045;46225;47280;47528.524714753796;48180.27729583989;48270.758646206545;38704.58135860975;38712;39136;39307.80346098251;39892.20215595614;38486.80756596199;38915.02712432212;38987.95397428934;39074.82775516739;39242.82271531859;38287.23425531529;39005.414918776805;39121.21757564776;39132.21735565216;40313.19373612453;27715.752791124043;33191.66808331886;35060.824695877374;35103.771368001995;36242.27515449729;25671.743282566935;26235.60646590341;26333.210003699918;26380.0766973155;26657 11:36:12 INFO - PROCESS | 1642 | |2;jquery.html;383.09589369088945;384.5886292943248;388.14607862702053;393.6830851164813;412.97315674481155;15536.300866461008;16419.83580164201;19371.903140484297;20569.99999999998;20677.586448271046;16933.745993810073;20585;20607.896960515176;20839.583208335825;20886.164553417882;4713.7643117844145;5715.8571035724235;5846.064629659255;5884.440978107073;5964.075568286922;5883.8529036774;5889.6171748836405;5900.085486749539;5906.2912450506;5918.970405147989;5820.534357251431;6030.517558595324;6033.366496517869;6119.3574674659185;6212.409821066992;5301.734913254341;5974.312954010279;6080.726367313481;6204.317525072239;6699.363560461748;5852.648841069549;5931.822045338647;5945.8810823783715;5951.107333899907;5952.761889524414;13014.219146851125;20326.390208293626;23064.654030189562;23100.65349019766;23355;2280.4982903761147;2286.634138537826;2361.1853910401055;2478.7893029092547;2905.7675385969073;9786.657466988692;10474.738131546696;14258.287085645676;15030.398784048624;15792.605184870356;1879.4079864842531;1897.4118023412786;1906.818852209038;1936.719175719527;1958.6474434601766;120996;123185;123892.76107238902;126166.36916815449;130204.34897825451;11417.828732569018;11429.542818287342;11677.299362038304;11776.175667703179;11795.41022948849;13205;14463.638409039859;14597.635059123395;14728.705425891421;14738.778918316233;7055.858882822417;7550.244975502405;8543.871841922377;8690;8827.867581986275;7656.80857978555;7974.162712915177;8668.393212475192;8801.691940782042;8822.426542274732;4544.636429085665;4544.818207271672;4615.215413379734;4623.815047398134;4716.773638853922;1984.6725290327222;1991.9502012449516;1996.5342801639963;2000.5898790747863;2044.2231951858198;888.3648191542949;893.3523195683077;935.5088578496208;964.8855571814565;980.9901900981041;18776.248950042118;19681.704774428395;20344;20620.484487887923;20687.06908189135;847.6778824046946;950.95720692569;970.3644113105927;979.8579206015088;1006.8288390973405;8032.39757018226;11150.49822757978;11155.27490713101;11188.944055279671;11305.604303849326;607751;612222;620700;632772;636027;122757;126464;127484.36257818837;131271;134791.32604336916;986.9654562090292;1020.7550187954837;1053.5259133390005;1057.7990181865575;1060.6022741471947;18700.81299186991;19342.032898355308;19571.82569045805;19593.216271348985;19610.313639022566;47374.28938565993;55124.72437637786;56723.432765671816;57413.703451863126;58335.70832145982;67513;84476.31047378895;84773.57613211895;86230.13769862472;86421;6724.4284235840505;6783.660816959231;7692.615369231628;8014.599270036591;8180.7954801130445;11138.88861111411;11190.824963378727;11357.308874615617;12228.571999979958;12770.850623443936;10817.945910270399;10880.075193608633;10905.672829815117;10955.397453140155;11101;10720.410377429316;10733.838992414963;10781.245312828027;10862.239643224899;11017.614383496539;9966.700998970042;10901.836472453078;11071.114310855273;11366.488508016993;11478.655640330804;6927.376536111774;7320.084989376328;7415.2214017527385;7423.962880185564;8019;9326.813463730552;10748.140148787921;10850.945745271223;10874.510647021061;10891.292066015683 11:36:12 INFO - PROCESS | 1642 | |3;mootools.html;1235.6725467751046;1368.5825823123946;1573.4178354009018;1846.1230915315236;1901.7337572739818;7804.531728096318;8000.959995200031;8318.875216871744;8776.648934042638;8797.912020879798;8166.346692264619;8445.40882138249;8466.280366168867;8582.184692454222;8597.699080532167;2371.739108698046;2410.927672169838;2412.457197130649;2415.879206039691;2417.190241269177;2396.3529846941315;2429.2955043037587;2438.5366780311683;2451.595486744685;2475.962860557093;2008.186684392816;2111.7782632823564;2407.3379820549403;2407.41018450479;2418.093215044358;2211.3365990202874;2394.347899949047;2411.9276421707377;2414.2153800014976;2414.3360575841784;2155.622766015941;2300.2639155470256;2414.4929564791414;2417.10567090176;2447.4003869052017;7533.849323013564;8123.822045803385;8599.355048371335;8661.956690216572;8676.132386761274;5203.4796520348045;5326.547243484309;5328.307320048408;5355.705436201008;5377.46225377463;3537.2571759930447;3583.874564390234;3607.3326434609417;3642.653947874974;3653.050206946213;955.7849483866144;1064.2231171244957;1069.673749506408;1100.5707773968159;1104.618906477264;11044.779104417867;11100.55597776088;11182.888171118266;11198.160137989684;11218.551257949672;4572.497025327211;4733.763311834395;4792.472827988919;4799.472058073609;4818.349522814376;9668.274879383933;9685.467299298465;9689.806203875884;9701.126898579161;9711.077447642463;5282.867928301746;5300.416954135042;5338.9466105339225;5350.5184533392185;5418.864528386822;4448.199324121689;4486.528914463999;4840.782164802592;4921.7785199666105;4971;3936.488256526633;3955.584663610337;3983.940240896389;4051.6758659307184;4059.330210515291;1293.6765808547864;1315.9407826647632;1316.8419789625307;1326.204277433532;1326.840779106494;780.4731806030907;876.509154873273;904.7240591619619;917.202034230224;921.3412410126791;5601.831945041656;5620.185073164368;5639.6334238274385;5845.976954033027;5914.76340946366;921.5209588610318;935.4424882570444;946.4084946908182;966.9033096690275;969.6896992962185;3738.981305093457;3877.8448862045766;3948.466956960831;3968.206358728266;3991;9959.452230127268;9969.35199212049;10143.188544916537;10268;10287.845682314772;10236.385816851012;10263.74340641475;10303.330283531546;10307.587696492206;10363.896361036444;6357.4596159326975;7687.846243075107;8105.31104856082;8138.674453021931;8150.307223885918;5701.287339082614;5751.9137212941005;5821.126830975388;5836.795712150054;5897.646141231368;9316.021817709043;9584.28117891147;9608.66369677058;9631.855522167032;9776.315657903879;8075.757727268191;9564;9699.806003880023;9833.803323933624;9871.358361706467;7174.713011479483;7240.022596949555;7331.963340183265;7346.742863999734;7428.888566671396;8189.50862948225;8226.42415030966;8248;8274.213949674771;8311.6675332986;7096.183938847099;7202.639868006683;7229.349358557755;7329.340359367682;7345.412367010519;7163.8567228656175;7254.202037775735;7276.890846637199;7280.1991780903;7286.271372862671;6738.225104113089;6781.728730850711;6784.423324017514;6840;6880.896786548105;4874.561289483963;4882.7558622068045;4898.853034408973;4902.63230257725;4985.825496107619;3831.463595096633;4835.927461088017;4868.294097355934;4896.92654610174;4943.30793688891 11:36:12 INFO - PROCESS | 1642 | |4;prototype.html;315.25756842635604;316.381474217904;324.1006207773429;327.32570903937875;328.6811792561215;5523.342997100864;5586.8490631107015;5756.309242890854;5791.594588378815;5818.447247511485;4433.64530837533;5173.922391164127;5345.305110335651;5347.866303342418;5381.300430943981;4285.314349704048;4293.849715259967;4305.526392096883;4317.395564620955;4324.1838427860375;3707.8876337098895;4164.354525048622;4224.155168966204;4252.532221455637;4298.161858437606;4211.978940105295;4240.5547417521175;4242.6605871530355;4252.914941701164;4275.786210689469;4253.575052357464;4271.273883439822;4277.850275240352;4291.656667466611;4297.73216901015;3508.7368447366293;3621.573545724371;3659.5242618459697;3667.991302391837;3713.57293911201;5226.608004399647;5510.283663123809;5524.8342549723575;5550.611457197998;5562.527185189264;4089.425571155097;4856.781444834991;4886.218205087169;4893.559579637814;4923.433805112422;5486.478784515464;5649.717514124277;5889.79385721502;5963.13534537494;5988.071848863389;3636.818159092035;3749.8687545936036;4031.3952907064177;4052.5947405259535;4053.5541090480024;4696.802315409583;5889.7644094236175;6250.7812226572305;6260.467860231885;6303.5902666327;3897.2595206911164;3973.4635824163947;4066.674666026711;4173.373993900939;4231.703780735381;3275.1484614000533;4140.254754144283;4276.935845962313;4290.399344091829;4322.675799315064;4360.495629007987;4985.376827896513;5002.374703162105;5011.398632164163;5016.573591244712;5759.112598995661;5995.640261584232;6038.373307611203;6062.9090563641585;6099.420555047263;1172.9941350293363;1229.2133034857698;1345.6837643153851;1413.964650883736;1418.3121186224673;885.6014793343021;960.596549449233;973.0464145137663;978.6085565773748;980.9797810277374;4990.850274491771;5410.540104091197;5417;5440.973679477159;5445.401005889349;5803.506701930383;5848.8537786554825;5859.472647461749;5873.941260587425;5910.704464776744;4508.954910450919;4559.293309537027;4791.784369703371;5209.53114219722;5334.306540149756;2779;2853.7146285371296;3058.525928481089;3096.0866544369464;3100.9844950775555;4796.640251981115;5962.612430192024;6008.746719980008;6067.969660151759;6118.174046503754;5410.296661433988;5779.942200578024;5943.64338139713;6008.506469814978;6014.548908831855;5095.566876815512;5251.002309561171;5602.943970560405;6076.118962750465;6103.328633850273;4646;5831.446012628793;5872.856407411349;5908;5937.248511688976;5278.841634750964;5762.0121058234845;5763.884722305615;5776.782948447572;5787.884242315046;4760.952390476189;5495.587830912617;5719.971400142973;6026.819195424145;6080.48315893154;3852.8073596320633;3979.303621866104;4032.3145065338376;4033;4059.7970101494216;5183.486009285569;5395.352557692945;5438.184272359178;5830.708464576839;5959.970200148971;4574.748388838646;5070.797168113234;5355.30381050461;5446.836594902159;5730.341010783646;5464.371597266365;5611.971940140274;5776.220210271559;6045.304789949037;6049.637021778707;4607.6083532900075;5167.793288268427;5187.662801918014;5187.948120518898;5190.754218987491;5282.524572788468;5540.501354878081;6005.39946005396;6047.9155630629575;6092.664903430354;5588.050031494575;5810.622309549865;5897.321807992136;5946.780909913544;5958.940410595838 11:36:12 INFO - PROCESS | 1642 | |5;yui.html;735.922728113548;777.2848978939376;781.6165387264542;816.4652152839892;830.9626066826991;14094.590540945901;14431.422743090277;14874.925625371858;15115.470958516455;15199.392024319028;12379.814302785466;13757.65605859854;13768.518101866437;13776.586702398945;13780;848.9235968762811;851.7189327521918;883.1036497954581;888.5823662878469;894.8523493623544;887.183790912359;895.0557162193883;898.6630013744846;902.7878448564582;904.7873749668822;914.0448231597996;921.1801496667937;924.7456949338952;926.4811705444939;927.1423932862109;897.5332826930025;908.0102688070035;916.8945571259324;918.3433844800966;919.5402298850574;672.2336536348566;682.0042737603105;684.4558575932145;684.866451042047;685.9348361905611;14500.274986250644;14565.271736413137;14823.258837058213;14933.551993440215;15040.473583424528;13341.132826366254;13721.176729396268;14010.789838152436;14096.647583810383;14184.0780349278;12475.064370172182;12681.302528360937;12847.614571562868;13016.869831301756;13095.738085238338;4606.5393460654;4640.071985602859;4735.479097299294;4870.001649661811;4878;88437.55781221052;91926.54036729774;92301;92977.53511232468;94396.52801735948;10977.341359518454;11129.944350278196;11144.665660030212;11150.721231969266;11187.384693841754;20847.791522084888;20868.686969695467;20922.058507367205;21039.78960210409;21100.261490847748;7428.368588669916;7665.3101220890385;7712.730054448068;7830.9934642468725;8097.473664211925;3796.6583007529457;4367.039251364695;4400.44994375703;4412.845550405785;4459.0858873930765;3315.303786204876;3420.504026916083;3430.691237788611;3435.1068722132427;3742.2328422673286;568.9203511508392;708.1360739897317;714.4427346669606;714.6319645382632;717.1573401253506;603.3483837455537;659.591053546804;665.3346653346654;673.6631684157921;693.2616763147232;7604.9353090567365;8854.734357969272;9408.670696525589;9703;9781.217502599775;551.2805788446117;592.8547505861005;655.783591414832;658.6147103944246;675.9155105611799;4533;4678.625709943196;4686.156491831503;4691.390119284471;4723.5984941279685;79362.6031869837;81039;82254.58872705598;97841.0215897832;98439.50780246053;87591;95837.52081239689;106889.4655526733;107514.92485075205;112658;88624;88810;90159.54920225489;92139;93584;8824.249938755278;9152.679656212;9167.816643667224;9192.31057670664;9242.399244049115;56718.14922776079;57617;59542.70228648829;59860;60943;81615;81984;83635;84988.57505712431;86694.56652716696;11872.52509899629;12091.093168012258;12119.636410907688;12138.696532586402;12184.20802647825;10943.726406839893;12757.872421276039;12775.80836287475;12889.419976100911;13042.934785326013;12142;12276.631701048982;12321.44553495077;12503.499860005863;12754.68113297175;12013.939930300292;12199.268043917393;12226.327551984727;12328.890399864054;12724.236545807282;11377.943110284396;12154.392280385768;12189.207701499374;12212;12231.266124032587;10128.544215510172;10658.360498369813;10677.252592318773;10756.838647420138;10960.725981850517;9935.950320248641;10434.947825260826;10446.738831529272;10474.633387831389;10490.31812932157 11:36:12 INFO - PROCESS | 1642 | __end_tp_report 11:36:12 INFO - PROCESS | 1642 | __start_cc_report 11:36:12 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,352 11:36:12 INFO - PROCESS | 1642 | __end_cc_report 11:36:12 INFO - PROCESS | 1642 | __startTimestamp1485891372984__endTimestamp 11:36:12 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | ------- Summary: start ------- 11:36:13 INFO - PROCESS | 1642 | Number of tests: 6 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5922.78 Median:6178.97 stddev:673.29 (10.9%) stddev-sans-first:647.59 11:36:13 INFO - PROCESS | 1642 | Values: 3483.4 3527.6 3560.8 3570.2 3573.1 5900.9 5940.4 5978.3 5985.6 5991.2 5983.2 6063.8 6073.6 6078.9 6082.4 4463.5 5365.6 5398.0 5437.7 5468.4 4500.3 5495.9 5505.3 5516.0 5522.0 4456.9 4521.3 5335.5 5357.2 5432.6 5387.5 5428.6 5441.6 5453.3 5480.2 5330.5 5356.9 5357.8 5433.7 5478.3 6073.9 6086.5 6109.4 6169.9 6192.6 5837.6 6263.3 6335.5 6370.3 6391.6 6470.7 6482.7 6487.6 6491.4 6512.9 5967.0 6048.2 6161.7 6179.2 6206.1 6466.7 6508.6 6528.8 6608.6 6615.1 6315.2 6346.0 6350.3 6355.0 6381.5 6237.9 6364.6 6465.4 6467.8 6478.9 6255.6 6271.7 6319.9 6320.3 6383.6 5236.0 6268.3 6336.1 6350.6 6394.1 5151.6 5154.3 5163.9 5170.7 5176.8 4499.3 4519.2 4546.0 4556.2 4610.8 5997.4 6097.1 6127.1 6139.8 6144.9 6266.5 6426.5 6459.2 6469.1 6486.1 5925.7 6108.0 6111.2 6137.9 6153.1 5606.1 5613.0 5630.3 5634.6 5642.3 6573.8 6589.9 6616.9 6620.5 6639.4 6249.7 6279.0 6282.8 6299.2 6342.0 6550.9 6593.3 6620.6 6621.1 6621.5 6338.8 6340.3 6347.7 6347.8 6367.8 6106.5 6261.6 6271.4 6322.6 6358.3 6248.8 6267.2 6270.2 6272.4 6284.9 5701.8 6008.6 6192.0 6233.8 6262.7 5580.4 5598.5 6083.1 6124.4 6127.3 6188.5 6251.5 6288.7 6322.8 6330.7 6179.0 6224.3 6227.3 6256.1 6263.5 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:71552.68 Median:40630.60 stddev:155713.56 (383.2%) stddev-sans-first:156058.93 11:36:13 INFO - PROCESS | 1642 | Values: 476.9 485.7 521.2 546.8 587.5 32473.5 34680.5 37628.9 40948.0 40969.8 41188.8 41329.8 42362.2 42365.0 42377.2 8345.9 9505.0 9629.4 9694.4 9716.6 9547.5 9575.6 9581.7 9659.9 9683.3 9553.9 9620.4 9633.1 9643.0 9691.1 9530.8 9588.8 9617.1 9632.6 9638.6 8421.7 9617.9 9619.3 9651.9 9786.9 31767.8 38317.8 38995.8 39052.6 39193.6 3422.4 3476.8 3588.0 3609.4 3908.1 30010.8 30971.4 31611.8 31625.7 31674.5 3226.0 3228.2 3332.8 3341.0 3363.4 509500.0 511382.4 513922.0 515366.0 516455.0 59785.0 60145.7 60476.4 60487.0 60601.7 62843.0 63073.7 63104.7 63109.7 63288.7 16146.0 16152.8 16587.7 16625.3 16866.6 13044.8 13084.8 13121.4 13152.5 13166.6 15760.0 16308.9 16310.8 16379.8 16394.3 5403.6 6269.9 6313.6 6314.5 6348.4 865.9 925.8 934.3 993.1 1103.3 30335.8 30632.4 30749.7 31027.9 31241.6 1092.7 1093.9 1141.5 1174.5 1189.4 15756.9 15900.8 15964.0 16115.3 16117.0 620802.0 631602.0 637796.0 638299.0 638470.0 59289.7 59500.4 59586.5 59683.7 59769.7 1200.8 1341.4 1341.6 1379.2 1386.3 29422.7 30135.8 30277.9 30428.8 30723.4 49852.0 50123.0 50126.7 50269.0 50302.5 589752.1 596226.0 596398.0 597029.0 598454.0 39666.8 40261.6 41203.4 41229.8 41260.2 46225.0 47280.0 47528.5 48180.3 48270.8 38704.6 38712.0 39136.0 39307.8 39892.2 38486.8 38915.0 38988.0 39074.8 39242.8 38287.2 39005.4 39121.2 39132.2 40313.2 27715.8 33191.7 35060.8 35103.8 36242.3 25671.7 26235.6 26333.2 26380.1 26657.0 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:35847.63 Median:23082.65 stddev:103867.13 (450.0%) stddev-sans-first:104124.37 11:36:13 INFO - PROCESS | 1642 | Values: 383.1 384.6 388.1 393.7 413.0 15536.3 16419.8 19371.9 20570.0 20677.6 16933.7 20585.0 20607.9 20839.6 20886.2 4713.8 5715.9 5846.1 5884.4 5964.1 5883.9 5889.6 5900.1 5906.3 5919.0 5820.5 6030.5 6033.4 6119.4 6212.4 5301.7 5974.3 6080.7 6204.3 6699.4 5852.6 5931.8 5945.9 5951.1 5952.8 13014.2 20326.4 23064.7 23100.7 23355.0 2280.5 2286.6 2361.2 2478.8 2905.8 9786.7 10474.7 14258.3 15030.4 15792.6 1879.4 1897.4 1906.8 1936.7 1958.6 120996.0 123185.0 123892.8 126166.4 130204.3 11417.8 11429.5 11677.3 11776.2 11795.4 13205.0 14463.6 14597.6 14728.7 14738.8 7055.9 7550.2 8543.9 8690.0 8827.9 7656.8 7974.2 8668.4 8801.7 8822.4 4544.6 4544.8 4615.2 4623.8 4716.8 1984.7 1992.0 1996.5 2000.6 2044.2 888.4 893.4 935.5 964.9 981.0 18776.2 19681.7 20344.0 20620.5 20687.1 847.7 951.0 970.4 979.9 1006.8 8032.4 11150.5 11155.3 11188.9 11305.6 607751.0 612222.0 620700.0 632772.0 636027.0 122757.0 126464.0 127484.4 131271.0 134791.3 987.0 1020.8 1053.5 1057.8 1060.6 18700.8 19342.0 19571.8 19593.2 19610.3 47374.3 55124.7 56723.4 57413.7 58335.7 67513.0 84476.3 84773.6 86230.1 86421.0 6724.4 6783.7 7692.6 8014.6 8180.8 11138.9 11190.8 11357.3 12228.6 12770.9 10817.9 10880.1 10905.7 10955.4 11101.0 10720.4 10733.8 10781.2 10862.2 11017.6 9966.7 10901.8 11071.1 11366.5 11478.7 6927.4 7320.1 7415.2 7424.0 8019.0 9326.8 10748.1 10850.9 10874.5 10891.3 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5563.16 Median:5327.43 stddev:3036.62 (57.0%) stddev-sans-first:3027.71 11:36:13 INFO - PROCESS | 1642 | Values: 1235.7 1368.6 1573.4 1846.1 1901.7 7804.5 8001.0 8318.9 8776.6 8797.9 8166.3 8445.4 8466.3 8582.2 8597.7 2371.7 2410.9 2412.5 2415.9 2417.2 2396.4 2429.3 2438.5 2451.6 2476.0 2008.2 2111.8 2407.3 2407.4 2418.1 2211.3 2394.3 2411.9 2414.2 2414.3 2155.6 2300.3 2414.5 2417.1 2447.4 7533.8 8123.8 8599.4 8662.0 8676.1 5203.5 5326.5 5328.3 5355.7 5377.5 3537.3 3583.9 3607.3 3642.7 3653.1 955.8 1064.2 1069.7 1100.6 1104.6 11044.8 11100.6 11182.9 11198.2 11218.6 4572.5 4733.8 4792.5 4799.5 4818.3 9668.3 9685.5 9689.8 9701.1 9711.1 5282.9 5300.4 5338.9 5350.5 5418.9 4448.2 4486.5 4840.8 4921.8 4971.0 3936.5 3955.6 3983.9 4051.7 4059.3 1293.7 1315.9 1316.8 1326.2 1326.8 780.5 876.5 904.7 917.2 921.3 5601.8 5620.2 5639.6 5846.0 5914.8 921.5 935.4 946.4 966.9 969.7 3739.0 3877.8 3948.5 3968.2 3991.0 9959.5 9969.4 10143.2 10268.0 10287.8 10236.4 10263.7 10303.3 10307.6 10363.9 6357.5 7687.8 8105.3 8138.7 8150.3 5701.3 5751.9 5821.1 5836.8 5897.6 9316.0 9584.3 9608.7 9631.9 9776.3 8075.8 9564.0 9699.8 9833.8 9871.4 7174.7 7240.0 7332.0 7346.7 7428.9 8189.5 8226.4 8248.0 8274.2 8311.7 7096.2 7202.6 7229.3 7329.3 7345.4 7163.9 7254.2 7276.9 7280.2 7286.3 6738.2 6781.7 6784.4 6840.0 6880.9 4874.6 4882.8 4898.9 4902.6 4985.8 3831.5 4835.9 4868.3 4896.9 4943.3 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4703.23 Median:5238.81 stddev:1426.94 (27.2%) stddev-sans-first:1392.42 11:36:13 INFO - PROCESS | 1642 | Values: 315.3 316.4 324.1 327.3 328.7 5523.3 5586.8 5756.3 5791.6 5818.4 4433.6 5173.9 5345.3 5347.9 5381.3 4285.3 4293.8 4305.5 4317.4 4324.2 3707.9 4164.4 4224.2 4252.5 4298.2 4212.0 4240.6 4242.7 4252.9 4275.8 4253.6 4271.3 4277.9 4291.7 4297.7 3508.7 3621.6 3659.5 3668.0 3713.6 5226.6 5510.3 5524.8 5550.6 5562.5 4089.4 4856.8 4886.2 4893.6 4923.4 5486.5 5649.7 5889.8 5963.1 5988.1 3636.8 3749.9 4031.4 4052.6 4053.6 4696.8 5889.8 6250.8 6260.5 6303.6 3897.3 3973.5 4066.7 4173.4 4231.7 3275.1 4140.3 4276.9 4290.4 4322.7 4360.5 4985.4 5002.4 5011.4 5016.6 5759.1 5995.6 6038.4 6062.9 6099.4 1173.0 1229.2 1345.7 1414.0 1418.3 885.6 960.6 973.0 978.6 981.0 4990.9 5410.5 5417.0 5441.0 5445.4 5803.5 5848.9 5859.5 5873.9 5910.7 4509.0 4559.3 4791.8 5209.5 5334.3 2779.0 2853.7 3058.5 3096.1 3101.0 4796.6 5962.6 6008.7 6068.0 6118.2 5410.3 5779.9 5943.6 6008.5 6014.5 5095.6 5251.0 5602.9 6076.1 6103.3 4646.0 5831.4 5872.9 5908.0 5937.2 5278.8 5762.0 5763.9 5776.8 5787.9 4761.0 5495.6 5720.0 6026.8 6080.5 3852.8 3979.3 4032.3 4033.0 4059.8 5183.5 5395.4 5438.2 5830.7 5960.0 4574.7 5070.8 5355.3 5446.8 5730.3 5464.4 5612.0 5776.2 6045.3 6049.6 4607.6 5167.8 5187.7 5187.9 5190.8 5282.5 5540.5 6005.4 6047.9 6092.7 5588.1 5810.6 5897.3 5946.8 5958.9 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20819.01 Median:4874.00 stddev:30218.69 (620.0%) stddev-sans-first:30265.84 11:36:13 INFO - PROCESS | 1642 | Values: 735.9 777.3 781.6 816.5 831.0 14094.6 14431.4 14874.9 15115.5 15199.4 12379.8 13757.7 13768.5 13776.6 13780.0 848.9 851.7 883.1 888.6 894.9 887.2 895.1 898.7 902.8 904.8 914.0 921.2 924.7 926.5 927.1 897.5 908.0 916.9 918.3 919.5 672.2 682.0 684.5 684.9 685.9 14500.3 14565.3 14823.3 14933.6 15040.5 13341.1 13721.2 14010.8 14096.6 14184.1 12475.1 12681.3 12847.6 13016.9 13095.7 4606.5 4640.1 4735.5 4870.0 4878.0 88437.6 91926.5 92301.0 92977.5 94396.5 10977.3 11129.9 11144.7 11150.7 11187.4 20847.8 20868.7 20922.1 21039.8 21100.3 7428.4 7665.3 7712.7 7831.0 8097.5 3796.7 4367.0 4400.4 4412.8 4459.1 3315.3 3420.5 3430.7 3435.1 3742.2 568.9 708.1 714.4 714.6 717.2 603.3 659.6 665.3 673.7 693.3 7604.9 8854.7 9408.7 9703.0 9781.2 551.3 592.9 655.8 658.6 675.9 4533.0 4678.6 4686.2 4691.4 4723.6 79362.6 81039.0 82254.6 97841.0 98439.5 87591.0 95837.5 106889.5 107514.9 112658.0 88624.0 88810.0 90159.5 92139.0 93584.0 8824.2 9152.7 9167.8 9192.3 9242.4 56718.1 57617.0 59542.7 59860.0 60943.0 81615.0 81984.0 83635.0 84988.6 86694.6 11872.5 12091.1 12119.6 12138.7 12184.2 10943.7 12757.9 12775.8 12889.4 13042.9 12142.0 12276.6 12321.4 12503.5 12754.7 12013.9 12199.3 12226.3 12328.9 12724.2 11377.9 12154.4 12189.2 12212.0 12231.3 10128.5 10658.4 10677.3 10756.8 10960.7 9936.0 10434.9 10446.7 10474.6 10490.3 11:36:13 INFO - PROCESS | 1642 | -------- Summary: end -------- 11:36:13 INFO - PROCESS | 1642 | 11:36:13 INFO - TEST-INFO | 1642: exit 0 11:36:13 INFO - TEST-OK | dromaeo_css | took 1114444ms 11:36:13 INFO - TEST-START | kraken 11:36:13 INFO - operating with platform_type : mac_ 11:36:13 INFO - Initialising browser for kraken test... 11:36:13 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpZGmLq7/profile http://localhost:49243/getInfo.html) 11:36:16 INFO - PROCESS | 1654 | 2017-01-31 11:36:16.334 plugin-container[1656:9954] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 11:36:16 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:36:16 INFO - PROCESS | 1654 | 2017-01-31 11:36:16.334 plugin-container[1656:9954] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 11:36:16 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:36:16 INFO - PROCESS | 1654 | 2017-01-31 11:36:16.334 plugin-container[1656:9954] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:36:16 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 11:36:16 INFO - PROCESS | 1654 | colorDepth:24 11:36:16 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 11:36:16 INFO - PROCESS | 1654 | __metrics 11:36:16 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 11:36:17 INFO - TEST-INFO | 1654: exit 0 11:36:17 INFO - Browser initialized. 11:36:17 INFO - Running cycle 1/1 for kraken test... 11:36:17 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpZGmLq7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:19 INFO - PROCESS | 1657 | 2017-01-31 11:36:19.575 plugin-container[1658:10078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x832b, name = 'com.apple.tsm.portname' 11:36:19 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:36:19 INFO - PROCESS | 1657 | 2017-01-31 11:36:19.576 plugin-container[1658:10078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 11:36:19 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:36:19 INFO - PROCESS | 1657 | 2017-01-31 11:36:19.576 plugin-container[1658:10078] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:36:29 INFO - PROCESS | 1657 | RSS: Main: 177221632 11:36:29 INFO - PROCESS | 1657 | 11:36:32 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:33 INFO - PROCESS | 1657 | RSS: Main: 189997056 11:36:33 INFO - PROCESS | 1657 | 11:36:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 11:36:36 INFO - PROCESS | 1657 | RSS: Main: 197992448 11:36:36 INFO - PROCESS | 1657 | 11:36:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 11:36:40 INFO - PROCESS | 1657 | RSS: Main: 201654272 11:36:40 INFO - PROCESS | 1657 | 11:36:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 11:36:42 INFO - PROCESS | 1657 | RSS: Main: 202665984 11:36:42 INFO - PROCESS | 1657 | 11:36:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:45 INFO - PROCESS | 1657 | RSS: Main: 202579968 11:36:45 INFO - PROCESS | 1657 | 11:36:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:48 INFO - PROCESS | 1657 | RSS: Main: 207192064 11:36:48 INFO - PROCESS | 1657 | 11:36:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:52 INFO - PROCESS | 1657 | RSS: Main: 207433728 11:36:52 INFO - PROCESS | 1657 | 11:36:55 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 11:36:55 INFO - PROCESS | 1657 | RSS: Main: 206929920 11:36:55 INFO - PROCESS | 1657 | 11:36:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:58 INFO - PROCESS | 1657 | RSS: Main: 205852672 11:36:58 INFO - PROCESS | 1657 | 11:37:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:00 INFO - PROCESS | 1657 | RSS: Main: 205930496 11:37:00 INFO - PROCESS | 1657 | 11:37:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:03 INFO - PROCESS | 1657 | RSS: Main: 205639680 11:37:03 INFO - PROCESS | 1657 | 11:37:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:07 INFO - PROCESS | 1657 | RSS: Main: 205656064 11:37:07 INFO - PROCESS | 1657 | 11:37:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:10 INFO - PROCESS | 1657 | RSS: Main: 206020608 11:37:10 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 11:37:12 INFO - PROCESS | 1657 | RSS: Main: 207708160 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | __start_tp_report 11:37:12 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 11:37:12 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 11:37:12 INFO - PROCESS | 1657 | |i|pagename|runs| 11:37:12 INFO - PROCESS | 1657 | |0;ai-astar;105;119;115;116;117;112;112;116;121;167 11:37:12 INFO - PROCESS | 1657 | |1;audio-beat-detection;145;113;113;140;108;110;98;125;174;142 11:37:12 INFO - PROCESS | 1657 | |2;audio-dft;211;233;281;211;192;195;193;194;192;195 11:37:12 INFO - PROCESS | 1657 | |3;audio-fft;76;61;61;83;60;60;82;51;95;84 11:37:12 INFO - PROCESS | 1657 | |4;audio-oscillator;85;71;89;72;69;71;84;69;71;85 11:37:12 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;89;87;89;95;89;87;90;89;123;87 11:37:12 INFO - PROCESS | 1657 | |6;imaging-darkroom;117;96;150;138;95;106;96;95;95;97 11:37:12 INFO - PROCESS | 1657 | |7;imaging-desaturate;87;72;140;136;95;115;117;89;84;88 11:37:12 INFO - PROCESS | 1657 | |8;json-parse-financial;56;56;53;59;61;60;61;59;59;58 11:37:12 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;65;73;71;91;105;100;98;80;70;70 11:37:12 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;83;81;86;84;103;104;79;83;83;83 11:37:12 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;132;148;154;159;139;143;140;142;191;148 11:37:12 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;163;164;182;140;211;230;166;164;163;167 11:37:12 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;66;67;67;68;66;69;83;85;87;85 11:37:12 INFO - PROCESS | 1657 | __end_tp_report 11:37:12 INFO - PROCESS | 1657 | __start_cc_report 11:37:12 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,898 11:37:12 INFO - PROCESS | 1657 | __end_cc_report 11:37:12 INFO - PROCESS | 1657 | __startTimestamp1485891432668__endTimestamp 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | ------- Summary: start ------- 11:37:12 INFO - PROCESS | 1657 | Number of tests: 14 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:120.00 Median:116.50 stddev:17.09 (14.7%) stddev-sans-first:17.25 11:37:12 INFO - PROCESS | 1657 | Values: 105.0 119.0 115.0 116.0 117.0 112.0 112.0 116.0 121.0 167.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:141.00 stddev:23.13 (16.4%) stddev-sans-first:23.57 11:37:12 INFO - PROCESS | 1657 | Values: 145.0 113.0 113.0 140.0 108.0 110.0 98.0 125.0 174.0 142.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:209.70 Median:203.00 stddev:28.31 (13.9%) stddev-sans-first:30.03 11:37:12 INFO - PROCESS | 1657 | Values: 211.0 233.0 281.0 211.0 192.0 195.0 193.0 194.0 192.0 195.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:71.30 Median:79.00 stddev:14.44 (18.3%) stddev-sans-first:15.21 11:37:12 INFO - PROCESS | 1657 | Values: 76.0 61.0 61.0 83.0 60.0 60.0 82.0 51.0 95.0 84.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.00 stddev:8.03 (10.3%) stddev-sans-first:7.92 11:37:12 INFO - PROCESS | 1657 | Values: 85.0 71.0 89.0 72.0 69.0 71.0 84.0 69.0 71.0 85.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:89.00 stddev:10.97 (12.3%) stddev-sans-first:11.56 11:37:12 INFO - PROCESS | 1657 | Values: 89.0 87.0 89.0 95.0 89.0 87.0 90.0 89.0 123.0 87.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:95.00 stddev:20.17 (21.2%) stddev-sans-first:21.16 11:37:12 INFO - PROCESS | 1657 | Values: 117.0 96.0 150.0 138.0 95.0 106.0 96.0 95.0 95.0 97.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:102.30 Median:85.50 stddev:23.23 (27.2%) stddev-sans-first:23.97 11:37:12 INFO - PROCESS | 1657 | Values: 87.0 72.0 140.0 136.0 95.0 115.0 117.0 89.0 84.0 88.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:2.53 (4.3%) stddev-sans-first:2.55 11:37:12 INFO - PROCESS | 1657 | Values: 56.0 56.0 53.0 59.0 61.0 60.0 61.0 59.0 59.0 58.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:82.30 Median:72.00 stddev:14.80 (20.6%) stddev-sans-first:14.32 11:37:12 INFO - PROCESS | 1657 | Values: 65.0 73.0 71.0 91.0 105.0 100.0 98.0 80.0 70.0 70.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:83.00 stddev:8.94 (10.8%) stddev-sans-first:9.37 11:37:12 INFO - PROCESS | 1657 | Values: 83.0 81.0 86.0 84.0 103.0 104.0 79.0 83.0 83.0 83.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:148.00 stddev:16.47 (11.1%) stddev-sans-first:16.19 11:37:12 INFO - PROCESS | 1657 | Values: 132.0 148.0 154.0 159.0 139.0 143.0 140.0 142.0 191.0 148.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:166.50 stddev:26.39 (15.9%) stddev-sans-first:27.64 11:37:12 INFO - PROCESS | 1657 | Values: 163.0 164.0 182.0 140.0 211.0 230.0 166.0 164.0 163.0 167.0 11:37:12 INFO - PROCESS | 1657 | 11:37:12 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:76.00 stddev:9.30 (12.2%) stddev-sans-first:9.36 11:37:12 INFO - PROCESS | 1657 | Values: 66.0 67.0 67.0 68.0 66.0 69.0 83.0 85.0 87.0 85.0 11:37:12 INFO - PROCESS | 1657 | -------- Summary: end -------- 11:37:12 INFO - PROCESS | 1657 | 11:37:13 INFO - TEST-INFO | 1657: exit 0 11:37:13 INFO - TEST-OK | kraken | took 60030ms 11:37:13 INFO - SUITE-END | took 1174s 11:37:13 INFO - Completed test suite (00:19:34) 11:37:13 INFO - javascript benchmark 11:37:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7391.527829111146, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.3729928612856, 3527.5590551181117, 3560.8041557714314, 3570.1610121621416, 3573.088862340103, 5900.852478688035, 5940.43565861243, 5978.252718410199, 5985.551083668721, 5991.161237426758, 5983.22218111646, 6063.848403789896, 6073.60521566099, 6078.878422431549, 6082.361352058037, 4463.509014008457, 5365.597580181482, 5398.0, 5437.673739575618, 5468.3711373192, 4500.347449619803, 5495.945040549584, 5505.284313039299, 5515.972420137914, 5521.972390138044, 4456.8885777855485, 4521.276595744682, 5335.466453354653, 5357.223202635615, 5432.565394768429, 5387.46125387464, 5428.5928555358305, 5441.59188060897, 5453.291072160594, 5480.205370221335, 5330.466953304677, 5356.866078348034, 5357.812476563302, 5433.7283135843445, 5478.342598888119, 6073.939260607382, 6086.513078953673, 6109.419605137505, 6169.907451388232, 6192.566520343577, 5837.5913686041995, 6263.31103578606, 6335.493160547145, 6370.299267080617, 6391.552591318609, 6470.7088181031495, 6482.675866206718, 6487.643179625119, 6491.415772580443, 6512.902306465407, 5966.970165149147, 6048.153258543719, 6161.7227224775, 6179.227596550431, 6206.06908963659, 6466.676666166767, 6508.60948343101, 6528.771492997722, 6608.636524991171, 6615.073889655452, 6315.210598675166, 6345.952917768609, 6350.269718982377, 6355.046742988497, 6381.489480841522, 6237.937620623827, 6364.554481186273, 6465.3857883501, 6467.773627923, 6478.870422591522, 6255.624662520263, 6271.717772700239, 6319.9368006320265, 6320.336364681642, 6383.585066970632, 5236.0, 6268.279147897959, 6336.112944187817, 6350.555461117678, 6394.136791533177, 5151.6136289778415, 5154.278401023859, 5163.870903227375, 5170.71561064145, 5176.767045482962, 4499.302608095751, 4519.186546421675, 4546.02260513991, 4556.179887620194, 4610.76946152691, 5997.370276121032, 6097.146399504073, 6127.128444391265, 6139.78118599196, 6144.941444616014, 6266.49868010558, 6426.485881129592, 6459.224893012774, 6469.061986012002, 6486.091947127406, 5925.703714814242, 6107.969460152671, 6111.174991376196, 6137.877242455126, 6153.107799369156, 5606.074997625427, 5612.971935140298, 5630.324361076697, 5634.577406694514, 5642.266505354278, 6573.80278591643, 6589.901151482732, 6616.933830661632, 6620.503462240351, 6639.3692599203, 6249.7187626557825, 6278.968605156945, 6282.780102696383, 6299.244090709144, 6342.016987366966, 6550.901736474052, 6593.307702691149, 6620.602763834186, 6621.1392518972225, 6621.503387246072, 6338.809835704937, 6340.270868849957, 6347.746090156342, 6347.809565713036, 6367.808965731036, 6106.491003209229, 6261.624302541862, 6271.3728627136925, 6322.589031712924, 6358.332375100548, 6248.750049997949, 6267.2165979252595, 6270.15352927349, 6272.435480806749, 6284.937150628435, 5701.831124619526, 6008.639481631116, 6192.0, 6233.75064997395, 6262.655553944577, 5580.437477506305, 5598.468145526169, 6083.057126145454, 6124.356942520971, 6127.342242870559, 6188.535859810442, 6251.53113516479, 6288.723667905685, 6322.778702745381, 6330.746770129143, 6178.969105154445, 6224.253089629274, 6227.346128656426, 6256.092866534418, 6263.498920086291], "value": 5880.5350650100145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.87124476391375, 485.65033176113207, 521.1505246448289, 546.8004178474857, 587.5241054745653, 32473.5128973065, 34680.4797928031, 37628.87113386599, 40947.99999999996, 40969.795151024206, 41188.79405602968, 41329.79335103328, 42362.152756944844, 42365.0, 42377.15245695092, 8345.873307103555, 9505.00197479265, 9629.374090684118, 9694.36986595869, 9716.61133554657, 9547.474888881108, 9575.569099390545, 9581.712548623518, 9659.90340096597, 9683.322167448281, 9553.856692149624, 9620.374675646095, 9633.08485693858, 9643.035696430372, 9691.127798498133, 9530.761730956712, 9588.760280992961, 9617.086376794194, 9632.61469541221, 9638.566264518113, 8421.747347579583, 9617.855732164024, 9619.326647134703, 9651.903480965171, 9786.902130978742, 31767.84116079428, 38317.808410958045, 38995.805020975, 39052.60947390547, 39193.60806391928, 3422.435298175823, 3476.774009689362, 3588.0, 3609.350316942949, 3908.0998359993887, 30010.84994575013, 30971.380572388425, 31611.84194079038, 31625.683743162735, 31674.524882126556, 3226.0, 3228.2252259457796, 3332.750043746729, 3341.031100980713, 3363.445031569788, 509500.0, 511382.4430877859, 513922.0, 515365.9999999963, 516455.0, 59785.0, 60145.69927150336, 60476.39523604796, 60487.0, 60601.696991514764, 62843.0, 63073.68463157655, 63104.684476578244, 63109.68445157745, 63288.68355658192, 16146.0, 16152.838471615369, 16587.66824663524, 16625.3349866004, 16866.578335541464, 13044.804327935088, 13084.803727944089, 13121.409536570878, 13152.473901043852, 13166.605001849959, 15760.0, 16308.918455407647, 16310.75533866993, 16379.836201638069, 16394.26225819841, 5403.594730395236, 6269.937300627026, 6313.558050936482, 6314.463270621956, 6348.396902294275, 865.8874346334936, 925.754859713684, 934.2806039349663, 993.0813997052697, 1103.2994048778924, 30335.848320758698, 30632.42286191747, 30749.692503074682, 31027.914023009085, 31241.59412826428, 1092.7158938676002, 1093.868735751715, 1141.5456767948976, 1174.4890972427022, 1189.3577468167266, 15756.897017208914, 15900.840991589936, 15964.004499437571, 16115.274812633459, 16117.0, 620802.0, 631602.0, 637796.0, 638299.0, 638470.0, 59289.703551481965, 59500.40499594949, 59586.51033724192, 59683.701581492685, 59769.70115149483, 1200.7572162811448, 1341.3829638366265, 1341.617638972888, 1379.2483096712315, 1386.3276310989363, 29422.705772941998, 30135.849320754132, 30277.94027209037, 30428.84785576058, 30723.385532289674, 49852.0, 50123.0, 50126.74936625294, 50269.0, 50302.4909252723, 589752.051239741, 596226.0, 596398.0, 597029.0, 598454.0, 39666.80166599149, 40261.59738402579, 41203.38194927138, 41229.793851031754, 41260.1747965045, 46225.0, 47280.0, 47528.524714753796, 48180.27729583989, 48270.758646206545, 38704.58135860975, 38712.0, 39136.0, 39307.80346098251, 39892.20215595614, 38486.80756596199, 38915.02712432212, 38987.95397428934, 39074.82775516739, 39242.82271531859, 38287.23425531529, 39005.414918776805, 39121.21757564776, 39132.21735565216, 40313.19373612453, 27715.752791124043, 33191.66808331886, 35060.824695877374, 35103.771368001995, 36242.27515449729, 25671.743282566935, 26235.60646590341, 26333.210003699918, 26380.0766973155, 26657.0], "value": 20170.79554755582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.09589369088945, 384.5886292943248, 388.14607862702053, 393.6830851164813, 412.97315674481155, 15536.300866461008, 16419.83580164201, 19371.903140484297, 20569.99999999998, 20677.586448271046, 16933.745993810073, 20585.0, 20607.896960515176, 20839.583208335825, 20886.164553417882, 4713.7643117844145, 5715.8571035724235, 5846.064629659255, 5884.440978107073, 5964.075568286922, 5883.8529036774, 5889.6171748836405, 5900.085486749539, 5906.2912450506, 5918.970405147989, 5820.534357251431, 6030.517558595324, 6033.366496517869, 6119.3574674659185, 6212.409821066992, 5301.734913254341, 5974.312954010279, 6080.726367313481, 6204.317525072239, 6699.363560461748, 5852.648841069549, 5931.822045338647, 5945.8810823783715, 5951.107333899907, 5952.761889524414, 13014.219146851125, 20326.390208293626, 23064.654030189562, 23100.65349019766, 23355.0, 2280.4982903761147, 2286.634138537826, 2361.1853910401055, 2478.7893029092547, 2905.7675385969073, 9786.657466988692, 10474.738131546696, 14258.287085645676, 15030.398784048624, 15792.605184870356, 1879.4079864842531, 1897.4118023412786, 1906.818852209038, 1936.719175719527, 1958.6474434601766, 120996.0, 123185.0, 123892.76107238902, 126166.36916815449, 130204.34897825451, 11417.828732569018, 11429.542818287342, 11677.299362038304, 11776.175667703179, 11795.41022948849, 13205.0, 14463.638409039859, 14597.635059123395, 14728.705425891421, 14738.778918316233, 7055.858882822417, 7550.244975502405, 8543.871841922377, 8690.0, 8827.867581986275, 7656.80857978555, 7974.162712915177, 8668.393212475192, 8801.691940782042, 8822.426542274732, 4544.636429085665, 4544.818207271672, 4615.215413379734, 4623.815047398134, 4716.773638853922, 1984.6725290327222, 1991.9502012449516, 1996.5342801639963, 2000.5898790747863, 2044.2231951858198, 888.3648191542949, 893.3523195683077, 935.5088578496208, 964.8855571814565, 980.9901900981041, 18776.248950042118, 19681.704774428395, 20344.0, 20620.484487887923, 20687.06908189135, 847.6778824046946, 950.95720692569, 970.3644113105927, 979.8579206015088, 1006.8288390973405, 8032.39757018226, 11150.49822757978, 11155.27490713101, 11188.944055279671, 11305.604303849326, 607751.0, 612222.0, 620700.0, 632772.0, 636027.0, 122757.0, 126464.0, 127484.36257818837, 131271.0, 134791.32604336916, 986.9654562090292, 1020.7550187954837, 1053.5259133390005, 1057.7990181865575, 1060.6022741471947, 18700.81299186991, 19342.032898355308, 19571.82569045805, 19593.216271348985, 19610.313639022566, 47374.28938565993, 55124.72437637786, 56723.432765671816, 57413.703451863126, 58335.70832145982, 67513.0, 84476.31047378895, 84773.57613211895, 86230.13769862472, 86421.0, 6724.4284235840505, 6783.660816959231, 7692.615369231628, 8014.599270036591, 8180.7954801130445, 11138.88861111411, 11190.824963378727, 11357.308874615617, 12228.571999979958, 12770.850623443936, 10817.945910270399, 10880.075193608633, 10905.672829815117, 10955.397453140155, 11101.0, 10720.410377429316, 10733.838992414963, 10781.245312828027, 10862.239643224899, 11017.614383496539, 9966.700998970042, 10901.836472453078, 11071.114310855273, 11366.488508016993, 11478.655640330804, 6927.376536111774, 7320.084989376328, 7415.2214017527385, 7423.962880185564, 8019.0, 9326.813463730552, 10748.140148787921, 10850.945745271223, 10874.510647021061, 10891.292066015683], "value": 9576.593444157828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.6725467751046, 1368.5825823123946, 1573.4178354009018, 1846.1230915315236, 1901.7337572739818, 7804.531728096318, 8000.959995200031, 8318.875216871744, 8776.648934042638, 8797.912020879798, 8166.346692264619, 8445.40882138249, 8466.280366168867, 8582.184692454222, 8597.699080532167, 2371.739108698046, 2410.927672169838, 2412.457197130649, 2415.879206039691, 2417.190241269177, 2396.3529846941315, 2429.2955043037587, 2438.5366780311683, 2451.595486744685, 2475.962860557093, 2008.186684392816, 2111.7782632823564, 2407.3379820549403, 2407.41018450479, 2418.093215044358, 2211.3365990202874, 2394.347899949047, 2411.9276421707377, 2414.2153800014976, 2414.3360575841784, 2155.622766015941, 2300.2639155470256, 2414.4929564791414, 2417.10567090176, 2447.4003869052017, 7533.849323013564, 8123.822045803385, 8599.355048371335, 8661.956690216572, 8676.132386761274, 5203.4796520348045, 5326.547243484309, 5328.307320048408, 5355.705436201008, 5377.46225377463, 3537.2571759930447, 3583.874564390234, 3607.3326434609417, 3642.653947874974, 3653.050206946213, 955.7849483866144, 1064.2231171244957, 1069.673749506408, 1100.5707773968159, 1104.618906477264, 11044.779104417867, 11100.55597776088, 11182.888171118266, 11198.160137989684, 11218.551257949672, 4572.497025327211, 4733.763311834395, 4792.472827988919, 4799.472058073609, 4818.349522814376, 9668.274879383933, 9685.467299298465, 9689.806203875884, 9701.126898579161, 9711.077447642463, 5282.867928301746, 5300.416954135042, 5338.9466105339225, 5350.5184533392185, 5418.864528386822, 4448.199324121689, 4486.528914463999, 4840.782164802592, 4921.7785199666105, 4971.0, 3936.488256526633, 3955.584663610337, 3983.940240896389, 4051.6758659307184, 4059.330210515291, 1293.6765808547864, 1315.9407826647632, 1316.8419789625307, 1326.204277433532, 1326.840779106494, 780.4731806030907, 876.509154873273, 904.7240591619619, 917.202034230224, 921.3412410126791, 5601.831945041656, 5620.185073164368, 5639.6334238274385, 5845.976954033027, 5914.76340946366, 921.5209588610318, 935.4424882570444, 946.4084946908182, 966.9033096690275, 969.6896992962185, 3738.981305093457, 3877.8448862045766, 3948.466956960831, 3968.206358728266, 3991.0, 9959.452230127268, 9969.35199212049, 10143.188544916537, 10268.0, 10287.845682314772, 10236.385816851012, 10263.74340641475, 10303.330283531546, 10307.587696492206, 10363.896361036444, 6357.4596159326975, 7687.846243075107, 8105.31104856082, 8138.674453021931, 8150.307223885918, 5701.287339082614, 5751.9137212941005, 5821.126830975388, 5836.795712150054, 5897.646141231368, 9316.021817709043, 9584.28117891147, 9608.66369677058, 9631.855522167032, 9776.315657903879, 8075.757727268191, 9564.0, 9699.806003880023, 9833.803323933624, 9871.358361706467, 7174.713011479483, 7240.022596949555, 7331.963340183265, 7346.742863999734, 7428.888566671396, 8189.50862948225, 8226.42415030966, 8248.0, 8274.213949674771, 8311.6675332986, 7096.183938847099, 7202.639868006683, 7229.349358557755, 7329.340359367682, 7345.412367010519, 7163.8567228656175, 7254.202037775735, 7276.890846637199, 7280.1991780903, 7286.271372862671, 6738.225104113089, 6781.728730850711, 6784.423324017514, 6840.0, 6880.896786548105, 4874.561289483963, 4882.7558622068045, 4898.853034408973, 4902.63230257725, 4985.825496107619, 3831.463595096633, 4835.927461088017, 4868.294097355934, 4896.92654610174, 4943.30793688891], "value": 4514.770573831453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.25756842635604, 316.381474217904, 324.1006207773429, 327.32570903937875, 328.6811792561215, 5523.342997100864, 5586.8490631107015, 5756.309242890854, 5791.594588378815, 5818.447247511485, 4433.64530837533, 5173.922391164127, 5345.305110335651, 5347.866303342418, 5381.300430943981, 4285.314349704048, 4293.849715259967, 4305.526392096883, 4317.395564620955, 4324.1838427860375, 3707.8876337098895, 4164.354525048622, 4224.155168966204, 4252.532221455637, 4298.161858437606, 4211.978940105295, 4240.5547417521175, 4242.6605871530355, 4252.914941701164, 4275.786210689469, 4253.575052357464, 4271.273883439822, 4277.850275240352, 4291.656667466611, 4297.73216901015, 3508.7368447366293, 3621.573545724371, 3659.5242618459697, 3667.991302391837, 3713.57293911201, 5226.608004399647, 5510.283663123809, 5524.8342549723575, 5550.611457197998, 5562.527185189264, 4089.425571155097, 4856.781444834991, 4886.218205087169, 4893.559579637814, 4923.433805112422, 5486.478784515464, 5649.717514124277, 5889.79385721502, 5963.13534537494, 5988.071848863389, 3636.818159092035, 3749.8687545936036, 4031.3952907064177, 4052.5947405259535, 4053.5541090480024, 4696.802315409583, 5889.7644094236175, 6250.7812226572305, 6260.467860231885, 6303.5902666327, 3897.2595206911164, 3973.4635824163947, 4066.674666026711, 4173.373993900939, 4231.703780735381, 3275.1484614000533, 4140.254754144283, 4276.935845962313, 4290.399344091829, 4322.675799315064, 4360.495629007987, 4985.376827896513, 5002.374703162105, 5011.398632164163, 5016.573591244712, 5759.112598995661, 5995.640261584232, 6038.373307611203, 6062.9090563641585, 6099.420555047263, 1172.9941350293363, 1229.2133034857698, 1345.6837643153851, 1413.964650883736, 1418.3121186224673, 885.6014793343021, 960.596549449233, 973.0464145137663, 978.6085565773748, 980.9797810277374, 4990.850274491771, 5410.540104091197, 5417.0, 5440.973679477159, 5445.401005889349, 5803.506701930383, 5848.8537786554825, 5859.472647461749, 5873.941260587425, 5910.704464776744, 4508.954910450919, 4559.293309537027, 4791.784369703371, 5209.53114219722, 5334.306540149756, 2779.0, 2853.7146285371296, 3058.525928481089, 3096.0866544369464, 3100.9844950775555, 4796.640251981115, 5962.612430192024, 6008.746719980008, 6067.969660151759, 6118.174046503754, 5410.296661433988, 5779.942200578024, 5943.64338139713, 6008.506469814978, 6014.548908831855, 5095.566876815512, 5251.002309561171, 5602.943970560405, 6076.118962750465, 6103.328633850273, 4646.0, 5831.446012628793, 5872.856407411349, 5908.0, 5937.248511688976, 5278.841634750964, 5762.0121058234845, 5763.884722305615, 5776.782948447572, 5787.884242315046, 4760.952390476189, 5495.587830912617, 5719.971400142973, 6026.819195424145, 6080.48315893154, 3852.8073596320633, 3979.303621866104, 4032.3145065338376, 4033.0, 4059.7970101494216, 5183.486009285569, 5395.352557692945, 5438.184272359178, 5830.708464576839, 5959.970200148971, 4574.748388838646, 5070.797168113234, 5355.30381050461, 5446.836594902159, 5730.341010783646, 5464.371597266365, 5611.971940140274, 5776.220210271559, 6045.304789949037, 6049.637021778707, 4607.6083532900075, 5167.793288268427, 5187.662801918014, 5187.948120518898, 5190.754218987491, 5282.524572788468, 5540.501354878081, 6005.39946005396, 6047.9155630629575, 6092.664903430354, 5588.050031494575, 5810.622309549865, 5897.321807992136, 5946.780909913544, 5958.940410595838], "value": 4249.223086721594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.922728113548, 777.2848978939376, 781.6165387264542, 816.4652152839892, 830.9626066826991, 14094.590540945901, 14431.422743090277, 14874.925625371858, 15115.470958516455, 15199.392024319028, 12379.814302785466, 13757.65605859854, 13768.518101866437, 13776.586702398945, 13780.0, 848.9235968762811, 851.7189327521918, 883.1036497954581, 888.5823662878469, 894.8523493623544, 887.183790912359, 895.0557162193883, 898.6630013744846, 902.7878448564582, 904.7873749668822, 914.0448231597996, 921.1801496667937, 924.7456949338952, 926.4811705444939, 927.1423932862109, 897.5332826930025, 908.0102688070035, 916.8945571259324, 918.3433844800966, 919.5402298850574, 672.2336536348566, 682.0042737603105, 684.4558575932145, 684.866451042047, 685.9348361905611, 14500.274986250644, 14565.271736413137, 14823.258837058213, 14933.551993440215, 15040.473583424528, 13341.132826366254, 13721.176729396268, 14010.789838152436, 14096.647583810383, 14184.0780349278, 12475.064370172182, 12681.302528360937, 12847.614571562868, 13016.869831301756, 13095.738085238338, 4606.5393460654, 4640.071985602859, 4735.479097299294, 4870.001649661811, 4878.0, 88437.55781221052, 91926.54036729774, 92301.0, 92977.53511232468, 94396.52801735948, 10977.341359518454, 11129.944350278196, 11144.665660030212, 11150.721231969266, 11187.384693841754, 20847.791522084888, 20868.686969695467, 20922.058507367205, 21039.78960210409, 21100.261490847748, 7428.368588669916, 7665.3101220890385, 7712.730054448068, 7830.9934642468725, 8097.473664211925, 3796.6583007529457, 4367.039251364695, 4400.44994375703, 4412.845550405785, 4459.0858873930765, 3315.303786204876, 3420.504026916083, 3430.691237788611, 3435.1068722132427, 3742.2328422673286, 568.9203511508392, 708.1360739897317, 714.4427346669606, 714.6319645382632, 717.1573401253506, 603.3483837455537, 659.591053546804, 665.3346653346654, 673.6631684157921, 693.2616763147232, 7604.9353090567365, 8854.734357969272, 9408.670696525589, 9703.0, 9781.217502599775, 551.2805788446117, 592.8547505861005, 655.783591414832, 658.6147103944246, 675.9155105611799, 4533.0, 4678.625709943196, 4686.156491831503, 4691.390119284471, 4723.5984941279685, 79362.6031869837, 81039.0, 82254.58872705598, 97841.0215897832, 98439.50780246053, 87591.0, 95837.52081239689, 106889.4655526733, 107514.92485075205, 112658.0, 88624.0, 88810.0, 90159.54920225489, 92139.0, 93584.0, 8824.249938755278, 9152.679656212, 9167.816643667224, 9192.31057670664, 9242.399244049115, 56718.14922776079, 57617.0, 59542.70228648829, 59860.0, 60943.0, 81615.0, 81984.0, 83635.0, 84988.57505712431, 86694.56652716696, 11872.52509899629, 12091.093168012258, 12119.636410907688, 12138.696532586402, 12184.20802647825, 10943.726406839893, 12757.872421276039, 12775.80836287475, 12889.419976100911, 13042.934785326013, 12142.0, 12276.631701048982, 12321.44553495077, 12503.499860005863, 12754.68113297175, 12013.939930300292, 12199.268043917393, 12226.327551984727, 12328.890399864054, 12724.236545807282, 11377.943110284396, 12154.392280385768, 12189.207701499374, 12212.0, 12231.266124032587, 10128.544215510172, 10658.360498369813, 10677.252592318773, 10756.838647420138, 10960.725981850517, 9935.950320248641, 10434.947825260826, 10446.738831529272, 10474.633387831389, 10490.31812932157], "value": 7482.806797489321, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 115.0, 116.0, 117.0, 112.0, 112.0, 116.0, 121.0, 167.0], "value": 120.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 113.0, 140.0, 108.0, 110.0, 98.0, 125.0, 174.0, 142.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 233.0, 281.0, 211.0, 192.0, 195.0, 193.0, 194.0, 192.0, 195.0], "value": 209.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 61.0, 61.0, 83.0, 60.0, 60.0, 82.0, 51.0, 95.0, 84.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 89.0, 72.0, 69.0, 71.0, 84.0, 69.0, 71.0, 85.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 95.0, 89.0, 87.0, 90.0, 89.0, 123.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 96.0, 150.0, 138.0, 95.0, 106.0, 96.0, 95.0, 95.0, 97.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 140.0, 136.0, 95.0, 115.0, 117.0, 89.0, 84.0, 88.0], "value": 102.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 59.0, 61.0, 60.0, 61.0, 59.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 71.0, 91.0, 105.0, 100.0, 98.0, 80.0, 70.0, 70.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 86.0, 84.0, 103.0, 104.0, 79.0, 83.0, 83.0, 83.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 148.0, 154.0, 159.0, 139.0, 143.0, 140.0, 142.0, 191.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 182.0, 140.0, 211.0, 230.0, 166.0, 164.0, 163.0, 167.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 66.0, 69.0, 83.0, 85.0, 87.0, 85.0], "value": 74.3, "unit": "score"}]}]} 11:37:13 INFO - Return code: 0 11:37:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:13 ERROR - # TBPL SUCCESS # 11:37:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:37:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:37:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:37:13 INFO - 2017-01-31 11:37:13.953 screenresolution[1662:10459] starting screenresolution argv=screenresolution get 11:37:13 INFO - 2017-01-31 11:37:13.956 screenresolution[1662:10459] Display 0: 1600x1200x32@60 11:37:13 INFO - 2017-01-31 11:37:13.962 screenresolution[1663:10462] starting screenresolution argv=screenresolution list 11:37:13 INFO - Available Modes on Display 0 11:37:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:37:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:37:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:37:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:37:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:37:14 INFO - Intel Iris: 11:37:14 INFO - Chipset Model: Intel Iris 11:37:14 INFO - Type: GPU 11:37:14 INFO - Bus: Built-In 11:37:14 INFO - VRAM (Dynamic, Max): 1536 MB 11:37:14 INFO - Vendor: Intel (0x8086) 11:37:14 INFO - Device ID: 0x0a2e 11:37:14 INFO - Revision ID: 0x0009 11:37:14 INFO - Displays: 11:37:14 INFO - Display: 11:37:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:37:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:37:14 INFO - Display Serial Number: 1600x1200 60 11:37:14 INFO - Main Display: Yes 11:37:14 INFO - Mirror: Off 11:37:14 INFO - Online: Yes 11:37:14 INFO - Rotation: Supported 11:37:14 INFO - Return code: 0 11:37:14 INFO - Running post-action listener: _resource_record_post_action 11:37:14 INFO - [mozharness: 2017-01-31 19:37:14.206314Z] Finished run-tests step (success) 11:37:14 INFO - Running post-run listener: _resource_record_post_run 11:37:14 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39356416; Write bytes: 498966528; Read time: 251; Write time: 1616 11:37:14 INFO - TinderboxPrint: CPU usage
54.2% 11:37:14 INFO - TinderboxPrint: I/O read bytes / time
39,356,416 / 251 11:37:14 INFO - TinderboxPrint: I/O write bytes / time
498,966,528 / 1,616 11:37:14 INFO - TinderboxPrint: CPU idle
2,190.8 (45.8%) 11:37:14 INFO - TinderboxPrint: CPU system
964.3 (20.1%) 11:37:14 INFO - TinderboxPrint: CPU user
1,630.6 (34.1%) 11:37:14 INFO - TinderboxPrint: Swap in / out
231,100,416 / 0 11:37:14 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181096960; Write bytes: 175650304; Read time: 16591; Write time: 390 11:37:14 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 38434816; Write bytes: 305584640; Read time: 240; Write time: 1167 11:37:14 INFO - Running post-run listener: _upload_blobber_files 11:37:14 INFO - Blob upload gear active. 11:37:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:14 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 11:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:15 INFO - (blobuploader) - INFO - Done attempting. 11:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:16 INFO - (blobuploader) - INFO - Done attempting. 11:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:19 INFO - (blobuploader) - INFO - Done attempting. 11:37:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:19 INFO - Return code: 0 11:37:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f8b0da8f635de3304d2ed9ea58105e09f4f73f952ab03dd586d2d75fe1d7e2959de5727c5080dc4f83842efc9eea7d8eb39bf7ae6da1fe6138d62f95fe37fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c689393e12768978b276d376197c50bfbf7160525c1605b6b24e414ece8c3ce9f3a27b8eefeb3ecbfe3cb5570543251a445ebeb000206517c20db3752a8866d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/138756ab4c31500b3105f0a95481d440c8b7aa9f6fe7f6c82387a72ce5c2365ec4a84475cfe720122aa42d994e11011ee3f59ec6aecfc945889bffa76d6701e2"} 11:37:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:19 INFO - Contents: 11:37:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f8b0da8f635de3304d2ed9ea58105e09f4f73f952ab03dd586d2d75fe1d7e2959de5727c5080dc4f83842efc9eea7d8eb39bf7ae6da1fe6138d62f95fe37fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c689393e12768978b276d376197c50bfbf7160525c1605b6b24e414ece8c3ce9f3a27b8eefeb3ecbfe3cb5570543251a445ebeb000206517c20db3752a8866d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/138756ab4c31500b3105f0a95481d440c8b7aa9f6fe7f6c82387a72ce5c2365ec4a84475cfe720122aa42d994e11011ee3f59ec6aecfc945889bffa76d6701e2"} 11:37:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:19 INFO - Copying logs to upload dir... 11:37:19 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.813357 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-31 11:37:19.404924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 11:37:19.408300) ========= 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.be3p9U6tHC/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.c8VPXjwtFx/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f8b0da8f635de3304d2ed9ea58105e09f4f73f952ab03dd586d2d75fe1d7e2959de5727c5080dc4f83842efc9eea7d8eb39bf7ae6da1fe6138d62f95fe37fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c689393e12768978b276d376197c50bfbf7160525c1605b6b24e414ece8c3ce9f3a27b8eefeb3ecbfe3cb5570543251a445ebeb000206517c20db3752a8866d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/138756ab4c31500b3105f0a95481d440c8b7aa9f6fe7f6c82387a72ce5c2365ec4a84475cfe720122aa42d994e11011ee3f59ec6aecfc945889bffa76d6701e2"} build_url:https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011086 build_url: 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f8b0da8f635de3304d2ed9ea58105e09f4f73f952ab03dd586d2d75fe1d7e2959de5727c5080dc4f83842efc9eea7d8eb39bf7ae6da1fe6138d62f95fe37fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c689393e12768978b276d376197c50bfbf7160525c1605b6b24e414ece8c3ce9f3a27b8eefeb3ecbfe3cb5570543251a445ebeb000206517c20db3752a8866d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/138756ab4c31500b3105f0a95481d440c8b7aa9f6fe7f6c82387a72ce5c2365ec4a84475cfe720122aa42d994e11011ee3f59ec6aecfc945889bffa76d6701e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 11:37:19.442544) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:37:19.442875) ========= 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.be3p9U6tHC/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.c8VPXjwtFx/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:37:19.491745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 11:37:19.492066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 11:37:19.492378) ========= ========= Total master_lag: 0.28 =========