builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0087 starttime: 1482442779.36 results: success (0) buildid: 20161222112653 builduid: 55683df77ac649eaad910edd58f4e3ec revision: 3f796290f90ecb3a66af13f2ea0435859a38b57a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.359527) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.359987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.360270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.385998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.386445) ========= 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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-12-22 13:39:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 122M=0s 2016-12-22 13:39:39 (122 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.488358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.488745) ========= 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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.020098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:39.537405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 13:39:39.537796) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f796290f90ecb3a66af13f2ea0435859a38b57a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f796290f90ecb3a66af13f2ea0435859a38b57a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-12-22 13:39:39,613 truncating revision to first 12 chars 2016-12-22 13:39:39,613 Setting DEBUG logging. 2016-12-22 13:39:39,613 attempt 1/10 2016-12-22 13:39:39,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3f796290f90e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 13:39:40,888 unpacking tar archive at: mozilla-aurora-3f796290f90e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.528588 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 13:39:41.092852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:41.093191) ========= script_repo_revision: 3f796290f90ecb3a66af13f2ea0435859a38b57a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:41.093588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:41.093849) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 13:39:41.114038) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-22 13:39:41.114428) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:39:41 INFO - MultiFileLogger online at 20161222 13:39:41 in /builds/slave/test 13:39:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:39:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:39:41 INFO - {'append_to_log': False, 13:39:41 INFO - 'base_work_dir': '/builds/slave/test', 13:39:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:39:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:39:41 INFO - 'branch': 'Mozilla-Aurora', 13:39:41 INFO - 'buildbot_json_path': 'buildprops.json', 13:39:41 INFO - 'config_files': ('talos/mac_config.py',), 13:39:41 INFO - 'default_actions': ('clobber', 13:39:41 INFO - 'read-buildbot-config', 13:39:41 INFO - 'download-and-extract', 13:39:41 INFO - 'populate-webroot', 13:39:41 INFO - 'create-virtualenv', 13:39:41 INFO - 'install', 13:39:41 INFO - 'run-tests'), 13:39:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:39:41 INFO - 'download_minidump_stackwalk': True, 13:39:41 INFO - 'download_symbols': 'ondemand', 13:39:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:39:41 INFO - 'tooltool.py': '/tools/tooltool.py', 13:39:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:39:41 INFO - '/tools/misc-python/virtualenv.py')}, 13:39:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:39:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:39:41 INFO - 'installer_path': 'installer.exe', 13:39:41 INFO - 'log_level': 'info', 13:39:41 INFO - 'log_name': 'talos', 13:39:41 INFO - 'log_to_console': True, 13:39:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:39:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:39:41 INFO - 'opt_config_files': (), 13:39:41 INFO - 'pip_index': False, 13:39:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:39:41 INFO - 'cmd': ('bash', 13:39:41 INFO - '-c', 13:39:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:39:41 INFO - 'enabled': True, 13:39:41 INFO - 'halt_on_failure': False, 13:39:41 INFO - 'name': 'check_screen_resolution'},), 13:39:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:39:41 INFO - 'cmd': ('bash', 13:39:41 INFO - '-c', 13:39:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:39:41 INFO - 'enabled': True, 13:39:41 INFO - 'halt_on_failure': False, 13:39:41 INFO - 'name': 'check_screen_resolution'},), 13:39:41 INFO - 'run_cmd_checks_enabled': True, 13:39:41 INFO - 'sps_profile': False, 13:39:41 INFO - 'sps_profile_interval': 0, 13:39:41 INFO - 'suite': 'dromaeojs-e10s', 13:39:41 INFO - 'system_bits': '32', 13:39:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:39:41 INFO - 'title': 't-yosemite-r7-0087', 13:39:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:39:41 INFO - 'use_talos_json': True, 13:39:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:39:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:39:41 INFO - 'work_dir': 'build'} 13:39:41 INFO - [mozharness: 2016-12-22 21:39:41.318406Z] Running clobber step. 13:39:41 INFO - Running pre-action listener: _resource_record_pre_action 13:39:41 INFO - Running main action method: clobber 13:39:41 INFO - rmtree: /builds/slave/test/build 13:39:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:39:42 INFO - Running post-action listener: _resource_record_post_action 13:39:42 INFO - [mozharness: 2016-12-22 21:39:42.800491Z] Finished clobber step (success) 13:39:42 INFO - [mozharness: 2016-12-22 21:39:42.800653Z] Running read-buildbot-config step. 13:39:42 INFO - Running pre-action listener: _resource_record_pre_action 13:39:42 INFO - Running main action method: read_buildbot_config 13:39:42 INFO - Using buildbot properties: 13:39:42 INFO - { 13:39:42 INFO - "project": "", 13:39:42 INFO - "product": "firefox", 13:39:42 INFO - "script_repo_revision": "production", 13:39:42 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:39:42 INFO - "repository": "", 13:39:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:39:42 INFO - "buildid": "20161222112653", 13:39:42 INFO - "pgo_build": "False", 13:39:42 INFO - "basedir": "/builds/slave/test", 13:39:42 INFO - "buildnumber": 50, 13:39:42 INFO - "slavename": "t-yosemite-r7-0087", 13:39:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:39:42 INFO - "platform": "yosemite_r7", 13:39:42 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:39:42 INFO - "branch": "mozilla-aurora", 13:39:42 INFO - "repo_path": "releases/mozilla-aurora", 13:39:42 INFO - "revision": "3f796290f90ecb3a66af13f2ea0435859a38b57a", 13:39:42 INFO - "stage_platform": "macosx64", 13:39:42 INFO - "builduid": "55683df77ac649eaad910edd58f4e3ec", 13:39:42 INFO - "slavebuilddir": "test" 13:39:42 INFO - } 13:39:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 13:39:42 INFO - Running post-action listener: _resource_record_post_action 13:39:42 INFO - [mozharness: 2016-12-22 21:39:42.803983Z] Finished read-buildbot-config step (success) 13:39:42 INFO - [mozharness: 2016-12-22 21:39:42.804103Z] Running download-and-extract step. 13:39:42 INFO - Running pre-action listener: _resource_record_pre_action 13:39:42 INFO - Running main action method: download_and_extract 13:39:42 INFO - mkdir: /builds/slave/test/build/tests 13:39:42 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')]} 13:39:42 INFO - trying https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 13:39:42 INFO - Downloading https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 13:39:44 INFO - Downloaded 1199 bytes. 13:39:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:39:44 INFO - Using the following test package requirements: 13:39:44 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:39:44 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 13:39:44 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 13:39:44 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'jsshell-mac.zip'], 13:39:44 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 13:39:44 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:39:44 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 13:39:44 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 13:39:44 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 13:39:44 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:39:44 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 13:39:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:39:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:39:44 INFO - Fetch https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:39:44 INFO - Http code: 200 13:39:44 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 13:39:44 INFO - x-amz-cf-id: z1sKMBKmwX5RN87m7V9EZyQPhMmvgPE6VUieSyVrYqOtWboWiUiuIA== 13:39:44 INFO - x-amz-version-id: KA3I1ljl4e95SveQk0f3eoV50_8fcPlS 13:39:45 INFO - Expected file size: 16271086 13:39:45 INFO - Obtained file size: 16271086 13:39:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:39:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:39:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:39:51 INFO - Fetch https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:39:52 INFO - Http code: 200 13:39:52 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:39:52 INFO - x-amz-cf-id: Gn0FRODv2v4-lVevMjux6J2dpmoX05dpxKipYXzY7RB5GI4OgqonZA== 13:39:52 INFO - x-amz-version-id: KA3I1ljl4e95SveQk0f3eoV50_8fcPlS 13:39:52 INFO - Expected file size: 16271086 13:39:52 INFO - Obtained file size: 16271086 13:39:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 13:39:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:39:59 INFO - Fetch https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 13:40:00 INFO - Http code: 200 13:40:00 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 13:40:00 INFO - x-amz-cf-id: KxKay9ew9b-67aP-CX1uIty7K1whbRaNkanYuMGwEbtnBIAFfBuRPQ== 13:40:00 INFO - x-amz-version-id: 98pV6vuxFcCBRq4lbrZ1S5WGAOU7FxRg 13:40:00 INFO - Expected file size: 14409038 13:40:00 INFO - Obtained file size: 14409038 13:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:00 INFO - trying https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:40:00 INFO - Downloading https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 13:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 13:40:03 INFO - Downloaded 109758683 bytes. 13:40:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:40:03 INFO - mkdir: /builds/slave/test/properties 13:40:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:40:03 INFO - Writing to file /builds/slave/test/properties/build_url 13:40:03 INFO - Contents: 13:40:03 INFO - build_url:https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:40:04 INFO - Running post-action listener: _resource_record_post_action 13:40:04 INFO - Running post-action listener: set_extra_try_arguments 13:40:04 INFO - [mozharness: 2016-12-22 21:40:04.210465Z] Finished download-and-extract step (success) 13:40:04 INFO - [mozharness: 2016-12-22 21:40:04.210605Z] Running populate-webroot step. 13:40:04 INFO - Running pre-action listener: _resource_record_pre_action 13:40:04 INFO - Running main action method: populate_webroot 13:40:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:40:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:40:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:40:04 INFO - '--tppagecycles', 13:40:04 INFO - '7'], 13:40:04 INFO - 'tests': ['tsvgm']}}, 13:40:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:40:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:40:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:40:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:40:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:40:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:40:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['damp', 'tps']}, 13:40:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'tests': ['damp', 'tps']}, 13:40:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['dromaeo_dom']}, 13:40:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:40:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['basic_compositor_video']}, 13:40:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:40:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['a11yr', 13:40:04 INFO - 'ts_paint', 13:40:04 INFO - 'tpaint', 13:40:04 INFO - 'sessionrestore', 13:40:04 INFO - 'sessionrestore_no_auto_restore', 13:40:04 INFO - 'tabpaint']}, 13:40:04 INFO - 'other-e10s': {'tests': ['a11yr', 13:40:04 INFO - 'ts_paint', 13:40:04 INFO - 'tpaint', 13:40:04 INFO - 'sessionrestore', 13:40:04 INFO - 'sessionrestore_no_auto_restore', 13:40:04 INFO - 'tabpaint']}, 13:40:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:40:04 INFO - 'ts_paint', 13:40:04 INFO - 'tpaint', 13:40:04 INFO - 'sessionrestore', 13:40:04 INFO - 'sessionrestore_no_auto_restore', 13:40:04 INFO - 'tabpaint']}, 13:40:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:40:04 INFO - 'ts_paint', 13:40:04 INFO - 'tpaint', 13:40:04 INFO - 'sessionrestore', 13:40:04 INFO - 'sessionrestore_no_auto_restore', 13:40:04 INFO - 'tabpaint']}, 13:40:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['a11yr', 13:40:04 INFO - 'ts_paint', 13:40:04 INFO - 'tpaint', 13:40:04 INFO - 'sessionrestore', 13:40:04 INFO - 'sessionrestore_no_auto_restore', 13:40:04 INFO - 'tabpaint']}, 13:40:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['a11yr', 13:40:04 INFO - 'ts_paint', 13:40:04 INFO - 'tpaint', 13:40:04 INFO - 'sessionrestore', 13:40:04 INFO - 'sessionrestore_no_auto_restore', 13:40:04 INFO - 'tabpaint']}, 13:40:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['tsvgx', 13:40:04 INFO - 'tsvgr_opacity', 13:40:04 INFO - 'tart', 13:40:04 INFO - 'tscrollx', 13:40:04 INFO - 'cart']}, 13:40:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:40:04 INFO - 'tsvgr_opacity', 13:40:04 INFO - 'tart', 13:40:04 INFO - 'tscrollx', 13:40:04 INFO - 'cart']}, 13:40:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'talos_options': ['--disable-e10s'], 13:40:04 INFO - 'tests': ['tp5o']}, 13:40:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'tests': ['tp5o']}, 13:40:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'talos_options': ['--disable-e10s', 13:40:04 INFO - '--xperf_path', 13:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:40:04 INFO - 'tests': ['tp5n']}, 13:40:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:04 INFO - 'talos_options': ['--xperf_path', 13:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:40:04 INFO - 'tests': ['tp5n']}}, 13:40:04 INFO - 'talos.zip': {'path': '', 13:40:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:40:04 INFO - Running post-action listener: _resource_record_post_action 13:40:04 INFO - [mozharness: 2016-12-22 21:40:04.229664Z] Finished populate-webroot step (success) 13:40:04 INFO - [mozharness: 2016-12-22 21:40:04.229772Z] Running create-virtualenv step. 13:40:04 INFO - Running pre-action listener: _resource_record_pre_action 13:40:04 INFO - Running main action method: create_virtualenv 13:40:04 INFO - Creating virtualenv /builds/slave/test/build/venv 13:40:04 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 13:40:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:40:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:40:04 INFO - Using real prefix '/tools/python27' 13:40:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:40:05 INFO - Installing distribute.............................................................................................................................................................................................done. 13:40:08 INFO - Installing pip.................done. 13:40:08 INFO - Return code: 0 13:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:40:08 INFO - Reading from file tmpfile_stdout 13:40:08 INFO - Output received: 13:40:08 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) 13:40:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:40:08 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')]} 13:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:08 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')]} 13:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:08 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:08 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 13:40:08 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 13:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:08 INFO - 'HOME': '/Users/cltbld', 13:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:08 INFO - 'LOGNAME': 'cltbld', 13:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:08 INFO - 'MOZ_NO_REMOTE': '1', 13:40:08 INFO - 'NO_EM_RESTART': '1', 13:40:08 INFO - 'PAGER': '/bin/cat', 13:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:08 INFO - 'PWD': '/builds/slave/test', 13:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:08 INFO - 'SHELL': '/bin/bash', 13:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:08 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:08 INFO - 'USER': 'cltbld', 13:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:08 INFO - 'XPC_FLAGS': '0x0', 13:40:08 INFO - 'XPC_SERVICE_NAME': '0', 13:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:08 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 13:40:08 INFO - Cleaning up... 13:40:08 INFO - Return code: 0 13:40:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:40:08 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')]} 13:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:08 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')]} 13:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:08 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:08 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 13:40:08 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 13:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:08 INFO - 'HOME': '/Users/cltbld', 13:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:08 INFO - 'LOGNAME': 'cltbld', 13:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:08 INFO - 'MOZ_NO_REMOTE': '1', 13:40:08 INFO - 'NO_EM_RESTART': '1', 13:40:08 INFO - 'PAGER': '/bin/cat', 13:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:08 INFO - 'PWD': '/builds/slave/test', 13:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:08 INFO - 'SHELL': '/bin/bash', 13:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:08 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:08 INFO - 'USER': 'cltbld', 13:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:08 INFO - 'XPC_FLAGS': '0x0', 13:40:08 INFO - 'XPC_SERVICE_NAME': '0', 13:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:08 INFO - Downloading/unpacking psutil>=3.1.1 13:40:08 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 13:40:08 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 13:40:08 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 13:40:08 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 13:40:08 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 13:40:08 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 13:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:40:12 INFO - Installing collected packages: psutil 13:40:12 INFO - Running setup.py install for psutil 13:40:12 INFO - building 'psutil._psutil_osx' extension 13:40:12 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 13:40:12 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 13:40:12 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 13:40:12 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 13:40:12 INFO - building 'psutil._psutil_posix' extension 13:40:12 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 13:40:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:40:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:40:13 INFO - ^ 13:40:13 INFO - 1 warning generated. 13:40:13 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 13:40:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:40:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:40:13 INFO - Successfully installed psutil 13:40:13 INFO - Cleaning up... 13:40:13 INFO - Return code: 0 13:40:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:40:13 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')]} 13:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:13 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')]} 13:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:13 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:13 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 13:40:13 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 13:40:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:13 INFO - 'HOME': '/Users/cltbld', 13:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:13 INFO - 'LOGNAME': 'cltbld', 13:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:13 INFO - 'MOZ_NO_REMOTE': '1', 13:40:13 INFO - 'NO_EM_RESTART': '1', 13:40:13 INFO - 'PAGER': '/bin/cat', 13:40:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:13 INFO - 'PWD': '/builds/slave/test', 13:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:13 INFO - 'SHELL': '/bin/bash', 13:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:13 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:13 INFO - 'USER': 'cltbld', 13:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:13 INFO - 'XPC_FLAGS': '0x0', 13:40:13 INFO - 'XPC_SERVICE_NAME': '0', 13:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:40:13 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 13:40:13 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 13:40:13 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 13:40:13 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 13:40:13 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 13:40:13 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 13:40:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:40:16 INFO - Installing collected packages: mozsystemmonitor 13:40:16 INFO - Running setup.py install for mozsystemmonitor 13:40:16 INFO - Successfully installed mozsystemmonitor 13:40:16 INFO - Cleaning up... 13:40:16 INFO - Return code: 0 13:40:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:16 INFO - 'HOME': '/Users/cltbld', 13:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:16 INFO - 'LOGNAME': 'cltbld', 13:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:16 INFO - 'MOZ_NO_REMOTE': '1', 13:40:16 INFO - 'NO_EM_RESTART': '1', 13:40:16 INFO - 'PAGER': '/bin/cat', 13:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:16 INFO - 'PWD': '/builds/slave/test', 13:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:16 INFO - 'SHELL': '/bin/bash', 13:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:16 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:16 INFO - 'USER': 'cltbld', 13:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:16 INFO - 'XPC_FLAGS': '0x0', 13:40:16 INFO - 'XPC_SERVICE_NAME': '0', 13:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:16 INFO - Downloading/unpacking jsonschema==2.5.1 13:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:40:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:19 INFO - Downloading functools32-3.2.3-2.tar.gz 13:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:40:19 INFO - warning: no files found matching '*.txt' 13:40:19 INFO - no previously-included directories found matching 'build' 13:40:19 INFO - no previously-included directories found matching 'dist' 13:40:19 INFO - no previously-included directories found matching '.git*' 13:40:19 INFO - Installing collected packages: jsonschema, functools32 13:40:19 INFO - Running setup.py install for functools32 13:40:20 INFO - warning: no files found matching '*.txt' 13:40:20 INFO - no previously-included directories found matching 'build' 13:40:20 INFO - no previously-included directories found matching 'dist' 13:40:20 INFO - no previously-included directories found matching '.git*' 13:40:20 INFO - Successfully installed jsonschema functools32 13:40:20 INFO - Cleaning up... 13:40:20 INFO - Return code: 0 13:40:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:40:20 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')]} 13:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:20 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')]} 13:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:20 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:20 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 13:40:20 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 13:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:20 INFO - 'HOME': '/Users/cltbld', 13:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:20 INFO - 'LOGNAME': 'cltbld', 13:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:20 INFO - 'MOZ_NO_REMOTE': '1', 13:40:20 INFO - 'NO_EM_RESTART': '1', 13:40:20 INFO - 'PAGER': '/bin/cat', 13:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:20 INFO - 'PWD': '/builds/slave/test', 13:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:20 INFO - 'SHELL': '/bin/bash', 13:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:20 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:20 INFO - 'USER': 'cltbld', 13:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:20 INFO - 'XPC_FLAGS': '0x0', 13:40:20 INFO - 'XPC_SERVICE_NAME': '0', 13:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:40:20 INFO - Cleaning up... 13:40:20 INFO - Return code: 0 13:40:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:40:20 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')]} 13:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:20 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')]} 13:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:20 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:20 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 13:40:20 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 13:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:20 INFO - 'HOME': '/Users/cltbld', 13:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:20 INFO - 'LOGNAME': 'cltbld', 13:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:20 INFO - 'MOZ_NO_REMOTE': '1', 13:40:20 INFO - 'NO_EM_RESTART': '1', 13:40:20 INFO - 'PAGER': '/bin/cat', 13:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:20 INFO - 'PWD': '/builds/slave/test', 13:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:20 INFO - 'SHELL': '/bin/bash', 13:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:20 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:20 INFO - 'USER': 'cltbld', 13:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:20 INFO - 'XPC_FLAGS': '0x0', 13:40:20 INFO - 'XPC_SERVICE_NAME': '0', 13:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:23 INFO - Downloading blobuploader-1.2.4.tar.gz 13:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:40:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:40:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:24 INFO - Downloading docopt-0.6.1.tar.gz 13:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:40:24 INFO - Installing collected packages: blobuploader, requests, docopt 13:40:24 INFO - Running setup.py install for blobuploader 13:40:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:40:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:40:24 INFO - Running setup.py install for requests 13:40:25 INFO - Running setup.py install for docopt 13:40:25 INFO - Successfully installed blobuploader requests docopt 13:40:25 INFO - Cleaning up... 13:40:25 INFO - Return code: 0 13:40:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:25 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:25 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 13:40:25 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 13:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:25 INFO - 'HOME': '/Users/cltbld', 13:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:25 INFO - 'LOGNAME': 'cltbld', 13:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:25 INFO - 'MOZ_NO_REMOTE': '1', 13:40:25 INFO - 'NO_EM_RESTART': '1', 13:40:25 INFO - 'PAGER': '/bin/cat', 13:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:25 INFO - 'PWD': '/builds/slave/test', 13:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:25 INFO - 'SHELL': '/bin/bash', 13:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:25 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:25 INFO - 'USER': 'cltbld', 13:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:25 INFO - 'XPC_FLAGS': '0x0', 13:40:25 INFO - 'XPC_SERVICE_NAME': '0', 13:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:40:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-yeEZHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:40:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-aCk1dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-4lCKA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-G0jN8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VoPYVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-PrKubx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-dsYyOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-RBTq3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-L7mEql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-wqEauC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-wVYtOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:40:26 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-egHhbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:40:27 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-5nrm_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:40:27 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-m3wQG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:27 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-knRJ50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:40:27 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-INPUSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:40:27 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-DWKEAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:40:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:40:27 INFO - Running setup.py install for manifestparser 13:40:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:40:27 INFO - Running setup.py install for mozcrash 13:40:27 INFO - Running setup.py install for mozdebug 13:40:27 INFO - Running setup.py install for mozdevice 13:40:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Running setup.py install for mozfile 13:40:28 INFO - Running setup.py install for mozhttpd 13:40:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Running setup.py install for mozinfo 13:40:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Running setup.py install for mozInstall 13:40:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:40:28 INFO - Running setup.py install for mozleak 13:40:28 INFO - Running setup.py install for mozlog 13:40:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:40:29 INFO - Running setup.py install for moznetwork 13:40:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:40:29 INFO - Running setup.py install for mozprocess 13:40:29 INFO - Running setup.py install for mozprofile 13:40:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:40:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:40:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:40:29 INFO - Running setup.py install for mozrunner 13:40:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:40:29 INFO - Running setup.py install for mozscreenshot 13:40:29 INFO - Running setup.py install for moztest 13:40:30 INFO - Running setup.py install for mozversion 13:40:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:40:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:40:30 INFO - Cleaning up... 13:40:30 INFO - Return code: 0 13:40:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:30 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:30 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 13:40:30 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 13:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:30 INFO - 'HOME': '/Users/cltbld', 13:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:30 INFO - 'LOGNAME': 'cltbld', 13:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:30 INFO - 'MOZ_NO_REMOTE': '1', 13:40:30 INFO - 'NO_EM_RESTART': '1', 13:40:30 INFO - 'PAGER': '/bin/cat', 13:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:30 INFO - 'PWD': '/builds/slave/test', 13:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:30 INFO - 'SHELL': '/bin/bash', 13:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:30 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:30 INFO - 'USER': 'cltbld', 13:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:30 INFO - 'XPC_FLAGS': '0x0', 13:40:30 INFO - 'XPC_SERVICE_NAME': '0', 13:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:40:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ObcqDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:40:30 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)) 13:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:40:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7RxgiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:40:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-DYXDhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:40:30 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)) 13:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:40:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-oxJDnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:40:30 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)) 13:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:40:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ejCBkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:40:30 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)) 13:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:40:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-TBhwbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-n2Lf3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-1AEztX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-IAldVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ORjuXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-2S8n6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-xrsdAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-2oH8Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:40:31 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)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-SFdZcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-YMqyD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:40:32 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)) 13:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:40:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-MvCT2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:40:32 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)) 13:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:40:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-BaGcOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:40:32 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)) 13:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:40:32 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)) 13:40:32 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)) 13:40:32 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)) 13:40:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:34 INFO - Downloading blessings-1.6.tar.gz 13:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:40:34 INFO - Installing collected packages: blessings 13:40:34 INFO - Running setup.py install for blessings 13:40:35 INFO - Successfully installed blessings 13:40:35 INFO - Cleaning up... 13:40:35 INFO - Return code: 0 13:40:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:40:35 INFO - Reading from file tmpfile_stdout 13:40:35 INFO - Current package versions: 13:40:35 INFO - blessings == 1.6 13:40:35 INFO - blobuploader == 1.2.4 13:40:35 INFO - docopt == 0.6.1 13:40:35 INFO - functools32 == 3.2.3-2 13:40:35 INFO - jsonschema == 2.5.1 13:40:35 INFO - manifestparser == 1.1 13:40:35 INFO - mozInstall == 1.12 13:40:35 INFO - mozcrash == 1.0 13:40:35 INFO - mozdebug == 0.1 13:40:35 INFO - mozdevice == 0.48 13:40:35 INFO - mozfile == 1.2 13:40:35 INFO - mozhttpd == 0.7 13:40:35 INFO - mozinfo == 0.9 13:40:35 INFO - mozleak == 0.1 13:40:35 INFO - mozlog == 3.4 13:40:35 INFO - moznetwork == 0.27 13:40:35 INFO - mozprocess == 0.23 13:40:35 INFO - mozprofile == 0.28 13:40:35 INFO - mozrunner == 6.13 13:40:35 INFO - mozscreenshot == 0.1 13:40:35 INFO - mozsystemmonitor == 0.3 13:40:35 INFO - moztest == 0.7 13:40:35 INFO - mozversion == 1.4 13:40:35 INFO - psutil == 3.1.1 13:40:35 INFO - requests == 1.2.3 13:40:35 INFO - wsgiref == 0.1.2 13:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:36 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:36 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 13:40:36 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 13:40:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:36 INFO - 'HOME': '/Users/cltbld', 13:40:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:36 INFO - 'LOGNAME': 'cltbld', 13:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:36 INFO - 'MOZ_NO_REMOTE': '1', 13:40:36 INFO - 'NO_EM_RESTART': '1', 13:40:36 INFO - 'PAGER': '/bin/cat', 13:40:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:36 INFO - 'PWD': '/builds/slave/test', 13:40:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:36 INFO - 'SHELL': '/bin/bash', 13:40:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:36 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:36 INFO - 'USER': 'cltbld', 13:40:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:36 INFO - 'XPC_FLAGS': '0x0', 13:40:36 INFO - 'XPC_SERVICE_NAME': '0', 13:40:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 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)) 13:40:36 INFO - Cleaning up... 13:40:36 INFO - Return code: 0 13:40:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:40: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')]} 13:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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')]} 13:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:36 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 0x10dd4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcc5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5105ba3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, '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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 13:40:36 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 13:40:36 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 13:40:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:40:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:36 INFO - 'HOME': '/Users/cltbld', 13:40:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:36 INFO - 'LOGNAME': 'cltbld', 13:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:36 INFO - 'MOZ_NO_REMOTE': '1', 13:40:36 INFO - 'NO_EM_RESTART': '1', 13:40:36 INFO - 'PAGER': '/bin/cat', 13:40:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:36 INFO - 'PWD': '/builds/slave/test', 13:40:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:36 INFO - 'SHELL': '/bin/bash', 13:40:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:40:36 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:40:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:36 INFO - 'USER': 'cltbld', 13:40:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:36 INFO - 'XPC_FLAGS': '0x0', 13:40:36 INFO - 'XPC_SERVICE_NAME': '0', 13:40:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:40:37 INFO - Cleaning up... 13:40:37 INFO - Return code: 0 13:40:37 INFO - Running post-action listener: _resource_record_post_action 13:40:37 INFO - Running post-action listener: _start_resource_monitoring 13:40:37 INFO - Starting resource monitoring. 13:40:37 INFO - [mozharness: 2016-12-22 21:40:37.197503Z] Finished create-virtualenv step (success) 13:40:37 INFO - [mozharness: 2016-12-22 21:40:37.198480Z] Running install step. 13:40:37 INFO - Running pre-action listener: _resource_record_pre_action 13:40:37 INFO - Running main action method: install 13:40:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:40:37 INFO - Reading from file tmpfile_stdout 13:40:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:40:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:40:37 INFO - Reading from file tmpfile_stdout 13:40:37 INFO - Output received: 13:40:37 INFO - Usage: mozinstall [options] installer 13:40:37 INFO - Options: 13:40:37 INFO - -h, --help show this help message and exit 13:40:37 INFO - -d DEST, --destination=DEST 13:40:37 INFO - Directory to install application into. [default: 13:40:37 INFO - "/builds/slave/test"] 13:40:37 INFO - --app=APP Application being installed. [default: firefox] 13:40:37 INFO - mkdir: /builds/slave/test/build/application 13:40:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:41:08 INFO - Reading from file tmpfile_stdout 13:41:08 INFO - Output received: 13:41:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:41:08 INFO - Running post-action listener: _resource_record_post_action 13:41:08 INFO - [mozharness: 2016-12-22 21:41:08.556103Z] Finished install step (success) 13:41:08 INFO - [mozharness: 2016-12-22 21:41:08.556253Z] Running run-tests step. 13:41:08 INFO - Running pre-action listener: _resource_record_pre_action 13:41:08 INFO - Running main action method: run_tests 13:41:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:41:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:41:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:41:08 INFO - 2016-12-22 13:41:08.571 screenresolution[1913:19505] starting screenresolution argv=screenresolution get 13:41:08 INFO - 2016-12-22 13:41:08.574 screenresolution[1913:19505] Display 0: 1600x1200x32@60 13:41:08 INFO - 2016-12-22 13:41:08.579 screenresolution[1914:19507] starting screenresolution argv=screenresolution list 13:41:08 INFO - Available Modes on Display 0 13:41:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:41:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:41:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:41:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:41:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:41:08 INFO - Intel Iris: 13:41:08 INFO - Chipset Model: Intel Iris 13:41:08 INFO - Type: GPU 13:41:08 INFO - Bus: Built-In 13:41:08 INFO - VRAM (Dynamic, Max): 1536 MB 13:41:08 INFO - Vendor: Intel (0x8086) 13:41:08 INFO - Device ID: 0x0a2e 13:41:08 INFO - Revision ID: 0x0009 13:41:08 INFO - Displays: 13:41:08 INFO - Display: 13:41:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:41:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:41:08 INFO - Display Serial Number: 1600x1200 60 13:41:08 INFO - Main Display: Yes 13:41:08 INFO - Mirror: Off 13:41:08 INFO - Online: Yes 13:41:08 INFO - Rotation: Supported 13:41:08 INFO - Return code: 0 13:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:41:08 INFO - Python 2.7.3 13:41:08 INFO - Return code: 0 13:41:08 INFO - grabbing minidump binary from tooltool 13:41:08 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')]} 13:41:08 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 0x10db63d30>, '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 0x10d9c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db5bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:41:08 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 13:41:08 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 13:41:08 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 13:41:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:41:08 INFO - Return code: 0 13:41:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:41:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:41:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:41:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:41:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jRSlz9Nzpp/Render', 13:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:08 INFO - 'HOME': '/Users/cltbld', 13:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:08 INFO - 'LOGNAME': 'cltbld', 13:41:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:41:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:08 INFO - 'MOZ_NO_REMOTE': '1', 13:41:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:41:08 INFO - 'NO_EM_RESTART': '1', 13:41:08 INFO - 'PAGER': '/bin/cat', 13:41:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:08 INFO - 'PWD': '/builds/slave/test', 13:41:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:08 INFO - 'SHELL': '/bin/bash', 13:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NKpsP6o9ib/Listeners', 13:41:08 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 13:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:08 INFO - 'USER': 'cltbld', 13:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:08 INFO - 'XPC_FLAGS': '0x0', 13:41:08 INFO - 'XPC_SERVICE_NAME': '0', 13:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:41:09 INFO - mozversion application_buildid: 20161222112653 13:41:09 INFO - mozversion application_changeset: 3f796290f90ecb3a66af13f2ea0435859a38b57a 13:41:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:41:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:41:09 INFO - mozversion application_name: Firefox 13:41:09 INFO - mozversion application_remotingname: firefox-dev 13:41:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:41:09 INFO - mozversion application_vendor: Mozilla 13:41:09 INFO - mozversion application_version: 52.0a2 13:41:09 INFO - mozversion platform_buildid: 20161222112653 13:41:09 INFO - mozversion platform_changeset: 3f796290f90ecb3a66af13f2ea0435859a38b57a 13:41:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:41:09 INFO - mozversion platform_version: 52.0a2 13:41:09 INFO - using testdate: 1482442869 13:41:09 INFO - actual date: 1482442869 13:41:09 INFO - starting webserver on 'localhost:55652' 13:41:09 INFO - SUITE-START | Running 2 tests 13:41:09 INFO - TEST-START | dromaeo_css 13:41:09 INFO - operating with platform_type : mac_ 13:41:09 INFO - Initialising browser for dromaeo_css test... 13:41:09 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpYCzBgO/profile http://localhost:55652/getInfo.html) 13:41:11 INFO - PROCESS | 1924 | 2016-12-22 13:41:11.956 plugin-container[1926:19677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b37, name = 'com.apple.tsm.portname' 13:41:11 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:41:11 INFO - PROCESS | 1924 | 2016-12-22 13:41:11.959 plugin-container[1926:19677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a63, name = 'com.apple.CFPasteboardClient' 13:41:11 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:41:11 INFO - PROCESS | 1924 | 2016-12-22 13:41:11.959 plugin-container[1926:19677] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:41:12 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 13:41:12 INFO - PROCESS | 1924 | colorDepth:24 13:41:12 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 13:41:12 INFO - PROCESS | 1924 | __metrics 13:41:12 ERROR - PROCESS | 1924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 13:41:12 INFO - TEST-INFO | 1924: exit 0 13:41:12 INFO - Browser initialized. 13:41:12 INFO - Running cycle 1/1 for dromaeo_css test... 13:41:12 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpYCzBgO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:15 INFO - PROCESS | 1927 | 2016-12-22 13:41:15.566 plugin-container[1928:19806] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8433, name = 'com.apple.tsm.portname' 13:41:15 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:41:15 INFO - PROCESS | 1927 | 2016-12-22 13:41:15.566 plugin-container[1928:19806] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4523, name = 'com.apple.CFPasteboardClient' 13:41:15 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:41:15 INFO - PROCESS | 1927 | 2016-12-22 13:41:15.566 plugin-container[1928:19806] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:41:25 INFO - PROCESS | 1927 | RSS: Main: 229740544 13:41:25 INFO - PROCESS | 1927 | 13:42:14 INFO - PROCESS | 1927 | 1482442934880 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] 13:44:28 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55652/tests/dromaeo/cssquery-ext.html) 13:44:30 INFO - PROCESS | 1927 | RSS: Main: 234029056 13:44:30 INFO - PROCESS | 1927 | 13:47:32 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-ext.html (next: http://localhost:55652/tests/dromaeo/cssquery-jquery.html) 13:47:33 INFO - PROCESS | 1927 | RSS: Main: 243679232 13:47:33 INFO - PROCESS | 1927 | 13:50:35 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55652/tests/dromaeo/cssquery-mootools.html) 13:50:35 INFO - PROCESS | 1927 | RSS: Main: 246398976 13:50:35 INFO - PROCESS | 1927 | 13:53:37 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55652/tests/dromaeo/cssquery-prototype.html) 13:53:38 INFO - PROCESS | 1927 | RSS: Main: 246153216 13:53:38 INFO - PROCESS | 1927 | 13:56:41 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55652/tests/dromaeo/cssquery-yui.html) 13:56:41 INFO - PROCESS | 1927 | RSS: Main: 249192448 13:56:41 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-yui.html (next: http://localhost:55652/tests/dromaeo/cssquery-dojo.html) 13:59:44 INFO - PROCESS | 1927 | RSS: Main: 250847232 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | __start_tp_report 13:59:44 INFO - PROCESS | 1927 | _x_x_mozilla_page_load 13:59:44 INFO - PROCESS | 1927 | _x_x_mozilla_page_load_details 13:59:44 INFO - PROCESS | 1927 | |i|pagename|runs| 13:59:44 INFO - PROCESS | 1927 | |0;dojo.html;3332.550105735725;3342.0976336389176;3365.0746044837683;3369.174552234703;3378.3918894598964;5599.832005039851;5647.265855438793;5701.572382071351;5709.4290570942985;5713.885722285552;5638.210650508921;5695.658260504372;5707.029804933161;5737.827865164041;5772.45161709638;5178.171492561181;5209.400918894337;5218.373795144569;5267.631265811395;5279.234510995903;5219.5041471060185;5267.973660131694;5281.603879709018;5307.787688492455;5355.7857685692525;4968.205087186069;5106.285120083191;5151.716655583941;5167.689938603677;5242.397124330712;5124.769385377667;5167.974160129175;5178.1973794061605;5182.911588566368;5199.090159222159;5083.034223497523;5100.234964755279;5110.361204849394;5157.277981082651;5161.27742116104;5468.6171967962255;5676.858078548028;5705.372409035002;5751.597388182829;5769.913451298234;6141.516692814226;6174.96912515439;6178.62928224308;6209.441150296449;6229.626222426669;4786.7845946932475;5211.530962213419;5481.095619222823;6167.722452489604;6255.906161407583;4742.596879265232;5067.341245638044;5608.046632072557;5676.829695109153;5780.479756821906;6170.136180934673;6190.535709821781;6205.565610407319;6215.223097112861;6310.873782524323;5308.92036619451;5966.761329546856;6102.69486525672;6108.5418593605655;6115.205023346936;6240.5319601030105;6246.312905580383;6250.874982500324;6271.6550589718;6273.153124328249;5474.890502190014;5653.123765816223;6024.759009639565;6083.6349819011;6139.631622102688;5636.323641163087;5766.509846662997;6171.197744293213;6210.937890621036;6265.749370025239;4856.053069651454;4871.196252618278;4880.853574392774;4904.901901961941;4962.702237865739;4352.956470435319;4376.124775045004;4380;4385.101054283864;4425.203463376559;4438.622717069021;5838.824835254949;5858.326292476335;5864.765409383577;5914.408559144051;6270.717817698214;6273.466755325849;6275.843103922439;6291.842703932347;6296.779612713533;5683.2895888014;5740.712964351766;5762.30852297727;5806.68063256525;5830.513219129095;5381.4349493303425;5416.377116631559;5422.349318081855;5424.674519528762;5453.209284653703;6235.563510554218;6280.623162610258;6283.811485655255;6292.496600271876;6303.779367722108;6120.632762034292;6130.601510901777;6149.477294430024;6212.81361559154;6284.968575157095;6188.783392581238;6211.3478084802255;6254.6247225166635;6269.968650156902;6277.278113016879;6190.164327815867;6199.194104766351;6199.318075011835;6203.8138855834395;6214.378562143749;6202.751889924352;6235.314115447207;6238.75044998195;6250.718717657625;6288.874222515616;5852.502537284378;5888.646681199141;5930.614510056833;6011.368806275278;6108.72510737009;5833.125031245348;5976.701164941648;5976.880462390641;5996.220491336098;6004;4783.736894470838;5732.742026608729;5902.852428689317;5918.378570250062;6024.789132380346;6106.056758142859;6127.5866022601795;6140.995089002448;6160.3223645398075;6166.105914642441;5969.04495280753;5987.730552125077;5993.460588547052;5993.61041532299;6021.518278537794 13:59:44 INFO - PROCESS | 1927 | |1;ext.html;436.00808161432735;462.58829641618945;505.4490605240288;510.6170372220834;526.4314540296477;25377.746222537768;37765.81117094417;38788.80605596975;38963.610363896354;39045.60954390455;39566.406503902464;40069;40101.598984010154;40151.39772903401;40318.59681403185;9220.677276295331;9321.114494123081;9370.10983956523;9385.38994965325;9436.386634868746;9292.721218363426;9379.812403751921;9380.390274632127;9387.718368448957;9411.764705882339;7514.0607424071995;8449.873251901226;9361.578728957213;9407.764805879873;9440.197583205436;7837.373010159174;9327.39371940825;9334.906650933506;9402.62389504419;9414.482203478807;7787.221277872224;9310.208632266265;9314.208292295163;9317.906820931772;9362.812743745088;37607;37844.81077594622;37882.431763523295;37913;37913;3209.7111259986714;3255.186203449138;3408.386490431721;3659.670629643318;3948.2893079245723;23289.883550582308;27168.728312716816;28024.439511209865;28224;29013.129606111852;3166.509191075387;3190.3619276144864;3191.2341038150907;3297;3309.4373956427467;483936;488123;491872;492682;494739;55244.72377638086;55263.61840953928;55324.72337638366;55670.72164639151;55769.44230557643;55813.16280255799;57678;57729;57916.42083579195;58027.70986145042;15483.225838708246;15708.528744137695;15710.607234819221;15714.371425143096;15726.606834829221;12260.26438413698;12273;12320.75358492825;12330.260184388786;12352.011839052855;14365.856341436453;14588.905832062637;14653.340599672827;14656.780148297785;14878.553643390716;5753.597248192586;5786.855328616818;5920.881582368328;5970.402959703995;6014.849628759229;839.4669384940606;967.2407160379069;1012.7974405119006;1028.0336483705294;1038.6987773545738;28922.855385722938;29443.11670649884;29479.11562653124;29745.851270743507;29746.553801692993;946.9289803264783;966.4636126949611;1021.5352014833232;1031.6286136990677;1049.7952899184738;14789.964702470723;15075.170865602278;15426.537203883901;15451.439970078543;15555.455559055605;633339;642638.786806063;644752;647079;647924;49904;51831.48168518267;54515;54782.630434238665;55169.44830551723;1336.7593833109938;1338.5783478204335;1363.0526783885302;1365.9795103073461;1366.269046060353;28125.015624453044;28867.85566072156;28900.843966241115;29080.56379154272;29418.852905735333;46340;46844.531554684014;46928.765356173004;47148.528514715785;47173.76413117912;539963;542693;542741.286293566;543545;544490.2775486256;25511;25863.353416164748;25883.482330352912;25885.835137418486;25921.611175832;43565.346519802864;44276;44417.777911110235;44829.32756008728;45093.09813803771;36846.44730328993;37134;37177.67440930968;37228.69699560502;38071.809640951615;33391.99824005284;37028.81485592663;37800.243995120494;38007.04982375463;38044.61955380411;35157.76947806814;35177.296454071286;35362.646373535936;35801.46297805483;36147;25433.745662543137;28475.145745627666;31834.044978650676;32918.61739217072;33116.668833311356;24652;24653.50692986166;24830.751692483565;25047.49905001926;25087.12195073164 13:59:44 INFO - PROCESS | 1927 | |2;jquery.html;331.46468453447676;361.4939085280607;363.18283861312045;370.9239605880794;374.61040517861426;18006.90996545017;18524.259029638815;19520.70718939217;19521.707174392395;19754.802451975513;14384.784228236585;19097.427077187705;19129.713054304197;19391.321303754372;20183.19267229309;5455.236266922624;5810.738516766755;5811.215485909391;5815.447532484428;5821.621594596359;5572.219889215513;5684.54523638108;5846.64920104793;5914.467697907187;5982.970085149568;5909.852253693649;5952.613080149777;5958.8808223835495;5966.224390829208;5974.163617093611;5652.434756524335;5683.175939488771;5874.089516124986;5898.970505147489;5913.2608423947;5458.972705136449;5662.971685141589;5719.056355701305;5735.913961290584;5742.483176514133;12857.935710321482;12910.612681619567;13064.542741004114;13119.47522099115;13127.409266583027;2037.8165965063215;2152.601768672785;2438.829281950264;2732.945341093187;2924.4443555724556;9744.90255097454;10106.44414557199;10164.4917754112;10237.641682541076;14474.638134046627;1806.7380229866726;1807.493901707524;1853.6570734414177;1865.9160337784833;1926.807319268076;114113;119673;119962.40018799937;120727.3963630185;121281;11507.71230719222;11701.414929253504;11705.239159454608;11760.941195293968;11897.524099035942;14597.489087882086;14607.78088328676;14621.92689036548;14631.707365852624;14644.414223431157;8352.791180220544;8410.537420441811;8427.199416055464;8452.788680283042;8558.700445484503;8218.931538900024;8229.094799572042;8266.628001739937;8362.958185209034;8393.160683931681;4442.200403927324;4481.103779244099;4490.708103973231;4526.7510286933875;4567.634589232854;1872.0437143185404;1912.1165651833212;1912.9340312462507;1918.0505649703487;1918.2710569983597;798.6406117247262;825.405707890318;912.1790388650268;928.2713070239829;990.3562684255292;20113.39659810208;20659;20865.69146943824;20886.89556552238;21203.575928481343;856.1823458597025;926.4950601921969;943.5706753427174;946.2666433514082;949.9620015199315;8739.563021848882;10235.948820256;10697.679069627924;10859.565617375374;11135.888641113646;555658;622733;629262.7073729296;632734;635362;107152;110332.4483377594;127717;146328;146523;955.3217215776738;971.2521358554015;991.4101109839634;994.2443742755557;996.267743208741;18295.71929964943;18420.171092301145;18609.720854187468;18641.347552835585;18676.906615466836;49144.75427622839;53463.59413826465;55381;56142;56883.71558142183;66500.33499665135;76950;83892.16107838844;86448.135518644;86638;7076.469264805057;7401.8149546261775;7654.693812247448;8065.87901181471;8072.031356237289;11759.706007349885;12649.93675031619;12666.303353315656;12702.809457858324;12761.361931903553;9232.399894006869;10552.366857988545;10581.418022008864;10871.347719136877;11050.889491104987;9052.230560402177;10279.17766578657;10776.67669969902;10913.727156821144;10933.45332733376;10689.51897164645;10783.6225732099;11013.449327533752;11054.281471704313;11097.445127743742;6522.34776522344;7194.388476979515;7263.201047884623;7418.888716669147;7643.235676432312;8823.602937867683;10779.784404311713;10869;10937.890621093688;10946.288491248044 13:59:44 INFO - PROCESS | 1927 | |3;mootools.html;1316.203696763458;1458.4020551573853;1615.1116885712854;1756.4554987953743;1803.2967142814305;7347.559146451204;7651.502652327595;7883;8333.166683331663;8364.289035431988;7825.256600622946;8127.796805079876;8146.2261085196815;8227.300679442254;8230.46501977371;2251.6735073414343;2277.954440911181;2287.7025986621716;2290.5189910118893;2292.3466811958597;2270.489139943516;2290.713660792401;2306.6194077977116;2317.1079134533243;2324.1168356024687;1900.5248687828043;2230.877301748403;2245.921392751254;2247.78646028627;2248.516568937678;2235.8099561537288;2242.383344580237;2256.9887150564223;2263.513344630896;2266.2181547366213;2266.7166604174477;2288.439332363565;2289.9198528051606;2291.2667946257206;2296.5062511560095;8064.5161290322185;8233.723772815223;8238.176182381714;8241.917580824174;8244.340452763765;4891.168501354743;5038.445770965228;5042.495750424928;5047.520485553867;5059.671121377136;3208.711215990572;3258.983705081483;3441.913952151216;3453.4647129694936;3459.6713312235297;972.8832540095163;978.3542861711236;985.2167526816127;1084.8535447714614;1086.7337502311984;10143.34068285559;10359.27485076045;10466.215033872413;10653.627123050655;10739.248252622241;4200.768957707294;4210.242156411875;4360.869173924787;4364.498082720528;4364.694471387036;8374.371922105867;8520.616572254263;8523.190296921783;8544.444611100384;8549.786255343666;4988.775505102279;4991.80032798684;4997.475265097185;4999.975000125049;5014.874628134326;3505.9298814023578;3973.443717879499;4639.396878405786;4703.976480117578;4719.858404247878;2850.3159241782237;2946.2487065798514;3643.1620727232885;3657.049167216543;3657.4513822926774;947.2989987409268;1108.3626914524182;1129.949152288149;1132.7394699219226;1143.7826812905687;729.8722723523363;759.2293821770907;884.7964968057254;885.2298500304776;886.2201262888746;5197.792088316425;5228.6339956203465;5324.713605547494;5449.373322067933;5489.4236105209175;382.3824523394753;397.4915196827987;438.7784168994637;450.182918003822;450.2233646959035;3476.60019097807;3597.1366871950545;3621.855125794939;3650.2152037312107;3714.294284086015;9559.856602150974;9813.705588832347;9929.2056635469;9952.751181220527;9968.950155249177;9840.065193806577;9904.158146557624;9921.107100361001;9930.30487865857;9939.602415903282;7206.783796486114;7501.512401693873;7715.344195743424;7741.109772376249;7741.961290193625;5269.1832765921345;5276.894462110659;5285.471452854684;5471.206675032177;5503.284573005644;9147.77130571741;9156.771080723036;9185.081491850762;9242;9275.21160701348;9090.363674542983;9269.490178040272;9296.58165382573;9419;9423.623055077995;6140.754369825157;6351.523635727432;6519.869602607826;6635.0710900473005;6641.369069938348;6139.693015349304;7710.421718371257;7752.961235193788;7810.609469526387;7822.960885195537;6940.583564986117;7087.114110736158;7097.467689923174;7104.3961263293195;7110.4667149962925;6886.758963436256;6966.1988871280455;6966.616836074065;6984.685689143899;6989.930100698928;6389.361063893573;6447.161868957006;6535.738570457319;6540.345965403421;6557.442617377385;3861.362875125573;4635.466921304093;4720.409948756405;4738.620910327097;4740.762961851962;4635.188841952712;4722.693024953367;4835.443923948791;4878.268259761065;4984.551390374883 13:59:44 INFO - PROCESS | 1927 | |4;prototype.html;280.99544129736194;298.9925251868704;305.4745837160084;309.3071519795658;312.6279727124721;4658.301254811771;5407.83776486705;5507.779688812448;5507.807226747064;5562.217691969459;4565.429321334833;4589.829593453673;5039.72281524516;5145.305383773199;5168.974155129228;4103.405006274089;4190.413342132104;4208.263553878059;4208.263553878074;4216.3464662977285;3518.36669399508;3936.881893543184;4089.9182016359805;4221.24017676818;4233.957660423387;3444.9483257751153;3937.0944682722993;4137.462129923121;4151.467604761094;4151.875443736692;3238.303764690591;4131.52487463941;4142.730722503027;4155.854545090938;4159.313713237312;3285.293661862711;3561.6438356164435;3610.6640542999257;3619.65182206458;3633.818309084562;4407.955920440787;5074.035933172722;5263.552598029172;5294.52349288562;5324.600654950894;4363.432753742025;4754;4797.568218860284;4804.591609713144;4809.807607695688;4317.438732964726;5398.325209348832;5779.768809247625;5812.622179558315;5817.127430885359;3854.4218367244857;3926.2343842950636;3981.064449854282;3982.8605998789903;4000.0399904023116;5971.253593300838;6003.909941350883;6043.335233124353;6086.421789929949;6089.543284253655;3576.4071048490155;3864.632859878307;4057.594240575978;4068.267711811843;4074.898127546835;3367.6800703933086;3916.8629097981434;4120.340745480708;4141.585841415895;4144.274751918402;4045;4595.724256544618;4650.651201159926;4737.620990320766;4782.33047373368;4817.686850354716;5732.914006289909;5797.594168408255;5830.795922142789;5837.883242335214;1284.7173621803188;1317.3993597778745;1320.8018797180307;1327.7784438316771;1334.0194956706812;789.3448437796615;889.5463313710054;903.978504290148;911.5305617606938;924.5885580916428;4858.036597675416;5106.744662766847;5228.607854410934;5230.744621290939;5264.578833693296;5244.9737751310995;5671.376148623648;5698.94569504643;5732.656040637575;5798.449147330997;4108.4453598764385;4479.70881892676;4632.884177895579;4636.976815115903;5190.455002224788;2710.227585138226;2736.65791776028;2942.014140455184;2948.3071478202605;2969.2576855786056;5081.426715955596;5217.217417387346;5475.4524547544925;5599.220526144917;5846.619969701956;5622.85942851432;5756.942430575725;5792.972459639177;5857.7949771757785;5901.380355062743;5544.417836127229;5797.565182611405;5851.04522216278;5907.911381329283;5923.318818335946;4847.5394837490385;4994.725290109079;5096.847094587169;5754.992876246556;5777.768889244383;4452.438049560274;5340.919886201632;5541.695206763667;5606.710456595088;5607.747651355618;5866.354700982974;5893.675847828239;5899;5899.528037756883;5955.3920441479695;3398.6091599466376;3625.021244264087;3658.5243918291517;3737.3646480097905;3863.420486926871;4849.684770489906;5635.830925072254;5653.717314134195;5658.745356459051;5667.376588575171;5233.476652334736;5710.543156547549;5812.6049748061005;5841.036229022164;5862.7654893805475;5147.819826306061;5530.534408381863;5840.912386314124;5852.619579727304;5870.647761134345;4802.711837289774;5023.794289370598;5390.460953904578;5691.77232910679;5730.369659337386;5803;5827.504662103769;5861.384554621874;5868.911966320423;5875.794347197999;4787.4494433140635;5551.472610102034;5638.971805141112;5772.567057470623;5797 13:59:44 INFO - PROCESS | 1927 | |5;yui.html;629.8079085878807;694.8957656351547;704.3625518905393;752.6377257164532;789.388224126302;14120.152790832544;14433.422663093465;14629.70740585189;14815.407383704653;14960.925195374035;13204.405801738922;13434.59696209113;13445.394957226923;13455.798163027537;13499.460021599149;800.5116878703986;820.938429617781;823.0822632764484;825.1377310710292;825.8761185822144;644.6679959820696;671.4628297362091;786.9488483248599;808.3331251717327;815.388458656008;846.2975730143966;847.7753395350237;848.753861380199;849.9107593702633;851.0425771007616;819.9262066414051;841.1672444280149;842.5366048673236;843.5992903370911;843.9156084391573;624.9562530622858;626.8401557602828;628.0673200297555;628.779927025542;628.9433950944391;13546.525871594447;13683.384247708877;13749.381277842522;13756.312184390741;13765.311734413339;13267.336633168303;13448.394822233024;13509.459621615124;13561.982851286193;13638.567950365266;8808.64765409383;10204.438755868425;10494.108000819939;10567.894321056769;10803.83794243087;3549.574051113857;3575.6424357564297;3778.376567866299;3780.584135745066;3783.2244389900006;84751.57624211902;87705.24589508238;88125.6781148277;90835.54582227046;91118.99999999933;10057.597696092074;10311.742206444898;10506.947465262625;10594.046535811814;10624.001270433648;19824.909629970203;19846.007699614962;19864.70202946957;19865;19899.900500497406;7318.487705860539;7408;7615.16233214346;7698.923010769932;7856.45004849655;4188.518320393194;4206.41110244566;4292.635126014324;4338.305871060616;4425.712328698624;3229.0474310078584;3321.4353559894876;3329.217633856042;3332.3668502984356;3332.8666853325594;602.2471910112359;619.9225096862892;633.7274971762187;635.8430393098289;641.6022066318819;598.6826981699706;609.6890585801185;614.7356636646196;630.3003665930813;630.3565392034051;7148.678309476086;7250.383717383976;8826.42628229163;8887.433775819969;9023.4134781239;455.77851358359914;554.4621716934647;595.5295316699759;605.748614325059;626.1671976271548;3802.2015376771187;3826.6556009959236;4277.315629499328;4319.179355922364;4343.087951530151;90216.54891725631;95952;105912.94087059185;113168;113211.86788132013;88543.55728221318;95936.52031739797;97670;98468.01531984731;99182.51226231613;72997;73812.2618773816;80101.599492001;86728.56635716782;88419;9357.344985850925;9725.24945509815;9765.316427849983;9807.754806129618;9823.607055717692;49912.500874992234;50097.747556311384;51195.48804512056;51579.74210128925;51930.48069519408;52706.472935270154;66622.33377666162;68701.07284695619;70746.58506829938;72918;11317.773644527228;12113.273203607812;12182.695432614255;12359.073069519642;12500.999920006196;10264.076233139054;11324.263922844988;13775.793363099361;13868.722625547634;14669;12638.115331927045;13073.215607063607;13088.345582721016;13678;13724.45102195901;13164.934175329063;13185.736285274432;13492.86507134916;13739;13776.380062897395;12714.809277860655;12878.098533102593;12915.095943284256;13154.21074735519;13528.188308701509;10814.945925270324;11283.605073822377;11375.1468639854;11567.363794991355;11614.709632258922;11269.71825704364;11474.464170272217;11542.769144617228;11570.595029174276;11575.189736718348 13:59:44 INFO - PROCESS | 1927 | __end_tp_report 13:59:44 INFO - PROCESS | 1927 | __start_cc_report 13:59:44 INFO - PROCESS | 1927 | _x_x_mozilla_cycle_collect,373 13:59:44 INFO - PROCESS | 1927 | __end_cc_report 13:59:44 INFO - PROCESS | 1927 | __startTimestamp1482443984666__endTimestamp 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | ------- Summary: start ------- 13:59:44 INFO - PROCESS | 1927 | Number of tests: 6 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | [#0] dojo.html Cycles:165 Average:5665.78 Median:5838.82 stddev:649.26 (11.1%) stddev-sans-first:624.92 13:59:44 INFO - PROCESS | 1927 | Values: 3332.6 3342.1 3365.1 3369.2 3378.4 5599.8 5647.3 5701.6 5709.4 5713.9 5638.2 5695.7 5707.0 5737.8 5772.5 5178.2 5209.4 5218.4 5267.6 5279.2 5219.5 5268.0 5281.6 5307.8 5355.8 4968.2 5106.3 5151.7 5167.7 5242.4 5124.8 5168.0 5178.2 5182.9 5199.1 5083.0 5100.2 5110.4 5157.3 5161.3 5468.6 5676.9 5705.4 5751.6 5769.9 6141.5 6175.0 6178.6 6209.4 6229.6 4786.8 5211.5 5481.1 6167.7 6255.9 4742.6 5067.3 5608.0 5676.8 5780.5 6170.1 6190.5 6205.6 6215.2 6310.9 5308.9 5966.8 6102.7 6108.5 6115.2 6240.5 6246.3 6250.9 6271.7 6273.2 5474.9 5653.1 6024.8 6083.6 6139.6 5636.3 5766.5 6171.2 6210.9 6265.7 4856.1 4871.2 4880.9 4904.9 4962.7 4353.0 4376.1 4380.0 4385.1 4425.2 4438.6 5838.8 5858.3 5864.8 5914.4 6270.7 6273.5 6275.8 6291.8 6296.8 5683.3 5740.7 5762.3 5806.7 5830.5 5381.4 5416.4 5422.3 5424.7 5453.2 6235.6 6280.6 6283.8 6292.5 6303.8 6120.6 6130.6 6149.5 6212.8 6285.0 6188.8 6211.3 6254.6 6270.0 6277.3 6190.2 6199.2 6199.3 6203.8 6214.4 6202.8 6235.3 6238.8 6250.7 6288.9 5852.5 5888.6 5930.6 6011.4 6108.7 5833.1 5976.7 5976.9 5996.2 6004.0 4783.7 5732.7 5902.9 5918.4 6024.8 6106.1 6127.6 6141.0 6160.3 6166.1 5969.0 5987.7 5993.5 5993.6 6021.5 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | [#1] ext.html Cycles:180 Average:67876.18 Median:38058.21 stddev:150459.07 (395.3%) stddev-sans-first:150795.94 13:59:44 INFO - PROCESS | 1927 | Values: 436.0 462.6 505.4 510.6 526.4 25377.7 37765.8 38788.8 38963.6 39045.6 39566.4 40069.0 40101.6 40151.4 40318.6 9220.7 9321.1 9370.1 9385.4 9436.4 9292.7 9379.8 9380.4 9387.7 9411.8 7514.1 8449.9 9361.6 9407.8 9440.2 7837.4 9327.4 9334.9 9402.6 9414.5 7787.2 9310.2 9314.2 9317.9 9362.8 37607.0 37844.8 37882.4 37913.0 37913.0 3209.7 3255.2 3408.4 3659.7 3948.3 23289.9 27168.7 28024.4 28224.0 29013.1 3166.5 3190.4 3191.2 3297.0 3309.4 483936.0 488123.0 491872.0 492682.0 494739.0 55244.7 55263.6 55324.7 55670.7 55769.4 55813.2 57678.0 57729.0 57916.4 58027.7 15483.2 15708.5 15710.6 15714.4 15726.6 12260.3 12273.0 12320.8 12330.3 12352.0 14365.9 14588.9 14653.3 14656.8 14878.6 5753.6 5786.9 5920.9 5970.4 6014.8 839.5 967.2 1012.8 1028.0 1038.7 28922.9 29443.1 29479.1 29745.9 29746.6 946.9 966.5 1021.5 1031.6 1049.8 14790.0 15075.2 15426.5 15451.4 15555.5 633339.0 642638.8 644752.0 647079.0 647924.0 49904.0 51831.5 54515.0 54782.6 55169.4 1336.8 1338.6 1363.1 1366.0 1366.3 28125.0 28867.9 28900.8 29080.6 29418.9 46340.0 46844.5 46928.8 47148.5 47173.8 539963.0 542693.0 542741.3 543545.0 544490.3 25511.0 25863.4 25883.5 25885.8 25921.6 43565.3 44276.0 44417.8 44829.3 45093.1 36846.4 37134.0 37177.7 37228.7 38071.8 33392.0 37028.8 37800.2 38007.0 38044.6 35157.8 35177.3 35362.6 35801.5 36147.0 25433.7 28475.1 31834.0 32918.6 33116.7 24652.0 24653.5 24830.8 25047.5 25087.1 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | [#2] jquery.html Cycles:180 Average:35077.79 Median:346.48 stddev:102823.20 (29676.6%) stddev-sans-first:103078.55 13:59:44 INFO - PROCESS | 1927 | Values: 331.5 361.5 363.2 370.9 374.6 18006.9 18524.3 19520.7 19521.7 19754.8 14384.8 19097.4 19129.7 19391.3 20183.2 5455.2 5810.7 5811.2 5815.4 5821.6 5572.2 5684.5 5846.6 5914.5 5983.0 5909.9 5952.6 5958.9 5966.2 5974.2 5652.4 5683.2 5874.1 5899.0 5913.3 5459.0 5663.0 5719.1 5735.9 5742.5 12857.9 12910.6 13064.5 13119.5 13127.4 2037.8 2152.6 2438.8 2732.9 2924.4 9744.9 10106.4 10164.5 10237.6 14474.6 1806.7 1807.5 1853.7 1865.9 1926.8 114113.0 119673.0 119962.4 120727.4 121281.0 11507.7 11701.4 11705.2 11760.9 11897.5 14597.5 14607.8 14621.9 14631.7 14644.4 8352.8 8410.5 8427.2 8452.8 8558.7 8218.9 8229.1 8266.6 8363.0 8393.2 4442.2 4481.1 4490.7 4526.8 4567.6 1872.0 1912.1 1912.9 1918.1 1918.3 798.6 825.4 912.2 928.3 990.4 20113.4 20659.0 20865.7 20886.9 21203.6 856.2 926.5 943.6 946.3 950.0 8739.6 10235.9 10697.7 10859.6 11135.9 555658.0 622733.0 629262.7 632734.0 635362.0 107152.0 110332.4 127717.0 146328.0 146523.0 955.3 971.3 991.4 994.2 996.3 18295.7 18420.2 18609.7 18641.3 18676.9 49144.8 53463.6 55381.0 56142.0 56883.7 66500.3 76950.0 83892.2 86448.1 86638.0 7076.5 7401.8 7654.7 8065.9 8072.0 11759.7 12649.9 12666.3 12702.8 12761.4 9232.4 10552.4 10581.4 10871.3 11050.9 9052.2 10279.2 10776.7 10913.7 10933.5 10689.5 10783.6 11013.4 11054.3 11097.4 6522.3 7194.4 7263.2 7418.9 7643.2 8823.6 10779.8 10869.0 10937.9 10946.3 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | [#3] mootools.html Cycles:180 Average:5242.23 Median:5128.73 stddev:2924.56 (57.0%) stddev-sans-first:2917.88 13:59:44 INFO - PROCESS | 1927 | Values: 1316.2 1458.4 1615.1 1756.5 1803.3 7347.6 7651.5 7883.0 8333.2 8364.3 7825.3 8127.8 8146.2 8227.3 8230.5 2251.7 2278.0 2287.7 2290.5 2292.3 2270.5 2290.7 2306.6 2317.1 2324.1 1900.5 2230.9 2245.9 2247.8 2248.5 2235.8 2242.4 2257.0 2263.5 2266.2 2266.7 2288.4 2289.9 2291.3 2296.5 8064.5 8233.7 8238.2 8241.9 8244.3 4891.2 5038.4 5042.5 5047.5 5059.7 3208.7 3259.0 3441.9 3453.5 3459.7 972.9 978.4 985.2 1084.9 1086.7 10143.3 10359.3 10466.2 10653.6 10739.2 4200.8 4210.2 4360.9 4364.5 4364.7 8374.4 8520.6 8523.2 8544.4 8549.8 4988.8 4991.8 4997.5 5000.0 5014.9 3505.9 3973.4 4639.4 4704.0 4719.9 2850.3 2946.2 3643.2 3657.0 3657.5 947.3 1108.4 1129.9 1132.7 1143.8 729.9 759.2 884.8 885.2 886.2 5197.8 5228.6 5324.7 5449.4 5489.4 382.4 397.5 438.8 450.2 450.2 3476.6 3597.1 3621.9 3650.2 3714.3 9559.9 9813.7 9929.2 9952.8 9969.0 9840.1 9904.2 9921.1 9930.3 9939.6 7206.8 7501.5 7715.3 7741.1 7742.0 5269.2 5276.9 5285.5 5471.2 5503.3 9147.8 9156.8 9185.1 9242.0 9275.2 9090.4 9269.5 9296.6 9419.0 9423.6 6140.8 6351.5 6519.9 6635.1 6641.4 6139.7 7710.4 7753.0 7810.6 7823.0 6940.6 7087.1 7097.5 7104.4 7110.5 6886.8 6966.2 6966.6 6984.7 6989.9 6389.4 6447.2 6535.7 6540.3 6557.4 3861.4 4635.5 4720.4 4738.6 4740.8 4635.2 4722.7 4835.4 4878.3 4984.6 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | [#4] prototype.html Cycles:180 Average:4571.38 Median:5089.14 stddev:1412.66 (27.8%) stddev-sans-first:1379.43 13:59:44 INFO - PROCESS | 1927 | Values: 281.0 299.0 305.5 309.3 312.6 4658.3 5407.8 5507.8 5507.8 5562.2 4565.4 4589.8 5039.7 5145.3 5169.0 4103.4 4190.4 4208.3 4208.3 4216.3 3518.4 3936.9 4089.9 4221.2 4234.0 3444.9 3937.1 4137.5 4151.5 4151.9 3238.3 4131.5 4142.7 4155.9 4159.3 3285.3 3561.6 3610.7 3619.7 3633.8 4408.0 5074.0 5263.6 5294.5 5324.6 4363.4 4754.0 4797.6 4804.6 4809.8 4317.4 5398.3 5779.8 5812.6 5817.1 3854.4 3926.2 3981.1 3982.9 4000.0 5971.3 6003.9 6043.3 6086.4 6089.5 3576.4 3864.6 4057.6 4068.3 4074.9 3367.7 3916.9 4120.3 4141.6 4144.3 4045.0 4595.7 4650.7 4737.6 4782.3 4817.7 5732.9 5797.6 5830.8 5837.9 1284.7 1317.4 1320.8 1327.8 1334.0 789.3 889.5 904.0 911.5 924.6 4858.0 5106.7 5228.6 5230.7 5264.6 5245.0 5671.4 5698.9 5732.7 5798.4 4108.4 4479.7 4632.9 4637.0 5190.5 2710.2 2736.7 2942.0 2948.3 2969.3 5081.4 5217.2 5475.5 5599.2 5846.6 5622.9 5756.9 5793.0 5857.8 5901.4 5544.4 5797.6 5851.0 5907.9 5923.3 4847.5 4994.7 5096.8 5755.0 5777.8 4452.4 5340.9 5541.7 5606.7 5607.7 5866.4 5893.7 5899.0 5899.5 5955.4 3398.6 3625.0 3658.5 3737.4 3863.4 4849.7 5635.8 5653.7 5658.7 5667.4 5233.5 5710.5 5812.6 5841.0 5862.8 5147.8 5530.5 5840.9 5852.6 5870.6 4802.7 5023.8 5390.5 5691.8 5730.4 5803.0 5827.5 5861.4 5868.9 5875.8 4787.4 5551.5 5639.0 5772.6 5797.0 13:59:44 INFO - PROCESS | 1927 | 13:59:44 INFO - PROCESS | 1927 | [#5] yui.html Cycles:180 Average:19895.83 Median:4384.40 stddev:28927.58 (659.8%) stddev-sans-first:28972.56 13:59:44 INFO - PROCESS | 1927 | Values: 629.8 694.9 704.4 752.6 789.4 14120.2 14433.4 14629.7 14815.4 14960.9 13204.4 13434.6 13445.4 13455.8 13499.5 800.5 820.9 823.1 825.1 825.9 644.7 671.5 786.9 808.3 815.4 846.3 847.8 848.8 849.9 851.0 819.9 841.2 842.5 843.6 843.9 625.0 626.8 628.1 628.8 628.9 13546.5 13683.4 13749.4 13756.3 13765.3 13267.3 13448.4 13509.5 13562.0 13638.6 8808.6 10204.4 10494.1 10567.9 10803.8 3549.6 3575.6 3778.4 3780.6 3783.2 84751.6 87705.2 88125.7 90835.5 91119.0 10057.6 10311.7 10506.9 10594.0 10624.0 19824.9 19846.0 19864.7 19865.0 19899.9 7318.5 7408.0 7615.2 7698.9 7856.5 4188.5 4206.4 4292.6 4338.3 4425.7 3229.0 3321.4 3329.2 3332.4 3332.9 602.2 619.9 633.7 635.8 641.6 598.7 609.7 614.7 630.3 630.4 7148.7 7250.4 8826.4 8887.4 9023.4 455.8 554.5 595.5 605.7 626.2 3802.2 3826.7 4277.3 4319.2 4343.1 90216.5 95952.0 105912.9 113168.0 113211.9 88543.6 95936.5 97670.0 98468.0 99182.5 72997.0 73812.3 80101.6 86728.6 88419.0 9357.3 9725.2 9765.3 9807.8 9823.6 49912.5 50097.7 51195.5 51579.7 51930.5 52706.5 66622.3 68701.1 70746.6 72918.0 11317.8 12113.3 12182.7 12359.1 12501.0 10264.1 11324.3 13775.8 13868.7 14669.0 12638.1 13073.2 13088.3 13678.0 13724.5 13164.9 13185.7 13492.9 13739.0 13776.4 12714.8 12878.1 12915.1 13154.2 13528.2 10814.9 11283.6 11375.1 11567.4 11614.7 11269.7 11474.5 11542.8 11570.6 11575.2 13:59:44 INFO - PROCESS | 1927 | -------- Summary: end -------- 13:59:44 INFO - PROCESS | 1927 | 13:59:45 INFO - TEST-INFO | 1927: exit 0 13:59:45 INFO - TEST-OK | dromaeo_css | took 1116185ms 13:59:45 INFO - TEST-START | kraken 13:59:45 INFO - operating with platform_type : mac_ 13:59:45 INFO - Initialising browser for kraken test... 13:59:45 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpesMh8B/profile http://localhost:55652/getInfo.html) 13:59:48 INFO - PROCESS | 1933 | 2016-12-22 13:59:48.279 plugin-container[1934:21822] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.tsm.portname' 13:59:48 INFO - PROCESS | 1933 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:48 INFO - PROCESS | 1933 | 2016-12-22 13:59:48.281 plugin-container[1934:21822] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4507, name = 'com.apple.CFPasteboardClient' 13:59:48 INFO - PROCESS | 1933 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:48 INFO - PROCESS | 1933 | 2016-12-22 13:59:48.281 plugin-container[1934:21822] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:59:48 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 13:59:48 INFO - PROCESS | 1933 | colorDepth:24 13:59:48 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 13:59:48 INFO - PROCESS | 1933 | __metrics 13:59:48 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 13:59:49 INFO - TEST-INFO | 1933: exit 0 13:59:49 INFO - Browser initialized. 13:59:49 INFO - Running cycle 1/1 for kraken test... 13:59:49 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpesMh8B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:51 INFO - PROCESS | 1935 | 2016-12-22 13:59:51.699 plugin-container[1936:21947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 13:59:51 INFO - PROCESS | 1935 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:51 INFO - PROCESS | 1935 | 2016-12-22 13:59:51.700 plugin-container[1936:21947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x842f, name = 'com.apple.CFPasteboardClient' 13:59:51 INFO - PROCESS | 1935 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:51 INFO - PROCESS | 1935 | 2016-12-22 13:59:51.700 plugin-container[1936:21947] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:00:01 INFO - PROCESS | 1935 | RSS: Main: 229634048 14:00:01 INFO - PROCESS | 1935 | 14:00:04 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-beat-detection) 14:00:05 INFO - PROCESS | 1935 | RSS: Main: 241512448 14:00:05 INFO - PROCESS | 1935 | 14:00:08 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-dft) 14:00:08 INFO - PROCESS | 1935 | RSS: Main: 249139200 14:00:08 INFO - PROCESS | 1935 | 14:00:12 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-fft) 14:00:13 INFO - PROCESS | 1935 | RSS: Main: 251588608 14:00:13 INFO - PROCESS | 1935 | 14:00:15 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-oscillator) 14:00:15 INFO - PROCESS | 1935 | RSS: Main: 253575168 14:00:15 INFO - PROCESS | 1935 | 14:00:17 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:00:18 INFO - PROCESS | 1935 | RSS: Main: 253898752 14:00:18 INFO - PROCESS | 1935 | 14:00:21 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-darkroom) 14:00:22 INFO - PROCESS | 1935 | RSS: Main: 258940928 14:00:22 INFO - PROCESS | 1935 | 14:00:25 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-desaturate) 14:00:26 INFO - PROCESS | 1935 | RSS: Main: 257945600 14:00:26 INFO - PROCESS | 1935 | 14:00:29 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55652/tests/kraken/driver.html?testName=json-parse-financial) 14:00:29 INFO - PROCESS | 1935 | RSS: Main: 257912832 14:00:29 INFO - PROCESS | 1935 | 14:00:31 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:00:31 INFO - PROCESS | 1935 | RSS: Main: 257257472 14:00:31 INFO - PROCESS | 1935 | 14:00:33 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:00:34 INFO - PROCESS | 1935 | RSS: Main: 257310720 14:00:34 INFO - PROCESS | 1935 | 14:00:36 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:00:37 INFO - PROCESS | 1935 | RSS: Main: 257347584 14:00:37 INFO - PROCESS | 1935 | 14:00:40 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:00:41 INFO - PROCESS | 1935 | RSS: Main: 257675264 14:00:41 INFO - PROCESS | 1935 | 14:00:44 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:00:44 INFO - PROCESS | 1935 | RSS: Main: 257499136 14:00:44 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55652/tests/kraken/driver.html?testName=ai-astar) 14:00:46 INFO - PROCESS | 1935 | RSS: Main: 260513792 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | __start_tp_report 14:00:46 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 14:00:46 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 14:00:46 INFO - PROCESS | 1935 | |i|pagename|runs| 14:00:46 INFO - PROCESS | 1935 | |0;ai-astar;108;120;171;165;117;128;110;148;106;104 14:00:46 INFO - PROCESS | 1935 | |1;audio-beat-detection;182;108;146;177;129;115;112;124;176;112 14:00:46 INFO - PROCESS | 1935 | |2;audio-dft;272;279;229;289;198;199;274;264;199;195 14:00:46 INFO - PROCESS | 1935 | |3;audio-fft;98;52;63;108;84;82;85;58;79;51 14:00:46 INFO - PROCESS | 1935 | |4;audio-oscillator;108;107;110;70;79;94;85;71;70;90 14:00:46 INFO - PROCESS | 1935 | |5;imaging-gaussian-blur;132;124;107;86;137;134;88;86;87;92 14:00:46 INFO - PROCESS | 1935 | |6;imaging-darkroom;115;130;154;105;157;152;115;93;155;153 14:00:46 INFO - PROCESS | 1935 | |7;imaging-desaturate;88;92;87;88;91;87;91;91;87;87 14:00:46 INFO - PROCESS | 1935 | |8;json-parse-financial;55;59;59;62;62;61;62;70;93;96 14:00:46 INFO - PROCESS | 1935 | |9;json-stringify-tinderbox;70;77;89;77;75;71;70;71;72;74 14:00:46 INFO - PROCESS | 1935 | |10;stanford-crypto-aes;83;87;84;84;86;83;82;86;83;84 14:00:46 INFO - PROCESS | 1935 | |11;stanford-crypto-ccm;159;154;161;142;148;158;161;163;202;144 14:00:46 INFO - PROCESS | 1935 | |12;stanford-crypto-pbkdf2;180;204;235;175;215;159;206;153;236;171 14:00:46 INFO - PROCESS | 1935 | |13;stanford-crypto-sha256-iterative;65;81;63;62;86;87;89;91;70;68 14:00:46 INFO - PROCESS | 1935 | __end_tp_report 14:00:46 INFO - PROCESS | 1935 | __start_cc_report 14:00:46 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,982 14:00:46 INFO - PROCESS | 1935 | __end_cc_report 14:00:46 INFO - PROCESS | 1935 | __startTimestamp1482444046828__endTimestamp 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | ------- Summary: start ------- 14:00:46 INFO - PROCESS | 1935 | Number of tests: 14 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#0] ai-astar Cycles:10 Average:127.70 Median:124.00 stddev:24.91 (20.1%) stddev-sans-first:25.38 14:00:46 INFO - PROCESS | 1935 | Values: 108.0 120.0 171.0 165.0 117.0 128.0 110.0 148.0 106.0 104.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:137.50 stddev:29.86 (21.7%) stddev-sans-first:27.11 14:00:46 INFO - PROCESS | 1935 | Values: 182.0 108.0 146.0 177.0 129.0 115.0 112.0 124.0 176.0 112.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#2] audio-dft Cycles:10 Average:239.80 Median:268.00 stddev:39.37 (14.7%) stddev-sans-first:40.00 14:00:46 INFO - PROCESS | 1935 | Values: 272.0 279.0 229.0 289.0 198.0 199.0 274.0 264.0 199.0 195.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#3] audio-fft Cycles:10 Average:76.00 Median:80.50 stddev:19.41 (24.1%) stddev-sans-first:18.89 14:00:46 INFO - PROCESS | 1935 | Values: 98.0 52.0 63.0 108.0 84.0 82.0 85.0 58.0 79.0 51.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:75.00 stddev:16.02 (21.4%) stddev-sans-first:15.34 14:00:46 INFO - PROCESS | 1935 | Values: 108.0 107.0 110.0 70.0 79.0 94.0 85.0 71.0 70.0 90.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:86.00 stddev:22.14 (25.7%) stddev-sans-first:21.60 14:00:46 INFO - PROCESS | 1935 | Values: 132.0 124.0 107.0 86.0 137.0 134.0 88.0 86.0 87.0 92.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#6] imaging-darkroom Cycles:10 Average:132.90 Median:153.50 stddev:24.27 (15.8%) stddev-sans-first:24.87 14:00:46 INFO - PROCESS | 1935 | Values: 115.0 130.0 154.0 105.0 157.0 152.0 115.0 93.0 155.0 153.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#7] imaging-desaturate Cycles:10 Average:88.90 Median:89.50 stddev:2.08 (2.3%) stddev-sans-first:2.18 14:00:46 INFO - PROCESS | 1935 | Values: 88.0 92.0 87.0 88.0 91.0 87.0 91.0 91.0 87.0 87.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:62.00 stddev:14.53 (23.4%) stddev-sans-first:14.65 14:00:46 INFO - PROCESS | 1935 | Values: 55.0 59.0 59.0 62.0 62.0 61.0 62.0 70.0 93.0 96.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#9] json-stringify-tinderbox Cycles:10 Average:74.60 Median:74.50 stddev:5.72 (7.7%) stddev-sans-first:5.82 14:00:46 INFO - PROCESS | 1935 | Values: 70.0 77.0 89.0 77.0 75.0 71.0 70.0 71.0 72.0 74.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.62 (1.9%) stddev-sans-first:1.66 14:00:46 INFO - PROCESS | 1935 | Values: 83.0 87.0 84.0 84.0 86.0 83.0 82.0 86.0 83.0 84.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#11] stanford-crypto-ccm Cycles:10 Average:159.20 Median:160.00 stddev:16.78 (10.5%) stddev-sans-first:17.80 14:00:46 INFO - PROCESS | 1935 | Values: 159.0 154.0 161.0 142.0 148.0 158.0 161.0 163.0 202.0 144.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:205.00 stddev:30.03 (14.7%) stddev-sans-first:31.46 14:00:46 INFO - PROCESS | 1935 | Values: 180.0 204.0 235.0 175.0 215.0 159.0 206.0 153.0 236.0 171.0 14:00:46 INFO - PROCESS | 1935 | 14:00:46 INFO - PROCESS | 1935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:83.50 stddev:11.67 (14.0%) stddev-sans-first:11.65 14:00:46 INFO - PROCESS | 1935 | Values: 65.0 81.0 63.0 62.0 86.0 87.0 89.0 91.0 70.0 68.0 14:00:46 INFO - PROCESS | 1935 | -------- Summary: end -------- 14:00:46 INFO - PROCESS | 1935 | 14:00:48 INFO - TEST-INFO | 1935: exit 0 14:00:48 INFO - TEST-OK | kraken | took 62715ms 14:00:48 INFO - SUITE-END | took 1178s 14:00:48 INFO - Completed test suite (00:19:39) 14:00:48 INFO - javascript benchmark 14:00:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7022.365433078459, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.550105735725, 3342.0976336389176, 3365.0746044837683, 3369.174552234703, 3378.3918894598964, 5599.832005039851, 5647.265855438793, 5701.572382071351, 5709.4290570942985, 5713.885722285552, 5638.210650508921, 5695.658260504372, 5707.029804933161, 5737.827865164041, 5772.45161709638, 5178.171492561181, 5209.400918894337, 5218.373795144569, 5267.631265811395, 5279.234510995903, 5219.5041471060185, 5267.973660131694, 5281.603879709018, 5307.787688492455, 5355.7857685692525, 4968.205087186069, 5106.285120083191, 5151.716655583941, 5167.689938603677, 5242.397124330712, 5124.769385377667, 5167.974160129175, 5178.1973794061605, 5182.911588566368, 5199.090159222159, 5083.034223497523, 5100.234964755279, 5110.361204849394, 5157.277981082651, 5161.27742116104, 5468.6171967962255, 5676.858078548028, 5705.372409035002, 5751.597388182829, 5769.913451298234, 6141.516692814226, 6174.96912515439, 6178.62928224308, 6209.441150296449, 6229.626222426669, 4786.7845946932475, 5211.530962213419, 5481.095619222823, 6167.722452489604, 6255.906161407583, 4742.596879265232, 5067.341245638044, 5608.046632072557, 5676.829695109153, 5780.479756821906, 6170.136180934673, 6190.535709821781, 6205.565610407319, 6215.223097112861, 6310.873782524323, 5308.92036619451, 5966.761329546856, 6102.69486525672, 6108.5418593605655, 6115.205023346936, 6240.5319601030105, 6246.312905580383, 6250.874982500324, 6271.6550589718, 6273.153124328249, 5474.890502190014, 5653.123765816223, 6024.759009639565, 6083.6349819011, 6139.631622102688, 5636.323641163087, 5766.509846662997, 6171.197744293213, 6210.937890621036, 6265.749370025239, 4856.053069651454, 4871.196252618278, 4880.853574392774, 4904.901901961941, 4962.702237865739, 4352.956470435319, 4376.124775045004, 4380.0, 4385.101054283864, 4425.203463376559, 4438.622717069021, 5838.824835254949, 5858.326292476335, 5864.765409383577, 5914.408559144051, 6270.717817698214, 6273.466755325849, 6275.843103922439, 6291.842703932347, 6296.779612713533, 5683.2895888014, 5740.712964351766, 5762.30852297727, 5806.68063256525, 5830.513219129095, 5381.4349493303425, 5416.377116631559, 5422.349318081855, 5424.674519528762, 5453.209284653703, 6235.563510554218, 6280.623162610258, 6283.811485655255, 6292.496600271876, 6303.779367722108, 6120.632762034292, 6130.601510901777, 6149.477294430024, 6212.81361559154, 6284.968575157095, 6188.783392581238, 6211.3478084802255, 6254.6247225166635, 6269.968650156902, 6277.278113016879, 6190.164327815867, 6199.194104766351, 6199.318075011835, 6203.8138855834395, 6214.378562143749, 6202.751889924352, 6235.314115447207, 6238.75044998195, 6250.718717657625, 6288.874222515616, 5852.502537284378, 5888.646681199141, 5930.614510056833, 6011.368806275278, 6108.72510737009, 5833.125031245348, 5976.701164941648, 5976.880462390641, 5996.220491336098, 6004.0, 4783.736894470838, 5732.742026608729, 5902.852428689317, 5918.378570250062, 6024.789132380346, 6106.056758142859, 6127.5866022601795, 6140.995089002448, 6160.3223645398075, 6166.105914642441, 5969.04495280753, 5987.730552125077, 5993.460588547052, 5993.61041532299, 6021.518278537794], "value": 5626.182535946593, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.00808161432735, 462.58829641618945, 505.4490605240288, 510.6170372220834, 526.4314540296477, 25377.746222537768, 37765.81117094417, 38788.80605596975, 38963.610363896354, 39045.60954390455, 39566.406503902464, 40069.0, 40101.598984010154, 40151.39772903401, 40318.59681403185, 9220.677276295331, 9321.114494123081, 9370.10983956523, 9385.38994965325, 9436.386634868746, 9292.721218363426, 9379.812403751921, 9380.390274632127, 9387.718368448957, 9411.764705882339, 7514.0607424071995, 8449.873251901226, 9361.578728957213, 9407.764805879873, 9440.197583205436, 7837.373010159174, 9327.39371940825, 9334.906650933506, 9402.62389504419, 9414.482203478807, 7787.221277872224, 9310.208632266265, 9314.208292295163, 9317.906820931772, 9362.812743745088, 37607.0, 37844.81077594622, 37882.431763523295, 37913.0, 37913.0, 3209.7111259986714, 3255.186203449138, 3408.386490431721, 3659.670629643318, 3948.2893079245723, 23289.883550582308, 27168.728312716816, 28024.439511209865, 28224.0, 29013.129606111852, 3166.509191075387, 3190.3619276144864, 3191.2341038150907, 3297.0, 3309.4373956427467, 483936.0, 488123.0, 491872.0, 492682.0, 494739.0, 55244.72377638086, 55263.61840953928, 55324.72337638366, 55670.72164639151, 55769.44230557643, 55813.16280255799, 57678.0, 57729.0, 57916.42083579195, 58027.70986145042, 15483.225838708246, 15708.528744137695, 15710.607234819221, 15714.371425143096, 15726.606834829221, 12260.26438413698, 12273.0, 12320.75358492825, 12330.260184388786, 12352.011839052855, 14365.856341436453, 14588.905832062637, 14653.340599672827, 14656.780148297785, 14878.553643390716, 5753.597248192586, 5786.855328616818, 5920.881582368328, 5970.402959703995, 6014.849628759229, 839.4669384940606, 967.2407160379069, 1012.7974405119006, 1028.0336483705294, 1038.6987773545738, 28922.855385722938, 29443.11670649884, 29479.11562653124, 29745.851270743507, 29746.553801692993, 946.9289803264783, 966.4636126949611, 1021.5352014833232, 1031.6286136990677, 1049.7952899184738, 14789.964702470723, 15075.170865602278, 15426.537203883901, 15451.439970078543, 15555.455559055605, 633339.0, 642638.786806063, 644752.0, 647079.0, 647924.0, 49904.0, 51831.48168518267, 54515.0, 54782.630434238665, 55169.44830551723, 1336.7593833109938, 1338.5783478204335, 1363.0526783885302, 1365.9795103073461, 1366.269046060353, 28125.015624453044, 28867.85566072156, 28900.843966241115, 29080.56379154272, 29418.852905735333, 46340.0, 46844.531554684014, 46928.765356173004, 47148.528514715785, 47173.76413117912, 539963.0, 542693.0, 542741.286293566, 543545.0, 544490.2775486256, 25511.0, 25863.353416164748, 25883.482330352912, 25885.835137418486, 25921.611175832, 43565.346519802864, 44276.0, 44417.777911110235, 44829.32756008728, 45093.09813803771, 36846.44730328993, 37134.0, 37177.67440930968, 37228.69699560502, 38071.809640951615, 33391.99824005284, 37028.81485592663, 37800.243995120494, 38007.04982375463, 38044.61955380411, 35157.76947806814, 35177.296454071286, 35362.646373535936, 35801.46297805483, 36147.0, 25433.745662543137, 28475.145745627666, 31834.044978650676, 32918.61739217072, 33116.668833311356, 24652.0, 24653.50692986166, 24830.751692483565, 25047.49905001926, 25087.12195073164], "value": 18874.537047523427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.46468453447676, 361.4939085280607, 363.18283861312045, 370.9239605880794, 374.61040517861426, 18006.90996545017, 18524.259029638815, 19520.70718939217, 19521.707174392395, 19754.802451975513, 14384.784228236585, 19097.427077187705, 19129.713054304197, 19391.321303754372, 20183.19267229309, 5455.236266922624, 5810.738516766755, 5811.215485909391, 5815.447532484428, 5821.621594596359, 5572.219889215513, 5684.54523638108, 5846.64920104793, 5914.467697907187, 5982.970085149568, 5909.852253693649, 5952.613080149777, 5958.8808223835495, 5966.224390829208, 5974.163617093611, 5652.434756524335, 5683.175939488771, 5874.089516124986, 5898.970505147489, 5913.2608423947, 5458.972705136449, 5662.971685141589, 5719.056355701305, 5735.913961290584, 5742.483176514133, 12857.935710321482, 12910.612681619567, 13064.542741004114, 13119.47522099115, 13127.409266583027, 2037.8165965063215, 2152.601768672785, 2438.829281950264, 2732.945341093187, 2924.4443555724556, 9744.90255097454, 10106.44414557199, 10164.4917754112, 10237.641682541076, 14474.638134046627, 1806.7380229866726, 1807.493901707524, 1853.6570734414177, 1865.9160337784833, 1926.807319268076, 114113.0, 119673.0, 119962.40018799937, 120727.3963630185, 121281.0, 11507.71230719222, 11701.414929253504, 11705.239159454608, 11760.941195293968, 11897.524099035942, 14597.489087882086, 14607.78088328676, 14621.92689036548, 14631.707365852624, 14644.414223431157, 8352.791180220544, 8410.537420441811, 8427.199416055464, 8452.788680283042, 8558.700445484503, 8218.931538900024, 8229.094799572042, 8266.628001739937, 8362.958185209034, 8393.160683931681, 4442.200403927324, 4481.103779244099, 4490.708103973231, 4526.7510286933875, 4567.634589232854, 1872.0437143185404, 1912.1165651833212, 1912.9340312462507, 1918.0505649703487, 1918.2710569983597, 798.6406117247262, 825.405707890318, 912.1790388650268, 928.2713070239829, 990.3562684255292, 20113.39659810208, 20659.0, 20865.69146943824, 20886.89556552238, 21203.575928481343, 856.1823458597025, 926.4950601921969, 943.5706753427174, 946.2666433514082, 949.9620015199315, 8739.563021848882, 10235.948820256, 10697.679069627924, 10859.565617375374, 11135.888641113646, 555658.0, 622733.0, 629262.7073729296, 632734.0, 635362.0, 107152.0, 110332.4483377594, 127717.0, 146328.0, 146523.0, 955.3217215776738, 971.2521358554015, 991.4101109839634, 994.2443742755557, 996.267743208741, 18295.71929964943, 18420.171092301145, 18609.720854187468, 18641.347552835585, 18676.906615466836, 49144.75427622839, 53463.59413826465, 55381.0, 56142.0, 56883.71558142183, 66500.33499665135, 76950.0, 83892.16107838844, 86448.135518644, 86638.0, 7076.469264805057, 7401.8149546261775, 7654.693812247448, 8065.87901181471, 8072.031356237289, 11759.706007349885, 12649.93675031619, 12666.303353315656, 12702.809457858324, 12761.361931903553, 9232.399894006869, 10552.366857988545, 10581.418022008864, 10871.347719136877, 11050.889491104987, 9052.230560402177, 10279.17766578657, 10776.67669969902, 10913.727156821144, 10933.45332733376, 10689.51897164645, 10783.6225732099, 11013.449327533752, 11054.281471704313, 11097.445127743742, 6522.34776522344, 7194.388476979515, 7263.201047884623, 7418.888716669147, 7643.235676432312, 8823.602937867683, 10779.784404311713, 10869.0, 10937.890621093688, 10946.288491248044], "value": 9256.87992171286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.203696763458, 1458.4020551573853, 1615.1116885712854, 1756.4554987953743, 1803.2967142814305, 7347.559146451204, 7651.502652327595, 7883.0, 8333.166683331663, 8364.289035431988, 7825.256600622946, 8127.796805079876, 8146.2261085196815, 8227.300679442254, 8230.46501977371, 2251.6735073414343, 2277.954440911181, 2287.7025986621716, 2290.5189910118893, 2292.3466811958597, 2270.489139943516, 2290.713660792401, 2306.6194077977116, 2317.1079134533243, 2324.1168356024687, 1900.5248687828043, 2230.877301748403, 2245.921392751254, 2247.78646028627, 2248.516568937678, 2235.8099561537288, 2242.383344580237, 2256.9887150564223, 2263.513344630896, 2266.2181547366213, 2266.7166604174477, 2288.439332363565, 2289.9198528051606, 2291.2667946257206, 2296.5062511560095, 8064.5161290322185, 8233.723772815223, 8238.176182381714, 8241.917580824174, 8244.340452763765, 4891.168501354743, 5038.445770965228, 5042.495750424928, 5047.520485553867, 5059.671121377136, 3208.711215990572, 3258.983705081483, 3441.913952151216, 3453.4647129694936, 3459.6713312235297, 972.8832540095163, 978.3542861711236, 985.2167526816127, 1084.8535447714614, 1086.7337502311984, 10143.34068285559, 10359.27485076045, 10466.215033872413, 10653.627123050655, 10739.248252622241, 4200.768957707294, 4210.242156411875, 4360.869173924787, 4364.498082720528, 4364.694471387036, 8374.371922105867, 8520.616572254263, 8523.190296921783, 8544.444611100384, 8549.786255343666, 4988.775505102279, 4991.80032798684, 4997.475265097185, 4999.975000125049, 5014.874628134326, 3505.9298814023578, 3973.443717879499, 4639.396878405786, 4703.976480117578, 4719.858404247878, 2850.3159241782237, 2946.2487065798514, 3643.1620727232885, 3657.049167216543, 3657.4513822926774, 947.2989987409268, 1108.3626914524182, 1129.949152288149, 1132.7394699219226, 1143.7826812905687, 729.8722723523363, 759.2293821770907, 884.7964968057254, 885.2298500304776, 886.2201262888746, 5197.792088316425, 5228.6339956203465, 5324.713605547494, 5449.373322067933, 5489.4236105209175, 382.3824523394753, 397.4915196827987, 438.7784168994637, 450.182918003822, 450.2233646959035, 3476.60019097807, 3597.1366871950545, 3621.855125794939, 3650.2152037312107, 3714.294284086015, 9559.856602150974, 9813.705588832347, 9929.2056635469, 9952.751181220527, 9968.950155249177, 9840.065193806577, 9904.158146557624, 9921.107100361001, 9930.30487865857, 9939.602415903282, 7206.783796486114, 7501.512401693873, 7715.344195743424, 7741.109772376249, 7741.961290193625, 5269.1832765921345, 5276.894462110659, 5285.471452854684, 5471.206675032177, 5503.284573005644, 9147.77130571741, 9156.771080723036, 9185.081491850762, 9242.0, 9275.21160701348, 9090.363674542983, 9269.490178040272, 9296.58165382573, 9419.0, 9423.623055077995, 6140.754369825157, 6351.523635727432, 6519.869602607826, 6635.0710900473005, 6641.369069938348, 6139.693015349304, 7710.421718371257, 7752.961235193788, 7810.609469526387, 7822.960885195537, 6940.583564986117, 7087.114110736158, 7097.467689923174, 7104.3961263293195, 7110.4667149962925, 6886.758963436256, 6966.1988871280455, 6966.616836074065, 6984.685689143899, 6989.930100698928, 6389.361063893573, 6447.161868957006, 6535.738570457319, 6540.345965403421, 6557.442617377385, 3861.362875125573, 4635.466921304093, 4720.409948756405, 4738.620910327097, 4740.762961851962, 4635.188841952712, 4722.693024953367, 4835.443923948791, 4878.268259761065, 4984.551390374883], "value": 4162.712458895194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.99544129736194, 298.9925251868704, 305.4745837160084, 309.3071519795658, 312.6279727124721, 4658.301254811771, 5407.83776486705, 5507.779688812448, 5507.807226747064, 5562.217691969459, 4565.429321334833, 4589.829593453673, 5039.72281524516, 5145.305383773199, 5168.974155129228, 4103.405006274089, 4190.413342132104, 4208.263553878059, 4208.263553878074, 4216.3464662977285, 3518.36669399508, 3936.881893543184, 4089.9182016359805, 4221.24017676818, 4233.957660423387, 3444.9483257751153, 3937.0944682722993, 4137.462129923121, 4151.467604761094, 4151.875443736692, 3238.303764690591, 4131.52487463941, 4142.730722503027, 4155.854545090938, 4159.313713237312, 3285.293661862711, 3561.6438356164435, 3610.6640542999257, 3619.65182206458, 3633.818309084562, 4407.955920440787, 5074.035933172722, 5263.552598029172, 5294.52349288562, 5324.600654950894, 4363.432753742025, 4754.0, 4797.568218860284, 4804.591609713144, 4809.807607695688, 4317.438732964726, 5398.325209348832, 5779.768809247625, 5812.622179558315, 5817.127430885359, 3854.4218367244857, 3926.2343842950636, 3981.064449854282, 3982.8605998789903, 4000.0399904023116, 5971.253593300838, 6003.909941350883, 6043.335233124353, 6086.421789929949, 6089.543284253655, 3576.4071048490155, 3864.632859878307, 4057.594240575978, 4068.267711811843, 4074.898127546835, 3367.6800703933086, 3916.8629097981434, 4120.340745480708, 4141.585841415895, 4144.274751918402, 4045.0, 4595.724256544618, 4650.651201159926, 4737.620990320766, 4782.33047373368, 4817.686850354716, 5732.914006289909, 5797.594168408255, 5830.795922142789, 5837.883242335214, 1284.7173621803188, 1317.3993597778745, 1320.8018797180307, 1327.7784438316771, 1334.0194956706812, 789.3448437796615, 889.5463313710054, 903.978504290148, 911.5305617606938, 924.5885580916428, 4858.036597675416, 5106.744662766847, 5228.607854410934, 5230.744621290939, 5264.578833693296, 5244.9737751310995, 5671.376148623648, 5698.94569504643, 5732.656040637575, 5798.449147330997, 4108.4453598764385, 4479.70881892676, 4632.884177895579, 4636.976815115903, 5190.455002224788, 2710.227585138226, 2736.65791776028, 2942.014140455184, 2948.3071478202605, 2969.2576855786056, 5081.426715955596, 5217.217417387346, 5475.4524547544925, 5599.220526144917, 5846.619969701956, 5622.85942851432, 5756.942430575725, 5792.972459639177, 5857.7949771757785, 5901.380355062743, 5544.417836127229, 5797.565182611405, 5851.04522216278, 5907.911381329283, 5923.318818335946, 4847.5394837490385, 4994.725290109079, 5096.847094587169, 5754.992876246556, 5777.768889244383, 4452.438049560274, 5340.919886201632, 5541.695206763667, 5606.710456595088, 5607.747651355618, 5866.354700982974, 5893.675847828239, 5899.0, 5899.528037756883, 5955.3920441479695, 3398.6091599466376, 3625.021244264087, 3658.5243918291517, 3737.3646480097905, 3863.420486926871, 4849.684770489906, 5635.830925072254, 5653.717314134195, 5658.745356459051, 5667.376588575171, 5233.476652334736, 5710.543156547549, 5812.6049748061005, 5841.036229022164, 5862.7654893805475, 5147.819826306061, 5530.534408381863, 5840.912386314124, 5852.619579727304, 5870.647761134345, 4802.711837289774, 5023.794289370598, 5390.460953904578, 5691.77232910679, 5730.369659337386, 5803.0, 5827.504662103769, 5861.384554621874, 5868.911966320423, 5875.794347197999, 4787.4494433140635, 5551.472610102034, 5638.971805141112, 5772.567057470623, 5797.0], "value": 4117.903380325821, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.8079085878807, 694.8957656351547, 704.3625518905393, 752.6377257164532, 789.388224126302, 14120.152790832544, 14433.422663093465, 14629.70740585189, 14815.407383704653, 14960.925195374035, 13204.405801738922, 13434.59696209113, 13445.394957226923, 13455.798163027537, 13499.460021599149, 800.5116878703986, 820.938429617781, 823.0822632764484, 825.1377310710292, 825.8761185822144, 644.6679959820696, 671.4628297362091, 786.9488483248599, 808.3331251717327, 815.388458656008, 846.2975730143966, 847.7753395350237, 848.753861380199, 849.9107593702633, 851.0425771007616, 819.9262066414051, 841.1672444280149, 842.5366048673236, 843.5992903370911, 843.9156084391573, 624.9562530622858, 626.8401557602828, 628.0673200297555, 628.779927025542, 628.9433950944391, 13546.525871594447, 13683.384247708877, 13749.381277842522, 13756.312184390741, 13765.311734413339, 13267.336633168303, 13448.394822233024, 13509.459621615124, 13561.982851286193, 13638.567950365266, 8808.64765409383, 10204.438755868425, 10494.108000819939, 10567.894321056769, 10803.83794243087, 3549.574051113857, 3575.6424357564297, 3778.376567866299, 3780.584135745066, 3783.2244389900006, 84751.57624211902, 87705.24589508238, 88125.6781148277, 90835.54582227046, 91118.99999999933, 10057.597696092074, 10311.742206444898, 10506.947465262625, 10594.046535811814, 10624.001270433648, 19824.909629970203, 19846.007699614962, 19864.70202946957, 19865.0, 19899.900500497406, 7318.487705860539, 7408.0, 7615.16233214346, 7698.923010769932, 7856.45004849655, 4188.518320393194, 4206.41110244566, 4292.635126014324, 4338.305871060616, 4425.712328698624, 3229.0474310078584, 3321.4353559894876, 3329.217633856042, 3332.3668502984356, 3332.8666853325594, 602.2471910112359, 619.9225096862892, 633.7274971762187, 635.8430393098289, 641.6022066318819, 598.6826981699706, 609.6890585801185, 614.7356636646196, 630.3003665930813, 630.3565392034051, 7148.678309476086, 7250.383717383976, 8826.42628229163, 8887.433775819969, 9023.4134781239, 455.77851358359914, 554.4621716934647, 595.5295316699759, 605.748614325059, 626.1671976271548, 3802.2015376771187, 3826.6556009959236, 4277.315629499328, 4319.179355922364, 4343.087951530151, 90216.54891725631, 95952.0, 105912.94087059185, 113168.0, 113211.86788132013, 88543.55728221318, 95936.52031739797, 97670.0, 98468.01531984731, 99182.51226231613, 72997.0, 73812.2618773816, 80101.599492001, 86728.56635716782, 88419.0, 9357.344985850925, 9725.24945509815, 9765.316427849983, 9807.754806129618, 9823.607055717692, 49912.500874992234, 50097.747556311384, 51195.48804512056, 51579.74210128925, 51930.48069519408, 52706.472935270154, 66622.33377666162, 68701.07284695619, 70746.58506829938, 72918.0, 11317.773644527228, 12113.273203607812, 12182.695432614255, 12359.073069519642, 12500.999920006196, 10264.076233139054, 11324.263922844988, 13775.793363099361, 13868.722625547634, 14669.0, 12638.115331927045, 13073.215607063607, 13088.345582721016, 13678.0, 13724.45102195901, 13164.934175329063, 13185.736285274432, 13492.86507134916, 13739.0, 13776.380062897395, 12714.809277860655, 12878.098533102593, 12915.095943284256, 13154.21074735519, 13528.188308701509, 10814.945925270324, 11283.605073822377, 11375.1468639854, 11567.363794991355, 11614.709632258922, 11269.71825704364, 11474.464170272217, 11542.769144617228, 11570.595029174276, 11575.189736718348], "value": 7116.170935586297, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1654.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 120.0, 171.0, 165.0, 117.0, 128.0, 110.0, 148.0, 106.0, 104.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 108.0, 146.0, 177.0, 129.0, 115.0, 112.0, 124.0, 176.0, 112.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [272.0, 279.0, 229.0, 289.0, 198.0, 199.0, 274.0, 264.0, 199.0, 195.0], "value": 239.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 52.0, 63.0, 108.0, 84.0, 82.0, 85.0, 58.0, 79.0, 51.0], "value": 76.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 110.0, 70.0, 79.0, 94.0, 85.0, 71.0, 70.0, 90.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 124.0, 107.0, 86.0, 137.0, 134.0, 88.0, 86.0, 87.0, 92.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 130.0, 154.0, 105.0, 157.0, 152.0, 115.0, 93.0, 155.0, 153.0], "value": 132.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 87.0, 88.0, 91.0, 87.0, 91.0, 91.0, 87.0, 87.0], "value": 88.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 59.0, 62.0, 62.0, 61.0, 62.0, 70.0, 93.0, 96.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 89.0, 77.0, 75.0, 71.0, 70.0, 71.0, 72.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 84.0, 84.0, 86.0, 83.0, 82.0, 86.0, 83.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 161.0, 142.0, 148.0, 158.0, 161.0, 163.0, 202.0, 144.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 204.0, 235.0, 175.0, 215.0, 159.0, 206.0, 153.0, 236.0, 171.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 81.0, 63.0, 62.0, 86.0, 87.0, 89.0, 91.0, 70.0, 68.0], "value": 76.2, "unit": "score"}]}]} 14:00:48 INFO - Return code: 0 14:00:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:00:48 ERROR - # TBPL SUCCESS # 14:00:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:00:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:00:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:00:48 INFO - 2016-12-22 14:00:48.672 screenresolution[1940:22333] starting screenresolution argv=screenresolution get 14:00:48 INFO - 2016-12-22 14:00:48.674 screenresolution[1940:22333] Display 0: 1600x1200x32@60 14:00:48 INFO - 2016-12-22 14:00:48.680 screenresolution[1941:22336] starting screenresolution argv=screenresolution list 14:00:48 INFO - Available Modes on Display 0 14:00:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:00:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:00:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:00:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:00:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:00:48 INFO - Intel Iris: 14:00:48 INFO - Chipset Model: Intel Iris 14:00:48 INFO - Type: GPU 14:00:48 INFO - Bus: Built-In 14:00:48 INFO - VRAM (Dynamic, Max): 1536 MB 14:00:48 INFO - Vendor: Intel (0x8086) 14:00:48 INFO - Device ID: 0x0a2e 14:00:48 INFO - Revision ID: 0x0009 14:00:48 INFO - Displays: 14:00:48 INFO - Display: 14:00:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:00:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:00:48 INFO - Display Serial Number: 1600x1200 60 14:00:48 INFO - Main Display: Yes 14:00:48 INFO - Mirror: Off 14:00:48 INFO - Online: Yes 14:00:48 INFO - Rotation: Supported 14:00:48 INFO - Return code: 0 14:00:48 INFO - Running post-action listener: _resource_record_post_action 14:00:48 INFO - [mozharness: 2016-12-22 22:00:48.915093Z] Finished run-tests step (success) 14:00:48 INFO - Running post-run listener: _resource_record_post_run 14:00:48 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 991232; Write bytes: 658524160; Read time: 15; Write time: 1815 14:00:48 INFO - TinderboxPrint: CPU usage
54.5% 14:00:48 INFO - TinderboxPrint: I/O read bytes / time
991,232 / 15 14:00:48 INFO - TinderboxPrint: I/O write bytes / time
658,524,160 / 1,815 14:00:48 INFO - TinderboxPrint: CPU idle
2,205.2 (45.5%) 14:00:48 INFO - TinderboxPrint: CPU system
982.8 (20.3%) 14:00:48 INFO - TinderboxPrint: CPU user
1,657.8 (34.2%) 14:00:48 INFO - TinderboxPrint: Swap in / out
350,048,256 / 0 14:00:48 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 345739776; Write bytes: 345630720; Read time: 26768; Write time: 662 14:00:48 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 954368; Write bytes: 305688576; Read time: 15; Write time: 1122 14:00:49 INFO - Running post-run listener: _upload_blobber_files 14:00:49 INFO - Blob upload gear active. 14:00:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:00:49 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 14:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:00:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:00:51 INFO - (blobuploader) - INFO - Done attempting. 14:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:00:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:00:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:00:52 INFO - (blobuploader) - INFO - Done attempting. 14:00:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:00:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:00:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:00:55 INFO - (blobuploader) - INFO - Done attempting. 14:00:55 INFO - (blobuploader) - INFO - Iteration through files over. 14:00:55 INFO - Return code: 0 14:00:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:00:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:00:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/315142722f4b047d743cbcd801d60f0282617449a8a6dbb460d630fadd24cb6bd3f1372acbc7d64063ae5bb8741930559fbc746a8ae5c60e5f377fbe0e98cc8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207ca8828822409f5119801a81655117a3e6fcac33e9be6f7c8f45a80864801f1c2f05b737a96d8e90b00189fc1493ecaabc6d1225354d6634b2f4bc2a024d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7083f3d0b74c862c4bf783fbdecc59478f636ac5205eb4ed0ba810e8e4f91400a7ebc4a40e120238b6fdc78da2f19ecbeb215cad1e4c490f444f7a721142f5b"} 14:00:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:00:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:00:55 INFO - Contents: 14:00:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/315142722f4b047d743cbcd801d60f0282617449a8a6dbb460d630fadd24cb6bd3f1372acbc7d64063ae5bb8741930559fbc746a8ae5c60e5f377fbe0e98cc8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207ca8828822409f5119801a81655117a3e6fcac33e9be6f7c8f45a80864801f1c2f05b737a96d8e90b00189fc1493ecaabc6d1225354d6634b2f4bc2a024d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7083f3d0b74c862c4bf783fbdecc59478f636ac5205eb4ed0ba810e8e4f91400a7ebc4a40e120238b6fdc78da2f19ecbeb215cad1e4c490f444f7a721142f5b"} 14:00:55 INFO - Running post-run listener: copy_logs_to_upload_dir 14:00:55 INFO - Copying logs to upload dir... 14:00:55 INFO - mkdir: /builds/slave/test/build/upload/logs 14:00:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.066607 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-22 14:00:55.228985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 14:00:55.233139) ========= 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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/315142722f4b047d743cbcd801d60f0282617449a8a6dbb460d630fadd24cb6bd3f1372acbc7d64063ae5bb8741930559fbc746a8ae5c60e5f377fbe0e98cc8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207ca8828822409f5119801a81655117a3e6fcac33e9be6f7c8f45a80864801f1c2f05b737a96d8e90b00189fc1493ecaabc6d1225354d6634b2f4bc2a024d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7083f3d0b74c862c4bf783fbdecc59478f636ac5205eb4ed0ba810e8e4f91400a7ebc4a40e120238b6fdc78da2f19ecbeb215cad1e4c490f444f7a721142f5b"} build_url:https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/E8SNTR8OTNWmIo-pgrrSMA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/315142722f4b047d743cbcd801d60f0282617449a8a6dbb460d630fadd24cb6bd3f1372acbc7d64063ae5bb8741930559fbc746a8ae5c60e5f377fbe0e98cc8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/207ca8828822409f5119801a81655117a3e6fcac33e9be6f7c8f45a80864801f1c2f05b737a96d8e90b00189fc1493ecaabc6d1225354d6634b2f4bc2a024d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7083f3d0b74c862c4bf783fbdecc59478f636ac5205eb4ed0ba810e8e4f91400a7ebc4a40e120238b6fdc78da2f19ecbeb215cad1e4c490f444f7a721142f5b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 14:00:55.268339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 14:00:55.268748) ========= 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.jRSlz9Nzpp/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.NKpsP6o9ib/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005248 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 14:00:55.319543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 14:00:55.319864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 14:00:55.320216) ========= ========= Total master_lag: 0.20 =========