builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0075 starttime: 1482357033.89 results: success (0) buildid: 20161221115353 builduid: 334bffdba84d4cd8965af2712ba8ac0f revision: d43a5a11c195d12ca3a3179855a6b50a05583311 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:33.885453) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:33.885870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:33.886188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:33.912745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:33.913129) ========= 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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-21 13:50:33-- 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% 34.6M=0s 2016-12-21 13:50:34 (34.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:34.019815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:34.020143) ========= 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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.027070 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:34.071329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 13:50:34.071695) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d43a5a11c195d12ca3a3179855a6b50a05583311 --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 d43a5a11c195d12ca3a3179855a6b50a05583311 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lF8V0YVhcP/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.0fCUnSXOsc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-21 13:50:34,166 truncating revision to first 12 chars 2016-12-21 13:50:34,166 Setting DEBUG logging. 2016-12-21 13:50:34,166 attempt 1/10 2016-12-21 13:50:34,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d43a5a11c195?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 13:50:35,859 unpacking tar archive at: mozilla-aurora-d43a5a11c195/testing/mozharness/ program finished with exit code 0 elapsedTime=1.964291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 13:50:36.059544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:36.059860) ========= script_repo_revision: d43a5a11c195d12ca3a3179855a6b50a05583311 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:36.060237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:36.060502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:36.080356) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-21 13:50:36.080771) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:50:36 INFO - MultiFileLogger online at 20161221 13:50:36 in /builds/slave/test 13:50:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:50:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:36 INFO - {'append_to_log': False, 13:50:36 INFO - 'base_work_dir': '/builds/slave/test', 13:50:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:50:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:36 INFO - 'branch': 'Mozilla-Aurora', 13:50:36 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:36 INFO - 'config_files': ('talos/mac_config.py',), 13:50:36 INFO - 'default_actions': ('clobber', 13:50:36 INFO - 'read-buildbot-config', 13:50:36 INFO - 'download-and-extract', 13:50:36 INFO - 'populate-webroot', 13:50:36 INFO - 'create-virtualenv', 13:50:36 INFO - 'install', 13:50:36 INFO - 'run-tests'), 13:50:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:36 INFO - 'download_minidump_stackwalk': True, 13:50:36 INFO - 'download_symbols': 'ondemand', 13:50:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:36 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:36 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:36 INFO - 'installer_path': 'installer.exe', 13:50:36 INFO - 'log_level': 'info', 13:50:36 INFO - 'log_name': 'talos', 13:50:36 INFO - 'log_to_console': True, 13:50:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:36 INFO - 'opt_config_files': (), 13:50:36 INFO - 'pip_index': False, 13:50:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:36 INFO - 'cmd': ('bash', 13:50:36 INFO - '-c', 13:50:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:36 INFO - 'enabled': True, 13:50:36 INFO - 'halt_on_failure': False, 13:50:36 INFO - 'name': 'check_screen_resolution'},), 13:50:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:36 INFO - 'cmd': ('bash', 13:50:36 INFO - '-c', 13:50:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:36 INFO - 'enabled': True, 13:50:36 INFO - 'halt_on_failure': False, 13:50:36 INFO - 'name': 'check_screen_resolution'},), 13:50:36 INFO - 'run_cmd_checks_enabled': True, 13:50:36 INFO - 'sps_profile': False, 13:50:36 INFO - 'sps_profile_interval': 0, 13:50:36 INFO - 'suite': 'dromaeojs', 13:50:36 INFO - 'system_bits': '32', 13:50:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:36 INFO - 'title': 't-yosemite-r7-0075', 13:50:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:36 INFO - 'use_talos_json': True, 13:50:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:36 INFO - 'work_dir': 'build'} 13:50:36 INFO - [mozharness: 2016-12-21 21:50:36.289470Z] Running clobber step. 13:50:36 INFO - Running pre-action listener: _resource_record_pre_action 13:50:36 INFO - Running main action method: clobber 13:50:36 INFO - rmtree: /builds/slave/test/build 13:50:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:38 INFO - Running post-action listener: _resource_record_post_action 13:50:38 INFO - [mozharness: 2016-12-21 21:50:38.644321Z] Finished clobber step (success) 13:50:38 INFO - [mozharness: 2016-12-21 21:50:38.644484Z] Running read-buildbot-config step. 13:50:38 INFO - Running pre-action listener: _resource_record_pre_action 13:50:38 INFO - Running main action method: read_buildbot_config 13:50:38 INFO - Using buildbot properties: 13:50:38 INFO - { 13:50:38 INFO - "project": "", 13:50:38 INFO - "product": "firefox", 13:50:38 INFO - "script_repo_revision": "production", 13:50:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:50:38 INFO - "repository": "", 13:50:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:50:38 INFO - "buildid": "20161221115353", 13:50:38 INFO - "pgo_build": "False", 13:50:38 INFO - "basedir": "/builds/slave/test", 13:50:38 INFO - "buildnumber": 23, 13:50:38 INFO - "slavename": "t-yosemite-r7-0075", 13:50:38 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:50:38 INFO - "platform": "yosemite_r7", 13:50:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:50:38 INFO - "branch": "mozilla-aurora", 13:50:38 INFO - "repo_path": "releases/mozilla-aurora", 13:50:38 INFO - "revision": "d43a5a11c195d12ca3a3179855a6b50a05583311", 13:50:38 INFO - "stage_platform": "macosx64", 13:50:38 INFO - "builduid": "334bffdba84d4cd8965af2712ba8ac0f", 13:50:38 INFO - "slavebuilddir": "test" 13:50:38 INFO - } 13:50:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 13:50:38 INFO - Running post-action listener: _resource_record_post_action 13:50:38 INFO - [mozharness: 2016-12-21 21:50:38.650110Z] Finished read-buildbot-config step (success) 13:50:38 INFO - [mozharness: 2016-12-21 21:50:38.650286Z] Running download-and-extract step. 13:50:38 INFO - Running pre-action listener: _resource_record_pre_action 13:50:38 INFO - Running main action method: download_and_extract 13:50:38 INFO - mkdir: /builds/slave/test/build/tests 13:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:38 INFO - trying https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/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:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/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:50:39 INFO - Downloaded 1199 bytes. 13:50:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:39 INFO - Using the following test package requirements: 13:50:39 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:50:39 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 13:50:39 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 13:50:39 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'jsshell-mac.zip'], 13:50:39 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 13:50:39 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:50:39 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 13:50:39 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 13:50:39 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 13:50:39 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:39 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 13:50:39 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:50:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:50:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:50:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:50:39 INFO - Http code: 200 13:50:39 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 13:50:39 INFO - x-amz-cf-id: GXWGCOoz_Fn9A4-AcPgWKtfu6AefJ2mmvDZr2N2Zs_WBdxm-vDEh6A== 13:50:39 INFO - x-amz-version-id: gSEvYMJ_KBl2Lst8J3.SJ5w1txR4vlfX 13:50:40 INFO - Expected file size: 16269587 13:50:40 INFO - Obtained file size: 16269587 13:50:46 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:50:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:50:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:50:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:50:47 INFO - Http code: 200 13:50:47 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 13:50:47 INFO - x-amz-cf-id: 9pft5p2kHRYSUXYrf7YWSSTNGXH3zawfqsB96Uoey6znLrEhiSRsEQ== 13:50:47 INFO - x-amz-version-id: gSEvYMJ_KBl2Lst8J3.SJ5w1txR4vlfX 13:50:47 INFO - Expected file size: 16269587 13:50:47 INFO - Obtained file size: 16269587 13:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 13:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 13:50:55 INFO - Http code: 200 13:50:55 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 13:50:55 INFO - x-amz-cf-id: 8LRTVtBKfwZ6t1wmOCC4Yf1IUiNfFOxE1rxa-Stag_z0TemjFCtClw== 13:50:55 INFO - x-amz-version-id: xl1WapBsMA7q64M_g1IN7eokAPdx7EaX 13:50:56 INFO - Expected file size: 14409038 13:50:56 INFO - Obtained file size: 14409038 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - trying https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 13:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/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:51:01 INFO - Downloaded 109757866 bytes. 13:51:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:51:01 INFO - mkdir: /builds/slave/test/properties 13:51:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:01 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:01 INFO - Contents: 13:51:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:51:02 INFO - Running post-action listener: _resource_record_post_action 13:51:02 INFO - Running post-action listener: set_extra_try_arguments 13:51:02 INFO - [mozharness: 2016-12-21 21:51:02.323567Z] Finished download-and-extract step (success) 13:51:02 INFO - [mozharness: 2016-12-21 21:51:02.323722Z] Running populate-webroot step. 13:51:02 INFO - Running pre-action listener: _resource_record_pre_action 13:51:02 INFO - Running main action method: populate_webroot 13:51:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:02 INFO - '--tppagecycles', 13:51:02 INFO - '7'], 13:51:02 INFO - 'tests': ['tsvgm']}}, 13:51:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['damp', 'tps']}, 13:51:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'tests': ['damp', 'tps']}, 13:51:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['dromaeo_dom']}, 13:51:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['basic_compositor_video']}, 13:51:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['a11yr', 13:51:02 INFO - 'ts_paint', 13:51:02 INFO - 'tpaint', 13:51:02 INFO - 'sessionrestore', 13:51:02 INFO - 'sessionrestore_no_auto_restore', 13:51:02 INFO - 'tabpaint']}, 13:51:02 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:02 INFO - 'ts_paint', 13:51:02 INFO - 'tpaint', 13:51:02 INFO - 'sessionrestore', 13:51:02 INFO - 'sessionrestore_no_auto_restore', 13:51:02 INFO - 'tabpaint']}, 13:51:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:02 INFO - 'ts_paint', 13:51:02 INFO - 'tpaint', 13:51:02 INFO - 'sessionrestore', 13:51:02 INFO - 'sessionrestore_no_auto_restore', 13:51:02 INFO - 'tabpaint']}, 13:51:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:02 INFO - 'ts_paint', 13:51:02 INFO - 'tpaint', 13:51:02 INFO - 'sessionrestore', 13:51:02 INFO - 'sessionrestore_no_auto_restore', 13:51:02 INFO - 'tabpaint']}, 13:51:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['a11yr', 13:51:02 INFO - 'ts_paint', 13:51:02 INFO - 'tpaint', 13:51:02 INFO - 'sessionrestore', 13:51:02 INFO - 'sessionrestore_no_auto_restore', 13:51:02 INFO - 'tabpaint']}, 13:51:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['a11yr', 13:51:02 INFO - 'ts_paint', 13:51:02 INFO - 'tpaint', 13:51:02 INFO - 'sessionrestore', 13:51:02 INFO - 'sessionrestore_no_auto_restore', 13:51:02 INFO - 'tabpaint']}, 13:51:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['tsvgx', 13:51:02 INFO - 'tsvgr_opacity', 13:51:02 INFO - 'tart', 13:51:02 INFO - 'tscrollx', 13:51:02 INFO - 'cart']}, 13:51:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:02 INFO - 'tsvgr_opacity', 13:51:02 INFO - 'tart', 13:51:02 INFO - 'tscrollx', 13:51:02 INFO - 'cart']}, 13:51:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'talos_options': ['--disable-e10s'], 13:51:02 INFO - 'tests': ['tp5o']}, 13:51:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'tests': ['tp5o']}, 13:51:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'talos_options': ['--disable-e10s', 13:51:02 INFO - '--xperf_path', 13:51:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:02 INFO - 'tests': ['tp5n']}, 13:51:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:02 INFO - 'talos_options': ['--xperf_path', 13:51:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:02 INFO - 'tests': ['tp5n']}}, 13:51:02 INFO - 'talos.zip': {'path': '', 13:51:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:02 INFO - Running post-action listener: _resource_record_post_action 13:51:02 INFO - [mozharness: 2016-12-21 21:51:02.342329Z] Finished populate-webroot step (success) 13:51:02 INFO - [mozharness: 2016-12-21 21:51:02.342468Z] Running create-virtualenv step. 13:51:02 INFO - Running pre-action listener: _resource_record_pre_action 13:51:02 INFO - Running main action method: create_virtualenv 13:51:02 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:02 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:51:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:02 INFO - Using real prefix '/tools/python27' 13:51:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:03 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:06 INFO - Installing pip.................done. 13:51:06 INFO - Return code: 0 13:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:06 INFO - Reading from file tmpfile_stdout 13:51:06 INFO - Output received: 13:51:06 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:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:06 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:06 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:51:06 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:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:06 INFO - 'HOME': '/Users/cltbld', 13:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:06 INFO - 'LOGNAME': 'cltbld', 13:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:06 INFO - 'MOZ_NO_REMOTE': '1', 13:51:06 INFO - 'NO_EM_RESTART': '1', 13:51:06 INFO - 'PAGER': '/bin/cat', 13:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:06 INFO - 'PWD': '/builds/slave/test', 13:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:06 INFO - 'SHELL': '/bin/bash', 13:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:06 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:06 INFO - 'USER': 'cltbld', 13:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:06 INFO - 'XPC_FLAGS': '0x0', 13:51:06 INFO - 'XPC_SERVICE_NAME': '0', 13:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:06 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:51:06 INFO - Cleaning up... 13:51:06 INFO - Return code: 0 13:51:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:06 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:06 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:51:06 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:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:06 INFO - 'HOME': '/Users/cltbld', 13:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:06 INFO - 'LOGNAME': 'cltbld', 13:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:06 INFO - 'MOZ_NO_REMOTE': '1', 13:51:06 INFO - 'NO_EM_RESTART': '1', 13:51:06 INFO - 'PAGER': '/bin/cat', 13:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:06 INFO - 'PWD': '/builds/slave/test', 13:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:06 INFO - 'SHELL': '/bin/bash', 13:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:06 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:06 INFO - 'USER': 'cltbld', 13:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:06 INFO - 'XPC_FLAGS': '0x0', 13:51:06 INFO - 'XPC_SERVICE_NAME': '0', 13:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:06 INFO - Downloading/unpacking psutil>=3.1.1 13:51:06 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:51:06 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:51:06 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:51:06 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:51:06 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:51:06 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:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:10 INFO - Installing collected packages: psutil 13:51:10 INFO - Running setup.py install for psutil 13:51:10 INFO - building 'psutil._psutil_osx' extension 13:51:10 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:51:10 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:51:10 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:51:11 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:51:11 INFO - building 'psutil._psutil_posix' extension 13:51:11 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:51:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:11 INFO - ^ 13:51:11 INFO - 1 warning generated. 13:51:11 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:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:11 INFO - Successfully installed psutil 13:51:11 INFO - Cleaning up... 13:51:11 INFO - Return code: 0 13:51:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51:11 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:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:11 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:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:11 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:11 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:51:11 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:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:11 INFO - 'HOME': '/Users/cltbld', 13:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:11 INFO - 'LOGNAME': 'cltbld', 13:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:11 INFO - 'MOZ_NO_REMOTE': '1', 13:51:11 INFO - 'NO_EM_RESTART': '1', 13:51:11 INFO - 'PAGER': '/bin/cat', 13:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:11 INFO - 'PWD': '/builds/slave/test', 13:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:11 INFO - 'SHELL': '/bin/bash', 13:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:11 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:11 INFO - 'USER': 'cltbld', 13:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:11 INFO - 'XPC_FLAGS': '0x0', 13:51:11 INFO - 'XPC_SERVICE_NAME': '0', 13:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:14 INFO - Installing collected packages: mozsystemmonitor 13:51:14 INFO - Running setup.py install for mozsystemmonitor 13:51:14 INFO - Successfully installed mozsystemmonitor 13:51:14 INFO - Cleaning up... 13:51:14 INFO - Return code: 0 13:51:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:14 INFO - 'HOME': '/Users/cltbld', 13:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:14 INFO - 'LOGNAME': 'cltbld', 13:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:14 INFO - 'MOZ_NO_REMOTE': '1', 13:51:14 INFO - 'NO_EM_RESTART': '1', 13:51:14 INFO - 'PAGER': '/bin/cat', 13:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:14 INFO - 'PWD': '/builds/slave/test', 13:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:14 INFO - 'SHELL': '/bin/bash', 13:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:14 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:14 INFO - 'USER': 'cltbld', 13:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:14 INFO - 'XPC_FLAGS': '0x0', 13:51:14 INFO - 'XPC_SERVICE_NAME': '0', 13:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:14 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:14 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:51:14 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:51:14 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:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:17 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:51:17 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:51:17 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:51:17 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:51:17 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:51:17 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:51:18 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:18 INFO - warning: no files found matching '*.txt' 13:51:18 INFO - no previously-included directories found matching 'build' 13:51:18 INFO - no previously-included directories found matching 'dist' 13:51:18 INFO - no previously-included directories found matching '.git*' 13:51:18 INFO - Installing collected packages: jsonschema, functools32 13:51:18 INFO - Running setup.py install for functools32 13:51:18 INFO - warning: no files found matching '*.txt' 13:51:18 INFO - no previously-included directories found matching 'build' 13:51:18 INFO - no previously-included directories found matching 'dist' 13:51:18 INFO - no previously-included directories found matching '.git*' 13:51:18 INFO - Successfully installed jsonschema functools32 13:51:18 INFO - Cleaning up... 13:51:18 INFO - Return code: 0 13:51:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:18 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:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:18 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:51:18 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:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:18 INFO - 'HOME': '/Users/cltbld', 13:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:18 INFO - 'LOGNAME': 'cltbld', 13:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:18 INFO - 'MOZ_NO_REMOTE': '1', 13:51:18 INFO - 'NO_EM_RESTART': '1', 13:51:18 INFO - 'PAGER': '/bin/cat', 13:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:18 INFO - 'PWD': '/builds/slave/test', 13:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:18 INFO - 'SHELL': '/bin/bash', 13:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:18 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:18 INFO - 'USER': 'cltbld', 13:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:18 INFO - 'XPC_FLAGS': '0x0', 13:51:18 INFO - 'XPC_SERVICE_NAME': '0', 13:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:18 INFO - Cleaning up... 13:51:18 INFO - Return code: 0 13:51:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:18 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:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:18 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:51:18 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:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:18 INFO - 'HOME': '/Users/cltbld', 13:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:18 INFO - 'LOGNAME': 'cltbld', 13:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:18 INFO - 'MOZ_NO_REMOTE': '1', 13:51:18 INFO - 'NO_EM_RESTART': '1', 13:51:18 INFO - 'PAGER': '/bin/cat', 13:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:18 INFO - 'PWD': '/builds/slave/test', 13:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:18 INFO - 'SHELL': '/bin/bash', 13:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:18 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:18 INFO - 'USER': 'cltbld', 13:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:18 INFO - 'XPC_FLAGS': '0x0', 13:51:18 INFO - 'XPC_SERVICE_NAME': '0', 13:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:18 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:22 INFO - Downloading docopt-0.6.1.tar.gz 13:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:23 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:23 INFO - Running setup.py install for blobuploader 13:51:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:23 INFO - Running setup.py install for requests 13:51:23 INFO - Running setup.py install for docopt 13:51:23 INFO - Successfully installed blobuploader requests docopt 13:51:23 INFO - Cleaning up... 13:51:23 INFO - Return code: 0 13:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:23 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:23 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:51:23 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:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:23 INFO - 'HOME': '/Users/cltbld', 13:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:23 INFO - 'LOGNAME': 'cltbld', 13:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:23 INFO - 'MOZ_NO_REMOTE': '1', 13:51:23 INFO - 'NO_EM_RESTART': '1', 13:51:23 INFO - 'PAGER': '/bin/cat', 13:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:23 INFO - 'PWD': '/builds/slave/test', 13:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:23 INFO - 'SHELL': '/bin/bash', 13:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:23 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:23 INFO - 'USER': 'cltbld', 13:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:23 INFO - 'XPC_FLAGS': '0x0', 13:51:23 INFO - 'XPC_SERVICE_NAME': '0', 13:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-BBjYxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mQQIzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-HlSeXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Fx4SBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-IsLFXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-zOqYE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-JDXCtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-r7MVHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:24 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-nuzRlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Gttgae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-P7sul9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-txsUgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-xq9C0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-IuyxQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-2P5_eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Mj8SMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:25 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-RNUhF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:25 INFO - Running setup.py install for manifestparser 13:51:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:26 INFO - Running setup.py install for mozcrash 13:51:26 INFO - Running setup.py install for mozdebug 13:51:26 INFO - Running setup.py install for mozdevice 13:51:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:26 INFO - Running setup.py install for mozfile 13:51:26 INFO - Running setup.py install for mozhttpd 13:51:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:26 INFO - Running setup.py install for mozinfo 13:51:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:26 INFO - Running setup.py install for mozInstall 13:51:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Running setup.py install for mozleak 13:51:27 INFO - Running setup.py install for mozlog 13:51:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Running setup.py install for moznetwork 13:51:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Running setup.py install for mozprocess 13:51:27 INFO - Running setup.py install for mozprofile 13:51:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:27 INFO - Running setup.py install for mozrunner 13:51:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:28 INFO - Running setup.py install for mozscreenshot 13:51:28 INFO - Running setup.py install for moztest 13:51:28 INFO - Running setup.py install for mozversion 13:51:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:28 INFO - Cleaning up... 13:51:28 INFO - Return code: 0 13:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:28 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:28 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:51:28 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:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:28 INFO - 'HOME': '/Users/cltbld', 13:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:28 INFO - 'LOGNAME': 'cltbld', 13:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:28 INFO - 'MOZ_NO_REMOTE': '1', 13:51:28 INFO - 'NO_EM_RESTART': '1', 13:51:28 INFO - 'PAGER': '/bin/cat', 13:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:28 INFO - 'PWD': '/builds/slave/test', 13:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:28 INFO - 'SHELL': '/bin/bash', 13:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:28 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:28 INFO - 'USER': 'cltbld', 13:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:28 INFO - 'XPC_FLAGS': '0x0', 13:51:28 INFO - 'XPC_SERVICE_NAME': '0', 13:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-WOH_4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:28 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:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-J_IS5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:28 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:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:28 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ORP4W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ihVlBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ziYNfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-h0iWhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-dqbWuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-OAozUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-tdwSgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-So9Rwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ydFIPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:29 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:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:29 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-haOQPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:30 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:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-xpNmYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:30 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:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-OiVH8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:30 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:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wXnxsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:30 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:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-m_MYeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:30 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:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-TgnfEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - Downloading blessings-1.6.tar.gz 13:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:33 INFO - Installing collected packages: blessings 13:51:33 INFO - Running setup.py install for blessings 13:51:33 INFO - Successfully installed blessings 13:51:33 INFO - Cleaning up... 13:51:33 INFO - Return code: 0 13:51:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:34 INFO - Reading from file tmpfile_stdout 13:51:34 INFO - Current package versions: 13:51:34 INFO - blessings == 1.6 13:51:34 INFO - blobuploader == 1.2.4 13:51:34 INFO - docopt == 0.6.1 13:51:34 INFO - functools32 == 3.2.3-2 13:51:34 INFO - jsonschema == 2.5.1 13:51:34 INFO - manifestparser == 1.1 13:51:34 INFO - mozInstall == 1.12 13:51:34 INFO - mozcrash == 1.0 13:51:34 INFO - mozdebug == 0.1 13:51:34 INFO - mozdevice == 0.48 13:51:34 INFO - mozfile == 1.2 13:51:34 INFO - mozhttpd == 0.7 13:51:34 INFO - mozinfo == 0.9 13:51:34 INFO - mozleak == 0.1 13:51:34 INFO - mozlog == 3.4 13:51:34 INFO - moznetwork == 0.27 13:51:34 INFO - mozprocess == 0.23 13:51:34 INFO - mozprofile == 0.28 13:51:34 INFO - mozrunner == 6.13 13:51:34 INFO - mozscreenshot == 0.1 13:51:34 INFO - mozsystemmonitor == 0.3 13:51:34 INFO - moztest == 0.7 13:51:34 INFO - mozversion == 1.4 13:51:34 INFO - psutil == 3.1.1 13:51:34 INFO - requests == 1.2.3 13:51:34 INFO - wsgiref == 0.1.2 13:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:34 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:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 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:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:34 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:51:34 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:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:34 INFO - 'HOME': '/Users/cltbld', 13:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:34 INFO - 'LOGNAME': 'cltbld', 13:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:34 INFO - 'MOZ_NO_REMOTE': '1', 13:51:34 INFO - 'NO_EM_RESTART': '1', 13:51:34 INFO - 'PAGER': '/bin/cat', 13:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:34 INFO - 'PWD': '/builds/slave/test', 13:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:34 INFO - 'SHELL': '/bin/bash', 13:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:34 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:34 INFO - 'USER': 'cltbld', 13:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:34 INFO - 'XPC_FLAGS': '0x0', 13:51:34 INFO - 'XPC_SERVICE_NAME': '0', 13:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 INFO - Cleaning up... 13:51:34 INFO - Return code: 0 13:51:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:34 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:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 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:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 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 0x103e7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb734c4bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, '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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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:51:34 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:51:34 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:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:34 INFO - 'HOME': '/Users/cltbld', 13:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:34 INFO - 'LOGNAME': 'cltbld', 13:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:34 INFO - 'MOZ_NO_REMOTE': '1', 13:51:34 INFO - 'NO_EM_RESTART': '1', 13:51:34 INFO - 'PAGER': '/bin/cat', 13:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:34 INFO - 'PWD': '/builds/slave/test', 13:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:34 INFO - 'SHELL': '/bin/bash', 13:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:51:34 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:34 INFO - 'USER': 'cltbld', 13:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:34 INFO - 'XPC_FLAGS': '0x0', 13:51:34 INFO - 'XPC_SERVICE_NAME': '0', 13:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Running post-action listener: _resource_record_post_action 13:51:35 INFO - Running post-action listener: _start_resource_monitoring 13:51:35 INFO - Starting resource monitoring. 13:51:35 INFO - [mozharness: 2016-12-21 21:51:35.067459Z] Finished create-virtualenv step (success) 13:51:35 INFO - [mozharness: 2016-12-21 21:51:35.068436Z] Running install step. 13:51:35 INFO - Running pre-action listener: _resource_record_pre_action 13:51:35 INFO - Running main action method: install 13:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:35 INFO - Reading from file tmpfile_stdout 13:51:35 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:35 INFO - Reading from file tmpfile_stdout 13:51:35 INFO - Output received: 13:51:35 INFO - Usage: mozinstall [options] installer 13:51:35 INFO - Options: 13:51:35 INFO - -h, --help show this help message and exit 13:51:35 INFO - -d DEST, --destination=DEST 13:51:35 INFO - Directory to install application into. [default: 13:51:35 INFO - "/builds/slave/test"] 13:51:35 INFO - --app=APP Application being installed. [default: firefox] 13:51:35 INFO - mkdir: /builds/slave/test/build/application 13:51:35 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:51:35 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:52:06 INFO - Reading from file tmpfile_stdout 13:52:06 INFO - Output received: 13:52:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:52:06 INFO - Running post-action listener: _resource_record_post_action 13:52:06 INFO - [mozharness: 2016-12-21 21:52:06.598859Z] Finished install step (success) 13:52:06 INFO - [mozharness: 2016-12-21 21:52:06.599011Z] Running run-tests step. 13:52:06 INFO - Running pre-action listener: _resource_record_pre_action 13:52:06 INFO - Running main action method: run_tests 13:52:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:06 INFO - 2016-12-21 13:52:06.613 screenresolution[1623:7380] starting screenresolution argv=screenresolution get 13:52:06 INFO - 2016-12-21 13:52:06.616 screenresolution[1623:7380] Display 0: 1600x1200x32@60 13:52:06 INFO - 2016-12-21 13:52:06.621 screenresolution[1624:7382] starting screenresolution argv=screenresolution list 13:52:06 INFO - Available Modes on Display 0 13:52:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:06 INFO - Intel Iris: 13:52:06 INFO - Chipset Model: Intel Iris 13:52:06 INFO - Type: GPU 13:52:06 INFO - Bus: Built-In 13:52:06 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:06 INFO - Vendor: Intel (0x8086) 13:52:06 INFO - Device ID: 0x0a2e 13:52:06 INFO - Revision ID: 0x0009 13:52:06 INFO - Displays: 13:52:06 INFO - Display: 13:52:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:06 INFO - Display Serial Number: 1600x1200 60 13:52:06 INFO - Main Display: Yes 13:52:06 INFO - Mirror: Off 13:52:06 INFO - Online: Yes 13:52:06 INFO - Rotation: Supported 13:52:06 INFO - Return code: 0 13:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:06 INFO - Python 2.7.3 13:52:06 INFO - Return code: 0 13:52:06 INFO - grabbing minidump binary from tooltool 13:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:06 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 0x103c8ed30>, '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 0x103af4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c86b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:06 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:52:06 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:52:06 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:52:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:06 INFO - Return code: 0 13:52:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:06 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:52:06 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lF8V0YVhcP/Render', 13:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:06 INFO - 'HOME': '/Users/cltbld', 13:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:06 INFO - 'LOGNAME': 'cltbld', 13:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:06 INFO - 'MOZ_NO_REMOTE': '1', 13:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:06 INFO - 'NO_EM_RESTART': '1', 13:52:06 INFO - 'PAGER': '/bin/cat', 13:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:06 INFO - 'PWD': '/builds/slave/test', 13:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:06 INFO - 'SHELL': '/bin/bash', 13:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0fCUnSXOsc/Listeners', 13:52:06 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:06 INFO - 'USER': 'cltbld', 13:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:06 INFO - 'XPC_FLAGS': '0x0', 13:52:06 INFO - 'XPC_SERVICE_NAME': '0', 13:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:52:07 INFO - mozversion application_buildid: 20161221115353 13:52:07 INFO - mozversion application_changeset: d43a5a11c195d12ca3a3179855a6b50a05583311 13:52:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:52:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:07 INFO - mozversion application_name: Firefox 13:52:07 INFO - mozversion application_remotingname: firefox-dev 13:52:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:52:07 INFO - mozversion application_vendor: Mozilla 13:52:07 INFO - mozversion application_version: 52.0a2 13:52:07 INFO - mozversion platform_buildid: 20161221115353 13:52:07 INFO - mozversion platform_changeset: d43a5a11c195d12ca3a3179855a6b50a05583311 13:52:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:52:07 INFO - mozversion platform_version: 52.0a2 13:52:07 INFO - using testdate: 1482357127 13:52:07 INFO - actual date: 1482357127 13:52:07 INFO - starting webserver on 'localhost:49235' 13:52:07 INFO - SUITE-START | Running 2 tests 13:52:07 INFO - TEST-START | dromaeo_css 13:52:07 INFO - operating with platform_type : mac_ 13:52:07 INFO - Initialising browser for dromaeo_css test... 13:52:07 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpSkta9f/profile http://localhost:49235/getInfo.html) 13:52:09 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 13:52:09 INFO - PROCESS | 1634 | colorDepth:24 13:52:09 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 13:52:09 INFO - PROCESS | 1634 | __metrics 13:52:09 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:52:09 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:10 INFO - TEST-INFO | 1634: exit 0 13:52:10 INFO - Browser initialized. 13:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:10 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpSkta9f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:23 INFO - PROCESS | 1636 | RSS: Main: 222265344 13:52:23 INFO - PROCESS | 1636 | 13:53:14 INFO - PROCESS | 1636 | 1482357194104 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:55:27 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 13:55:29 INFO - PROCESS | 1636 | RSS: Main: 314658816 13:55:29 INFO - PROCESS | 1636 | 13:58:32 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 13:58:32 INFO - PROCESS | 1636 | RSS: Main: 346537984 13:58:32 INFO - PROCESS | 1636 | 14:01:35 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 14:01:35 INFO - PROCESS | 1636 | RSS: Main: 321720320 14:01:35 INFO - PROCESS | 1636 | 14:04:38 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 14:04:38 INFO - PROCESS | 1636 | RSS: Main: 323100672 14:04:38 INFO - PROCESS | 1636 | 14:07:42 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 14:07:42 INFO - PROCESS | 1636 | RSS: Main: 306495488 14:07:42 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 14:10:46 INFO - PROCESS | 1636 | RSS: Main: 431955968 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | __start_tp_report 14:10:46 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 14:10:46 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 14:10:46 INFO - PROCESS | 1636 | |i|pagename|runs| 14:10:46 INFO - PROCESS | 1636 | |0;dojo.html;3282.786618869773;3307.570015897933;3322.634510203877;3334.199792049909;3339.4823802310652;5489.313835770528;5536.640118392302;5538.833834984946;5566.332040155177;5586.91619625706;5447.319085114361;5546.389897111325;5557.666540007603;5565.554755619551;5592.692401917893;5053.494650534944;5056.3173971513925;5071.898562028758;5165.922511162316;5182.559482443997;5039.823606173784;5042.974785126069;5053;5080.720560369196;5114.335136432277;4718.693284936486;4775.928361074587;5112.437631860493;5150.845474635748;5183.144781111112;5157.690538567698;5173.715445650488;5174.922376164361;5177.689338639693;5212.739363031871;4945.085159245551;4996.150654388763;5096.235564665293;5119.59043276537;5138.3577052868395;4135.793210339471;5453.045716999509;5480.890382192374;5494;5564.4991950724225;5971.492423144038;5993.6403815770755;5998.1602575639445;6002.399760023963;6073.058675905242;5801.941980580183;6148.6618235997;6150.692465376758;6171.074338849208;6177.166082578839;5459.153831156217;5559.916601250984;5613.859653508695;5623.044082505984;5632.690202038845;6273.404026617464;6278.748850046039;6288.402601752826;6313.842153946188;6325.588836725598;5905.8954026951715;5929.407059294036;5932.466078052996;5956.315023772235;5974.551908606785;5894.852628684232;5963.045912654041;5964.761409543657;5977.282726072812;6017.518598512109;5982.850428739229;6002.249718785152;6005.249343832021;6035;6044.365341639064;6017.398260174035;6039.939600604026;6055.878882422327;6077.969610151921;6100;4690.9765451172525;4728.834490792806;4746;4797.304390863305;4819.903601927942;4224.176285624274;4274.636655884223;4298.677599180074;4304.246756817544;4372.409724687126;5760.769569217268;5763.942360576424;5766.826995190151;5785.8553536161935;5785.971070144707;6145.324014358417;6151.3541078187045;6165.260168779685;6165.445109940127;6165.568410211332;5600.635958662674;5613.550915926716;5659.151127330851;5694.601377903507;5742.827715168552;5255.76349064293;5287.286216360819;5303.734813259399;5320.946790532045;5333.43998880112;6299.338569450233;6301.936980630135;6314.147590075373;6315.621062736251;6327.272363678052;5753.971230143822;5878.617889837147;6105.419985101408;6148.200733904564;6159.322474527708;6238.906416403848;6309.905351419824;6317.147185129948;6327.651979141191;6338.524610654312;6017.729202185999;6027.849303767441;6034.517238620812;6036.547258955684;6057.130318565211;6001.4298641628975;6057.121717350871;6086.80082364288;6142.069075791408;6172.321044684992;5820.563457740771;5838.007538718343;5859.945209862266;5951.434613711691;5972.581919265784;5901.940980590311;5911.467967882912;5917.082852157922;5932.436418540232;5944.64332140073;5580.1629755537;5795.188673585786;5795.942040579709;5797.826065218051;5799.8550036249435;5616.578756593353;5817.825465236049;5833.883322333445;5860.736266867916;5935.34711181761;5712.7714891403875;5726.455986681259;5726.713664316684;5729.140628905698;5747.48272655463 14:10:46 INFO - PROCESS | 1636 | |1;ext.html;459.4394838297277;473.38696388177317;474.97642580239597;482.32233711635143;485.50236008091724;30106.698933010663;31824.36351272973;31854.36291274176;31882.52176217353;38740;39359;41481.792591037076;41513.79243103788;41558.37662435066;41613.375799363035;9348.766280843;9502.429854208734;9527.571259293314;9532.18976387008;9534.380265282769;8478.915210847874;8714.041455439896;9372.203362714177;9474.147326740593;9491.762705932373;11268.774624507505;11522.251053681526;11522.942385288105;11640.476178571984;11650.533978640886;11301;11341.829872551918;11382.487788049557;11417.200795944287;11423.82864257041;7258.782236532912;8673.306135509145;8695.130486951255;11274.323540587591;11295.548178072868;31458.37083258322;31732;38497.80751096254;39255.60744392548;39345.80327098375;3307.702306792376;3331.1172539277113;3511.578610566723;3612.981935090334;3813.3531893770164;28050.859745701346;28266.43467130646;29840.70159298401;30284.394312113633;30323.69676303231;3158.8578513966927;3184.251700850298;3212.8232947187894;3260.5272235525717;3356.345512625039;463589.6820515943;463746;464993;465752;471644.64177679236;39880.80059599742;47765.761171193924;57462.42537574654;57539.84920301654;57670.7116464415;50379;55205.72397138069;57006.14490782641;61451.38548614546;64164.716705665625;15297.847021529642;15615.609609759847;15636.687266254612;15639.357867423983;15669.686606267811;11829.822552661717;12072.094592905392;12097.032237420985;12099.939500302442;12119.212251203644;14257;14534.418623254951;15744.685106298039;15952.92023539898;16220.51338459848;5578.944210557924;6759.695813688396;6771;6791.030601125717;6799.422049125781;842.9409941304173;917.559571405729;947.8436058050482;960.4765402855461;1071.0842229893485;27587.172384828085;27679.861600691867;28348.149555513366;28453.628731806584;28560.85719571389;956.3735753081743;1043.8225501664735;1045.2979049158012;1126.2904370246856;1180.5100883133402;12060.819087713691;14248.85751142496;14645.267736613127;15069.773953390708;15111.622209444631;597230;599624;600556;600905;604646;43076.923076923325;46003.079938401046;46776.766116169885;52993.2051019235;53257;1360.31984007996;1375.7936309553647;1404.6207523968676;1404.985950140506;1405.7891316302637;28181.71818281791;28954.276143095747;29149.417011660073;29421.558676620298;30287.545686814276;47837.76081119572;48338.5166148334;48381.5161848377;48460;48492.2726159115;688477;710007;711628;718585.4070729822;723626;24401.535907845588;25123.371915702253;25230;25386;25524.23427297184;40123.59876401316;44473.11053778971;44785.776071119435;45207;45730.08539829251;36651.15909576119;36735.08162295964;37126.44310335293;37152.628473715995;38115.42826857655;36936;37015.629843701216;37309.62690373061;38147.664831730755;38215.28031238657;35901.461478077326;36409;36506;36553.81723091367;36765.08087297732;26652;29547.261318467212;30903.38193236078;32178.67821321757;33089.66910330962;23914;24180.39549011289;24431.900564474287;24980.75019249857;25059.248222553353 14:10:46 INFO - PROCESS | 1636 | |2;jquery.html;354.3639167693989;372.09580718853175;375.90226541099315;386.82012864018236;402.8207447685779;14540.41838326467;14569.344379502922;15471.303791329403;19751.308704195355;20350.69473957888;19234.711479327787;19384.90307548464;19856.305029323976;19881.20475180991;20070;5721.513671337942;5815.883682326351;5849.941500585003;5874.70626468677;5877.70611469427;4553.612942899841;6515.446187074081;6587.176602924635;6651.534392592521;6659.700313485905;6256.906146407808;6481.805545833632;6575.309592492791;6582.275949645536;6601.867962640745;6505.804825855232;6514.315996820336;6553.180852393451;6554.508411869081;6563;5463.3717122530625;5498.9826882026955;5551.8889622207735;5554.0835762099205;5568.387477377485;23971.76028239713;24067;24098.759012409828;24236;24499.510009799884;2068.4621998280404;2230.631945728969;2250.088714070804;2951.4982452983045;3018.713222243883;13676.589702308947;14907.478238261718;15502.379904803907;15611.3755449783;15627.609309767233;1828.7165489349172;1831.230883029131;1864.6363959027994;1892.4890279624424;1913.0817207740224;117846.64306713988;122581;124578.75421245763;126718;127806.36096819457;8866;11163.665090047312;11348;11457.369844658457;11722.47607810979;14484.275786210648;14595.85404145945;14695.926520367544;14945.327460264314;14997.025193362397;8329.875051874105;8406.621702023423;8515.48907065578;8567.18611731897;8725.476471411735;8046.758597242092;8168.959155204186;8187.5087494750505;8360.122187170382;8404.07555168931;3955.624215699504;4363.865394997323;4375.096832877708;4449.221386257392;4545.477270113913;1886.3209244671907;1937.651222779913;1938.4766113149371;1945.7762357328804;1949.8927558984108;769.4690663442207;903.3315346643436;925.1257561604219;932.8274269260073;940.6425558287943;19012.429627111207;19535.413937581896;20551.97240137987;20568.897155514125;20872;877.8946526416743;889.9065598112235;897.8742975983367;907.1744712311764;942.7501712046313;9901.653442129491;10684.358938463716;10691.465426728633;10728.302660327054;10741.89258107409;531167;535581.3220933948;536953.3152334292;629406;634431;81670;133199.34405247556;133232;140895.29552352172;143771;944.2917811641269;964.508100868548;1003.4180175498047;1004.929654924163;1011.8330475471465;15089.849101508844;17132;17675.558111047325;18755.6248875019;19085;54785.1782223259;55067.695938243836;55732.72133639306;56917.14624280556;57461.712691436274;77742.6112869432;79584.60207698925;80160.59919700364;81017;82297.58851205706;6733.158355205599;6825.215100263533;7697.345725613161;8167.591620418836;8414;11377.54489820398;12154.939225303817;12530.686732831753;12728.6817829555;13182.274974876475;10826.458677065957;10828.296160749525;10953.452327383759;11248.325100493996;11251.549938002388;10064.84902726445;10680.57277708883;11018.889811101786;11357.886421135683;11521.308721476738;9970.451625160686;10714.089302409071;11275.605353812578;11698.022672291461;11717;7180.856382872418;7389.445791565761;7421.666025028994;7704.075510938723;8241.464304820167;10547.630832920811;10553.208509361675;10704.785904281714;10980.341179529254;11319.943400282946 14:10:46 INFO - PROCESS | 1636 | |3;mootools.html;1312.3897387714724;1448.29033773451;1476.9704605907882;1617.6360318928243;1820.035381247939;7458.962705186474;7842.451028428005;8028.438009339341;8381.580920953944;8401.41190116692;8212.589370531465;8217.055038670554;8317.83364332713;8331.583420828965;8333.791655208623;2285.874276914765;2318.1654604342425;2318.2002209237785;2320.570694421529;2324.8721320327377;2268.296827983322;2296.7588403217674;2304.4008557775014;2306.1582522379294;2366.0299277296313;2290.541891621674;2293.7706229377013;2330.766923307664;2339.578875802355;2342.074880422232;1978.7130866024418;2290.381596968809;2302.067662596651;2323.5004474038165;2327.7439481657;2293.8738369389675;2355.081518207883;2360.6426304874767;2363.6572696958847;2370.9407264818346;8054.315383192436;8256.628451719687;8331.66673333066;8331.916680833174;8339.249467547888;5019.698818070891;5214.713190774506;5221.791128354861;5227.137522308814;5228.503292187236;3354.1614596350914;3491.7555771096036;3509.982450087733;3584.229390681016;3586.6413358664186;1062.9362238265728;1083.9729006774894;1097.314178638351;1097.9615713449991;1113.5156207049959;10860.402677852715;10915.617953371673;10976.451177441177;10986.395748233845;11018.669439916815;3976.681865450757;4432.556744325541;4482.125985432875;4513.458384993822;4518.141553104965;8461.2807911327;8642.135786421433;8651.394402391898;8657.350698697623;8662.783430414163;4958.677685950402;4958.826441074617;5030.346055012825;5074.188129899198;5074.974625126851;4003.139325045129;4219.430376899079;4373.125374925028;4374.978125109354;4714.22215334466;3614.0964758810296;3634.5638523377365;3699.5930447650735;3724.1062145084984;3731.104534911656;1107.1364335818075;1119.6249256499163;1121.8541589593465;1126.3748619516248;1146.621614867092;791.4934441957153;875.7810547363159;892.9107089291019;922.8477301245354;929.3401684803865;5780.479756821906;5811.854703632358;5923.466887980103;5933.436323549256;6181.629102253879;914.1087439746194;920.9125133112477;925.250547056886;926.1710768861831;979.7305740921161;3680.9815950920074;3793.5447746270074;3829.1384438501673;3883.262180185756;3891.5330160380936;9719.125278724807;10209.285350025428;10226.028527289896;10240.692779216635;10253.692389228336;10172;10173.135283500986;10183.33808302458;10190.286679932333;10201.642942496977;7582.962085189649;7730.96134519335;7834.804129896685;7882.330001949898;7940.967674202432;5601.24383208278;5608.831735047955;5632.295963004624;5678.290213723285;5882.735276912635;8860.202581767671;9005.864912026194;9338.486383248715;9460.053994600485;9486.383385079947;9386.5776040077;9463.432194068379;9496.620135194515;9519.904800951901;9643.758906027124;7023.543469674455;7182.60495672743;7252.637368131678;7318.487705860539;7342.302481264272;7975.282224599814;8051.033875934925;8133.024037115584;8133.308668763221;8148.103708592169;7081.18566364854;7162.391196748126;7226.168990565942;7237.529560578546;7341.302576255247;7064.752733654297;7094.858102838018;7112.004319395185;7136.179339376038;7149.177844547944;6623.834404139935;6723.327667233433;6834.419074378733;6843.931560684528;6857.5199736018;4793.592544633745;4822.156122678447;4838.637102217418;4857.757112144449;4873;4786.664933454625;4884.90230195387;4953.455119936732;4978.626603004862;4990.577685359655 14:10:46 INFO - PROCESS | 1636 | |4;prototype.html;297.6904019819388;302.21424296828235;306.89412152807273;312.07158702859;312.7404254468791;4556.27099664053;5188.377394712635;5236.633435659496;5241.240020197074;5285.365756109268;4362.476502819666;4537.387452693885;4860.076585448771;4886.413630364353;5015.799368025275;3980.765962551604;4012.2376748417855;4021.77880216588;4026.71812973092;4030.556638769733;3603.9099022524383;3803.5055442792536;3998.760074395531;4018.6985976051765;4076.857309994136;3877.8448862045484;3955.9604403956023;3971.7418367806144;3995.60043995601;4006.038550747814;3328.4508056170826;3963.7621742695533;3980.467520004819;3982.880513584597;4029.9798501007454;3456.3087382523595;3470.340635279289;3491.5635545556806;3516.9120771980647;3520.295940811822;4411.051623900877;4743.146233677937;4750.477447480775;4975.900481990376;5092.618053645954;3574.803385813779;3836.3120227099985;3882.941755873664;4471.485779135376;4583.243764778807;4529.7735113244535;5407.107827208545;5453.727313634342;5460.836174914759;5481.643693159932;3826.0921699508294;3839.9616003839883;3841.481400010991;3850.4994350734505;3850.8652197172964;4997.600191984632;5406.405295417501;5674.687892165888;5703.116017017369;5710.657995371084;3198.7441004719567;3293.604767427876;3909.58949310324;3911.2764138634443;3918.490596222473;3951.4194322270746;3961.603839616015;3971.4439978403047;3974.4038394241097;3993.1414745829784;4171.451968881381;4252.128313695685;4361.3676016978;4473.680264322033;4590.586847183769;4345.500267469219;4769.403824521934;5290.603204759658;5321.6163797412955;5471.50756431923;1264.2667252993242;1279.4754150798128;1279.7696414645268;1297.4874924404996;1299.9025073119365;832.2260297922869;848.4909054567211;849.7450764770545;849.9872501912477;850.2951582078018;4411.411891718979;4656.4645065817185;4816.831410900601;5168.560672342818;5342.171963345688;4578.5650363215445;5524.58565607581;5609.49514543693;5628.887422251532;5649.774009039593;4943.752812359367;4993.50064993505;5169.405518365361;5197.532222100029;5284.947150528523;2457.640664961657;2672.906448274301;2788.177487641151;2795.8042936994216;2810.6205662235743;5649.853055838755;5669.489745922887;5680.318361796611;5683.460071293221;5690.573207009491;4723.622110231242;5059.6353424971985;5382.3541175059245;5427.294451721251;5469.425710300441;5258.999999999924;5398.1362981923485;5646.571974051198;5697.515711164598;5702.942970570241;4780.378550788375;4821.445533763662;4990.351254336913;5349.314965785765;5350.889900145274;4873.707577545359;5221.008008478377;5625.606207565595;5642.576806739593;5663.518600918803;5255.500727430888;5440.646357986719;5743.4543718346695;6023.36754640774;6025.698715064317;3363.6972672459597;3642.653947874948;3856.5564960029956;3882.514685664292;3892.766434013968;4655.299037265315;5618.269624948731;5618.6628802272;5620.887582248414;5626;4999.500049995117;5454.645448045864;5462.180672899097;5470.878469913579;5527.668339899619;4773.37946067009;5012.616483873298;5097.6941383517105;5363.785448582169;5488.368837583569;4349.956500435082;4489.981466587451;5210.45290244534;5427.267318912054;5440.028778991279;4789.114013907439;5355.991503186305;5412.431694672003;5433.8369848904595;5455.727213639381;4207.537170911259;5014.674046186986;5020.472850350807;5385.818743408769;5391.29913111293 14:10:46 INFO - PROCESS | 1636 | |5;yui.html;698.1343134513205;748.7603966730642;751.6504825256254;766.7508059880538;796.4385108498508;14089.788653170197;14341.641458963531;14744.483943061994;14783.630409239775;14794.112353258812;12922;12995.675108122301;13017.153884997491;13021.804672929913;13036.869631303683;602.9517638588902;644.3073695777035;664.7141729056503;670.0485310858593;807.9515229086244;737.6938570493239;822.9876551851727;823.0329362998483;823.2549542663869;823.7775800533852;867.8524650809346;869.2611280411631;872.8734333521636;873.458455757428;873.52829472085;667.8330417395651;695.6382681005899;699.9510034297601;869.5739087846941;870.4298684361753;518.8625014371195;519.210799584633;520.3755493407888;614.2260751453157;639.6034458635629;13828.101173423694;13894.444222231099;13898.16611003343;13944.930275348659;13950.720985580232;10583.894161058368;12407.379631018413;12568.994480441634;12709.936450317782;13101.039027242581;11509.827352589718;11727.296362218294;11953;11969.341686207255;11974.700632484171;4197.118605092935;4303.526612072669;4385.407969924051;4405.015916077959;4447.421835161441;81823.5908820452;87196.99999999936;88290.11709882884;88391.67412488817;92251;10172.287939844287;10189.949050254849;10238.897611023795;10249.38503689781;10285.382877027403;19195.712064319046;19304.32434864773;19336;19336.516587085436;19352.903235483733;6234.937650623527;7189.784306470814;7500.662470188855;7504;7569.545827250383;3924.7841368724994;4156.106437115974;4190.727602705814;4194.706370554093;4314.697971142053;3036.5900603418254;3159.4470967580583;3163.225009872596;3165.414398336315;3168.350488149924;631.5105793010362;636.7071147272306;672.9697163627649;708.0794966543576;712.3055021354241;614.658864330301;639.8432384065934;647.3720491123603;653.5163978655855;664.3721683009607;8736.301095912311;9123.543822808833;9262.212711919563;9278.350515463853;9384.577694003787;622.2315440431064;649.4187702006772;652.116382301974;660.8050625065617;678.3149019490351;4244.469441319835;4455.6212721919;4479.8800299925015;4491.236489796743;4622.537746225351;113113;115626;117845;117868;122979;71748;83957;103189.48405258075;104746;106464.46767766112;63269.367306327265;82213.17786822055;90020.09979900117;91928.54035729778;92652.07347926569;8793.692220772242;8825;8825.602847871733;8833.602487887933;8836.558172091498;43596.78201608972;47004.7649761749;47535.286970694775;57420;58334;62766;71290.28709712837;73037.26962730305;74381;74650.52096874204;11776.352300623204;11916.842036860065;12312;12766.758662378907;12864.742705145658;13835.308234588028;14139;14379.928100359431;14877.553673389815;15163.469278575198;13279.269640169883;13317.334133293103;13720.45118195261;13819.654508637364;13859.792103118663;12963.805542916674;12991;13059.608211753663;13435.596932092052;13900.443982241002;10523.78952420932;12721.745565088462;12739.426725797546;12867.742645147231;12996.960243180334;8568.485890846569;9881.654142104991;10115.696529104138;10923.83614245771;11375.715607109889;8490.278326342082;9548.618055277711;10091.79816403653;11133;11193.440327983732 14:10:46 INFO - PROCESS | 1636 | __end_tp_report 14:10:46 INFO - PROCESS | 1636 | __start_cc_report 14:10:46 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1717 14:10:46 INFO - PROCESS | 1636 | __end_cc_report 14:10:46 INFO - PROCESS | 1636 | __startTimestamp1482358246469__endTimestamp 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | ------- Summary: start ------- 14:10:46 INFO - PROCESS | 1636 | Number of tests: 6 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5599.34 Median:5785.97 stddev:639.67 (11.1%) stddev-sans-first:615.28 14:10:46 INFO - PROCESS | 1636 | Values: 3282.8 3307.6 3322.6 3334.2 3339.5 5489.3 5536.6 5538.8 5566.3 5586.9 5447.3 5546.4 5557.7 5565.6 5592.7 5053.5 5056.3 5071.9 5165.9 5182.6 5039.8 5043.0 5053.0 5080.7 5114.3 4718.7 4775.9 5112.4 5150.8 5183.1 5157.7 5173.7 5174.9 5177.7 5212.7 4945.1 4996.2 5096.2 5119.6 5138.4 4135.8 5453.0 5480.9 5494.0 5564.5 5971.5 5993.6 5998.2 6002.4 6073.1 5801.9 6148.7 6150.7 6171.1 6177.2 5459.2 5559.9 5613.9 5623.0 5632.7 6273.4 6278.7 6288.4 6313.8 6325.6 5905.9 5929.4 5932.5 5956.3 5974.6 5894.9 5963.0 5964.8 5977.3 6017.5 5982.9 6002.2 6005.2 6035.0 6044.4 6017.4 6039.9 6055.9 6078.0 6100.0 4691.0 4728.8 4746.0 4797.3 4819.9 4224.2 4274.6 4298.7 4304.2 4372.4 5760.8 5763.9 5766.8 5785.9 5786.0 6145.3 6151.4 6165.3 6165.4 6165.6 5600.6 5613.6 5659.2 5694.6 5742.8 5255.8 5287.3 5303.7 5320.9 5333.4 6299.3 6301.9 6314.1 6315.6 6327.3 5754.0 5878.6 6105.4 6148.2 6159.3 6238.9 6309.9 6317.1 6327.7 6338.5 6017.7 6027.8 6034.5 6036.5 6057.1 6001.4 6057.1 6086.8 6142.1 6172.3 5820.6 5838.0 5859.9 5951.4 5972.6 5901.9 5911.5 5917.1 5932.4 5944.6 5580.2 5795.2 5795.9 5797.8 5799.9 5616.6 5817.8 5833.9 5860.7 5935.3 5712.8 5726.5 5726.7 5729.1 5747.5 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:70575.93 Median:36602.49 stddev:161217.13 (440.5%) stddev-sans-first:161583.43 14:10:46 INFO - PROCESS | 1636 | Values: 459.4 473.4 475.0 482.3 485.5 30106.7 31824.4 31854.4 31882.5 38740.0 39359.0 41481.8 41513.8 41558.4 41613.4 9348.8 9502.4 9527.6 9532.2 9534.4 8478.9 8714.0 9372.2 9474.1 9491.8 11268.8 11522.3 11522.9 11640.5 11650.5 11301.0 11341.8 11382.5 11417.2 11423.8 7258.8 8673.3 8695.1 11274.3 11295.5 31458.4 31732.0 38497.8 39255.6 39345.8 3307.7 3331.1 3511.6 3613.0 3813.4 28050.9 28266.4 29840.7 30284.4 30323.7 3158.9 3184.3 3212.8 3260.5 3356.3 463589.7 463746.0 464993.0 465752.0 471644.6 39880.8 47765.8 57462.4 57539.8 57670.7 50379.0 55205.7 57006.1 61451.4 64164.7 15297.8 15615.6 15636.7 15639.4 15669.7 11829.8 12072.1 12097.0 12099.9 12119.2 14257.0 14534.4 15744.7 15952.9 16220.5 5578.9 6759.7 6771.0 6791.0 6799.4 842.9 917.6 947.8 960.5 1071.1 27587.2 27679.9 28348.1 28453.6 28560.9 956.4 1043.8 1045.3 1126.3 1180.5 12060.8 14248.9 14645.3 15069.8 15111.6 597230.0 599624.0 600556.0 600905.0 604646.0 43076.9 46003.1 46776.8 52993.2 53257.0 1360.3 1375.8 1404.6 1405.0 1405.8 28181.7 28954.3 29149.4 29421.6 30287.5 47837.8 48338.5 48381.5 48460.0 48492.3 688477.0 710007.0 711628.0 718585.4 723626.0 24401.5 25123.4 25230.0 25386.0 25524.2 40123.6 44473.1 44785.8 45207.0 45730.1 36651.2 36735.1 37126.4 37152.6 38115.4 36936.0 37015.6 37309.6 38147.7 38215.3 35901.5 36409.0 36506.0 36553.8 36765.1 26652.0 29547.3 30903.4 32178.7 33089.7 23914.0 24180.4 24431.9 24980.8 25059.2 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:34510.26 Median:24367.76 stddev:96525.59 (396.1%) stddev-sans-first:96762.30 14:10:46 INFO - PROCESS | 1636 | Values: 354.4 372.1 375.9 386.8 402.8 14540.4 14569.3 15471.3 19751.3 20350.7 19234.7 19384.9 19856.3 19881.2 20070.0 5721.5 5815.9 5849.9 5874.7 5877.7 4553.6 6515.4 6587.2 6651.5 6659.7 6256.9 6481.8 6575.3 6582.3 6601.9 6505.8 6514.3 6553.2 6554.5 6563.0 5463.4 5499.0 5551.9 5554.1 5568.4 23971.8 24067.0 24098.8 24236.0 24499.5 2068.5 2230.6 2250.1 2951.5 3018.7 13676.6 14907.5 15502.4 15611.4 15627.6 1828.7 1831.2 1864.6 1892.5 1913.1 117846.6 122581.0 124578.8 126718.0 127806.4 8866.0 11163.7 11348.0 11457.4 11722.5 14484.3 14595.9 14695.9 14945.3 14997.0 8329.9 8406.6 8515.5 8567.2 8725.5 8046.8 8169.0 8187.5 8360.1 8404.1 3955.6 4363.9 4375.1 4449.2 4545.5 1886.3 1937.7 1938.5 1945.8 1949.9 769.5 903.3 925.1 932.8 940.6 19012.4 19535.4 20552.0 20568.9 20872.0 877.9 889.9 897.9 907.2 942.8 9901.7 10684.4 10691.5 10728.3 10741.9 531167.0 535581.3 536953.3 629406.0 634431.0 81670.0 133199.3 133232.0 140895.3 143771.0 944.3 964.5 1003.4 1004.9 1011.8 15089.8 17132.0 17675.6 18755.6 19085.0 54785.2 55067.7 55732.7 56917.1 57461.7 77742.6 79584.6 80160.6 81017.0 82297.6 6733.2 6825.2 7697.3 8167.6 8414.0 11377.5 12154.9 12530.7 12728.7 13182.3 10826.5 10828.3 10953.5 11248.3 11251.5 10064.8 10680.6 11018.9 11357.9 11521.3 9970.5 10714.1 11275.6 11698.0 11717.0 7180.9 7389.4 7421.7 7704.1 8241.5 10547.6 10553.2 10704.8 10980.3 11319.9 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5438.15 Median:5005.14 stddev:2982.49 (59.6%) stddev-sans-first:2974.74 14:10:46 INFO - PROCESS | 1636 | Values: 1312.4 1448.3 1477.0 1617.6 1820.0 7459.0 7842.5 8028.4 8381.6 8401.4 8212.6 8217.1 8317.8 8331.6 8333.8 2285.9 2318.2 2318.2 2320.6 2324.9 2268.3 2296.8 2304.4 2306.2 2366.0 2290.5 2293.8 2330.8 2339.6 2342.1 1978.7 2290.4 2302.1 2323.5 2327.7 2293.9 2355.1 2360.6 2363.7 2370.9 8054.3 8256.6 8331.7 8331.9 8339.2 5019.7 5214.7 5221.8 5227.1 5228.5 3354.2 3491.8 3510.0 3584.2 3586.6 1062.9 1084.0 1097.3 1098.0 1113.5 10860.4 10915.6 10976.5 10986.4 11018.7 3976.7 4432.6 4482.1 4513.5 4518.1 8461.3 8642.1 8651.4 8657.4 8662.8 4958.7 4958.8 5030.3 5074.2 5075.0 4003.1 4219.4 4373.1 4375.0 4714.2 3614.1 3634.6 3699.6 3724.1 3731.1 1107.1 1119.6 1121.9 1126.4 1146.6 791.5 875.8 892.9 922.8 929.3 5780.5 5811.9 5923.5 5933.4 6181.6 914.1 920.9 925.3 926.2 979.7 3681.0 3793.5 3829.1 3883.3 3891.5 9719.1 10209.3 10226.0 10240.7 10253.7 10172.0 10173.1 10183.3 10190.3 10201.6 7583.0 7731.0 7834.8 7882.3 7941.0 5601.2 5608.8 5632.3 5678.3 5882.7 8860.2 9005.9 9338.5 9460.1 9486.4 9386.6 9463.4 9496.6 9519.9 9643.8 7023.5 7182.6 7252.6 7318.5 7342.3 7975.3 8051.0 8133.0 8133.3 8148.1 7081.2 7162.4 7226.2 7237.5 7341.3 7064.8 7094.9 7112.0 7136.2 7149.2 6623.8 6723.3 6834.4 6843.9 6857.5 4793.6 4822.2 4838.6 4857.8 4873.0 4786.7 4884.9 4953.5 4978.6 4990.6 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4379.03 Median:4819.14 stddev:1330.38 (27.6%) stddev-sans-first:1298.37 14:10:46 INFO - PROCESS | 1636 | Values: 297.7 302.2 306.9 312.1 312.7 4556.3 5188.4 5236.6 5241.2 5285.4 4362.5 4537.4 4860.1 4886.4 5015.8 3980.8 4012.2 4021.8 4026.7 4030.6 3603.9 3803.5 3998.8 4018.7 4076.9 3877.8 3956.0 3971.7 3995.6 4006.0 3328.5 3963.8 3980.5 3982.9 4030.0 3456.3 3470.3 3491.6 3516.9 3520.3 4411.1 4743.1 4750.5 4975.9 5092.6 3574.8 3836.3 3882.9 4471.5 4583.2 4529.8 5407.1 5453.7 5460.8 5481.6 3826.1 3840.0 3841.5 3850.5 3850.9 4997.6 5406.4 5674.7 5703.1 5710.7 3198.7 3293.6 3909.6 3911.3 3918.5 3951.4 3961.6 3971.4 3974.4 3993.1 4171.5 4252.1 4361.4 4473.7 4590.6 4345.5 4769.4 5290.6 5321.6 5471.5 1264.3 1279.5 1279.8 1297.5 1299.9 832.2 848.5 849.7 850.0 850.3 4411.4 4656.5 4816.8 5168.6 5342.2 4578.6 5524.6 5609.5 5628.9 5649.8 4943.8 4993.5 5169.4 5197.5 5284.9 2457.6 2672.9 2788.2 2795.8 2810.6 5649.9 5669.5 5680.3 5683.5 5690.6 4723.6 5059.6 5382.4 5427.3 5469.4 5259.0 5398.1 5646.6 5697.5 5702.9 4780.4 4821.4 4990.4 5349.3 5350.9 4873.7 5221.0 5625.6 5642.6 5663.5 5255.5 5440.6 5743.5 6023.4 6025.7 3363.7 3642.7 3856.6 3882.5 3892.8 4655.3 5618.3 5618.7 5620.9 5626.0 4999.5 5454.6 5462.2 5470.9 5527.7 4773.4 5012.6 5097.7 5363.8 5488.4 4350.0 4490.0 5210.5 5427.3 5440.0 4789.1 5356.0 5412.4 5433.8 5455.7 4207.5 5014.7 5020.5 5385.8 5391.3 14:10:46 INFO - PROCESS | 1636 | 14:10:46 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20394.30 Median:4451.52 stddev:30430.70 (683.6%) stddev-sans-first:30480.13 14:10:46 INFO - PROCESS | 1636 | Values: 698.1 748.8 751.7 766.8 796.4 14089.8 14341.6 14744.5 14783.6 14794.1 12922.0 12995.7 13017.2 13021.8 13036.9 603.0 644.3 664.7 670.0 808.0 737.7 823.0 823.0 823.3 823.8 867.9 869.3 872.9 873.5 873.5 667.8 695.6 700.0 869.6 870.4 518.9 519.2 520.4 614.2 639.6 13828.1 13894.4 13898.2 13944.9 13950.7 10583.9 12407.4 12569.0 12709.9 13101.0 11509.8 11727.3 11953.0 11969.3 11974.7 4197.1 4303.5 4385.4 4405.0 4447.4 81823.6 87197.0 88290.1 88391.7 92251.0 10172.3 10189.9 10238.9 10249.4 10285.4 19195.7 19304.3 19336.0 19336.5 19352.9 6234.9 7189.8 7500.7 7504.0 7569.5 3924.8 4156.1 4190.7 4194.7 4314.7 3036.6 3159.4 3163.2 3165.4 3168.4 631.5 636.7 673.0 708.1 712.3 614.7 639.8 647.4 653.5 664.4 8736.3 9123.5 9262.2 9278.4 9384.6 622.2 649.4 652.1 660.8 678.3 4244.5 4455.6 4479.9 4491.2 4622.5 113113.0 115626.0 117845.0 117868.0 122979.0 71748.0 83957.0 103189.5 104746.0 106464.5 63269.4 82213.2 90020.1 91928.5 92652.1 8793.7 8825.0 8825.6 8833.6 8836.6 43596.8 47004.8 47535.3 57420.0 58334.0 62766.0 71290.3 73037.3 74381.0 74650.5 11776.4 11916.8 12312.0 12766.8 12864.7 13835.3 14139.0 14379.9 14877.6 15163.5 13279.3 13317.3 13720.5 13819.7 13859.8 12963.8 12991.0 13059.6 13435.6 13900.4 10523.8 12721.7 12739.4 12867.7 12997.0 8568.5 9881.7 10115.7 10923.8 11375.7 8490.3 9548.6 10091.8 11133.0 11193.4 14:10:46 INFO - PROCESS | 1636 | -------- Summary: end -------- 14:10:46 INFO - PROCESS | 1636 | 14:10:47 INFO - TEST-INFO | 1636: exit 0 14:10:47 INFO - TEST-OK | dromaeo_css | took 1119958ms 14:10:47 INFO - TEST-START | kraken 14:10:47 INFO - operating with platform_type : mac_ 14:10:47 INFO - Initialising browser for kraken test... 14:10:47 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmp_cFlup/profile http://localhost:49235/getInfo.html) 14:10:49 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 14:10:49 INFO - PROCESS | 1645 | colorDepth:24 14:10:49 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 14:10:49 INFO - PROCESS | 1645 | __metrics 14:10:49 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:10:49 INFO - PROCESS | 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:10:50 INFO - TEST-INFO | 1645: exit 0 14:10:50 INFO - Browser initialized. 14:10:50 INFO - Running cycle 1/1 for kraken test... 14:10:50 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmp_cFlup/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:03 INFO - PROCESS | 1646 | RSS: Main: 222351360 14:11:03 INFO - PROCESS | 1646 | 14:11:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:06 INFO - PROCESS | 1646 | RSS: Main: 272216064 14:11:06 INFO - PROCESS | 1646 | 14:11:09 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 14:11:10 INFO - PROCESS | 1646 | RSS: Main: 282861568 14:11:10 INFO - PROCESS | 1646 | 14:11:13 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 14:11:13 INFO - PROCESS | 1646 | RSS: Main: 380522496 14:11:13 INFO - PROCESS | 1646 | 14:11:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 14:11:16 INFO - PROCESS | 1646 | RSS: Main: 281931776 14:11:16 INFO - PROCESS | 1646 | 14:11:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:19 INFO - PROCESS | 1646 | RSS: Main: 284311552 14:11:19 INFO - PROCESS | 1646 | 14:11:21 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:22 INFO - PROCESS | 1646 | RSS: Main: 324308992 14:11:22 INFO - PROCESS | 1646 | 14:11:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:25 INFO - PROCESS | 1646 | RSS: Main: 326860800 14:11:25 INFO - PROCESS | 1646 | 14:11:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 14:11:29 INFO - PROCESS | 1646 | RSS: Main: 324296704 14:11:29 INFO - PROCESS | 1646 | 14:11:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:31 INFO - PROCESS | 1646 | RSS: Main: 298999808 14:11:31 INFO - PROCESS | 1646 | 14:11:33 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:33 INFO - PROCESS | 1646 | RSS: Main: 298721280 14:11:33 INFO - PROCESS | 1646 | 14:11:36 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:36 INFO - PROCESS | 1646 | RSS: Main: 301162496 14:11:36 INFO - PROCESS | 1646 | 14:11:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:40 INFO - PROCESS | 1646 | RSS: Main: 321507328 14:11:40 INFO - PROCESS | 1646 | 14:11:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:44 INFO - PROCESS | 1646 | RSS: Main: 315068416 14:11:44 INFO - PROCESS | 1646 | 14:11:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 14:11:46 INFO - PROCESS | 1646 | RSS: Main: 358522880 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | __start_tp_report 14:11:46 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:11:46 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:11:46 INFO - PROCESS | 1646 | |i|pagename|runs| 14:11:46 INFO - PROCESS | 1646 | |0;ai-astar;122;144;114;114;114;111;112;113;109;112 14:11:46 INFO - PROCESS | 1646 | |1;audio-beat-detection;145;110;112;143;107;108;139;96;165;92 14:11:46 INFO - PROCESS | 1646 | |2;audio-dft;185;182;184;184;182;183;184;186;183;184 14:11:46 INFO - PROCESS | 1646 | |3;audio-fft;81;59;60;88;63;58;60;58;83;57 14:11:46 INFO - PROCESS | 1646 | |4;audio-oscillator;87;71;94;70;69;69;89;68;69;94 14:11:46 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;87;84;88;85;87;85;88;85;87;84 14:11:46 INFO - PROCESS | 1646 | |6;imaging-darkroom;93;94;108;149;93;94;94;94;94;96 14:11:46 INFO - PROCESS | 1646 | |7;imaging-desaturate;85;81;79;82;81;83;85;84;83;84 14:11:46 INFO - PROCESS | 1646 | |8;json-parse-financial;55;54;55;53;56;57;58;57;57;57 14:11:46 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;64;72;73;80;72;70;69;71;71;71 14:11:46 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;83;83;83;84;83;83;83;82;83;98 14:11:46 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;141;140;142;139;142;142;142;141;182;150 14:11:46 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;161;166;167;175;229;191;166;166;165;162 14:11:46 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;68;69;80;83;87;85;71;66;67;65 14:11:46 INFO - PROCESS | 1646 | __end_tp_report 14:11:46 INFO - PROCESS | 1646 | __start_cc_report 14:11:46 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2082 14:11:46 INFO - PROCESS | 1646 | __end_cc_report 14:11:46 INFO - PROCESS | 1646 | __startTimestamp1482358306115__endTimestamp 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:11:46 INFO - PROCESS | 1646 | Number of tests: 14 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:116.50 Median:114.00 stddev:10.24 (9.0%) stddev-sans-first:10.67 14:11:46 INFO - PROCESS | 1646 | Values: 122.0 144.0 114.0 114.0 114.0 111.0 112.0 113.0 109.0 112.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:144.00 stddev:24.38 (16.9%) stddev-sans-first:24.35 14:11:46 INFO - PROCESS | 1646 | Values: 145.0 110.0 112.0 143.0 107.0 108.0 139.0 96.0 165.0 92.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.25 (0.7%) stddev-sans-first:1.24 14:11:46 INFO - PROCESS | 1646 | Values: 185.0 182.0 184.0 184.0 182.0 183.0 184.0 186.0 183.0 184.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.50 stddev:12.17 (19.8%) stddev-sans-first:11.75 14:11:46 INFO - PROCESS | 1646 | Values: 81.0 59.0 60.0 88.0 63.0 58.0 60.0 58.0 83.0 57.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:79.00 stddev:11.40 (14.4%) stddev-sans-first:11.62 14:11:46 INFO - PROCESS | 1646 | Values: 87.0 71.0 94.0 70.0 69.0 69.0 89.0 68.0 69.0 94.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 14:11:46 INFO - PROCESS | 1646 | Values: 87.0 84.0 88.0 85.0 87.0 85.0 88.0 85.0 87.0 84.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:94.00 stddev:17.48 (18.6%) stddev-sans-first:18.31 14:11:46 INFO - PROCESS | 1646 | Values: 93.0 94.0 108.0 149.0 93.0 94.0 94.0 94.0 94.0 96.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:82.70 Median:83.50 stddev:1.95 (2.3%) stddev-sans-first:1.88 14:11:46 INFO - PROCESS | 1646 | Values: 85.0 81.0 79.0 82.0 81.0 83.0 85.0 84.0 83.0 84.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.60 (2.8%) stddev-sans-first:1.66 14:11:46 INFO - PROCESS | 1646 | Values: 55.0 54.0 55.0 53.0 56.0 57.0 58.0 57.0 57.0 57.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.95 (5.5%) stddev-sans-first:3.18 14:11:46 INFO - PROCESS | 1646 | Values: 64.0 72.0 73.0 80.0 72.0 70.0 69.0 71.0 71.0 71.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.00 stddev:4.77 (5.7%) stddev-sans-first:5.02 14:11:46 INFO - PROCESS | 1646 | Values: 83.0 83.0 83.0 84.0 83.0 83.0 83.0 82.0 83.0 98.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:142.00 stddev:12.96 (9.1%) stddev-sans-first:13.61 14:11:46 INFO - PROCESS | 1646 | Values: 141.0 140.0 142.0 139.0 142.0 142.0 142.0 141.0 182.0 150.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:166.50 stddev:20.93 (12.6%) stddev-sans-first:21.60 14:11:46 INFO - PROCESS | 1646 | Values: 161.0 166.0 167.0 175.0 229.0 191.0 166.0 166.0 165.0 162.0 14:11:46 INFO - PROCESS | 1646 | 14:11:46 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:75.50 stddev:8.63 (11.4%) stddev-sans-first:8.87 14:11:46 INFO - PROCESS | 1646 | Values: 68.0 69.0 80.0 83.0 87.0 85.0 71.0 66.0 67.0 65.0 14:11:46 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:11:46 INFO - PROCESS | 1646 | 14:11:47 INFO - TEST-INFO | 1646: exit 0 14:11:47 INFO - TEST-OK | kraken | took 60056ms 14:11:47 INFO - SUITE-END | took 1180s 14:11:47 INFO - Completed test suite (00:19:40) 14:11:47 INFO - javascript benchmark 14:11:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.786618869773, 3307.570015897933, 3322.634510203877, 3334.199792049909, 3339.4823802310652, 5489.313835770528, 5536.640118392302, 5538.833834984946, 5566.332040155177, 5586.91619625706, 5447.319085114361, 5546.389897111325, 5557.666540007603, 5565.554755619551, 5592.692401917893, 5053.494650534944, 5056.3173971513925, 5071.898562028758, 5165.922511162316, 5182.559482443997, 5039.823606173784, 5042.974785126069, 5053.0, 5080.720560369196, 5114.335136432277, 4718.693284936486, 4775.928361074587, 5112.437631860493, 5150.845474635748, 5183.144781111112, 5157.690538567698, 5173.715445650488, 5174.922376164361, 5177.689338639693, 5212.739363031871, 4945.085159245551, 4996.150654388763, 5096.235564665293, 5119.59043276537, 5138.3577052868395, 4135.793210339471, 5453.045716999509, 5480.890382192374, 5494.0, 5564.4991950724225, 5971.492423144038, 5993.6403815770755, 5998.1602575639445, 6002.399760023963, 6073.058675905242, 5801.941980580183, 6148.6618235997, 6150.692465376758, 6171.074338849208, 6177.166082578839, 5459.153831156217, 5559.916601250984, 5613.859653508695, 5623.044082505984, 5632.690202038845, 6273.404026617464, 6278.748850046039, 6288.402601752826, 6313.842153946188, 6325.588836725598, 5905.8954026951715, 5929.407059294036, 5932.466078052996, 5956.315023772235, 5974.551908606785, 5894.852628684232, 5963.045912654041, 5964.761409543657, 5977.282726072812, 6017.518598512109, 5982.850428739229, 6002.249718785152, 6005.249343832021, 6035.0, 6044.365341639064, 6017.398260174035, 6039.939600604026, 6055.878882422327, 6077.969610151921, 6100.0, 4690.9765451172525, 4728.834490792806, 4746.0, 4797.304390863305, 4819.903601927942, 4224.176285624274, 4274.636655884223, 4298.677599180074, 4304.246756817544, 4372.409724687126, 5760.769569217268, 5763.942360576424, 5766.826995190151, 5785.8553536161935, 5785.971070144707, 6145.324014358417, 6151.3541078187045, 6165.260168779685, 6165.445109940127, 6165.568410211332, 5600.635958662674, 5613.550915926716, 5659.151127330851, 5694.601377903507, 5742.827715168552, 5255.76349064293, 5287.286216360819, 5303.734813259399, 5320.946790532045, 5333.43998880112, 6299.338569450233, 6301.936980630135, 6314.147590075373, 6315.621062736251, 6327.272363678052, 5753.971230143822, 5878.617889837147, 6105.419985101408, 6148.200733904564, 6159.322474527708, 6238.906416403848, 6309.905351419824, 6317.147185129948, 6327.651979141191, 6338.524610654312, 6017.729202185999, 6027.849303767441, 6034.517238620812, 6036.547258955684, 6057.130318565211, 6001.4298641628975, 6057.121717350871, 6086.80082364288, 6142.069075791408, 6172.321044684992, 5820.563457740771, 5838.007538718343, 5859.945209862266, 5951.434613711691, 5972.581919265784, 5901.940980590311, 5911.467967882912, 5917.082852157922, 5932.436418540232, 5944.64332140073, 5580.1629755537, 5795.188673585786, 5795.942040579709, 5797.826065218051, 5799.8550036249435, 5616.578756593353, 5817.825465236049, 5833.883322333445, 5860.736266867916, 5935.34711181761, 5712.7714891403875, 5726.455986681259, 5726.713664316684, 5729.140628905698, 5747.48272655463], "value": 5558.04766930911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.4394838297277, 473.38696388177317, 474.97642580239597, 482.32233711635143, 485.50236008091724, 30106.698933010663, 31824.36351272973, 31854.36291274176, 31882.52176217353, 38740.0, 39359.0, 41481.792591037076, 41513.79243103788, 41558.37662435066, 41613.375799363035, 9348.766280843, 9502.429854208734, 9527.571259293314, 9532.18976387008, 9534.380265282769, 8478.915210847874, 8714.041455439896, 9372.203362714177, 9474.147326740593, 9491.762705932373, 11268.774624507505, 11522.251053681526, 11522.942385288105, 11640.476178571984, 11650.533978640886, 11301.0, 11341.829872551918, 11382.487788049557, 11417.200795944287, 11423.82864257041, 7258.782236532912, 8673.306135509145, 8695.130486951255, 11274.323540587591, 11295.548178072868, 31458.37083258322, 31732.0, 38497.80751096254, 39255.60744392548, 39345.80327098375, 3307.702306792376, 3331.1172539277113, 3511.578610566723, 3612.981935090334, 3813.3531893770164, 28050.859745701346, 28266.43467130646, 29840.70159298401, 30284.394312113633, 30323.69676303231, 3158.8578513966927, 3184.251700850298, 3212.8232947187894, 3260.5272235525717, 3356.345512625039, 463589.6820515943, 463746.0, 464993.0, 465752.0, 471644.64177679236, 39880.80059599742, 47765.761171193924, 57462.42537574654, 57539.84920301654, 57670.7116464415, 50379.0, 55205.72397138069, 57006.14490782641, 61451.38548614546, 64164.716705665625, 15297.847021529642, 15615.609609759847, 15636.687266254612, 15639.357867423983, 15669.686606267811, 11829.822552661717, 12072.094592905392, 12097.032237420985, 12099.939500302442, 12119.212251203644, 14257.0, 14534.418623254951, 15744.685106298039, 15952.92023539898, 16220.51338459848, 5578.944210557924, 6759.695813688396, 6771.0, 6791.030601125717, 6799.422049125781, 842.9409941304173, 917.559571405729, 947.8436058050482, 960.4765402855461, 1071.0842229893485, 27587.172384828085, 27679.861600691867, 28348.149555513366, 28453.628731806584, 28560.85719571389, 956.3735753081743, 1043.8225501664735, 1045.2979049158012, 1126.2904370246856, 1180.5100883133402, 12060.819087713691, 14248.85751142496, 14645.267736613127, 15069.773953390708, 15111.622209444631, 597230.0, 599624.0, 600556.0, 600905.0, 604646.0, 43076.923076923325, 46003.079938401046, 46776.766116169885, 52993.2051019235, 53257.0, 1360.31984007996, 1375.7936309553647, 1404.6207523968676, 1404.985950140506, 1405.7891316302637, 28181.71818281791, 28954.276143095747, 29149.417011660073, 29421.558676620298, 30287.545686814276, 47837.76081119572, 48338.5166148334, 48381.5161848377, 48460.0, 48492.2726159115, 688477.0, 710007.0, 711628.0, 718585.4070729822, 723626.0, 24401.535907845588, 25123.371915702253, 25230.0, 25386.0, 25524.23427297184, 40123.59876401316, 44473.11053778971, 44785.776071119435, 45207.0, 45730.08539829251, 36651.15909576119, 36735.08162295964, 37126.44310335293, 37152.628473715995, 38115.42826857655, 36936.0, 37015.629843701216, 37309.62690373061, 38147.664831730755, 38215.28031238657, 35901.461478077326, 36409.0, 36506.0, 36553.81723091367, 36765.08087297732, 26652.0, 29547.261318467212, 30903.38193236078, 32178.67821321757, 33089.66910330962, 23914.0, 24180.39549011289, 24431.900564474287, 24980.75019249857, 25059.248222553353], "value": 19175.550449901326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.3639167693989, 372.09580718853175, 375.90226541099315, 386.82012864018236, 402.8207447685779, 14540.41838326467, 14569.344379502922, 15471.303791329403, 19751.308704195355, 20350.69473957888, 19234.711479327787, 19384.90307548464, 19856.305029323976, 19881.20475180991, 20070.0, 5721.513671337942, 5815.883682326351, 5849.941500585003, 5874.70626468677, 5877.70611469427, 4553.612942899841, 6515.446187074081, 6587.176602924635, 6651.534392592521, 6659.700313485905, 6256.906146407808, 6481.805545833632, 6575.309592492791, 6582.275949645536, 6601.867962640745, 6505.804825855232, 6514.315996820336, 6553.180852393451, 6554.508411869081, 6563.0, 5463.3717122530625, 5498.9826882026955, 5551.8889622207735, 5554.0835762099205, 5568.387477377485, 23971.76028239713, 24067.0, 24098.759012409828, 24236.0, 24499.510009799884, 2068.4621998280404, 2230.631945728969, 2250.088714070804, 2951.4982452983045, 3018.713222243883, 13676.589702308947, 14907.478238261718, 15502.379904803907, 15611.3755449783, 15627.609309767233, 1828.7165489349172, 1831.230883029131, 1864.6363959027994, 1892.4890279624424, 1913.0817207740224, 117846.64306713988, 122581.0, 124578.75421245763, 126718.0, 127806.36096819457, 8866.0, 11163.665090047312, 11348.0, 11457.369844658457, 11722.47607810979, 14484.275786210648, 14595.85404145945, 14695.926520367544, 14945.327460264314, 14997.025193362397, 8329.875051874105, 8406.621702023423, 8515.48907065578, 8567.18611731897, 8725.476471411735, 8046.758597242092, 8168.959155204186, 8187.5087494750505, 8360.122187170382, 8404.07555168931, 3955.624215699504, 4363.865394997323, 4375.096832877708, 4449.221386257392, 4545.477270113913, 1886.3209244671907, 1937.651222779913, 1938.4766113149371, 1945.7762357328804, 1949.8927558984108, 769.4690663442207, 903.3315346643436, 925.1257561604219, 932.8274269260073, 940.6425558287943, 19012.429627111207, 19535.413937581896, 20551.97240137987, 20568.897155514125, 20872.0, 877.8946526416743, 889.9065598112235, 897.8742975983367, 907.1744712311764, 942.7501712046313, 9901.653442129491, 10684.358938463716, 10691.465426728633, 10728.302660327054, 10741.89258107409, 531167.0, 535581.3220933948, 536953.3152334292, 629406.0, 634431.0, 81670.0, 133199.34405247556, 133232.0, 140895.29552352172, 143771.0, 944.2917811641269, 964.508100868548, 1003.4180175498047, 1004.929654924163, 1011.8330475471465, 15089.849101508844, 17132.0, 17675.558111047325, 18755.6248875019, 19085.0, 54785.1782223259, 55067.695938243836, 55732.72133639306, 56917.14624280556, 57461.712691436274, 77742.6112869432, 79584.60207698925, 80160.59919700364, 81017.0, 82297.58851205706, 6733.158355205599, 6825.215100263533, 7697.345725613161, 8167.591620418836, 8414.0, 11377.54489820398, 12154.939225303817, 12530.686732831753, 12728.6817829555, 13182.274974876475, 10826.458677065957, 10828.296160749525, 10953.452327383759, 11248.325100493996, 11251.549938002388, 10064.84902726445, 10680.57277708883, 11018.889811101786, 11357.886421135683, 11521.308721476738, 9970.451625160686, 10714.089302409071, 11275.605353812578, 11698.022672291461, 11717.0, 7180.856382872418, 7389.445791565761, 7421.666025028994, 7704.075510938723, 8241.464304820167, 10547.630832920811, 10553.208509361675, 10704.785904281714, 10980.341179529254, 11319.943400282946], "value": 9578.977250429276, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.3897387714724, 1448.29033773451, 1476.9704605907882, 1617.6360318928243, 1820.035381247939, 7458.962705186474, 7842.451028428005, 8028.438009339341, 8381.580920953944, 8401.41190116692, 8212.589370531465, 8217.055038670554, 8317.83364332713, 8331.583420828965, 8333.791655208623, 2285.874276914765, 2318.1654604342425, 2318.2002209237785, 2320.570694421529, 2324.8721320327377, 2268.296827983322, 2296.7588403217674, 2304.4008557775014, 2306.1582522379294, 2366.0299277296313, 2290.541891621674, 2293.7706229377013, 2330.766923307664, 2339.578875802355, 2342.074880422232, 1978.7130866024418, 2290.381596968809, 2302.067662596651, 2323.5004474038165, 2327.7439481657, 2293.8738369389675, 2355.081518207883, 2360.6426304874767, 2363.6572696958847, 2370.9407264818346, 8054.315383192436, 8256.628451719687, 8331.66673333066, 8331.916680833174, 8339.249467547888, 5019.698818070891, 5214.713190774506, 5221.791128354861, 5227.137522308814, 5228.503292187236, 3354.1614596350914, 3491.7555771096036, 3509.982450087733, 3584.229390681016, 3586.6413358664186, 1062.9362238265728, 1083.9729006774894, 1097.314178638351, 1097.9615713449991, 1113.5156207049959, 10860.402677852715, 10915.617953371673, 10976.451177441177, 10986.395748233845, 11018.669439916815, 3976.681865450757, 4432.556744325541, 4482.125985432875, 4513.458384993822, 4518.141553104965, 8461.2807911327, 8642.135786421433, 8651.394402391898, 8657.350698697623, 8662.783430414163, 4958.677685950402, 4958.826441074617, 5030.346055012825, 5074.188129899198, 5074.974625126851, 4003.139325045129, 4219.430376899079, 4373.125374925028, 4374.978125109354, 4714.22215334466, 3614.0964758810296, 3634.5638523377365, 3699.5930447650735, 3724.1062145084984, 3731.104534911656, 1107.1364335818075, 1119.6249256499163, 1121.8541589593465, 1126.3748619516248, 1146.621614867092, 791.4934441957153, 875.7810547363159, 892.9107089291019, 922.8477301245354, 929.3401684803865, 5780.479756821906, 5811.854703632358, 5923.466887980103, 5933.436323549256, 6181.629102253879, 914.1087439746194, 920.9125133112477, 925.250547056886, 926.1710768861831, 979.7305740921161, 3680.9815950920074, 3793.5447746270074, 3829.1384438501673, 3883.262180185756, 3891.5330160380936, 9719.125278724807, 10209.285350025428, 10226.028527289896, 10240.692779216635, 10253.692389228336, 10172.0, 10173.135283500986, 10183.33808302458, 10190.286679932333, 10201.642942496977, 7582.962085189649, 7730.96134519335, 7834.804129896685, 7882.330001949898, 7940.967674202432, 5601.24383208278, 5608.831735047955, 5632.295963004624, 5678.290213723285, 5882.735276912635, 8860.202581767671, 9005.864912026194, 9338.486383248715, 9460.053994600485, 9486.383385079947, 9386.5776040077, 9463.432194068379, 9496.620135194515, 9519.904800951901, 9643.758906027124, 7023.543469674455, 7182.60495672743, 7252.637368131678, 7318.487705860539, 7342.302481264272, 7975.282224599814, 8051.033875934925, 8133.024037115584, 8133.308668763221, 8148.103708592169, 7081.18566364854, 7162.391196748126, 7226.168990565942, 7237.529560578546, 7341.302576255247, 7064.752733654297, 7094.858102838018, 7112.004319395185, 7136.179339376038, 7149.177844547944, 6623.834404139935, 6723.327667233433, 6834.419074378733, 6843.931560684528, 6857.5199736018, 4793.592544633745, 4822.156122678447, 4838.637102217418, 4857.757112144449, 4873.0, 4786.664933454625, 4884.90230195387, 4953.455119936732, 4978.626603004862, 4990.577685359655], "value": 4400.780179061001, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6904019819388, 302.21424296828235, 306.89412152807273, 312.07158702859, 312.7404254468791, 4556.27099664053, 5188.377394712635, 5236.633435659496, 5241.240020197074, 5285.365756109268, 4362.476502819666, 4537.387452693885, 4860.076585448771, 4886.413630364353, 5015.799368025275, 3980.765962551604, 4012.2376748417855, 4021.77880216588, 4026.71812973092, 4030.556638769733, 3603.9099022524383, 3803.5055442792536, 3998.760074395531, 4018.6985976051765, 4076.857309994136, 3877.8448862045484, 3955.9604403956023, 3971.7418367806144, 3995.60043995601, 4006.038550747814, 3328.4508056170826, 3963.7621742695533, 3980.467520004819, 3982.880513584597, 4029.9798501007454, 3456.3087382523595, 3470.340635279289, 3491.5635545556806, 3516.9120771980647, 3520.295940811822, 4411.051623900877, 4743.146233677937, 4750.477447480775, 4975.900481990376, 5092.618053645954, 3574.803385813779, 3836.3120227099985, 3882.941755873664, 4471.485779135376, 4583.243764778807, 4529.7735113244535, 5407.107827208545, 5453.727313634342, 5460.836174914759, 5481.643693159932, 3826.0921699508294, 3839.9616003839883, 3841.481400010991, 3850.4994350734505, 3850.8652197172964, 4997.600191984632, 5406.405295417501, 5674.687892165888, 5703.116017017369, 5710.657995371084, 3198.7441004719567, 3293.604767427876, 3909.58949310324, 3911.2764138634443, 3918.490596222473, 3951.4194322270746, 3961.603839616015, 3971.4439978403047, 3974.4038394241097, 3993.1414745829784, 4171.451968881381, 4252.128313695685, 4361.3676016978, 4473.680264322033, 4590.586847183769, 4345.500267469219, 4769.403824521934, 5290.603204759658, 5321.6163797412955, 5471.50756431923, 1264.2667252993242, 1279.4754150798128, 1279.7696414645268, 1297.4874924404996, 1299.9025073119365, 832.2260297922869, 848.4909054567211, 849.7450764770545, 849.9872501912477, 850.2951582078018, 4411.411891718979, 4656.4645065817185, 4816.831410900601, 5168.560672342818, 5342.171963345688, 4578.5650363215445, 5524.58565607581, 5609.49514543693, 5628.887422251532, 5649.774009039593, 4943.752812359367, 4993.50064993505, 5169.405518365361, 5197.532222100029, 5284.947150528523, 2457.640664961657, 2672.906448274301, 2788.177487641151, 2795.8042936994216, 2810.6205662235743, 5649.853055838755, 5669.489745922887, 5680.318361796611, 5683.460071293221, 5690.573207009491, 4723.622110231242, 5059.6353424971985, 5382.3541175059245, 5427.294451721251, 5469.425710300441, 5258.999999999924, 5398.1362981923485, 5646.571974051198, 5697.515711164598, 5702.942970570241, 4780.378550788375, 4821.445533763662, 4990.351254336913, 5349.314965785765, 5350.889900145274, 4873.707577545359, 5221.008008478377, 5625.606207565595, 5642.576806739593, 5663.518600918803, 5255.500727430888, 5440.646357986719, 5743.4543718346695, 6023.36754640774, 6025.698715064317, 3363.6972672459597, 3642.653947874948, 3856.5564960029956, 3882.514685664292, 3892.766434013968, 4655.299037265315, 5618.269624948731, 5618.6628802272, 5620.887582248414, 5626.0, 4999.500049995117, 5454.645448045864, 5462.180672899097, 5470.878469913579, 5527.668339899619, 4773.37946067009, 5012.616483873298, 5097.6941383517105, 5363.785448582169, 5488.368837583569, 4349.956500435082, 4489.981466587451, 5210.45290244534, 5427.267318912054, 5440.028778991279, 4789.114013907439, 5355.991503186305, 5412.431694672003, 5433.8369848904595, 5455.727213639381, 4207.537170911259, 5014.674046186986, 5020.472850350807, 5385.818743408769, 5391.29913111293], "value": 3957.299080857492, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.1343134513205, 748.7603966730642, 751.6504825256254, 766.7508059880538, 796.4385108498508, 14089.788653170197, 14341.641458963531, 14744.483943061994, 14783.630409239775, 14794.112353258812, 12922.0, 12995.675108122301, 13017.153884997491, 13021.804672929913, 13036.869631303683, 602.9517638588902, 644.3073695777035, 664.7141729056503, 670.0485310858593, 807.9515229086244, 737.6938570493239, 822.9876551851727, 823.0329362998483, 823.2549542663869, 823.7775800533852, 867.8524650809346, 869.2611280411631, 872.8734333521636, 873.458455757428, 873.52829472085, 667.8330417395651, 695.6382681005899, 699.9510034297601, 869.5739087846941, 870.4298684361753, 518.8625014371195, 519.210799584633, 520.3755493407888, 614.2260751453157, 639.6034458635629, 13828.101173423694, 13894.444222231099, 13898.16611003343, 13944.930275348659, 13950.720985580232, 10583.894161058368, 12407.379631018413, 12568.994480441634, 12709.936450317782, 13101.039027242581, 11509.827352589718, 11727.296362218294, 11953.0, 11969.341686207255, 11974.700632484171, 4197.118605092935, 4303.526612072669, 4385.407969924051, 4405.015916077959, 4447.421835161441, 81823.5908820452, 87196.99999999936, 88290.11709882884, 88391.67412488817, 92251.0, 10172.287939844287, 10189.949050254849, 10238.897611023795, 10249.38503689781, 10285.382877027403, 19195.712064319046, 19304.32434864773, 19336.0, 19336.516587085436, 19352.903235483733, 6234.937650623527, 7189.784306470814, 7500.662470188855, 7504.0, 7569.545827250383, 3924.7841368724994, 4156.106437115974, 4190.727602705814, 4194.706370554093, 4314.697971142053, 3036.5900603418254, 3159.4470967580583, 3163.225009872596, 3165.414398336315, 3168.350488149924, 631.5105793010362, 636.7071147272306, 672.9697163627649, 708.0794966543576, 712.3055021354241, 614.658864330301, 639.8432384065934, 647.3720491123603, 653.5163978655855, 664.3721683009607, 8736.301095912311, 9123.543822808833, 9262.212711919563, 9278.350515463853, 9384.577694003787, 622.2315440431064, 649.4187702006772, 652.116382301974, 660.8050625065617, 678.3149019490351, 4244.469441319835, 4455.6212721919, 4479.8800299925015, 4491.236489796743, 4622.537746225351, 113113.0, 115626.0, 117845.0, 117868.0, 122979.0, 71748.0, 83957.0, 103189.48405258075, 104746.0, 106464.46767766112, 63269.367306327265, 82213.17786822055, 90020.09979900117, 91928.54035729778, 92652.07347926569, 8793.692220772242, 8825.0, 8825.602847871733, 8833.602487887933, 8836.558172091498, 43596.78201608972, 47004.7649761749, 47535.286970694775, 57420.0, 58334.0, 62766.0, 71290.28709712837, 73037.26962730305, 74381.0, 74650.52096874204, 11776.352300623204, 11916.842036860065, 12312.0, 12766.758662378907, 12864.742705145658, 13835.308234588028, 14139.0, 14379.928100359431, 14877.553673389815, 15163.469278575198, 13279.269640169883, 13317.334133293103, 13720.45118195261, 13819.654508637364, 13859.792103118663, 12963.805542916674, 12991.0, 13059.608211753663, 13435.596932092052, 13900.443982241002, 10523.78952420932, 12721.745565088462, 12739.426725797546, 12867.742645147231, 12996.960243180334, 8568.485890846569, 9881.654142104991, 10115.696529104138, 10923.83614245771, 11375.715607109889, 8490.278326342082, 9548.618055277711, 10091.79816403653, 11133.0, 11193.440327983732], "value": 7155.039417928834, "unit": "score"}], "name": "dromaeo_css", "value": 7091.905503123187, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 144.0, 114.0, 114.0, 114.0, 111.0, 112.0, 113.0, 109.0, 112.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 112.0, 143.0, 107.0, 108.0, 139.0, 96.0, 165.0, 92.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 184.0, 184.0, 182.0, 183.0, 184.0, 186.0, 183.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 88.0, 63.0, 58.0, 60.0, 58.0, 83.0, 57.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 94.0, 70.0, 69.0, 69.0, 89.0, 68.0, 69.0, 94.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 85.0, 87.0, 85.0, 88.0, 85.0, 87.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 108.0, 149.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 79.0, 82.0, 81.0, 83.0, 85.0, 84.0, 83.0, 84.0], "value": 82.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 56.0, 57.0, 58.0, 57.0, 57.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 73.0, 80.0, 72.0, 70.0, 69.0, 71.0, 71.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 83.0, 82.0, 83.0, 98.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 142.0, 139.0, 142.0, 142.0, 142.0, 141.0, 182.0, 150.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 167.0, 175.0, 229.0, 191.0, 166.0, 166.0, 165.0, 162.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 80.0, 83.0, 87.0, 85.0, 71.0, 66.0, 67.0, 65.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1442.8999999999996, "alertThreshold": 2.0}]} 14:11:47 INFO - Return code: 0 14:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:47 INFO - # TBPL SUCCESS # 14:11:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:47 INFO - 2016-12-21 14:11:47.443 screenresolution[1650:9919] starting screenresolution argv=screenresolution get 14:11:47 INFO - 2016-12-21 14:11:47.445 screenresolution[1650:9919] Display 0: 1600x1200x32@60 14:11:47 INFO - 2016-12-21 14:11:47.452 screenresolution[1651:9922] starting screenresolution argv=screenresolution list 14:11:47 INFO - Available Modes on Display 0 14:11:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:47 INFO - Intel Iris: 14:11:47 INFO - Chipset Model: Intel Iris 14:11:47 INFO - Type: GPU 14:11:47 INFO - Bus: Built-In 14:11:47 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:47 INFO - Vendor: Intel (0x8086) 14:11:47 INFO - Device ID: 0x0a2e 14:11:47 INFO - Revision ID: 0x0009 14:11:47 INFO - Displays: 14:11:47 INFO - Display: 14:11:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:47 INFO - Display Serial Number: 1600x1200 60 14:11:47 INFO - Main Display: Yes 14:11:47 INFO - Mirror: Off 14:11:47 INFO - Online: Yes 14:11:47 INFO - Rotation: Supported 14:11:47 INFO - Return code: 0 14:11:47 INFO - Running post-action listener: _resource_record_post_action 14:11:47 INFO - [mozharness: 2016-12-21 22:11:47.701501Z] Finished run-tests step (success) 14:11:47 INFO - Running post-run listener: _resource_record_post_run 14:11:47 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38749184; Write bytes: 658468864; Read time: 410; Write time: 2037 14:11:47 INFO - TinderboxPrint: CPU usage
53.5% 14:11:47 INFO - TinderboxPrint: I/O read bytes / time
38,749,184 / 410 14:11:47 INFO - TinderboxPrint: I/O write bytes / time
658,468,864 / 2,037 14:11:47 INFO - TinderboxPrint: CPU idle
2,253.1 (46.5%) 14:11:47 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 14:11:47 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 14:11:47 INFO - TinderboxPrint: Swap in / out
387,309,568 / 0 14:11:47 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344363520; Write bytes: 344696832; Read time: 26854; Write time: 602 14:11:47 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36779008; Write bytes: 305508864; Read time: 390; Write time: 1375 14:11:48 INFO - Running post-run listener: _upload_blobber_files 14:11:48 INFO - Blob upload gear active. 14:11:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:48 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:11:48 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:11:48 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:11:48 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:49 INFO - (blobuploader) - INFO - Done attempting. 14:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:50 INFO - (blobuploader) - INFO - Done attempting. 14:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:54 INFO - (blobuploader) - INFO - Done attempting. 14:11:54 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:54 INFO - Return code: 0 14:11:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7f6d0bceaeea1d26ce4bc279f1851823ac367586a0f93f0c26dd19269b7d8a884e490014fa0d8ad94df8763eaa3b42ff8a38f7e830353262a52897b805519bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e0208dbfc69cc74293b5c71640479ee386046bd43a73a1d1c84ea3f7c2107e08d389be6a1802b159cb1f3ddf0ecb28ef01ff919ba2fbb5a24a5fead0c96ace6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/115ae786914933f4bd2dd4b6f6bc9c2547d79fe4d1c23006ad2ae1e317260977d09808945e8f2af2847603150eda78a6e8cc5242440f0e939bd95775f7bb0a90"} 14:11:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:54 INFO - Contents: 14:11:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7f6d0bceaeea1d26ce4bc279f1851823ac367586a0f93f0c26dd19269b7d8a884e490014fa0d8ad94df8763eaa3b42ff8a38f7e830353262a52897b805519bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e0208dbfc69cc74293b5c71640479ee386046bd43a73a1d1c84ea3f7c2107e08d389be6a1802b159cb1f3ddf0ecb28ef01ff919ba2fbb5a24a5fead0c96ace6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/115ae786914933f4bd2dd4b6f6bc9c2547d79fe4d1c23006ad2ae1e317260977d09808945e8f2af2847603150eda78a6e8cc5242440f0e939bd95775f7bb0a90"} 14:11:54 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:54 INFO - Copying logs to upload dir... 14:11:54 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.311484 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-21 14:11:54.430571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 14:11:54.434181) ========= 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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7f6d0bceaeea1d26ce4bc279f1851823ac367586a0f93f0c26dd19269b7d8a884e490014fa0d8ad94df8763eaa3b42ff8a38f7e830353262a52897b805519bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e0208dbfc69cc74293b5c71640479ee386046bd43a73a1d1c84ea3f7c2107e08d389be6a1802b159cb1f3ddf0ecb28ef01ff919ba2fbb5a24a5fead0c96ace6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/115ae786914933f4bd2dd4b6f6bc9c2547d79fe4d1c23006ad2ae1e317260977d09808945e8f2af2847603150eda78a6e8cc5242440f0e939bd95775f7bb0a90"} build_url:https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010913 build_url: 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7f6d0bceaeea1d26ce4bc279f1851823ac367586a0f93f0c26dd19269b7d8a884e490014fa0d8ad94df8763eaa3b42ff8a38f7e830353262a52897b805519bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e0208dbfc69cc74293b5c71640479ee386046bd43a73a1d1c84ea3f7c2107e08d389be6a1802b159cb1f3ddf0ecb28ef01ff919ba2fbb5a24a5fead0c96ace6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/115ae786914933f4bd2dd4b6f6bc9c2547d79fe4d1c23006ad2ae1e317260977d09808945e8f2af2847603150eda78a6e8cc5242440f0e939bd95775f7bb0a90"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 14:11:54.468467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:11:54.468800) ========= 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.lF8V0YVhcP/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.0fCUnSXOsc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005255 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:11:54.517691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 14:11:54.518046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 14:11:54.518364) ========= ========= Total master_lag: 0.18 =========