builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0031 starttime: 1476792645.67 results: success (0) buildid: 20161018014648 builduid: 7b908df9ca3a416793d26a82430b66c5 revision: d87df32f5c1f5565de9e7e6108ea1d47c410d6f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.668784) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.669230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.669503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.691979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.692479) ========= 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.e2YWqnWK81/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.qyYc6zjc2C/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-18 05:10:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-10-18 05:10:45 (15.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.878103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.878458) ========= 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.e2YWqnWK81/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.qyYc6zjc2C/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.026369 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:45.927348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 05:10:45.927694) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d87df32f5c1f5565de9e7e6108ea1d47c410d6f8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d87df32f5c1f5565de9e7e6108ea1d47c410d6f8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e2YWqnWK81/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.qyYc6zjc2C/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-18 05:10:45,996 truncating revision to first 12 chars 2016-10-18 05:10:45,996 Setting DEBUG logging. 2016-10-18 05:10:45,996 attempt 1/10 2016-10-18 05:10:45,996 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d87df32f5c1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 05:10:47,028 unpacking tar archive at: autoland-d87df32f5c1f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 05:10:47.232550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:47.232866) ========= script_repo_revision: d87df32f5c1f5565de9e7e6108ea1d47c410d6f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:47.233259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:47.233520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 05:10:47.251300) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-18 05:10:47.251605) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e2YWqnWK81/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.qyYc6zjc2C/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:10:47 INFO - MultiFileLogger online at 20161018 05:10:47 in /builds/slave/test 05:10:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 05:10:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:47 INFO - {'append_to_log': False, 05:10:47 INFO - 'base_work_dir': '/builds/slave/test', 05:10:47 INFO - 'blob_upload_branch': 'Autoland', 05:10:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:47 INFO - 'branch': 'Autoland', 05:10:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:47 INFO - 'config_files': ('talos/mac_config.py',), 05:10:47 INFO - 'default_actions': ('clobber', 05:10:47 INFO - 'read-buildbot-config', 05:10:47 INFO - 'download-and-extract', 05:10:47 INFO - 'populate-webroot', 05:10:47 INFO - 'create-virtualenv', 05:10:47 INFO - 'install', 05:10:47 INFO - 'run-tests'), 05:10:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:47 INFO - 'download_minidump_stackwalk': True, 05:10:47 INFO - 'download_symbols': 'ondemand', 05:10:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:47 INFO - 'installer_path': 'installer.exe', 05:10:47 INFO - 'log_level': 'info', 05:10:47 INFO - 'log_name': 'talos', 05:10:47 INFO - 'log_to_console': True, 05:10:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:10:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:10:47 INFO - 'opt_config_files': (), 05:10:47 INFO - 'pip_index': False, 05:10:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:47 INFO - 'cmd': ('bash', 05:10:47 INFO - '-c', 05:10:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:47 INFO - 'enabled': True, 05:10:47 INFO - 'halt_on_failure': False, 05:10:47 INFO - 'name': 'check_screen_resolution'},), 05:10:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:47 INFO - 'cmd': ('bash', 05:10:47 INFO - '-c', 05:10:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:47 INFO - 'enabled': True, 05:10:47 INFO - 'halt_on_failure': False, 05:10:47 INFO - 'name': 'check_screen_resolution'},), 05:10:47 INFO - 'run_cmd_checks_enabled': True, 05:10:47 INFO - 'sps_profile': False, 05:10:47 INFO - 'sps_profile_interval': 0, 05:10:47 INFO - 'suite': 'dromaeojs', 05:10:47 INFO - 'system_bits': '32', 05:10:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:47 INFO - 'title': 't-yosemite-r7-0031', 05:10:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:47 INFO - 'use_talos_json': True, 05:10:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:47 INFO - 'work_dir': 'build'} 05:10:47 INFO - [mozharness: 2016-10-18 12:10:47.453135Z] Running clobber step. 05:10:47 INFO - Running pre-action listener: _resource_record_pre_action 05:10:47 INFO - Running main action method: clobber 05:10:47 INFO - rmtree: /builds/slave/test/build 05:10:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:49 INFO - Running post-action listener: _resource_record_post_action 05:10:49 INFO - [mozharness: 2016-10-18 12:10:49.718273Z] Finished clobber step (success) 05:10:49 INFO - [mozharness: 2016-10-18 12:10:49.718539Z] Running read-buildbot-config step. 05:10:49 INFO - Running pre-action listener: _resource_record_pre_action 05:10:49 INFO - Running main action method: read_buildbot_config 05:10:49 INFO - Using buildbot properties: 05:10:49 INFO - { 05:10:49 INFO - "project": "", 05:10:49 INFO - "product": "firefox", 05:10:49 INFO - "script_repo_revision": "production", 05:10:49 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 05:10:49 INFO - "repository": "", 05:10:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 05:10:49 INFO - "buildid": "20161018014648", 05:10:49 INFO - "pgo_build": "False", 05:10:49 INFO - "basedir": "/builds/slave/test", 05:10:49 INFO - "buildnumber": 447, 05:10:49 INFO - "slavename": "t-yosemite-r7-0031", 05:10:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:10:49 INFO - "platform": "yosemite_r7", 05:10:49 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 05:10:49 INFO - "branch": "autoland", 05:10:49 INFO - "repo_path": "integration/autoland", 05:10:49 INFO - "revision": "d87df32f5c1f5565de9e7e6108ea1d47c410d6f8", 05:10:49 INFO - "stage_platform": "macosx64", 05:10:49 INFO - "builduid": "7b908df9ca3a416793d26a82430b66c5", 05:10:49 INFO - "slavebuilddir": "test" 05:10:49 INFO - } 05:10:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:10:49 INFO - Running post-action listener: _resource_record_post_action 05:10:49 INFO - [mozharness: 2016-10-18 12:10:49.724042Z] Finished read-buildbot-config step (success) 05:10:49 INFO - [mozharness: 2016-10-18 12:10:49.724267Z] Running download-and-extract step. 05:10:49 INFO - Running pre-action listener: _resource_record_pre_action 05:10:49 INFO - Running main action method: download_and_extract 05:10:49 INFO - mkdir: /builds/slave/test/build/tests 05:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:49 INFO - trying https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:10:49 INFO - Downloading https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:10:50 INFO - Downloaded 1199 bytes. 05:10:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:10:50 INFO - Using the following test package requirements: 05:10:50 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:10:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:10:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:10:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'jsshell-mac.zip'], 05:10:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:10:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:10:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:10:50 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:10:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:10:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:50 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:10:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:10:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:10:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:10:51 INFO - Http code: 200 05:10:51 INFO - via: 1.1 68e4011ca1c00bec92bb202e1ddce131.cloudfront.net (CloudFront) 05:10:51 INFO - x-amz-cf-id: O1SaDlP3-hGev-TygL_ikkNbFyCxOa4pVFMsvgm2uHFeY3RKf1ckSA== 05:10:51 INFO - x-amz-version-id: 5nN7pNTwdNvnCvyZSUfNWnZlnFzvtu48 05:10:51 INFO - Expected file size: 16483609 05:10:51 INFO - Obtained file size: 16483609 05:10:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:10:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:10:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:10:58 INFO - Http code: 200 05:10:58 INFO - via: 1.1 6eaa7f856e226a0db7cef6201d3b8393.cloudfront.net (CloudFront) 05:10:58 INFO - x-amz-cf-id: x_wO3rhCNVwjRd4YrcFy7NGYc0Ey-HrHWzIaWq9Y52gXIGke1zxq-g== 05:10:58 INFO - x-amz-version-id: 5nN7pNTwdNvnCvyZSUfNWnZlnFzvtu48 05:10:59 INFO - Expected file size: 16483609 05:10:59 INFO - Obtained file size: 16483609 05:11:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:11:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:11:05 INFO - Fetch https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:11:06 INFO - Http code: 200 05:11:06 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 05:11:06 INFO - x-amz-cf-id: Y6_0XFsFCmdqxNWHiIRkvA7YRX9qkvtrCOnTWgJNdoyCUacPpy7K9g== 05:11:06 INFO - x-amz-version-id: K5o8h68PQQdvSuyy1lWljTXSh8PKwfht 05:11:06 INFO - Expected file size: 14409028 05:11:06 INFO - Obtained file size: 14409028 05:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:06 INFO - trying https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:11:06 INFO - Downloading https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:11:09 INFO - Downloaded 111619237 bytes. 05:11:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:11:09 INFO - mkdir: /builds/slave/test/properties 05:11:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:09 INFO - Contents: 05:11:09 INFO - build_url:https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:11:10 INFO - Running post-action listener: _resource_record_post_action 05:11:10 INFO - Running post-action listener: set_extra_try_arguments 05:11:10 INFO - [mozharness: 2016-10-18 12:11:10.881522Z] Finished download-and-extract step (success) 05:11:10 INFO - [mozharness: 2016-10-18 12:11:10.881661Z] Running populate-webroot step. 05:11:10 INFO - Running pre-action listener: _resource_record_pre_action 05:11:10 INFO - Running main action method: populate_webroot 05:11:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:10 INFO - '--tppagecycles', 05:11:10 INFO - '7'], 05:11:10 INFO - 'tests': ['tsvgm']}}, 05:11:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['damp', 'tps']}, 05:11:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'tests': ['damp', 'tps']}, 05:11:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['dromaeo_dom']}, 05:11:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['basic_compositor_video']}, 05:11:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore', 05:11:10 INFO - 'tabpaint']}, 05:11:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore', 05:11:10 INFO - 'tabpaint']}, 05:11:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore', 05:11:10 INFO - 'tabpaint']}, 05:11:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore', 05:11:10 INFO - 'tabpaint']}, 05:11:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore', 05:11:10 INFO - 'tabpaint']}, 05:11:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['a11yr', 05:11:10 INFO - 'ts_paint', 05:11:10 INFO - 'tpaint', 05:11:10 INFO - 'sessionrestore', 05:11:10 INFO - 'sessionrestore_no_auto_restore', 05:11:10 INFO - 'tabpaint']}, 05:11:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['tsvgx', 05:11:10 INFO - 'tsvgr_opacity', 05:11:10 INFO - 'tart', 05:11:10 INFO - 'tscrollx', 05:11:10 INFO - 'cart']}, 05:11:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:10 INFO - 'tsvgr_opacity', 05:11:10 INFO - 'tart', 05:11:10 INFO - 'tscrollx', 05:11:10 INFO - 'cart']}, 05:11:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--disable-e10s'], 05:11:10 INFO - 'tests': ['tp5o']}, 05:11:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'tests': ['tp5o']}, 05:11:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--disable-e10s', 05:11:10 INFO - '--xperf_path', 05:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:10 INFO - 'tests': ['tp5n']}, 05:11:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:10 INFO - 'talos_options': ['--xperf_path', 05:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:10 INFO - 'tests': ['tp5n']}}, 05:11:10 INFO - 'talos.zip': {'path': '', 05:11:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:10 INFO - Running post-action listener: _resource_record_post_action 05:11:10 INFO - [mozharness: 2016-10-18 12:11:10.900414Z] Finished populate-webroot step (success) 05:11:10 INFO - [mozharness: 2016-10-18 12:11:10.900531Z] Running create-virtualenv step. 05:11:10 INFO - Running pre-action listener: _resource_record_pre_action 05:11:10 INFO - Running main action method: create_virtualenv 05:11:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:11:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:11 INFO - Using real prefix '/tools/python27' 05:11:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:14 INFO - Installing pip.................done. 05:11:14 INFO - Return code: 0 05:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:14 INFO - Reading from file tmpfile_stdout 05:11:14 INFO - Output received: 05:11:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:11:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:14 INFO - 'HOME': '/Users/cltbld', 05:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:14 INFO - 'LOGNAME': 'cltbld', 05:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:14 INFO - 'MOZ_NO_REMOTE': '1', 05:11:14 INFO - 'NO_EM_RESTART': '1', 05:11:14 INFO - 'PAGER': '/bin/cat', 05:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:14 INFO - 'PWD': '/builds/slave/test', 05:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:14 INFO - 'SHELL': '/bin/bash', 05:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:14 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:14 INFO - 'USER': 'cltbld', 05:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:14 INFO - 'XPC_FLAGS': '0x0', 05:11:14 INFO - 'XPC_SERVICE_NAME': '0', 05:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:15 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 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 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 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:15 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 05:11:15 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 05:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:15 INFO - 'HOME': '/Users/cltbld', 05:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PAGER': '/bin/cat', 05:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:15 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - 'XPC_FLAGS': '0x0', 05:11:15 INFO - 'XPC_SERVICE_NAME': '0', 05:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:15 INFO - Downloading/unpacking psutil>=3.1.1 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:18 INFO - Installing collected packages: psutil 05:11:18 INFO - Running setup.py install for psutil 05:11:18 INFO - building 'psutil._psutil_osx' extension 05:11:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:11:19 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 05:11:19 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 05:11:19 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 05:11:19 INFO - building 'psutil._psutil_posix' extension 05:11:19 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 05:11:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:11:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:11:19 INFO - ^ 05:11:19 INFO - 1 warning generated. 05:11:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:11:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:19 INFO - Successfully installed psutil 05:11:19 INFO - Cleaning up... 05:11:19 INFO - Return code: 0 05:11:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:19 INFO - 'HOME': '/Users/cltbld', 05:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:19 INFO - 'LOGNAME': 'cltbld', 05:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:19 INFO - 'MOZ_NO_REMOTE': '1', 05:11:19 INFO - 'NO_EM_RESTART': '1', 05:11:19 INFO - 'PAGER': '/bin/cat', 05:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:19 INFO - 'PWD': '/builds/slave/test', 05:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:19 INFO - 'SHELL': '/bin/bash', 05:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:19 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:19 INFO - 'USER': 'cltbld', 05:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:19 INFO - 'XPC_FLAGS': '0x0', 05:11:19 INFO - 'XPC_SERVICE_NAME': '0', 05:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:22 INFO - Installing collected packages: mozsystemmonitor 05:11:22 INFO - Running setup.py install for mozsystemmonitor 05:11:22 INFO - Successfully installed mozsystemmonitor 05:11:22 INFO - Cleaning up... 05:11:22 INFO - Return code: 0 05:11:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:22 INFO - 'HOME': '/Users/cltbld', 05:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:22 INFO - 'LOGNAME': 'cltbld', 05:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:22 INFO - 'MOZ_NO_REMOTE': '1', 05:11:22 INFO - 'NO_EM_RESTART': '1', 05:11:22 INFO - 'PAGER': '/bin/cat', 05:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:22 INFO - 'PWD': '/builds/slave/test', 05:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:22 INFO - 'SHELL': '/bin/bash', 05:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:22 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:22 INFO - 'USER': 'cltbld', 05:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:22 INFO - 'XPC_FLAGS': '0x0', 05:11:22 INFO - 'XPC_SERVICE_NAME': '0', 05:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:23 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 05:11:23 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 05:11:23 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 05:11:23 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 05:11:23 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 05:11:23 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 05:11:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:25 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 05:11:25 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 05:11:25 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 05:11:25 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 05:11:25 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 05:11:25 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 05:11:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:26 INFO - warning: no files found matching '*.txt' 05:11:26 INFO - no previously-included directories found matching 'build' 05:11:26 INFO - no previously-included directories found matching 'dist' 05:11:26 INFO - no previously-included directories found matching '.git*' 05:11:26 INFO - Installing collected packages: jsonschema, functools32 05:11:26 INFO - Running setup.py install for functools32 05:11:26 INFO - warning: no files found matching '*.txt' 05:11:26 INFO - no previously-included directories found matching 'build' 05:11:26 INFO - no previously-included directories found matching 'dist' 05:11:26 INFO - no previously-included directories found matching '.git*' 05:11:26 INFO - Successfully installed jsonschema functools32 05:11:26 INFO - Cleaning up... 05:11:26 INFO - Return code: 0 05:11:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:26 INFO - 'HOME': '/Users/cltbld', 05:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:26 INFO - 'LOGNAME': 'cltbld', 05:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:26 INFO - 'MOZ_NO_REMOTE': '1', 05:11:26 INFO - 'NO_EM_RESTART': '1', 05:11:26 INFO - 'PAGER': '/bin/cat', 05:11:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:26 INFO - 'PWD': '/builds/slave/test', 05:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:26 INFO - 'SHELL': '/bin/bash', 05:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:26 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:26 INFO - 'USER': 'cltbld', 05:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:26 INFO - 'XPC_FLAGS': '0x0', 05:11:26 INFO - 'XPC_SERVICE_NAME': '0', 05:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:11:26 INFO - Cleaning up... 05:11:26 INFO - Return code: 0 05:11:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:26 INFO - 'HOME': '/Users/cltbld', 05:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:26 INFO - 'LOGNAME': 'cltbld', 05:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:26 INFO - 'MOZ_NO_REMOTE': '1', 05:11:26 INFO - 'NO_EM_RESTART': '1', 05:11:26 INFO - 'PAGER': '/bin/cat', 05:11:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:26 INFO - 'PWD': '/builds/slave/test', 05:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:26 INFO - 'SHELL': '/bin/bash', 05:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:26 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:26 INFO - 'USER': 'cltbld', 05:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:26 INFO - 'XPC_FLAGS': '0x0', 05:11:26 INFO - 'XPC_SERVICE_NAME': '0', 05:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:30 INFO - Downloading docopt-0.6.1.tar.gz 05:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:30 INFO - Running setup.py install for blobuploader 05:11:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:30 INFO - Running setup.py install for requests 05:11:31 INFO - Running setup.py install for docopt 05:11:31 INFO - Successfully installed blobuploader requests docopt 05:11:31 INFO - Cleaning up... 05:11:31 INFO - Return code: 0 05:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:31 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')]} 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 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')]} 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 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 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:31 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 05:11:31 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 05:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:31 INFO - 'HOME': '/Users/cltbld', 05:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:31 INFO - 'LOGNAME': 'cltbld', 05:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:31 INFO - 'MOZ_NO_REMOTE': '1', 05:11:31 INFO - 'NO_EM_RESTART': '1', 05:11:31 INFO - 'PAGER': '/bin/cat', 05:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:31 INFO - 'PWD': '/builds/slave/test', 05:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:31 INFO - 'SHELL': '/bin/bash', 05:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:31 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:31 INFO - 'USER': 'cltbld', 05:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:31 INFO - 'XPC_FLAGS': '0x0', 05:11:31 INFO - 'XPC_SERVICE_NAME': '0', 05:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:31 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-QwI45C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-YPcn76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-CpdYMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-spo9_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-An_4fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-D9macL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-SADYsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-EYVF_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-0NXqAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-zW5XJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:32 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-RnZ5Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:33 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-hUJ0PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:33 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-UL0yAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:33 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-MALZ5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:33 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Aqd6_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:33 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AboVB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:33 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-jih0yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:33 INFO - Running setup.py install for manifestparser 05:11:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:33 INFO - Running setup.py install for mozcrash 05:11:33 INFO - Running setup.py install for mozdebug 05:11:34 INFO - Running setup.py install for mozdevice 05:11:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozfile 05:11:34 INFO - Running setup.py install for mozhttpd 05:11:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozinfo 05:11:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozInstall 05:11:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:34 INFO - Running setup.py install for mozleak 05:11:34 INFO - Running setup.py install for mozlog 05:11:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for moznetwork 05:11:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for mozprocess 05:11:35 INFO - Running setup.py install for mozprofile 05:11:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for mozrunner 05:11:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:35 INFO - Running setup.py install for mozscreenshot 05:11:35 INFO - Running setup.py install for moztest 05:11:36 INFO - Running setup.py install for mozversion 05:11:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:36 INFO - Cleaning up... 05:11:36 INFO - Return code: 0 05:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:36 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')]} 05:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:36 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')]} 05:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:36 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 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:36 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 05:11:36 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 05:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:36 INFO - 'HOME': '/Users/cltbld', 05:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:36 INFO - 'LOGNAME': 'cltbld', 05:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:36 INFO - 'MOZ_NO_REMOTE': '1', 05:11:36 INFO - 'NO_EM_RESTART': '1', 05:11:36 INFO - 'PAGER': '/bin/cat', 05:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:36 INFO - 'PWD': '/builds/slave/test', 05:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:36 INFO - 'SHELL': '/bin/bash', 05:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:36 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:36 INFO - 'USER': 'cltbld', 05:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:36 INFO - 'XPC_FLAGS': '0x0', 05:11:36 INFO - 'XPC_SERVICE_NAME': '0', 05:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5tFVAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:36 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)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-2QUogp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-wIzIFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ruis75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-T4Sr9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-X3v1ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-IzSBqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-hO3nJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-T3mwM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-34C45r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:37 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)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yRhcjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Zv3PDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Cz8IKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:37 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-1elGqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:38 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-QixHy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:38 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-T7tnAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:38 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-QLvetL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:38 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)) 05:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:38 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)) 05:11:38 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)) 05:11:38 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)) 05:11:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 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 05:11:38 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 05:11:40 INFO - Downloading blessings-1.6.tar.gz 05:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:40 INFO - Installing collected packages: blessings 05:11:40 INFO - Running setup.py install for blessings 05:11:41 INFO - Successfully installed blessings 05:11:41 INFO - Cleaning up... 05:11:41 INFO - Return code: 0 05:11:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:41 INFO - Reading from file tmpfile_stdout 05:11:41 INFO - Current package versions: 05:11:41 INFO - blessings == 1.6 05:11:41 INFO - blobuploader == 1.2.4 05:11:41 INFO - docopt == 0.6.1 05:11:41 INFO - functools32 == 3.2.3-2 05:11:41 INFO - jsonschema == 2.5.1 05:11:41 INFO - manifestparser == 1.1 05:11:41 INFO - mozInstall == 1.12 05:11:41 INFO - mozcrash == 0.17 05:11:41 INFO - mozdebug == 0.1 05:11:41 INFO - mozdevice == 0.48 05:11:41 INFO - mozfile == 1.2 05:11:41 INFO - mozhttpd == 0.7 05:11:41 INFO - mozinfo == 0.9 05:11:41 INFO - mozleak == 0.1 05:11:41 INFO - mozlog == 3.4 05:11:41 INFO - moznetwork == 0.27 05:11:41 INFO - mozprocess == 0.23 05:11:41 INFO - mozprofile == 0.28 05:11:41 INFO - mozrunner == 6.12 05:11:41 INFO - mozscreenshot == 0.1 05:11:41 INFO - mozsystemmonitor == 0.3 05:11:41 INFO - moztest == 0.7 05:11:41 INFO - mozversion == 1.4 05:11:41 INFO - psutil == 3.1.1 05:11:41 INFO - requests == 1.2.3 05:11:41 INFO - wsgiref == 0.1.2 05:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:41 INFO - 'HOME': '/Users/cltbld', 05:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:41 INFO - 'LOGNAME': 'cltbld', 05:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:41 INFO - 'MOZ_NO_REMOTE': '1', 05:11:41 INFO - 'NO_EM_RESTART': '1', 05:11:41 INFO - 'PAGER': '/bin/cat', 05:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:41 INFO - 'PWD': '/builds/slave/test', 05:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:41 INFO - 'SHELL': '/bin/bash', 05:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:41 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:41 INFO - 'USER': 'cltbld', 05:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:41 INFO - 'XPC_FLAGS': '0x0', 05:11:41 INFO - 'XPC_SERVICE_NAME': '0', 05:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:41 INFO - Cleaning up... 05:11:41 INFO - Return code: 0 05:11:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:41 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 0x10625e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd65ad9ff80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, '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.e2YWqnWK81/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.qyYc6zjc2C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 05:11:41 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 05:11:41 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 05:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:41 INFO - 'HOME': '/Users/cltbld', 05:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:41 INFO - 'LOGNAME': 'cltbld', 05:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:41 INFO - 'MOZ_NO_REMOTE': '1', 05:11:41 INFO - 'NO_EM_RESTART': '1', 05:11:41 INFO - 'PAGER': '/bin/cat', 05:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:41 INFO - 'PWD': '/builds/slave/test', 05:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:41 INFO - 'SHELL': '/bin/bash', 05:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:11:41 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:41 INFO - 'USER': 'cltbld', 05:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:41 INFO - 'XPC_FLAGS': '0x0', 05:11:41 INFO - 'XPC_SERVICE_NAME': '0', 05:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:42 INFO - Cleaning up... 05:11:42 INFO - Return code: 0 05:11:42 INFO - Running post-action listener: _resource_record_post_action 05:11:42 INFO - Running post-action listener: _start_resource_monitoring 05:11:42 INFO - Starting resource monitoring. 05:11:42 INFO - [mozharness: 2016-10-18 12:11:42.068318Z] Finished create-virtualenv step (success) 05:11:42 INFO - [mozharness: 2016-10-18 12:11:42.069157Z] Running install step. 05:11:42 INFO - Running pre-action listener: _resource_record_pre_action 05:11:42 INFO - Running main action method: install 05:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:42 INFO - Reading from file tmpfile_stdout 05:11:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:42 INFO - Reading from file tmpfile_stdout 05:11:42 INFO - Output received: 05:11:42 INFO - Usage: mozinstall [options] installer 05:11:42 INFO - Options: 05:11:42 INFO - -h, --help show this help message and exit 05:11:42 INFO - -d DEST, --destination=DEST 05:11:42 INFO - Directory to install application into. [default: 05:11:42 INFO - "/builds/slave/test"] 05:11:42 INFO - --app=APP Application being installed. [default: firefox] 05:11:42 INFO - mkdir: /builds/slave/test/build/application 05:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:12:17 INFO - Reading from file tmpfile_stdout 05:12:17 INFO - Output received: 05:12:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:12:17 INFO - Running post-action listener: _resource_record_post_action 05:12:17 INFO - [mozharness: 2016-10-18 12:12:17.033923Z] Finished install step (success) 05:12:17 INFO - [mozharness: 2016-10-18 12:12:17.034051Z] Running run-tests step. 05:12:17 INFO - Running pre-action listener: _resource_record_pre_action 05:12:17 INFO - Running main action method: run_tests 05:12:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:12:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:12:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:12:17 INFO - 2016-10-18 05:12:17.046 screenresolution[1642:7684] starting screenresolution argv=screenresolution get 05:12:17 INFO - 2016-10-18 05:12:17.048 screenresolution[1642:7684] Display 0: 1600x1200x32@60 05:12:17 INFO - 2016-10-18 05:12:17.053 screenresolution[1643:7686] starting screenresolution argv=screenresolution list 05:12:17 INFO - Available Modes on Display 0 05:12:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:12:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:12:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:12:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:12:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:12:17 INFO - Intel Iris: 05:12:17 INFO - Chipset Model: Intel Iris 05:12:17 INFO - Type: GPU 05:12:17 INFO - Bus: Built-In 05:12:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:12:17 INFO - Vendor: Intel (0x8086) 05:12:17 INFO - Device ID: 0x0a2e 05:12:17 INFO - Revision ID: 0x0009 05:12:17 INFO - Displays: 05:12:17 INFO - Display: 05:12:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:12:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:12:17 INFO - Display Serial Number: 1600x1200 60 05:12:17 INFO - Main Display: Yes 05:12:17 INFO - Mirror: Off 05:12:17 INFO - Online: Yes 05:12:17 INFO - Rotation: Supported 05:12:17 INFO - Return code: 0 05:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:17 INFO - Python 2.7.3 05:12:17 INFO - Return code: 0 05:12:17 INFO - grabbing minidump binary from tooltool 05:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106072d30>, '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 0x105e98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10606ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:12:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:12:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:12:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:17 INFO - Return code: 0 05:12:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:12:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:12:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2YWqnWK81/Render', 05:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:17 INFO - 'HOME': '/Users/cltbld', 05:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:17 INFO - 'LOGNAME': 'cltbld', 05:12:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:17 INFO - 'MOZ_NO_REMOTE': '1', 05:12:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:17 INFO - 'NO_EM_RESTART': '1', 05:12:17 INFO - 'PAGER': '/bin/cat', 05:12:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:17 INFO - 'PWD': '/builds/slave/test', 05:12:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:17 INFO - 'SHELL': '/bin/bash', 05:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qyYc6zjc2C/Listeners', 05:12:17 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 05:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:17 INFO - 'USER': 'cltbld', 05:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:17 INFO - 'XPC_FLAGS': '0x0', 05:12:17 INFO - 'XPC_SERVICE_NAME': '0', 05:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:12:17 INFO - mozversion application_buildid: 20161018014648 05:12:17 INFO - mozversion application_changeset: d87df32f5c1f5565de9e7e6108ea1d47c410d6f8 05:12:17 INFO - mozversion application_display_name: Nightly 05:12:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:17 INFO - mozversion application_name: Firefox 05:12:17 INFO - mozversion application_remotingname: firefox 05:12:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:12:17 INFO - mozversion application_vendor: Mozilla 05:12:17 INFO - mozversion application_version: 52.0a1 05:12:17 INFO - mozversion platform_buildid: 20161018014648 05:12:17 INFO - mozversion platform_changeset: d87df32f5c1f5565de9e7e6108ea1d47c410d6f8 05:12:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:12:17 INFO - mozversion platform_version: 52.0a1 05:12:17 INFO - using testdate: 1476792737 05:12:17 INFO - actual date: 1476792737 05:12:17 INFO - starting webserver on 'localhost:49274' 05:12:17 INFO - SUITE-START | Running 2 tests 05:12:17 INFO - TEST-START | dromaeo_css 05:12:17 INFO - operating with platform_type : mac_ 05:12:17 INFO - Initialising browser for dromaeo_css test... 05:12:17 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp_pQPXd/profile http://localhost:49274/getInfo.html) 05:12:20 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 05:12:20 INFO - PROCESS | 1653 | colorDepth:24 05:12:20 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 05:12:20 INFO - PROCESS | 1653 | __metrics 05:12:20 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:20 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:21 INFO - TEST-INFO | 1653: exit 0 05:12:21 INFO - Browser initialized. 05:12:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:21 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp_pQPXd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:32 INFO - PROCESS | 1655 | RSS: Main: 231964672 05:12:32 INFO - PROCESS | 1655 | 05:13:24 INFO - PROCESS | 1655 | 1476792804188 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:15:40 INFO - PROCESS | 1655 | RSS: Main: 365936640 05:15:40 INFO - PROCESS | 1655 | 05:18:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:18:44 INFO - PROCESS | 1655 | RSS: Main: 371585024 05:18:44 INFO - PROCESS | 1655 | 05:21:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:21:47 INFO - PROCESS | 1655 | RSS: Main: 351543296 05:21:47 INFO - PROCESS | 1655 | 05:24:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:24:50 INFO - PROCESS | 1655 | RSS: Main: 340262912 05:24:50 INFO - PROCESS | 1655 | 05:27:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:27:54 INFO - PROCESS | 1655 | RSS: Main: 328650752 05:27:54 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:30:57 INFO - PROCESS | 1655 | RSS: Main: 597995520 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | __start_tp_report 05:30:57 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 05:30:57 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 05:30:57 INFO - PROCESS | 1655 | |i|pagename|runs| 05:30:57 INFO - PROCESS | 1655 | |0;dojo.html;3107.2697915989725;3169.68303169683;3288.8026718396914;3350.346682396933;3399.6260411354747;5392.786623009821;5630.40880707526;5725.312962444507;5785.161151633016;5790.189373487705;5188.766505507252;5699.287589051369;5700.287464066992;5719.542436605072;5722.484976352138;5181.507756763121;5211.635185536995;5218.295530103444;5232.084385232588;5253.395859476152;5302.337207849019;5303.681779093247;5305.867353316159;5325.760340784674;5332.386775520826;5204.089284375238;5255.632105752599;5257.080010998079;5287.894242115155;5289.338832645919;5266.025785229706;5276.630635855492;5287.339082614692;5294.258803767476;5332.173513105475;5115.66748161372;5128;5170.560502357304;5243.213517972296;5243.475652434764;5636.436356364331;5646;5664;5675.978323901696;5712.11462223356;6159.38406159385;6203.565750397474;6252.812415627538;6264.9686751566405;6268.749250030039;6120.995732433061;6223.87552248957;6254.838210249239;6313.210848643919;6329.145565348665;5742.425757424307;5753.223314852525;5810.767569297265;5812.738426770806;5816.185733997244;6255.176060905359;6311.116443697886;6319.652419116901;6326.905096423558;6344.143540621957;6126.295476020315;6130.846728831815;6131.601445906091;6153.077038444179;6154.5384096192965;6093.595082292339;6124.869201255686;6147.985582378947;6191.071339299141;6230.59501132425;6153.077038444269;6229.190205273376;6232.875342493125;6239.688015599202;6254.499640028877;6201.875962480725;6232.594881332699;6245.469135123474;6264.185655864709;6270.435660790459;4852.272159176152;4871.658983871095;4904.362432883702;4916.680415772963;4969.82605608802;4403.163398954189;4407.713498622579;4439.023414848728;4479.171353299585;4526.683132180781;5740.39725828782;5763.423657634287;5779.017567013618;5781.959247335436;5795.594308398372;4978.551930326288;6210.50315974721;6238.563300568917;6268.1851359323;6275.341089185661;5665;5704.372519022904;5714.342850572238;5714.857128571736;5715.514181294637;5332.973335133377;5371.919421208685;5373.838784836461;5377.919331210035;5383.569314454834;6324;6324.114623952558;6338.619682819046;6342.080398342122;6348.619082855043;6189.319174890668;6201.906971395523;6254.312025677263;6305;6317.526185536011;6307.30619631831;6308.747650093945;6310.337414571404;6312.873742525032;6314.210723659543;6069.423404776539;6217.036359364306;6228.968855155696;6239;6248.4688801452385;6008.339082700987;6199;6227.532935029801;6235.812925612239;6260;6132.256728365309;6132.692058233554;6137.959273351923;6140.4428991762525;6147.477464415575;6120.660465672032;6137.867325793252;6138.75626760427;6149.907751383822;6150.200473938359;5798.072308430631;5829;5836.095405212199;5859.970700146472;5980.312264089685;6053.697315134314;6118.558266176285;6139.781185991871;6144.341027922525;6145.494353883327;5938.138969849434;5950.2264705587995;5952.285725712942;5958.255218097738;5974.4324289192455 05:30:57 INFO - PROCESS | 1655 | |1;ext.html;444.19378827428204;485.3811390477141;503.6197670758577;515.0574448758772;521.9556337711294;35629.10927226821;39966.20067598646;41320.17359652809;41640.750777476685;43012;42511;42976.925576860514;43033.35449968253;43037.569624303746;43064.13871722572;9510.144087032166;9677.951610241938;9679;9704.175145112675;9706.951465242664;9570.52147392631;9673.806523869518;9684.322097453145;9690.757731056745;9714.805703885953;9665.10046985905;9713;9716.65991690291;9727.708168754913;9735.41587504752;9639.71080867575;9669.661561845372;9690.854637180448;9691.75770605737;9729.027097290285;9536;9622.422654640673;9622.759431014281;9643.373180743229;9648.517574121266;40424.79787601073;40750;40776.79611601923;40802.38796418026;40807.7959610203;3314.436545787222;3454.7408944329277;3531.1878267998504;3770.8303126359106;4051.918961620751;30175.849120754476;30266.69733302661;31476;31625.683743162503;31868;3152.4168028914496;3286.359159963808;3327.683870032343;3328.4674452087793;3362.3107263011025;448618;451368;453606;453650.4397126248;454867.72566136956;57667;57856.13215801682;57878;57935.42064579385;58013;61823;61888.071678924854;61924.69037654873;62077.37922620806;62117.82587609412;15985.680286394207;16186;16205.756913646304;16220.51338459848;16283.104429256504;12638.494460221487;12668.303243321521;12703.618891433272;12718.236905785683;12719.236845789283;15930.60173495672;16602;16611.750823737653;16677.332906683598;16702.914310569773;6302.621842689453;6304.338044505261;6321.778737744157;6402.775902843378;6438.903416448757;724.5263570002048;736.2453485177736;823.5593957232852;830.4228561149943;931.1759093202564;28212.576811347848;30222;30251.697483024887;30394.387750032434;30489.847550762104;1028.6554004408606;1043.6190790361616;1056.2447849787286;1105.7788442311569;1138.5218208352512;14599.78100328496;14893.47872824446;15003.399864005318;15235.628793408425;15375.384984600714;609333;613869;614824;614912;615301;58034.70982645144;58139.4186058134;58170;58198;58247.417525824196;1214.8359971403925;1259.2066997791333;1307.1046333261745;1368.3295185359302;1380.4340220509544;30229.244268893453;31097.8445107773;31149.065528034196;31683.36633267368;32030.35939281248;48335.274970874765;49072;49110;49186.50813491819;49196.75401622969;434168;515033;517907;518081;519592;25221.873890631163;25248.74751252464;25546.744532554436;25762.227133186036;25832.483350333263;45226;45491.772541137085;45630.77184614056;45861.77069114766;45994.770026150996;32346;35551;37936.62063379441;37950.240995180495;38800.41799373068;37381.439278410304;38225;38322.80838595789;38358;38977.6102238974;36516.45225321569;36709.26581468409;37514.437283441315;37517.87446376613;37568.43647345238;32435.513467298482;33216.83391583123;34176.82911585426;34189.82905085458;34409.65590344165;25085.749142508343;25204.865781040266;25226.99092036298;25286.988520458977;25475 05:30:57 INFO - PROCESS | 1655 | |2;jquery.html;345.8046203894798;363.1230578153757;372.84340576957675;376.3583090830134;398.8185375654078;14642.414303427864;14870.959032867704;15678;19651.803481965177;20559.486012849688;19695.60608787827;20275.898620506876;20938.581228375424;21015.684764728543;21198.89400552995;5634.760352722395;5697.376247769386;5941.8217453476245;5992.400759924017;5992.7902523411685;5359.330083739533;5854.414558544154;5909.290885093795;5911.852203694899;5917.142014407908;5700.200584789487;5724.456176663231;5820.214271073414;5854.707264636772;5869.911951320733;4834.371531700874;5815.767369305223;5824.563157763185;5826.397740621321;5839.941600583982;4925.507449255082;4959.70241785494;5080.441151473335;5103.719295438749;5104.69371837691;25429.10998115057;25435.364115897064;25486.36284092894;25733.74266257332;25769.840357183974;1639.9344026239055;2145.4743587820926;2168.1977668262684;2227.6213043782595;2293.9197128100604;9865.753356166082;10336.328138671037;10376.014278643517;10859.674209773719;11218.214724969255;1762.6210364771507;1764.1620230390463;1865.6455273497993;1886.2360743898744;1904.4001139640968;95725.84635839688;97564;99673.50163249137;110935.44532277368;115237;9696.369735967139;11390.373529455794;11513.481893314822;11727.824082638766;11811;14473.78289325661;14496.985211035126;14521.91085668579;14532.85467145315;14555.490557830424;8085.474444161111;8279.668813247403;8461.576921153917;8489;8607.698730544402;8284.792880178044;8294.419390642597;8342.62458189383;8488.108748581433;8543;3829.463875057494;4525.954740452553;4551.658625603093;4556.997460558672;4584.6561507887045;1861.944141675752;1900.2304066852946;1904.1336192032593;1904.5429097016615;1908.4560900143392;865.9523726194993;894.5259012723267;945.6737425588161;966.6568368229318;998.7503124218945;19885.502862428264;20796.688049679266;21115.577688446145;21365;21466.467012425426;756.0096273881123;917.3440989692268;917.8990311065777;928.8095940332215;968.2399316536626;10861.34831910088;11196.272242304223;11217.831732524019;11241.887581124247;11256;549913;577742.1112894493;589993;592987;593217;63410.68294658497;95690.52154739182;114773;119610.40194799144;120341;868.2793281576277;897.9012308646044;933.8412469880137;936.2930987104828;937.9202767764816;18988.3354082612;19097.140628671466;19148;19170.52073698113;19180.71228931595;45133.42033028828;51805.7409712949;52256;53638.338581735;54283.18575221454;72522;72575;73566.63216683883;73717.26282737104;73729.6313518429;7627.580483073262;7806.375489960903;8061.113277539349;8095.150009248944;8381.664733410595;10934.507947142556;12243.326617035793;12303.93848030754;12816.871831281567;12834.229946203257;8820.823583528165;9082.59128339213;10691.946540267249;10747.35515869019;11140.275882067639;10858.45707714627;10955.233133680566;11069.944650276697;11275.097992160772;11358.977692007758;8839.166150340745;10787.083097936764;11011.779764404508;11229.3262404256;11298.378589177346;7847.2152784721075;8096.190380962093;8143.470674406145;8276.08963014056;8307.626156822836;9017.233535149586;9778.315517913677;10938.015578597646;10990.560377584807;11006 05:30:57 INFO - PROCESS | 1655 | |3;mootools.html;1524.375006247438;1558.7817705521225;1786.1337251433054;1916.3867562380026;1952.1800843645667;8247.91752082479;8698.73903782886;8706.0858609846;8723.127687231274;8737.737867863967;7655.464117511777;7920.405969552277;7946.404019698532;8340.541270230135;8539.018012928515;2353.1999120299097;2355.3758254062686;2358.2807243790635;2359.268626725712;2363.09021026905;2293.7018187635585;2301.9309420717404;2329.26628112145;2331.603627383349;2332.5917964356254;2015.2644284836076;2313.410080429488;2331.067572970808;2337.333859849943;2340.625499920013;1939.76722793265;2288.0962020002007;2296.1733775840685;2297.356740112763;2298.954020919589;1877.802830702784;2294.2773026496766;2302.861828290308;2305.8155347572156;2307.2501437033034;8608.612612432393;8672.609732561987;8678.956605216996;8688.044315125331;8693.565321733888;5120.61595380348;5290.68255904647;5293.470652934714;5312.1766126250495;5317.2821669074565;3433.399155147864;3490.7556471047037;3626.0934766308424;3632.273545290926;3646.6717995380545;1074.6333881244038;1083.041508265191;1088.5754555723274;1104.6465131158034;1105.6240878101403;11306.265092768943;11441.942790285995;11448.969592736694;11462.82805757906;11468.827967580493;4470.105978804252;4555.9772201138785;4707.882302942454;4725.527447255316;4726.480087190406;9531.046895310414;9689.660861869941;9703.514824258758;9706.466144362128;9750.414975101517;5266.262723218752;5287.312649355559;5297.17893726473;5299.814506492331;5301.443348448434;4322.286822674224;4482;4645.46577143626;4782.0435912817575;4860.027994401134;3800.847966081381;3825;3901.4147877818555;3926.8821935341984;3952.6837852971694;1170.9180357374903;1188.6849984754047;1259.622113366005;1265.411583613624;1278.9296588687712;820.4830956497368;882.0429833630454;885.5527958380976;899.1952202778476;905.7373361725158;5571.749271282721;5713.342965559014;5818.912716309259;5882.794102206402;6042.6978651067275;425.90967124162245;434.4482507215818;436.16474451425796;437.29377056054244;437.4968785896181;3859.7877116758286;3881.1073453105378;3987.501562304712;3993.281209382339;4072.8370865165653;8562.357823163287;10255.384676919408;10429.269951103503;10600.734981625521;10636.52135653882;10558.683239502827;10564.841527377095;10572.577096916037;10578.894211057945;10579.788404232026;7788.4548081634875;7992.760217193493;8092.554909480035;8093.959530202312;8101.513909165351;5705.343885453226;5742.425757424224;5760.308762948473;5779.335376431596;5865.061590145556;9683.854742179014;9729.367591106555;9786.363886347364;9863.457509837028;9881.703548893545;8701.738947831574;9476;9965.551550180115;10035.19718422539;10039.899601003897;6686.598804071771;6850.554713943578;7079.115110611174;7233.638318083969;7329.816754581178;8054;8165.305948994164;8280.337572994267;8285.130061343472;8285.83428331418;7088.220295767358;7155.499115061895;7186.209516953027;7258.3104605062435;7334.376577990717;7041.155061392461;7055.18865330473;7058.858822823618;7100.041494398397;7127.964360178166;6613.074169616161;6754.324567543206;6829.93170068293;6832.555883867532;6839;4879.634027448026;4927.876803079952;4942.6293028023765;4992.425871024879;5071.797128114982;4219.578042195756;4880.1215781159735;4913.213885778258;5049.974750126225;5072.695638261716 05:30:57 INFO - PROCESS | 1655 | |4;prototype.html;256.34248153486305;291.66312908590584;300.3182179793159;304.61922596754056;307.13541381012436;5374.623776335653;5441.863953401157;5477.233187353769;5486.835394938148;5486.91769623456;5075.213341931997;5080.364954380702;5209.609279304058;5272.604554658396;5399.217113518537;3637.345008021344;3669.2111196092833;4057.5130984281927;4112.999999999993;4143.337066069429;3548.9645103549024;3944.8559917623857;4072.857449989251;4085.2442298174783;4137.565555616647;3527.224010717651;3715.7770533767925;3875.9031024224337;4064.9390259146135;4087.6934229932726;2980.210244285266;3007.7142671446286;3327.667233276677;3570.1788588624763;3968.8015599220066;3399.1332210286464;3551.3430015447225;3552.8045957472327;3553.236054248349;3560.2167523144867;4284.635805956497;4525.818967241306;5264.289320941701;5308.681479111266;5310.787568497255;3734.9813250933844;4481.820727170909;4536.637069034469;4686.976565117153;4706.388169537972;4684.695494792828;5671.723862131029;5709.543236541108;5726.284214473191;5737.311522617312;3937.0944682722848;3950.8222130003933;3959.6436320730986;3973.443717879499;3978.4629075074786;5061.5950723942;5607.859803504945;5623.381428042912;5882.764689412461;6008.45501154321;3304.8512816923294;3954.189391174802;3956.4658771066115;3989.708490495353;3998.980005099956;3777.471154038437;4001.759454569093;4058.037632528271;4060.26915155269;4078.347464405681;4478.910421791546;4586.747728874877;4687.742174180453;4692.389989301369;4700.2244629635725;4934.225317632015;5402.567794576425;5629.804376293249;5634.661920284796;5659.518940889988;1244.9107031347571;1264.8545417276946;1356.240505317006;1375.848656647768;1380.6824430381068;874.9693760718471;895.9104089591119;924.371427429341;952.2382094324652;955.9187469065068;4656.231721765871;4776.9761151194025;5022.372203474566;5091.930694554111;5358.490943360374;5798.971005144947;5823.641425222791;5824.796132135355;5829.766809327664;5877.764889404376;4011.1777085697363;4363.410939523187;4915.43472500667;5398.784048638089;5402.945970540323;2665.2537289558954;2908.403777225664;2970.6928951261375;3000.7599392048583;3023.8034527756067;5603.635763675348;5940.405959404025;5942.70286485674;5950.345461999176;5968.761249550056;4267;5343.381742945929;5817.720101577646;5866.7653293868625;5881.411858814085;5111.923321150186;5850.47345738877;5876.706164691834;5879.265091863517;5898.705064746746;5415.702136382537;5660.632058916157;5694.804091140742;5699.974004679198;5726.599138060463;4880.633952453652;5187.325647665779;5375.747672657985;5613;5685.715714214355;4919.335889654851;5187.948120518747;5555.805546805843;5913.34953155144;5930.7924222652;3735;3867.8646247381207;3929.2730844793805;3930.486762596364;3950.5456872458885;5239.476052394883;5690.5163061140265;5695.117256825199;5729.9713501432225;5735.99620066495;4811.975940120277;5401.3236369233255;5578.63738856973;5583.604098975256;5620.381758006534;4725.976370118127;5218.66078704883;5432.402435732145;5565.749541270734;5570.610057296112;4422.3366495026;5191.896162076813;5377.569794416516;5395.730213489232;5407.269673704534;5213.582913366998;5333.0002498126405;5383.67697938125;5667.8866422672145;5699.686517241592;4646.140464014168;4667.9766601166775;5168.346129238607;5444.727763611882;5528.926652505311 05:30:57 INFO - PROCESS | 1655 | |5;yui.html;674.5076094451051;734.1520543771945;736.900518430012;745.634639026877;774.6204359863665;14660.78008829867;15376.769348459782;15411.306491207895;15448.995815272014;15692.529224123266;14020;14168.787468187986;14176.43294268228;14204.857951420483;14208.573742787732;689.0353505092885;713.636045616734;714.5498336048282;720.9170945341274;863.8661007543841;872.3893274707698;878.6046279174365;883.4610887358706;884.2086332732201;884.7434244069212;932.3380399916068;932.6549176804592;933.1834644685899;934.042606328512;934.1965909317981;720.2869159532078;747.637395863006;928.0997432490474;931.2177770672668;931.5807886451124;553.3194171169484;554.3569459427046;554.6727430815798;672.8856094463953;694.1773997812609;11721.824172637418;14787.334569944378;14846.035007724464;14857.182854942974;14871.330790114363;13108.47566097355;13491.66270843227;13553.864461355359;13571;13912.37394317258;11982.580609678707;12100.636980890587;12189.878101218963;12672.746545069047;12695.873041269562;4355.216061108999;4391.8462853799965;4431.800568974404;4452.821887124511;4454.643628509712;113168.43415782951;115479.42260288645;116041.4197929005;116153;117197.4140129294;10749.193810464247;10749.731256718489;10779.568817247378;10946;11177.888221117848;21249.043793029352;21275;21294.574108518053;21299.574008519743;21319;6793.694283757242;6983;7531.849363012709;7575.810604734816;7743.186965368668;4046.251443482965;4062.73592216505;4099.9180016400105;4105.2405305018665;4151.564085771011;3326.6507016763376;3423.1955490459723;3427.7429192810637;3429.176997520627;3431.0564594736147;595.6068994463633;642.7493277621732;694.7325279767326;695.5061906046764;700.1178515070945;631.8641492079225;633.268574796102;669.7321071571313;672.2235817630644;679.1374953808636;8800.207981281588;8880.37837351392;9038.231750301298;9083.500407477652;9092.454452732858;585.5140233606097;624.7906951171318;652.2238536142071;668.8294484906318;680.4556354916048;4269.914601707948;4427.955720442755;4452.376667266521;4478.507364189936;4574.153781550423;90897;109028.4548577252;135972.32013839867;139172.3041384807;149484;133824.33087834498;138560.8367205114;140219;141478;142109.28945355208;97470;112997;113288;115430.84569154368;119321;6658.9667051666365;7674.961625191839;8328.867186724734;8464.365172611955;8863.556822158995;41056.79471602623;64646.67676661775;65845.34154658392;66572.66713666401;68973;93007;97193.54209686718;99460;100135;101113;11046.447677616248;11146.331220126818;11226.607068752555;11229.775404492028;11338.829917551078;12469.688257793629;12531.436085375997;12660.366981651065;13034.869651303745;13061.151025183333;11675.007624352025;11837.171398002401;12055.57805476804;12392.132550721362;12485.250884946932;11886.643400697993;12119.878801211875;12139.939300303442;12277.140600157903;12406.81389779136;11855.822162667395;11961.700957475785;12068.396580171131;12190.51237950472;12229.388530573258;9640.614375424904;9952.410614177152;10036.949815250877;10054.19566434698;10473.423961681876;6922.446204303543;8732.432391894507;9288.11091888964;10040.347377420445;10202.234832387452 05:30:57 INFO - PROCESS | 1655 | __end_tp_report 05:30:57 INFO - PROCESS | 1655 | __start_cc_report 05:30:57 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1855 05:30:57 INFO - PROCESS | 1655 | __end_cc_report 05:30:57 INFO - PROCESS | 1655 | __startTimestamp1476793857516__endTimestamp 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | ------- Summary: start ------- 05:30:57 INFO - PROCESS | 1655 | Number of tests: 6 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5742.25 Median:5952.29 stddev:649.47 (10.9%) stddev-sans-first:617.70 05:30:57 INFO - PROCESS | 1655 | Values: 3107.3 3169.7 3288.8 3350.3 3399.6 5392.8 5630.4 5725.3 5785.2 5790.2 5188.8 5699.3 5700.3 5719.5 5722.5 5181.5 5211.6 5218.3 5232.1 5253.4 5302.3 5303.7 5305.9 5325.8 5332.4 5204.1 5255.6 5257.1 5287.9 5289.3 5266.0 5276.6 5287.3 5294.3 5332.2 5115.7 5128.0 5170.6 5243.2 5243.5 5636.4 5646.0 5664.0 5676.0 5712.1 6159.4 6203.6 6252.8 6265.0 6268.7 6121.0 6223.9 6254.8 6313.2 6329.1 5742.4 5753.2 5810.8 5812.7 5816.2 6255.2 6311.1 6319.7 6326.9 6344.1 6126.3 6130.8 6131.6 6153.1 6154.5 6093.6 6124.9 6148.0 6191.1 6230.6 6153.1 6229.2 6232.9 6239.7 6254.5 6201.9 6232.6 6245.5 6264.2 6270.4 4852.3 4871.7 4904.4 4916.7 4969.8 4403.2 4407.7 4439.0 4479.2 4526.7 5740.4 5763.4 5779.0 5782.0 5795.6 4978.6 6210.5 6238.6 6268.2 6275.3 5665.0 5704.4 5714.3 5714.9 5715.5 5333.0 5371.9 5373.8 5377.9 5383.6 6324.0 6324.1 6338.6 6342.1 6348.6 6189.3 6201.9 6254.3 6305.0 6317.5 6307.3 6308.7 6310.3 6312.9 6314.2 6069.4 6217.0 6229.0 6239.0 6248.5 6008.3 6199.0 6227.5 6235.8 6260.0 6132.3 6132.7 6138.0 6140.4 6147.5 6120.7 6137.9 6138.8 6149.9 6150.2 5798.1 5829.0 5836.1 5860.0 5980.3 6053.7 6118.6 6139.8 6144.3 6145.5 5938.1 5950.2 5952.3 5958.3 5974.4 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66052.90 Median:40805.09 stddev:140564.96 (344.5%) stddev-sans-first:140872.97 05:30:57 INFO - PROCESS | 1655 | Values: 444.2 485.4 503.6 515.1 522.0 35629.1 39966.2 41320.2 41640.8 43012.0 42511.0 42976.9 43033.4 43037.6 43064.1 9510.1 9678.0 9679.0 9704.2 9707.0 9570.5 9673.8 9684.3 9690.8 9714.8 9665.1 9713.0 9716.7 9727.7 9735.4 9639.7 9669.7 9690.9 9691.8 9729.0 9536.0 9622.4 9622.8 9643.4 9648.5 40424.8 40750.0 40776.8 40802.4 40807.8 3314.4 3454.7 3531.2 3770.8 4051.9 30175.8 30266.7 31476.0 31625.7 31868.0 3152.4 3286.4 3327.7 3328.5 3362.3 448618.0 451368.0 453606.0 453650.4 454867.7 57667.0 57856.1 57878.0 57935.4 58013.0 61823.0 61888.1 61924.7 62077.4 62117.8 15985.7 16186.0 16205.8 16220.5 16283.1 12638.5 12668.3 12703.6 12718.2 12719.2 15930.6 16602.0 16611.8 16677.3 16702.9 6302.6 6304.3 6321.8 6402.8 6438.9 724.5 736.2 823.6 830.4 931.2 28212.6 30222.0 30251.7 30394.4 30489.8 1028.7 1043.6 1056.2 1105.8 1138.5 14599.8 14893.5 15003.4 15235.6 15375.4 609333.0 613869.0 614824.0 614912.0 615301.0 58034.7 58139.4 58170.0 58198.0 58247.4 1214.8 1259.2 1307.1 1368.3 1380.4 30229.2 31097.8 31149.1 31683.4 32030.4 48335.3 49072.0 49110.0 49186.5 49196.8 434168.0 515033.0 517907.0 518081.0 519592.0 25221.9 25248.7 25546.7 25762.2 25832.5 45226.0 45491.8 45630.8 45861.8 45994.8 32346.0 35551.0 37936.6 37950.2 38800.4 37381.4 38225.0 38322.8 38358.0 38977.6 36516.5 36709.3 37514.4 37517.9 37568.4 32435.5 33216.8 34176.8 34189.8 34409.7 25085.7 25204.9 25227.0 25287.0 25475.0 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33097.82 Median:4538.81 stddev:96275.34 (2121.2%) stddev-sans-first:96514.01 05:30:57 INFO - PROCESS | 1655 | Values: 345.8 363.1 372.8 376.4 398.8 14642.4 14871.0 15678.0 19651.8 20559.5 19695.6 20275.9 20938.6 21015.7 21198.9 5634.8 5697.4 5941.8 5992.4 5992.8 5359.3 5854.4 5909.3 5911.9 5917.1 5700.2 5724.5 5820.2 5854.7 5869.9 4834.4 5815.8 5824.6 5826.4 5839.9 4925.5 4959.7 5080.4 5103.7 5104.7 25429.1 25435.4 25486.4 25733.7 25769.8 1639.9 2145.5 2168.2 2227.6 2293.9 9865.8 10336.3 10376.0 10859.7 11218.2 1762.6 1764.2 1865.6 1886.2 1904.4 95725.8 97564.0 99673.5 110935.4 115237.0 9696.4 11390.4 11513.5 11727.8 11811.0 14473.8 14497.0 14521.9 14532.9 14555.5 8085.5 8279.7 8461.6 8489.0 8607.7 8284.8 8294.4 8342.6 8488.1 8543.0 3829.5 4526.0 4551.7 4557.0 4584.7 1861.9 1900.2 1904.1 1904.5 1908.5 866.0 894.5 945.7 966.7 998.8 19885.5 20796.7 21115.6 21365.0 21466.5 756.0 917.3 917.9 928.8 968.2 10861.3 11196.3 11217.8 11241.9 11256.0 549913.0 577742.1 589993.0 592987.0 593217.0 63410.7 95690.5 114773.0 119610.4 120341.0 868.3 897.9 933.8 936.3 937.9 18988.3 19097.1 19148.0 19170.5 19180.7 45133.4 51805.7 52256.0 53638.3 54283.2 72522.0 72575.0 73566.6 73717.3 73729.6 7627.6 7806.4 8061.1 8095.2 8381.7 10934.5 12243.3 12303.9 12816.9 12834.2 8820.8 9082.6 10691.9 10747.4 11140.3 10858.5 10955.2 11069.9 11275.1 11359.0 8839.2 10787.1 11011.8 11229.3 11298.4 7847.2 8096.2 8143.5 8276.1 8307.6 9017.2 9778.3 10938.0 10990.6 11006.0 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5562.43 Median:4935.25 stddev:3116.54 (63.1%) stddev-sans-first:3110.51 05:30:57 INFO - PROCESS | 1655 | Values: 1524.4 1558.8 1786.1 1916.4 1952.2 8247.9 8698.7 8706.1 8723.1 8737.7 7655.5 7920.4 7946.4 8340.5 8539.0 2353.2 2355.4 2358.3 2359.3 2363.1 2293.7 2301.9 2329.3 2331.6 2332.6 2015.3 2313.4 2331.1 2337.3 2340.6 1939.8 2288.1 2296.2 2297.4 2299.0 1877.8 2294.3 2302.9 2305.8 2307.3 8608.6 8672.6 8679.0 8688.0 8693.6 5120.6 5290.7 5293.5 5312.2 5317.3 3433.4 3490.8 3626.1 3632.3 3646.7 1074.6 1083.0 1088.6 1104.6 1105.6 11306.3 11441.9 11449.0 11462.8 11468.8 4470.1 4556.0 4707.9 4725.5 4726.5 9531.0 9689.7 9703.5 9706.5 9750.4 5266.3 5287.3 5297.2 5299.8 5301.4 4322.3 4482.0 4645.5 4782.0 4860.0 3800.8 3825.0 3901.4 3926.9 3952.7 1170.9 1188.7 1259.6 1265.4 1278.9 820.5 882.0 885.6 899.2 905.7 5571.7 5713.3 5818.9 5882.8 6042.7 425.9 434.4 436.2 437.3 437.5 3859.8 3881.1 3987.5 3993.3 4072.8 8562.4 10255.4 10429.3 10600.7 10636.5 10558.7 10564.8 10572.6 10578.9 10579.8 7788.5 7992.8 8092.6 8094.0 8101.5 5705.3 5742.4 5760.3 5779.3 5865.1 9683.9 9729.4 9786.4 9863.5 9881.7 8701.7 9476.0 9965.6 10035.2 10039.9 6686.6 6850.6 7079.1 7233.6 7329.8 8054.0 8165.3 8280.3 8285.1 8285.8 7088.2 7155.5 7186.2 7258.3 7334.4 7041.2 7055.2 7058.9 7100.0 7128.0 6613.1 6754.3 6829.9 6832.6 6839.0 4879.6 4927.9 4942.6 4992.4 5071.8 4219.6 4880.1 4913.2 5050.0 5072.7 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4505.64 Median:5086.15 stddev:1389.90 (27.3%) stddev-sans-first:1356.71 05:30:57 INFO - PROCESS | 1655 | Values: 256.3 291.7 300.3 304.6 307.1 5374.6 5441.9 5477.2 5486.8 5486.9 5075.2 5080.4 5209.6 5272.6 5399.2 3637.3 3669.2 4057.5 4113.0 4143.3 3549.0 3944.9 4072.9 4085.2 4137.6 3527.2 3715.8 3875.9 4064.9 4087.7 2980.2 3007.7 3327.7 3570.2 3968.8 3399.1 3551.3 3552.8 3553.2 3560.2 4284.6 4525.8 5264.3 5308.7 5310.8 3735.0 4481.8 4536.6 4687.0 4706.4 4684.7 5671.7 5709.5 5726.3 5737.3 3937.1 3950.8 3959.6 3973.4 3978.5 5061.6 5607.9 5623.4 5882.8 6008.5 3304.9 3954.2 3956.5 3989.7 3999.0 3777.5 4001.8 4058.0 4060.3 4078.3 4478.9 4586.7 4687.7 4692.4 4700.2 4934.2 5402.6 5629.8 5634.7 5659.5 1244.9 1264.9 1356.2 1375.8 1380.7 875.0 895.9 924.4 952.2 955.9 4656.2 4777.0 5022.4 5091.9 5358.5 5799.0 5823.6 5824.8 5829.8 5877.8 4011.2 4363.4 4915.4 5398.8 5402.9 2665.3 2908.4 2970.7 3000.8 3023.8 5603.6 5940.4 5942.7 5950.3 5968.8 4267.0 5343.4 5817.7 5866.8 5881.4 5111.9 5850.5 5876.7 5879.3 5898.7 5415.7 5660.6 5694.8 5700.0 5726.6 4880.6 5187.3 5375.7 5613.0 5685.7 4919.3 5187.9 5555.8 5913.3 5930.8 3735.0 3867.9 3929.3 3930.5 3950.5 5239.5 5690.5 5695.1 5730.0 5736.0 4812.0 5401.3 5578.6 5583.6 5620.4 4726.0 5218.7 5432.4 5565.7 5570.6 4422.3 5191.9 5377.6 5395.7 5407.3 5213.6 5333.0 5383.7 5667.9 5699.7 4646.1 4668.0 5168.3 5444.7 5528.9 05:30:57 INFO - PROCESS | 1655 | 05:30:57 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24429.97 Median:4054.49 stddev:39598.43 (976.7%) stddev-sans-first:39669.34 05:30:57 INFO - PROCESS | 1655 | Values: 674.5 734.2 736.9 745.6 774.6 14660.8 15376.8 15411.3 15449.0 15692.5 14020.0 14168.8 14176.4 14204.9 14208.6 689.0 713.6 714.5 720.9 863.9 872.4 878.6 883.5 884.2 884.7 932.3 932.7 933.2 934.0 934.2 720.3 747.6 928.1 931.2 931.6 553.3 554.4 554.7 672.9 694.2 11721.8 14787.3 14846.0 14857.2 14871.3 13108.5 13491.7 13553.9 13571.0 13912.4 11982.6 12100.6 12189.9 12672.7 12695.9 4355.2 4391.8 4431.8 4452.8 4454.6 113168.4 115479.4 116041.4 116153.0 117197.4 10749.2 10749.7 10779.6 10946.0 11177.9 21249.0 21275.0 21294.6 21299.6 21319.0 6793.7 6983.0 7531.8 7575.8 7743.2 4046.3 4062.7 4099.9 4105.2 4151.6 3326.7 3423.2 3427.7 3429.2 3431.1 595.6 642.7 694.7 695.5 700.1 631.9 633.3 669.7 672.2 679.1 8800.2 8880.4 9038.2 9083.5 9092.5 585.5 624.8 652.2 668.8 680.5 4269.9 4428.0 4452.4 4478.5 4574.2 90897.0 109028.5 135972.3 139172.3 149484.0 133824.3 138560.8 140219.0 141478.0 142109.3 97470.0 112997.0 113288.0 115430.8 119321.0 6659.0 7675.0 8328.9 8464.4 8863.6 41056.8 64646.7 65845.3 66572.7 68973.0 93007.0 97193.5 99460.0 100135.0 101113.0 11046.4 11146.3 11226.6 11229.8 11338.8 12469.7 12531.4 12660.4 13034.9 13061.2 11675.0 11837.2 12055.6 12392.1 12485.3 11886.6 12119.9 12139.9 12277.1 12406.8 11855.8 11961.7 12068.4 12190.5 12229.4 9640.6 9952.4 10036.9 10054.2 10473.4 6922.4 8732.4 9288.1 10040.3 10202.2 05:30:57 INFO - PROCESS | 1655 | -------- Summary: end -------- 05:30:57 INFO - PROCESS | 1655 | 05:30:58 INFO - TEST-INFO | 1655: exit 0 05:30:58 INFO - TEST-OK | dromaeo_css | took 1120532ms 05:30:58 INFO - TEST-START | kraken 05:30:58 INFO - operating with platform_type : mac_ 05:30:58 INFO - Initialising browser for kraken test... 05:30:58 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpQBa3IE/profile http://localhost:49274/getInfo.html) 05:31:00 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:31:00 INFO - PROCESS | 1665 | colorDepth:24 05:31:00 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:31:00 INFO - PROCESS | 1665 | __metrics 05:31:00 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:31:00 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:01 INFO - TEST-INFO | 1665: exit 0 05:31:01 INFO - Browser initialized. 05:31:01 INFO - Running cycle 1/1 for kraken test... 05:31:01 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpQBa3IE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:13 INFO - PROCESS | 1666 | RSS: Main: 231759872 05:31:13 INFO - PROCESS | 1666 | 05:31:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:16 INFO - PROCESS | 1666 | RSS: Main: 290734080 05:31:16 INFO - PROCESS | 1666 | 05:31:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:31:19 INFO - PROCESS | 1666 | RSS: Main: 291663872 05:31:19 INFO - PROCESS | 1666 | 05:31:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:31:24 INFO - PROCESS | 1666 | RSS: Main: 383483904 05:31:24 INFO - PROCESS | 1666 | 05:31:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:31:26 INFO - PROCESS | 1666 | RSS: Main: 286212096 05:31:26 INFO - PROCESS | 1666 | 05:31:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:29 INFO - PROCESS | 1666 | RSS: Main: 290676736 05:31:29 INFO - PROCESS | 1666 | 05:31:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:32 INFO - PROCESS | 1666 | RSS: Main: 327565312 05:31:32 INFO - PROCESS | 1666 | 05:31:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:36 INFO - PROCESS | 1666 | RSS: Main: 330162176 05:31:36 INFO - PROCESS | 1666 | 05:31:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:31:39 INFO - PROCESS | 1666 | RSS: Main: 329424896 05:31:39 INFO - PROCESS | 1666 | 05:31:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:41 INFO - PROCESS | 1666 | RSS: Main: 302952448 05:31:41 INFO - PROCESS | 1666 | 05:31:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:44 INFO - PROCESS | 1666 | RSS: Main: 306421760 05:31:44 INFO - PROCESS | 1666 | 05:31:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:47 INFO - PROCESS | 1666 | RSS: Main: 308969472 05:31:47 INFO - PROCESS | 1666 | 05:31:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:50 INFO - PROCESS | 1666 | RSS: Main: 317313024 05:31:50 INFO - PROCESS | 1666 | 05:31:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:54 INFO - PROCESS | 1666 | RSS: Main: 317292544 05:31:54 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:31:56 INFO - PROCESS | 1666 | RSS: Main: 361152512 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | __start_tp_report 05:31:56 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:31:56 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:31:56 INFO - PROCESS | 1666 | |i|pagename|runs| 05:31:56 INFO - PROCESS | 1666 | |0;ai-astar;104;114;114;114;114;115;114;113;113;113 05:31:56 INFO - PROCESS | 1666 | |1;audio-beat-detection;148;113;113;147;115;112;111;108;142;111 05:31:56 INFO - PROCESS | 1666 | |2;audio-dft;183;184;183;186;185;184;183;183;201;238 05:31:56 INFO - PROCESS | 1666 | |3;audio-fft;80;59;58;86;63;59;59;58;83;58 05:31:56 INFO - PROCESS | 1666 | |4;audio-oscillator;85;71;92;69;67;70;95;66;68;90 05:31:56 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;91;88;91;89;90;88;91;88;91;87 05:31:56 INFO - PROCESS | 1666 | |6;imaging-darkroom;101;100;101;101;102;101;101;100;100;101 05:31:56 INFO - PROCESS | 1666 | |7;imaging-desaturate;82;83;79;82;83;84;85;85;84;90 05:31:56 INFO - PROCESS | 1666 | |8;json-parse-financial;58;55;56;56;53;53;54;54;54;54 05:31:56 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;75;80;75;72;70;70;70;70;72 05:31:56 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;87;90;86;85;90;86;85;85;91;90 05:31:56 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;143;147;168;142;149;156;163;146;183;146 05:31:56 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;173;172;171;174;175;175;172;167;208;183 05:31:56 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;66;67;70;66;70;69;68;66;68;67 05:31:56 INFO - PROCESS | 1666 | __end_tp_report 05:31:56 INFO - PROCESS | 1666 | __start_cc_report 05:31:56 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1968 05:31:56 INFO - PROCESS | 1666 | __end_cc_report 05:31:56 INFO - PROCESS | 1666 | __startTimestamp1476793916390__endTimestamp 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:31:56 INFO - PROCESS | 1666 | Number of tests: 14 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:0.67 05:31:56 INFO - PROCESS | 1666 | Values: 104.0 114.0 114.0 114.0 114.0 115.0 114.0 113.0 113.0 113.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:114.00 stddev:16.50 (14.5%) stddev-sans-first:14.57 05:31:56 INFO - PROCESS | 1666 | Values: 148.0 113.0 113.0 147.0 115.0 112.0 111.0 108.0 142.0 111.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:191.00 Median:184.50 stddev:17.40 (9.4%) stddev-sans-first:18.21 05:31:56 INFO - PROCESS | 1666 | Values: 183.0 184.0 183.0 186.0 185.0 184.0 183.0 183.0 201.0 238.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:11.70 (19.2%) stddev-sans-first:11.31 05:31:56 INFO - PROCESS | 1666 | Values: 80.0 59.0 58.0 86.0 63.0 59.0 59.0 58.0 83.0 58.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:11.70 (15.0%) stddev-sans-first:12.07 05:31:56 INFO - PROCESS | 1666 | Values: 85.0 71.0 92.0 69.0 67.0 70.0 95.0 66.0 68.0 90.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.50 stddev:1.58 (1.7%) stddev-sans-first:1.56 05:31:56 INFO - PROCESS | 1666 | Values: 91.0 88.0 91.0 89.0 90.0 88.0 91.0 88.0 91.0 87.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:101.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 05:31:56 INFO - PROCESS | 1666 | Values: 101.0 100.0 101.0 101.0 102.0 101.0 101.0 100.0 100.0 101.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:84.00 stddev:2.83 (3.4%) stddev-sans-first:2.93 05:31:56 INFO - PROCESS | 1666 | Values: 82.0 83.0 79.0 82.0 83.0 84.0 85.0 85.0 84.0 90.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:1.57 (2.9%) stddev-sans-first:1.12 05:31:56 INFO - PROCESS | 1666 | Values: 58.0 55.0 56.0 56.0 53.0 53.0 54.0 54.0 54.0 54.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:4.24 (5.9%) stddev-sans-first:3.43 05:31:56 INFO - PROCESS | 1666 | Values: 64.0 75.0 80.0 75.0 72.0 70.0 70.0 70.0 70.0 72.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.50 stddev:2.46 (2.8%) stddev-sans-first:2.60 05:31:56 INFO - PROCESS | 1666 | Values: 87.0 90.0 86.0 85.0 90.0 86.0 85.0 85.0 91.0 90.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:154.30 Median:152.50 stddev:13.28 (8.7%) stddev-sans-first:13.45 05:31:56 INFO - PROCESS | 1666 | Values: 143.0 147.0 168.0 142.0 149.0 156.0 163.0 146.0 183.0 146.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:174.50 stddev:11.62 (6.7%) stddev-sans-first:12.24 05:31:56 INFO - PROCESS | 1666 | Values: 173.0 172.0 171.0 174.0 175.0 175.0 172.0 167.0 208.0 183.0 05:31:56 INFO - PROCESS | 1666 | 05:31:56 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.57 (2.3%) stddev-sans-first:1.54 05:31:56 INFO - PROCESS | 1666 | Values: 66.0 67.0 70.0 66.0 70.0 69.0 68.0 66.0 68.0 67.0 05:31:56 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:31:56 INFO - PROCESS | 1666 | 05:31:57 INFO - TEST-INFO | 1666: exit 0 05:31:57 INFO - TEST-OK | kraken | took 59088ms 05:31:57 INFO - SUITE-END | took 1179s 05:31:57 INFO - Completed test suite (00:19:39) 05:31:57 INFO - javascript benchmark 05:31:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.2697915989725, 3169.68303169683, 3288.8026718396914, 3350.346682396933, 3399.6260411354747, 5392.786623009821, 5630.40880707526, 5725.312962444507, 5785.161151633016, 5790.189373487705, 5188.766505507252, 5699.287589051369, 5700.287464066992, 5719.542436605072, 5722.484976352138, 5181.507756763121, 5211.635185536995, 5218.295530103444, 5232.084385232588, 5253.395859476152, 5302.337207849019, 5303.681779093247, 5305.867353316159, 5325.760340784674, 5332.386775520826, 5204.089284375238, 5255.632105752599, 5257.080010998079, 5287.894242115155, 5289.338832645919, 5266.025785229706, 5276.630635855492, 5287.339082614692, 5294.258803767476, 5332.173513105475, 5115.66748161372, 5128.0, 5170.560502357304, 5243.213517972296, 5243.475652434764, 5636.436356364331, 5646.0, 5664.0, 5675.978323901696, 5712.11462223356, 6159.38406159385, 6203.565750397474, 6252.812415627538, 6264.9686751566405, 6268.749250030039, 6120.995732433061, 6223.87552248957, 6254.838210249239, 6313.210848643919, 6329.145565348665, 5742.425757424307, 5753.223314852525, 5810.767569297265, 5812.738426770806, 5816.185733997244, 6255.176060905359, 6311.116443697886, 6319.652419116901, 6326.905096423558, 6344.143540621957, 6126.295476020315, 6130.846728831815, 6131.601445906091, 6153.077038444179, 6154.5384096192965, 6093.595082292339, 6124.869201255686, 6147.985582378947, 6191.071339299141, 6230.59501132425, 6153.077038444269, 6229.190205273376, 6232.875342493125, 6239.688015599202, 6254.499640028877, 6201.875962480725, 6232.594881332699, 6245.469135123474, 6264.185655864709, 6270.435660790459, 4852.272159176152, 4871.658983871095, 4904.362432883702, 4916.680415772963, 4969.82605608802, 4403.163398954189, 4407.713498622579, 4439.023414848728, 4479.171353299585, 4526.683132180781, 5740.39725828782, 5763.423657634287, 5779.017567013618, 5781.959247335436, 5795.594308398372, 4978.551930326288, 6210.50315974721, 6238.563300568917, 6268.1851359323, 6275.341089185661, 5665.0, 5704.372519022904, 5714.342850572238, 5714.857128571736, 5715.514181294637, 5332.973335133377, 5371.919421208685, 5373.838784836461, 5377.919331210035, 5383.569314454834, 6324.0, 6324.114623952558, 6338.619682819046, 6342.080398342122, 6348.619082855043, 6189.319174890668, 6201.906971395523, 6254.312025677263, 6305.0, 6317.526185536011, 6307.30619631831, 6308.747650093945, 6310.337414571404, 6312.873742525032, 6314.210723659543, 6069.423404776539, 6217.036359364306, 6228.968855155696, 6239.0, 6248.4688801452385, 6008.339082700987, 6199.0, 6227.532935029801, 6235.812925612239, 6260.0, 6132.256728365309, 6132.692058233554, 6137.959273351923, 6140.4428991762525, 6147.477464415575, 6120.660465672032, 6137.867325793252, 6138.75626760427, 6149.907751383822, 6150.200473938359, 5798.072308430631, 5829.0, 5836.095405212199, 5859.970700146472, 5980.312264089685, 6053.697315134314, 6118.558266176285, 6139.781185991871, 6144.341027922525, 6145.494353883327, 5938.138969849434, 5950.2264705587995, 5952.285725712942, 5958.255218097738, 5974.4324289192455], "value": 5699.196991030493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.19378827428204, 485.3811390477141, 503.6197670758577, 515.0574448758772, 521.9556337711294, 35629.10927226821, 39966.20067598646, 41320.17359652809, 41640.750777476685, 43012.0, 42511.0, 42976.925576860514, 43033.35449968253, 43037.569624303746, 43064.13871722572, 9510.144087032166, 9677.951610241938, 9679.0, 9704.175145112675, 9706.951465242664, 9570.52147392631, 9673.806523869518, 9684.322097453145, 9690.757731056745, 9714.805703885953, 9665.10046985905, 9713.0, 9716.65991690291, 9727.708168754913, 9735.41587504752, 9639.71080867575, 9669.661561845372, 9690.854637180448, 9691.75770605737, 9729.027097290285, 9536.0, 9622.422654640673, 9622.759431014281, 9643.373180743229, 9648.517574121266, 40424.79787601073, 40750.0, 40776.79611601923, 40802.38796418026, 40807.7959610203, 3314.436545787222, 3454.7408944329277, 3531.1878267998504, 3770.8303126359106, 4051.918961620751, 30175.849120754476, 30266.69733302661, 31476.0, 31625.683743162503, 31868.0, 3152.4168028914496, 3286.359159963808, 3327.683870032343, 3328.4674452087793, 3362.3107263011025, 448618.0, 451368.0, 453606.0, 453650.4397126248, 454867.72566136956, 57667.0, 57856.13215801682, 57878.0, 57935.42064579385, 58013.0, 61823.0, 61888.071678924854, 61924.69037654873, 62077.37922620806, 62117.82587609412, 15985.680286394207, 16186.0, 16205.756913646304, 16220.51338459848, 16283.104429256504, 12638.494460221487, 12668.303243321521, 12703.618891433272, 12718.236905785683, 12719.236845789283, 15930.60173495672, 16602.0, 16611.750823737653, 16677.332906683598, 16702.914310569773, 6302.621842689453, 6304.338044505261, 6321.778737744157, 6402.775902843378, 6438.903416448757, 724.5263570002048, 736.2453485177736, 823.5593957232852, 830.4228561149943, 931.1759093202564, 28212.576811347848, 30222.0, 30251.697483024887, 30394.387750032434, 30489.847550762104, 1028.6554004408606, 1043.6190790361616, 1056.2447849787286, 1105.7788442311569, 1138.5218208352512, 14599.78100328496, 14893.47872824446, 15003.399864005318, 15235.628793408425, 15375.384984600714, 609333.0, 613869.0, 614824.0, 614912.0, 615301.0, 58034.70982645144, 58139.4186058134, 58170.0, 58198.0, 58247.417525824196, 1214.8359971403925, 1259.2066997791333, 1307.1046333261745, 1368.3295185359302, 1380.4340220509544, 30229.244268893453, 31097.8445107773, 31149.065528034196, 31683.36633267368, 32030.35939281248, 48335.274970874765, 49072.0, 49110.0, 49186.50813491819, 49196.75401622969, 434168.0, 515033.0, 517907.0, 518081.0, 519592.0, 25221.873890631163, 25248.74751252464, 25546.744532554436, 25762.227133186036, 25832.483350333263, 45226.0, 45491.772541137085, 45630.77184614056, 45861.77069114766, 45994.770026150996, 32346.0, 35551.0, 37936.62063379441, 37950.240995180495, 38800.41799373068, 37381.439278410304, 38225.0, 38322.80838595789, 38358.0, 38977.6102238974, 36516.45225321569, 36709.26581468409, 37514.437283441315, 37517.87446376613, 37568.43647345238, 32435.513467298482, 33216.83391583123, 34176.82911585426, 34189.82905085458, 34409.65590344165, 25085.749142508343, 25204.865781040266, 25226.99092036298, 25286.988520458977, 25475.0], "value": 19496.86955961431, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8046203894798, 363.1230578153757, 372.84340576957675, 376.3583090830134, 398.8185375654078, 14642.414303427864, 14870.959032867704, 15678.0, 19651.803481965177, 20559.486012849688, 19695.60608787827, 20275.898620506876, 20938.581228375424, 21015.684764728543, 21198.89400552995, 5634.760352722395, 5697.376247769386, 5941.8217453476245, 5992.400759924017, 5992.7902523411685, 5359.330083739533, 5854.414558544154, 5909.290885093795, 5911.852203694899, 5917.142014407908, 5700.200584789487, 5724.456176663231, 5820.214271073414, 5854.707264636772, 5869.911951320733, 4834.371531700874, 5815.767369305223, 5824.563157763185, 5826.397740621321, 5839.941600583982, 4925.507449255082, 4959.70241785494, 5080.441151473335, 5103.719295438749, 5104.69371837691, 25429.10998115057, 25435.364115897064, 25486.36284092894, 25733.74266257332, 25769.840357183974, 1639.9344026239055, 2145.4743587820926, 2168.1977668262684, 2227.6213043782595, 2293.9197128100604, 9865.753356166082, 10336.328138671037, 10376.014278643517, 10859.674209773719, 11218.214724969255, 1762.6210364771507, 1764.1620230390463, 1865.6455273497993, 1886.2360743898744, 1904.4001139640968, 95725.84635839688, 97564.0, 99673.50163249137, 110935.44532277368, 115237.0, 9696.369735967139, 11390.373529455794, 11513.481893314822, 11727.824082638766, 11811.0, 14473.78289325661, 14496.985211035126, 14521.91085668579, 14532.85467145315, 14555.490557830424, 8085.474444161111, 8279.668813247403, 8461.576921153917, 8489.0, 8607.698730544402, 8284.792880178044, 8294.419390642597, 8342.62458189383, 8488.108748581433, 8543.0, 3829.463875057494, 4525.954740452553, 4551.658625603093, 4556.997460558672, 4584.6561507887045, 1861.944141675752, 1900.2304066852946, 1904.1336192032593, 1904.5429097016615, 1908.4560900143392, 865.9523726194993, 894.5259012723267, 945.6737425588161, 966.6568368229318, 998.7503124218945, 19885.502862428264, 20796.688049679266, 21115.577688446145, 21365.0, 21466.467012425426, 756.0096273881123, 917.3440989692268, 917.8990311065777, 928.8095940332215, 968.2399316536626, 10861.34831910088, 11196.272242304223, 11217.831732524019, 11241.887581124247, 11256.0, 549913.0, 577742.1112894493, 589993.0, 592987.0, 593217.0, 63410.68294658497, 95690.52154739182, 114773.0, 119610.40194799144, 120341.0, 868.2793281576277, 897.9012308646044, 933.8412469880137, 936.2930987104828, 937.9202767764816, 18988.3354082612, 19097.140628671466, 19148.0, 19170.52073698113, 19180.71228931595, 45133.42033028828, 51805.7409712949, 52256.0, 53638.338581735, 54283.18575221454, 72522.0, 72575.0, 73566.63216683883, 73717.26282737104, 73729.6313518429, 7627.580483073262, 7806.375489960903, 8061.113277539349, 8095.150009248944, 8381.664733410595, 10934.507947142556, 12243.326617035793, 12303.93848030754, 12816.871831281567, 12834.229946203257, 8820.823583528165, 9082.59128339213, 10691.946540267249, 10747.35515869019, 11140.275882067639, 10858.45707714627, 10955.233133680566, 11069.944650276697, 11275.097992160772, 11358.977692007758, 8839.166150340745, 10787.083097936764, 11011.779764404508, 11229.3262404256, 11298.378589177346, 7847.2152784721075, 8096.190380962093, 8143.470674406145, 8276.08963014056, 8307.626156822836, 9017.233535149586, 9778.315517913677, 10938.015578597646, 10990.560377584807, 11006.0], "value": 9235.054523888242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.375006247438, 1558.7817705521225, 1786.1337251433054, 1916.3867562380026, 1952.1800843645667, 8247.91752082479, 8698.73903782886, 8706.0858609846, 8723.127687231274, 8737.737867863967, 7655.464117511777, 7920.405969552277, 7946.404019698532, 8340.541270230135, 8539.018012928515, 2353.1999120299097, 2355.3758254062686, 2358.2807243790635, 2359.268626725712, 2363.09021026905, 2293.7018187635585, 2301.9309420717404, 2329.26628112145, 2331.603627383349, 2332.5917964356254, 2015.2644284836076, 2313.410080429488, 2331.067572970808, 2337.333859849943, 2340.625499920013, 1939.76722793265, 2288.0962020002007, 2296.1733775840685, 2297.356740112763, 2298.954020919589, 1877.802830702784, 2294.2773026496766, 2302.861828290308, 2305.8155347572156, 2307.2501437033034, 8608.612612432393, 8672.609732561987, 8678.956605216996, 8688.044315125331, 8693.565321733888, 5120.61595380348, 5290.68255904647, 5293.470652934714, 5312.1766126250495, 5317.2821669074565, 3433.399155147864, 3490.7556471047037, 3626.0934766308424, 3632.273545290926, 3646.6717995380545, 1074.6333881244038, 1083.041508265191, 1088.5754555723274, 1104.6465131158034, 1105.6240878101403, 11306.265092768943, 11441.942790285995, 11448.969592736694, 11462.82805757906, 11468.827967580493, 4470.105978804252, 4555.9772201138785, 4707.882302942454, 4725.527447255316, 4726.480087190406, 9531.046895310414, 9689.660861869941, 9703.514824258758, 9706.466144362128, 9750.414975101517, 5266.262723218752, 5287.312649355559, 5297.17893726473, 5299.814506492331, 5301.443348448434, 4322.286822674224, 4482.0, 4645.46577143626, 4782.0435912817575, 4860.027994401134, 3800.847966081381, 3825.0, 3901.4147877818555, 3926.8821935341984, 3952.6837852971694, 1170.9180357374903, 1188.6849984754047, 1259.622113366005, 1265.411583613624, 1278.9296588687712, 820.4830956497368, 882.0429833630454, 885.5527958380976, 899.1952202778476, 905.7373361725158, 5571.749271282721, 5713.342965559014, 5818.912716309259, 5882.794102206402, 6042.6978651067275, 425.90967124162245, 434.4482507215818, 436.16474451425796, 437.29377056054244, 437.4968785896181, 3859.7877116758286, 3881.1073453105378, 3987.501562304712, 3993.281209382339, 4072.8370865165653, 8562.357823163287, 10255.384676919408, 10429.269951103503, 10600.734981625521, 10636.52135653882, 10558.683239502827, 10564.841527377095, 10572.577096916037, 10578.894211057945, 10579.788404232026, 7788.4548081634875, 7992.760217193493, 8092.554909480035, 8093.959530202312, 8101.513909165351, 5705.343885453226, 5742.425757424224, 5760.308762948473, 5779.335376431596, 5865.061590145556, 9683.854742179014, 9729.367591106555, 9786.363886347364, 9863.457509837028, 9881.703548893545, 8701.738947831574, 9476.0, 9965.551550180115, 10035.19718422539, 10039.899601003897, 6686.598804071771, 6850.554713943578, 7079.115110611174, 7233.638318083969, 7329.816754581178, 8054.0, 8165.305948994164, 8280.337572994267, 8285.130061343472, 8285.83428331418, 7088.220295767358, 7155.499115061895, 7186.209516953027, 7258.3104605062435, 7334.376577990717, 7041.155061392461, 7055.18865330473, 7058.858822823618, 7100.041494398397, 7127.964360178166, 6613.074169616161, 6754.324567543206, 6829.93170068293, 6832.555883867532, 6839.0, 4879.634027448026, 4927.876803079952, 4942.6293028023765, 4992.425871024879, 5071.797128114982, 4219.578042195756, 4880.1215781159735, 4913.213885778258, 5049.974750126225, 5072.695638261716], "value": 4407.672018958282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.34248153486305, 291.66312908590584, 300.3182179793159, 304.61922596754056, 307.13541381012436, 5374.623776335653, 5441.863953401157, 5477.233187353769, 5486.835394938148, 5486.91769623456, 5075.213341931997, 5080.364954380702, 5209.609279304058, 5272.604554658396, 5399.217113518537, 3637.345008021344, 3669.2111196092833, 4057.5130984281927, 4112.999999999993, 4143.337066069429, 3548.9645103549024, 3944.8559917623857, 4072.857449989251, 4085.2442298174783, 4137.565555616647, 3527.224010717651, 3715.7770533767925, 3875.9031024224337, 4064.9390259146135, 4087.6934229932726, 2980.210244285266, 3007.7142671446286, 3327.667233276677, 3570.1788588624763, 3968.8015599220066, 3399.1332210286464, 3551.3430015447225, 3552.8045957472327, 3553.236054248349, 3560.2167523144867, 4284.635805956497, 4525.818967241306, 5264.289320941701, 5308.681479111266, 5310.787568497255, 3734.9813250933844, 4481.820727170909, 4536.637069034469, 4686.976565117153, 4706.388169537972, 4684.695494792828, 5671.723862131029, 5709.543236541108, 5726.284214473191, 5737.311522617312, 3937.0944682722848, 3950.8222130003933, 3959.6436320730986, 3973.443717879499, 3978.4629075074786, 5061.5950723942, 5607.859803504945, 5623.381428042912, 5882.764689412461, 6008.45501154321, 3304.8512816923294, 3954.189391174802, 3956.4658771066115, 3989.708490495353, 3998.980005099956, 3777.471154038437, 4001.759454569093, 4058.037632528271, 4060.26915155269, 4078.347464405681, 4478.910421791546, 4586.747728874877, 4687.742174180453, 4692.389989301369, 4700.2244629635725, 4934.225317632015, 5402.567794576425, 5629.804376293249, 5634.661920284796, 5659.518940889988, 1244.9107031347571, 1264.8545417276946, 1356.240505317006, 1375.848656647768, 1380.6824430381068, 874.9693760718471, 895.9104089591119, 924.371427429341, 952.2382094324652, 955.9187469065068, 4656.231721765871, 4776.9761151194025, 5022.372203474566, 5091.930694554111, 5358.490943360374, 5798.971005144947, 5823.641425222791, 5824.796132135355, 5829.766809327664, 5877.764889404376, 4011.1777085697363, 4363.410939523187, 4915.43472500667, 5398.784048638089, 5402.945970540323, 2665.2537289558954, 2908.403777225664, 2970.6928951261375, 3000.7599392048583, 3023.8034527756067, 5603.635763675348, 5940.405959404025, 5942.70286485674, 5950.345461999176, 5968.761249550056, 4267.0, 5343.381742945929, 5817.720101577646, 5866.7653293868625, 5881.411858814085, 5111.923321150186, 5850.47345738877, 5876.706164691834, 5879.265091863517, 5898.705064746746, 5415.702136382537, 5660.632058916157, 5694.804091140742, 5699.974004679198, 5726.599138060463, 4880.633952453652, 5187.325647665779, 5375.747672657985, 5613.0, 5685.715714214355, 4919.335889654851, 5187.948120518747, 5555.805546805843, 5913.34953155144, 5930.7924222652, 3735.0, 3867.8646247381207, 3929.2730844793805, 3930.486762596364, 3950.5456872458885, 5239.476052394883, 5690.5163061140265, 5695.117256825199, 5729.9713501432225, 5735.99620066495, 4811.975940120277, 5401.3236369233255, 5578.63738856973, 5583.604098975256, 5620.381758006534, 4725.976370118127, 5218.66078704883, 5432.402435732145, 5565.749541270734, 5570.610057296112, 4422.3366495026, 5191.896162076813, 5377.569794416516, 5395.730213489232, 5407.269673704534, 5213.582913366998, 5333.0002498126405, 5383.67697938125, 5667.8866422672145, 5699.686517241592, 4646.140464014168, 4667.9766601166775, 5168.346129238607, 5444.727763611882, 5528.926652505311], "value": 4063.5442986049306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.5076094451051, 734.1520543771945, 736.900518430012, 745.634639026877, 774.6204359863665, 14660.78008829867, 15376.769348459782, 15411.306491207895, 15448.995815272014, 15692.529224123266, 14020.0, 14168.787468187986, 14176.43294268228, 14204.857951420483, 14208.573742787732, 689.0353505092885, 713.636045616734, 714.5498336048282, 720.9170945341274, 863.8661007543841, 872.3893274707698, 878.6046279174365, 883.4610887358706, 884.2086332732201, 884.7434244069212, 932.3380399916068, 932.6549176804592, 933.1834644685899, 934.042606328512, 934.1965909317981, 720.2869159532078, 747.637395863006, 928.0997432490474, 931.2177770672668, 931.5807886451124, 553.3194171169484, 554.3569459427046, 554.6727430815798, 672.8856094463953, 694.1773997812609, 11721.824172637418, 14787.334569944378, 14846.035007724464, 14857.182854942974, 14871.330790114363, 13108.47566097355, 13491.66270843227, 13553.864461355359, 13571.0, 13912.37394317258, 11982.580609678707, 12100.636980890587, 12189.878101218963, 12672.746545069047, 12695.873041269562, 4355.216061108999, 4391.8462853799965, 4431.800568974404, 4452.821887124511, 4454.643628509712, 113168.43415782951, 115479.42260288645, 116041.4197929005, 116153.0, 117197.4140129294, 10749.193810464247, 10749.731256718489, 10779.568817247378, 10946.0, 11177.888221117848, 21249.043793029352, 21275.0, 21294.574108518053, 21299.574008519743, 21319.0, 6793.694283757242, 6983.0, 7531.849363012709, 7575.810604734816, 7743.186965368668, 4046.251443482965, 4062.73592216505, 4099.9180016400105, 4105.2405305018665, 4151.564085771011, 3326.6507016763376, 3423.1955490459723, 3427.7429192810637, 3429.176997520627, 3431.0564594736147, 595.6068994463633, 642.7493277621732, 694.7325279767326, 695.5061906046764, 700.1178515070945, 631.8641492079225, 633.268574796102, 669.7321071571313, 672.2235817630644, 679.1374953808636, 8800.207981281588, 8880.37837351392, 9038.231750301298, 9083.500407477652, 9092.454452732858, 585.5140233606097, 624.7906951171318, 652.2238536142071, 668.8294484906318, 680.4556354916048, 4269.914601707948, 4427.955720442755, 4452.376667266521, 4478.507364189936, 4574.153781550423, 90897.0, 109028.4548577252, 135972.32013839867, 139172.3041384807, 149484.0, 133824.33087834498, 138560.8367205114, 140219.0, 141478.0, 142109.28945355208, 97470.0, 112997.0, 113288.0, 115430.84569154368, 119321.0, 6658.9667051666365, 7674.961625191839, 8328.867186724734, 8464.365172611955, 8863.556822158995, 41056.79471602623, 64646.67676661775, 65845.34154658392, 66572.66713666401, 68973.0, 93007.0, 97193.54209686718, 99460.0, 100135.0, 101113.0, 11046.447677616248, 11146.331220126818, 11226.607068752555, 11229.775404492028, 11338.829917551078, 12469.688257793629, 12531.436085375997, 12660.366981651065, 13034.869651303745, 13061.151025183333, 11675.007624352025, 11837.171398002401, 12055.57805476804, 12392.132550721362, 12485.250884946932, 11886.643400697993, 12119.878801211875, 12139.939300303442, 12277.140600157903, 12406.81389779136, 11855.822162667395, 11961.700957475785, 12068.396580171131, 12190.51237950472, 12229.388530573258, 9640.614375424904, 9952.410614177152, 10036.949815250877, 10054.19566434698, 10473.423961681876, 6922.446204303543, 8732.432391894507, 9288.11091888964, 10040.347377420445, 10202.234832387452], "value": 7519.174730763112, "unit": "score"}], "name": "dromaeo_css", "value": 7190.483960184813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 113.0, 147.0, 115.0, 112.0, 111.0, 108.0, 142.0, 111.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 186.0, 185.0, 184.0, 183.0, 183.0, 201.0, 238.0], "value": 191.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 86.0, 63.0, 59.0, 59.0, 58.0, 83.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 92.0, 69.0, 67.0, 70.0, 95.0, 66.0, 68.0, 90.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 90.0, 88.0, 91.0, 88.0, 91.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 101.0, 101.0, 102.0, 101.0, 101.0, 100.0, 100.0, 101.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 79.0, 82.0, 83.0, 84.0, 85.0, 85.0, 84.0, 90.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 56.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 80.0, 75.0, 72.0, 70.0, 70.0, 70.0, 70.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 86.0, 85.0, 90.0, 86.0, 85.0, 85.0, 91.0, 90.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 147.0, 168.0, 142.0, 149.0, 156.0, 163.0, 146.0, 183.0, 146.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 171.0, 174.0, 175.0, 175.0, 172.0, 167.0, 208.0, 183.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 70.0, 66.0, 70.0, 69.0, 68.0, 66.0, 68.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1456.3, "alertThreshold": 2.0}]} 05:31:57 INFO - Return code: 0 05:31:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:57 INFO - # TBPL SUCCESS # 05:31:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:57 INFO - 2016-10-18 05:31:57.693 screenresolution[1670:10118] starting screenresolution argv=screenresolution get 05:31:57 INFO - 2016-10-18 05:31:57.695 screenresolution[1670:10118] Display 0: 1600x1200x32@60 05:31:57 INFO - 2016-10-18 05:31:57.701 screenresolution[1671:10121] starting screenresolution argv=screenresolution list 05:31:57 INFO - Available Modes on Display 0 05:31:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:57 INFO - Intel Iris: 05:31:57 INFO - Chipset Model: Intel Iris 05:31:57 INFO - Type: GPU 05:31:57 INFO - Bus: Built-In 05:31:57 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:57 INFO - Vendor: Intel (0x8086) 05:31:57 INFO - Device ID: 0x0a2e 05:31:57 INFO - Revision ID: 0x0009 05:31:57 INFO - Displays: 05:31:57 INFO - Display: 05:31:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:57 INFO - Display Serial Number: 1600x1200 60 05:31:57 INFO - Main Display: Yes 05:31:57 INFO - Mirror: Off 05:31:57 INFO - Online: Yes 05:31:57 INFO - Rotation: Supported 05:31:57 INFO - Return code: 0 05:31:57 INFO - Running post-action listener: _resource_record_post_action 05:31:57 INFO - [mozharness: 2016-10-18 12:31:57.938756Z] Finished run-tests step (success) 05:31:57 INFO - Running post-run listener: _resource_record_post_run 05:31:58 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 38691840; Write bytes: 706575872; Read time: 378; Write time: 2087 05:31:58 INFO - TinderboxPrint: CPU usage
53.5% 05:31:58 INFO - TinderboxPrint: I/O read bytes / time
38,691,840 / 378 05:31:58 INFO - TinderboxPrint: I/O write bytes / time
706,575,872 / 2,087 05:31:58 INFO - TinderboxPrint: CPU idle
2,259.9 (46.5%) 05:31:58 INFO - TinderboxPrint: CPU system
975.1 (20.1%) 05:31:58 INFO - TinderboxPrint: CPU user
1,626.6 (33.5%) 05:31:58 INFO - TinderboxPrint: Swap in / out
444,772,352 / 0 05:31:58 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384985600; Write bytes: 378484224; Read time: 28955; Write time: 719 05:31:58 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 37716992; Write bytes: 298219520; Read time: 362; Write time: 1313 05:31:58 INFO - Running post-run listener: _upload_blobber_files 05:31:58 INFO - Blob upload gear active. 05:31:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:58 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 05:31:58 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:58 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:00 INFO - (blobuploader) - INFO - Done attempting. 05:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:01 INFO - (blobuploader) - INFO - Done attempting. 05:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:03 INFO - (blobuploader) - INFO - Done attempting. 05:32:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:04 INFO - Return code: 0 05:32:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f0b25b946893805cc20a05896fe2388eb5406c607966be7ee2bd4d6896829830901c8c4c10accf8bd776e52e0449f2d57ca55aaa4a2794b389fda8152cbd4c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5ce60db9d375e6937d3b0ede771ac60dd79fe41d34954c3d584e1db20465f01c64f9adadb81348117c6953cf771791badd8f39ab9b9c518813d3ae877443801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08a57eb65f692851c93002aa499e51025d13ba20c5be4a59791c708ca6d4d7fdba25b2059c07a7cdc5d44610b7f73181f44c266f4e8dd60df4f30de47f09bb20"} 05:32:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:04 INFO - Contents: 05:32:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f0b25b946893805cc20a05896fe2388eb5406c607966be7ee2bd4d6896829830901c8c4c10accf8bd776e52e0449f2d57ca55aaa4a2794b389fda8152cbd4c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5ce60db9d375e6937d3b0ede771ac60dd79fe41d34954c3d584e1db20465f01c64f9adadb81348117c6953cf771791badd8f39ab9b9c518813d3ae877443801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08a57eb65f692851c93002aa499e51025d13ba20c5be4a59791c708ca6d4d7fdba25b2059c07a7cdc5d44610b7f73181f44c266f4e8dd60df4f30de47f09bb20"} 05:32:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:04 INFO - Copying logs to upload dir... 05:32:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.784234 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-18 05:32:04.072776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 05:32:04.076743) ========= 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.e2YWqnWK81/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.qyYc6zjc2C/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f0b25b946893805cc20a05896fe2388eb5406c607966be7ee2bd4d6896829830901c8c4c10accf8bd776e52e0449f2d57ca55aaa4a2794b389fda8152cbd4c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5ce60db9d375e6937d3b0ede771ac60dd79fe41d34954c3d584e1db20465f01c64f9adadb81348117c6953cf771791badd8f39ab9b9c518813d3ae877443801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08a57eb65f692851c93002aa499e51025d13ba20c5be4a59791c708ca6d4d7fdba25b2059c07a7cdc5d44610b7f73181f44c266f4e8dd60df4f30de47f09bb20"} build_url:https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/GuDiu7xcSNGY_Il70-utBQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f0b25b946893805cc20a05896fe2388eb5406c607966be7ee2bd4d6896829830901c8c4c10accf8bd776e52e0449f2d57ca55aaa4a2794b389fda8152cbd4c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f5ce60db9d375e6937d3b0ede771ac60dd79fe41d34954c3d584e1db20465f01c64f9adadb81348117c6953cf771791badd8f39ab9b9c518813d3ae877443801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/08a57eb65f692851c93002aa499e51025d13ba20c5be4a59791c708ca6d4d7fdba25b2059c07a7cdc5d44610b7f73181f44c266f4e8dd60df4f30de47f09bb20"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 05:32:04.110286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 05:32:04.110720) ========= 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.e2YWqnWK81/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.qyYc6zjc2C/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.004992 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 05:32:04.160318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 05:32:04.160661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 05:32:04.161012) ========= ========= Total master_lag: 0.17 =========