builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0269 starttime: 1481036720.68 results: success (0) buildid: 20161206055938 builduid: 819d402fe0b645bc8a0d487346a45582 revision: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:20.678409) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:20.678812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:20.679104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:20.707238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:20.707519) ========= 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.qXMMSeYnkJ/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.B0G952zSXe/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-06 07:05:20-- 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% 18.6M=0.001s 2016-12-06 07:05:21 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.630800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:21.361887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:21.362210) ========= 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.qXMMSeYnkJ/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.B0G952zSXe/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.025271 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:21.410767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-06 07:05:21.411144) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48a4769a75a5d459dd86c4a1a2f9babb75c9eede --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 48a4769a75a5d459dd86c4a1a2f9babb75c9eede --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qXMMSeYnkJ/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.B0G952zSXe/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-06 07:05:21,507 truncating revision to first 12 chars 2016-12-06 07:05:21,507 Setting DEBUG logging. 2016-12-06 07:05:21,507 attempt 1/10 2016-12-06 07:05:21,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/48a4769a75a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-06 07:05:22,224 unpacking tar archive at: mozilla-aurora-48a4769a75a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.983947 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-06 07:05:22.418578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:22.419044) ========= script_repo_revision: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:22.419431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:22.419703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 07:05:22.438948) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-06 07:05:22.439302) ========= /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.qXMMSeYnkJ/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.B0G952zSXe/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:05:22 INFO - MultiFileLogger online at 20161206 07:05:22 in /builds/slave/test 07:05:22 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 07:05:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:22 INFO - {'append_to_log': False, 07:05:22 INFO - 'base_work_dir': '/builds/slave/test', 07:05:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:05:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:22 INFO - 'branch': 'Mozilla-Aurora', 07:05:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:22 INFO - 'config_files': ('talos/mac_config.py',), 07:05:22 INFO - 'default_actions': ('clobber', 07:05:22 INFO - 'read-buildbot-config', 07:05:22 INFO - 'download-and-extract', 07:05:22 INFO - 'populate-webroot', 07:05:22 INFO - 'create-virtualenv', 07:05:22 INFO - 'install', 07:05:22 INFO - 'run-tests'), 07:05:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:22 INFO - 'download_minidump_stackwalk': True, 07:05:22 INFO - 'download_symbols': 'ondemand', 07:05:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:22 INFO - 'installer_path': 'installer.exe', 07:05:22 INFO - 'log_level': 'info', 07:05:22 INFO - 'log_name': 'talos', 07:05:22 INFO - 'log_to_console': True, 07:05:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:05:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:05:22 INFO - 'opt_config_files': (), 07:05:22 INFO - 'pip_index': False, 07:05:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:22 INFO - 'cmd': ('bash', 07:05:22 INFO - '-c', 07:05:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:22 INFO - 'enabled': True, 07:05:22 INFO - 'halt_on_failure': False, 07:05:22 INFO - 'name': 'check_screen_resolution'},), 07:05:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:05:22 INFO - 'cmd': ('bash', 07:05:22 INFO - '-c', 07:05:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:05:22 INFO - 'enabled': True, 07:05:22 INFO - 'halt_on_failure': False, 07:05:22 INFO - 'name': 'check_screen_resolution'},), 07:05:22 INFO - 'run_cmd_checks_enabled': True, 07:05:22 INFO - 'sps_profile': False, 07:05:22 INFO - 'sps_profile_interval': 0, 07:05:22 INFO - 'suite': 'dromaeojs', 07:05:22 INFO - 'system_bits': '32', 07:05:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:22 INFO - 'title': 't-yosemite-r7-0269', 07:05:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:22 INFO - 'use_talos_json': True, 07:05:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:22 INFO - 'work_dir': 'build'} 07:05:22 INFO - [mozharness: 2016-12-06 15:05:22.644153Z] Running clobber step. 07:05:22 INFO - Running pre-action listener: _resource_record_pre_action 07:05:22 INFO - Running main action method: clobber 07:05:22 INFO - rmtree: /builds/slave/test/build 07:05:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:24 INFO - Running post-action listener: _resource_record_post_action 07:05:24 INFO - [mozharness: 2016-12-06 15:05:24.945685Z] Finished clobber step (success) 07:05:24 INFO - [mozharness: 2016-12-06 15:05:24.945831Z] Running read-buildbot-config step. 07:05:24 INFO - Running pre-action listener: _resource_record_pre_action 07:05:24 INFO - Running main action method: read_buildbot_config 07:05:24 INFO - Using buildbot properties: 07:05:24 INFO - { 07:05:24 INFO - "project": "", 07:05:24 INFO - "product": "firefox", 07:05:24 INFO - "script_repo_revision": "production", 07:05:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:05:24 INFO - "repository": "", 07:05:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:05:24 INFO - "buildid": "20161206055938", 07:05:24 INFO - "pgo_build": "False", 07:05:24 INFO - "basedir": "/builds/slave/test", 07:05:24 INFO - "buildnumber": 57, 07:05:24 INFO - "slavename": "t-yosemite-r7-0269", 07:05:24 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:05:24 INFO - "platform": "yosemite_r7", 07:05:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:05:24 INFO - "branch": "mozilla-aurora", 07:05:24 INFO - "repo_path": "releases/mozilla-aurora", 07:05:24 INFO - "revision": "48a4769a75a5d459dd86c4a1a2f9babb75c9eede", 07:05:24 INFO - "stage_platform": "macosx64", 07:05:24 INFO - "builduid": "819d402fe0b645bc8a0d487346a45582", 07:05:24 INFO - "slavebuilddir": "test" 07:05:24 INFO - } 07:05:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:05:24 INFO - Running post-action listener: _resource_record_post_action 07:05:24 INFO - [mozharness: 2016-12-06 15:05:24.949063Z] Finished read-buildbot-config step (success) 07:05:24 INFO - [mozharness: 2016-12-06 15:05:24.949143Z] Running download-and-extract step. 07:05:24 INFO - Running pre-action listener: _resource_record_pre_action 07:05:24 INFO - Running main action method: download_and_extract 07:05:24 INFO - mkdir: /builds/slave/test/build/tests 07:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:24 INFO - trying https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:05:24 INFO - Downloading https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/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 07:05:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/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 07:05:26 INFO - Downloaded 1199 bytes. 07:05:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:05:26 INFO - Using the following test package requirements: 07:05:26 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:05:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:05:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:05:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'jsshell-mac.zip'], 07:05:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:05:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:05:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:05:26 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:05:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:05:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:05:26 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:05:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:05:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:05:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:05:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:05:26 INFO - Http code: 200 07:05:26 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 07:05:26 INFO - x-amz-cf-id: Albjm-tFPWb3AJ6L4RZ-GGLsHsjlvWJhrhpeFKhW77pOo43-ZSgxFQ== 07:05:26 INFO - x-amz-version-id: ItgR4FZ.oK6LrFu7yvjy43y374Vcoydi 07:05:27 INFO - Expected file size: 16281937 07:05:27 INFO - Obtained file size: 16281937 07:05:33 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 07:05:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:05:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:05:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:05:34 INFO - Http code: 200 07:05:34 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 07:05:34 INFO - x-amz-cf-id: fVQjkG6K2KG7LTNEALNS4Po0h4jnfn8LvNfTPB5OLElb6SjQCy5-1Q== 07:05:34 INFO - x-amz-version-id: ItgR4FZ.oK6LrFu7yvjy43y374Vcoydi 07:05:34 INFO - Expected file size: 16281937 07:05:34 INFO - Obtained file size: 16281937 07:05:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:05:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:05:40 INFO - Fetch https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:05:41 INFO - Http code: 200 07:05:41 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 07:05:41 INFO - x-amz-cf-id: TnR8mZW7LgdFOai9ftkckAbQCFqbaMaQLLoIPYg36TyNFAWvlSTDHg== 07:05:41 INFO - x-amz-version-id: ZG7Q_YXDbldfqDxZCi1STcVbaxUE1AOZ 07:05:41 INFO - Expected file size: 14409038 07:05:41 INFO - Obtained file size: 14409038 07:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:42 INFO - trying https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:05:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/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 07:05:44 INFO - Downloaded 109760365 bytes. 07:05:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:05:44 INFO - mkdir: /builds/slave/test/properties 07:05:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:05:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:05:44 INFO - Contents: 07:05:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:05:45 INFO - Running post-action listener: _resource_record_post_action 07:05:45 INFO - Running post-action listener: set_extra_try_arguments 07:05:45 INFO - [mozharness: 2016-12-06 15:05:45.537460Z] Finished download-and-extract step (success) 07:05:45 INFO - [mozharness: 2016-12-06 15:05:45.537606Z] Running populate-webroot step. 07:05:45 INFO - Running pre-action listener: _resource_record_pre_action 07:05:45 INFO - Running main action method: populate_webroot 07:05:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:45 INFO - '--tppagecycles', 07:05:45 INFO - '7'], 07:05:45 INFO - 'tests': ['tsvgm']}}, 07:05:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['damp', 'tps']}, 07:05:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'tests': ['damp', 'tps']}, 07:05:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['dromaeo_dom']}, 07:05:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['basic_compositor_video']}, 07:05:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['a11yr', 07:05:45 INFO - 'ts_paint', 07:05:45 INFO - 'tpaint', 07:05:45 INFO - 'sessionrestore', 07:05:45 INFO - 'sessionrestore_no_auto_restore', 07:05:45 INFO - 'tabpaint']}, 07:05:45 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:45 INFO - 'ts_paint', 07:05:45 INFO - 'tpaint', 07:05:45 INFO - 'sessionrestore', 07:05:45 INFO - 'sessionrestore_no_auto_restore', 07:05:45 INFO - 'tabpaint']}, 07:05:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:45 INFO - 'ts_paint', 07:05:45 INFO - 'tpaint', 07:05:45 INFO - 'sessionrestore', 07:05:45 INFO - 'sessionrestore_no_auto_restore', 07:05:45 INFO - 'tabpaint']}, 07:05:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:45 INFO - 'ts_paint', 07:05:45 INFO - 'tpaint', 07:05:45 INFO - 'sessionrestore', 07:05:45 INFO - 'sessionrestore_no_auto_restore', 07:05:45 INFO - 'tabpaint']}, 07:05:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['a11yr', 07:05:45 INFO - 'ts_paint', 07:05:45 INFO - 'tpaint', 07:05:45 INFO - 'sessionrestore', 07:05:45 INFO - 'sessionrestore_no_auto_restore', 07:05:45 INFO - 'tabpaint']}, 07:05:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['a11yr', 07:05:45 INFO - 'ts_paint', 07:05:45 INFO - 'tpaint', 07:05:45 INFO - 'sessionrestore', 07:05:45 INFO - 'sessionrestore_no_auto_restore', 07:05:45 INFO - 'tabpaint']}, 07:05:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['tsvgx', 07:05:45 INFO - 'tsvgr_opacity', 07:05:45 INFO - 'tart', 07:05:45 INFO - 'tscrollx', 07:05:45 INFO - 'cart']}, 07:05:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:45 INFO - 'tsvgr_opacity', 07:05:45 INFO - 'tart', 07:05:45 INFO - 'tscrollx', 07:05:45 INFO - 'cart']}, 07:05:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'talos_options': ['--disable-e10s'], 07:05:45 INFO - 'tests': ['tp5o']}, 07:05:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'tests': ['tp5o']}, 07:05:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'talos_options': ['--disable-e10s', 07:05:45 INFO - '--xperf_path', 07:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:45 INFO - 'tests': ['tp5n']}, 07:05:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:45 INFO - 'talos_options': ['--xperf_path', 07:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:45 INFO - 'tests': ['tp5n']}}, 07:05:45 INFO - 'talos.zip': {'path': '', 07:05:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:45 INFO - Running post-action listener: _resource_record_post_action 07:05:45 INFO - [mozharness: 2016-12-06 15:05:45.556608Z] Finished populate-webroot step (success) 07:05:45 INFO - [mozharness: 2016-12-06 15:05:45.556741Z] Running create-virtualenv step. 07:05:45 INFO - Running pre-action listener: _resource_record_pre_action 07:05:45 INFO - Running main action method: create_virtualenv 07:05:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:45 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 07:05:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:45 INFO - Using real prefix '/tools/python27' 07:05:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:49 INFO - Installing pip.................done. 07:05:49 INFO - Return code: 0 07:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:05:49 INFO - Reading from file tmpfile_stdout 07:05:49 INFO - Output received: 07:05:49 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) 07:05:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:49 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:05:49 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 07:05:49 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 07:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:49 INFO - 'HOME': '/Users/cltbld', 07:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:49 INFO - 'LOGNAME': 'cltbld', 07:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:49 INFO - 'MOZ_NO_REMOTE': '1', 07:05:49 INFO - 'NO_EM_RESTART': '1', 07:05:49 INFO - 'PAGER': '/bin/cat', 07:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:49 INFO - 'PWD': '/builds/slave/test', 07:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:49 INFO - 'SHELL': '/bin/bash', 07:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:05:49 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:49 INFO - 'USER': 'cltbld', 07:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:49 INFO - 'XPC_FLAGS': '0x0', 07:05:49 INFO - 'XPC_SERVICE_NAME': '0', 07:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:49 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 07:05:49 INFO - Cleaning up... 07:05:49 INFO - Return code: 0 07:05:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:49 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:05:49 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 07:05:49 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 07:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:49 INFO - 'HOME': '/Users/cltbld', 07:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:49 INFO - 'LOGNAME': 'cltbld', 07:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:49 INFO - 'MOZ_NO_REMOTE': '1', 07:05:49 INFO - 'NO_EM_RESTART': '1', 07:05:49 INFO - 'PAGER': '/bin/cat', 07:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:49 INFO - 'PWD': '/builds/slave/test', 07:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:49 INFO - 'SHELL': '/bin/bash', 07:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:05:49 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:49 INFO - 'USER': 'cltbld', 07:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:49 INFO - 'XPC_FLAGS': '0x0', 07:05:49 INFO - 'XPC_SERVICE_NAME': '0', 07:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:50 INFO - Downloading/unpacking psutil>=3.1.1 07:05:50 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 07:05:50 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 07:05:50 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 07:05:50 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 07:05:50 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 07:05:50 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 07:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:54 INFO - Installing collected packages: psutil 07:05:54 INFO - Running setup.py install for psutil 07:05:54 INFO - building 'psutil._psutil_osx' extension 07:05:54 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 07:05:54 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 07:05:54 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 07:05:54 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 07:05:54 INFO - building 'psutil._psutil_posix' extension 07:05:54 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 07:05:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:05:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:05:54 INFO - ^ 07:05:55 INFO - 1 warning generated. 07:05:55 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 07:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:55 INFO - Successfully installed psutil 07:05:55 INFO - Cleaning up... 07:05:55 INFO - Return code: 0 07:05:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:05:55 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')]} 07:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:55 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')]} 07:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:55 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:05:55 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 07:05:55 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 07:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:55 INFO - 'HOME': '/Users/cltbld', 07:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:55 INFO - 'LOGNAME': 'cltbld', 07:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:55 INFO - 'MOZ_NO_REMOTE': '1', 07:05:55 INFO - 'NO_EM_RESTART': '1', 07:05:55 INFO - 'PAGER': '/bin/cat', 07:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:55 INFO - 'PWD': '/builds/slave/test', 07:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:55 INFO - 'SHELL': '/bin/bash', 07:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:05:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:55 INFO - 'USER': 'cltbld', 07:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:55 INFO - 'XPC_FLAGS': '0x0', 07:05:55 INFO - 'XPC_SERVICE_NAME': '0', 07:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:05:55 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 07:05:55 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 07:05:55 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 07:05:55 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 07:05:55 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 07:05:55 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 07:05:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:05:58 INFO - Installing collected packages: mozsystemmonitor 07:05:58 INFO - Running setup.py install for mozsystemmonitor 07:05:58 INFO - Successfully installed mozsystemmonitor 07:05:58 INFO - Cleaning up... 07:05:58 INFO - Return code: 0 07:05:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:05:58 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')]} 07:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:58 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')]} 07:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:58 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:05:58 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 07:05:58 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 07:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:05:58 INFO - 'HOME': '/Users/cltbld', 07:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:05:58 INFO - 'LOGNAME': 'cltbld', 07:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:58 INFO - 'MOZ_NO_REMOTE': '1', 07:05:58 INFO - 'NO_EM_RESTART': '1', 07:05:58 INFO - 'PAGER': '/bin/cat', 07:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:58 INFO - 'PWD': '/builds/slave/test', 07:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:05:58 INFO - 'SHELL': '/bin/bash', 07:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:05:58 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:05:58 INFO - 'USER': 'cltbld', 07:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:58 INFO - 'XPC_FLAGS': '0x0', 07:05:58 INFO - 'XPC_SERVICE_NAME': '0', 07:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:58 INFO - Downloading/unpacking jsonschema==2.5.1 07:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:01 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 07:06:01 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 07:06:01 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 07:06:01 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 07:06:01 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 07:06:01 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 07:06:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:01 INFO - warning: no files found matching '*.txt' 07:06:01 INFO - no previously-included directories found matching 'build' 07:06:01 INFO - no previously-included directories found matching 'dist' 07:06:01 INFO - no previously-included directories found matching '.git*' 07:06:01 INFO - Installing collected packages: jsonschema, functools32 07:06:01 INFO - Running setup.py install for functools32 07:06:01 INFO - warning: no files found matching '*.txt' 07:06:01 INFO - no previously-included directories found matching 'build' 07:06:01 INFO - no previously-included directories found matching 'dist' 07:06:01 INFO - no previously-included directories found matching '.git*' 07:06:01 INFO - Successfully installed jsonschema functools32 07:06:01 INFO - Cleaning up... 07:06:02 INFO - Return code: 0 07:06:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:02 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')]} 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:02 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')]} 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:02 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:06:02 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 07:06:02 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 07:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:02 INFO - 'HOME': '/Users/cltbld', 07:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:02 INFO - 'LOGNAME': 'cltbld', 07:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:02 INFO - 'MOZ_NO_REMOTE': '1', 07:06:02 INFO - 'NO_EM_RESTART': '1', 07:06:02 INFO - 'PAGER': '/bin/cat', 07:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:02 INFO - 'PWD': '/builds/slave/test', 07:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:02 INFO - 'SHELL': '/bin/bash', 07:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:02 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:02 INFO - 'USER': 'cltbld', 07:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:02 INFO - 'XPC_FLAGS': '0x0', 07:06:02 INFO - 'XPC_SERVICE_NAME': '0', 07:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:02 INFO - Cleaning up... 07:06:02 INFO - Return code: 0 07:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:02 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')]} 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:02 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')]} 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:02 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:06:02 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 07:06:02 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 07:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:02 INFO - 'HOME': '/Users/cltbld', 07:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:02 INFO - 'LOGNAME': 'cltbld', 07:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:02 INFO - 'MOZ_NO_REMOTE': '1', 07:06:02 INFO - 'NO_EM_RESTART': '1', 07:06:02 INFO - 'PAGER': '/bin/cat', 07:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:02 INFO - 'PWD': '/builds/slave/test', 07:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:02 INFO - 'SHELL': '/bin/bash', 07:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:02 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:02 INFO - 'USER': 'cltbld', 07:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:02 INFO - 'XPC_FLAGS': '0x0', 07:06:02 INFO - 'XPC_SERVICE_NAME': '0', 07:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 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 07:06:05 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 07:06:06 INFO - Downloading docopt-0.6.1.tar.gz 07:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:06 INFO - Running setup.py install for blobuploader 07:06:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:06 INFO - Running setup.py install for requests 07:06:07 INFO - Running setup.py install for docopt 07:06:07 INFO - Successfully installed blobuploader requests docopt 07:06:07 INFO - Cleaning up... 07:06:07 INFO - Return code: 0 07:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:07 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')]} 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:07 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')]} 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:07 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:06:07 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 07:06:07 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 07:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:07 INFO - 'HOME': '/Users/cltbld', 07:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:07 INFO - 'LOGNAME': 'cltbld', 07:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:07 INFO - 'MOZ_NO_REMOTE': '1', 07:06:07 INFO - 'NO_EM_RESTART': '1', 07:06:07 INFO - 'PAGER': '/bin/cat', 07:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:07 INFO - 'PWD': '/builds/slave/test', 07:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:07 INFO - 'SHELL': '/bin/bash', 07:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:07 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:07 INFO - 'USER': 'cltbld', 07:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:07 INFO - 'XPC_FLAGS': '0x0', 07:06:07 INFO - 'XPC_SERVICE_NAME': '0', 07:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:07 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-NYgr52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:07 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-nxmHHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:07 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-6ML73w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:07 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-bcounB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:07 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-DRz8hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-HZtoCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-hmLiRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-W5ncZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-lEq6kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-VGCp2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-I2ySe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-DEDnM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-JNYv2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:08 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0qTsUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-H9DScu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-BDfHte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:09 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-tmSxps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:09 INFO - Running setup.py install for manifestparser 07:06:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:09 INFO - Running setup.py install for mozcrash 07:06:09 INFO - Running setup.py install for mozdebug 07:06:09 INFO - Running setup.py install for mozdevice 07:06:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:09 INFO - Running setup.py install for mozfile 07:06:10 INFO - Running setup.py install for mozhttpd 07:06:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozinfo 07:06:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozInstall 07:06:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozleak 07:06:10 INFO - Running setup.py install for mozlog 07:06:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for moznetwork 07:06:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozprocess 07:06:11 INFO - Running setup.py install for mozprofile 07:06:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Running setup.py install for mozrunner 07:06:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Running setup.py install for mozscreenshot 07:06:11 INFO - Running setup.py install for moztest 07:06:11 INFO - Running setup.py install for mozversion 07:06:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:11 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:06:11 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 07:06:11 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 07:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:11 INFO - 'HOME': '/Users/cltbld', 07:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PAGER': '/bin/cat', 07:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:11 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - 'XPC_FLAGS': '0x0', 07:06:11 INFO - 'XPC_SERVICE_NAME': '0', 07:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-QPHlcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-R3bffr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-uuLECx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wN8Izh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_fYGel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-7r32Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZXEUdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:12 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)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0cnkFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0Hrpc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-XZ4ObM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-z6LYZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-2YfIz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-4n4CXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_RwMzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-H3KCZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-3C5SXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:13 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)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Bee_Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:14 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)) 07:06:14 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)) 07:06:14 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)) 07:06:14 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)) 07:06:14 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)) 07:06:14 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)) 07:06:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06: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 07:06: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 07:06: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 07:06:14 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 07:06: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 07:06: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 07:06:16 INFO - Downloading blessings-1.6.tar.gz 07:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:16 INFO - Installing collected packages: blessings 07:06:16 INFO - Running setup.py install for blessings 07:06:16 INFO - Successfully installed blessings 07:06:16 INFO - Cleaning up... 07:06:17 INFO - Return code: 0 07:06:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:17 INFO - Reading from file tmpfile_stdout 07:06:17 INFO - Current package versions: 07:06:17 INFO - blessings == 1.6 07:06:17 INFO - blobuploader == 1.2.4 07:06:17 INFO - docopt == 0.6.1 07:06:17 INFO - functools32 == 3.2.3-2 07:06:17 INFO - jsonschema == 2.5.1 07:06:17 INFO - manifestparser == 1.1 07:06:17 INFO - mozInstall == 1.12 07:06:17 INFO - mozcrash == 1.0 07:06:17 INFO - mozdebug == 0.1 07:06:17 INFO - mozdevice == 0.48 07:06:17 INFO - mozfile == 1.2 07:06:17 INFO - mozhttpd == 0.7 07:06:17 INFO - mozinfo == 0.9 07:06:17 INFO - mozleak == 0.1 07:06:17 INFO - mozlog == 3.4 07:06:17 INFO - moznetwork == 0.27 07:06:17 INFO - mozprocess == 0.23 07:06:17 INFO - mozprofile == 0.28 07:06:17 INFO - mozrunner == 6.13 07:06:17 INFO - mozscreenshot == 0.1 07:06:17 INFO - mozsystemmonitor == 0.3 07:06:17 INFO - moztest == 0.7 07:06:17 INFO - mozversion == 1.4 07:06:17 INFO - psutil == 3.1.1 07:06:17 INFO - requests == 1.2.3 07:06:17 INFO - wsgiref == 0.1.2 07:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:17 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:06:17 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 07:06:17 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 07:06:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:17 INFO - 'HOME': '/Users/cltbld', 07:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:17 INFO - 'LOGNAME': 'cltbld', 07:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:17 INFO - 'MOZ_NO_REMOTE': '1', 07:06:17 INFO - 'NO_EM_RESTART': '1', 07:06:17 INFO - 'PAGER': '/bin/cat', 07:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:17 INFO - 'PWD': '/builds/slave/test', 07:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:17 INFO - 'SHELL': '/bin/bash', 07:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:17 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:17 INFO - 'USER': 'cltbld', 07:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:17 INFO - 'XPC_FLAGS': '0x0', 07:06:17 INFO - 'XPC_SERVICE_NAME': '0', 07:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 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)) 07:06:17 INFO - Cleaning up... 07:06:17 INFO - Return code: 0 07:06:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:17 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 0x10c81c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c792570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1bd5e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, '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.qXMMSeYnkJ/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.B0G952zSXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 07:06:17 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 07:06:17 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 07:06:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:17 INFO - 'HOME': '/Users/cltbld', 07:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:17 INFO - 'LOGNAME': 'cltbld', 07:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:17 INFO - 'MOZ_NO_REMOTE': '1', 07:06:17 INFO - 'NO_EM_RESTART': '1', 07:06:17 INFO - 'PAGER': '/bin/cat', 07:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:17 INFO - 'PWD': '/builds/slave/test', 07:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:17 INFO - 'SHELL': '/bin/bash', 07:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:17 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:17 INFO - 'USER': 'cltbld', 07:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:17 INFO - 'XPC_FLAGS': '0x0', 07:06:17 INFO - 'XPC_SERVICE_NAME': '0', 07:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:17 INFO - Cleaning up... 07:06:17 INFO - Return code: 0 07:06:17 INFO - Running post-action listener: _resource_record_post_action 07:06:17 INFO - Running post-action listener: _start_resource_monitoring 07:06:17 INFO - Starting resource monitoring. 07:06:17 INFO - [mozharness: 2016-12-06 15:06:17.853730Z] Finished create-virtualenv step (success) 07:06:17 INFO - [mozharness: 2016-12-06 15:06:17.854666Z] Running install step. 07:06:17 INFO - Running pre-action listener: _resource_record_pre_action 07:06:17 INFO - Running main action method: install 07:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:18 INFO - Reading from file tmpfile_stdout 07:06:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:18 INFO - Reading from file tmpfile_stdout 07:06:18 INFO - Output received: 07:06:18 INFO - Usage: mozinstall [options] installer 07:06:18 INFO - Options: 07:06:18 INFO - -h, --help show this help message and exit 07:06:18 INFO - -d DEST, --destination=DEST 07:06:18 INFO - Directory to install application into. [default: 07:06:18 INFO - "/builds/slave/test"] 07:06:18 INFO - --app=APP Application being installed. [default: firefox] 07:06:18 INFO - mkdir: /builds/slave/test/build/application 07:06:18 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'] 07:06:18 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 07:06:49 INFO - Reading from file tmpfile_stdout 07:06:49 INFO - Output received: 07:06:49 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:06:49 INFO - Running post-action listener: _resource_record_post_action 07:06:49 INFO - [mozharness: 2016-12-06 15:06:49.317166Z] Finished install step (success) 07:06:49 INFO - [mozharness: 2016-12-06 15:06:49.317306Z] Running run-tests step. 07:06:49 INFO - Running pre-action listener: _resource_record_pre_action 07:06:49 INFO - Running main action method: run_tests 07:06:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:06:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:06:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:06:49 INFO - 2016-12-06 07:06:49.330 screenresolution[1643:10720] starting screenresolution argv=screenresolution get 07:06:49 INFO - 2016-12-06 07:06:49.333 screenresolution[1643:10720] Display 0: 1600x1200x32@60 07:06:49 INFO - 2016-12-06 07:06:49.338 screenresolution[1644:10723] starting screenresolution argv=screenresolution list 07:06:49 INFO - Available Modes on Display 0 07:06:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:06:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:06:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:06:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:06:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:06:49 INFO - Intel Iris: 07:06:49 INFO - Chipset Model: Intel Iris 07:06:49 INFO - Type: GPU 07:06:49 INFO - Bus: Built-In 07:06:49 INFO - VRAM (Dynamic, Max): 1536 MB 07:06:49 INFO - Vendor: Intel (0x8086) 07:06:49 INFO - Device ID: 0x0a2e 07:06:49 INFO - Revision ID: 0x0009 07:06:49 INFO - Displays: 07:06:49 INFO - Display: 07:06:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:06:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:06:49 INFO - Display Serial Number: 1600x1200 60 07:06:49 INFO - Main Display: Yes 07:06:49 INFO - Mirror: Off 07:06:49 INFO - Online: Yes 07:06:49 INFO - Rotation: Supported 07:06:49 INFO - Return code: 0 07:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:49 INFO - Python 2.7.3 07:06:49 INFO - Return code: 0 07:06:49 INFO - grabbing minidump binary from tooltool 07:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:49 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 0x10c630d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c628b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:49 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 07:06:49 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 07:06:49 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 07:06:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:49 INFO - Return code: 0 07:06:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:06:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:06:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:49 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/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--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 07:06:49 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/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --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 07:06:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qXMMSeYnkJ/Render', 07:06:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:06:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:06:49 INFO - 'HOME': '/Users/cltbld', 07:06:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:06:49 INFO - 'LOGNAME': 'cltbld', 07:06:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:49 INFO - 'MOZ_NO_REMOTE': '1', 07:06:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:49 INFO - 'NO_EM_RESTART': '1', 07:06:49 INFO - 'PAGER': '/bin/cat', 07:06:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:49 INFO - 'PWD': '/builds/slave/test', 07:06:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:06:49 INFO - 'SHELL': '/bin/bash', 07:06:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B0G952zSXe/Listeners', 07:06:49 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 07:06:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:06:49 INFO - 'USER': 'cltbld', 07:06:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:06:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:49 INFO - 'XPC_FLAGS': '0x0', 07:06:49 INFO - 'XPC_SERVICE_NAME': '0', 07:06:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:06:49 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/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--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 07:06:49 INFO - mozversion application_buildid: 20161206055938 07:06:49 INFO - mozversion application_changeset: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede 07:06:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:06:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:49 INFO - mozversion application_name: Firefox 07:06:49 INFO - mozversion application_remotingname: firefox-dev 07:06:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:06:49 INFO - mozversion application_vendor: Mozilla 07:06:49 INFO - mozversion application_version: 52.0a2 07:06:49 INFO - mozversion platform_buildid: 20161206055938 07:06:49 INFO - mozversion platform_changeset: 48a4769a75a5d459dd86c4a1a2f9babb75c9eede 07:06:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:06:49 INFO - mozversion platform_version: 52.0a2 07:06:49 INFO - using testdate: 1481036809 07:06:49 INFO - actual date: 1481036809 07:06:49 INFO - starting webserver on 'localhost:49252' 07:06:49 INFO - SUITE-START | Running 2 tests 07:06:49 INFO - TEST-START | dromaeo_css 07:06:49 INFO - operating with platform_type : mac_ 07:06:49 INFO - Initialising browser for dromaeo_css test... 07:06:49 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpgB__g_/profile http://localhost:49252/getInfo.html) 07:06:52 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 07:06:52 INFO - PROCESS | 1654 | colorDepth:24 07:06:52 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 07:06:52 INFO - PROCESS | 1654 | __metrics 07:06:52 INFO - PROCESS | 1654 | 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" 07:06:52 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:53 INFO - TEST-INFO | 1654: exit 0 07:06:53 INFO - Browser initialized. 07:06:53 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:53 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpgB__g_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:05 INFO - PROCESS | 1657 | RSS: Main: 222875648 07:07:05 INFO - PROCESS | 1657 | 07:07:56 INFO - PROCESS | 1657 | 1481036876583 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] 07:10:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 07:10:13 INFO - PROCESS | 1657 | RSS: Main: 376651776 07:10:13 INFO - PROCESS | 1657 | 07:13:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 07:13:16 INFO - PROCESS | 1657 | RSS: Main: 346566656 07:13:16 INFO - PROCESS | 1657 | 07:16:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 07:16:19 INFO - PROCESS | 1657 | RSS: Main: 315461632 07:16:19 INFO - PROCESS | 1657 | 07:19:21 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 07:19:22 INFO - PROCESS | 1657 | RSS: Main: 316694528 07:19:22 INFO - PROCESS | 1657 | 07:22:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 07:22:26 INFO - PROCESS | 1657 | RSS: Main: 309899264 07:22:26 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 07:25:29 INFO - PROCESS | 1657 | RSS: Main: 380751872 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | __start_tp_report 07:25:29 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 07:25:29 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 07:25:29 INFO - PROCESS | 1657 | |i|pagename|runs| 07:25:29 INFO - PROCESS | 1657 | |0;dojo.html;3307.9007629771104;3318.2533929865785;3331.2504686445554;3339.5324654548353;3430.9656903430973;5674.489295963363;5736.426357364261;5750.1949727038245;5756.251687280658;5762.827115186546;4846.515348465152;5621.465960733734;5757.769689212427;5760.798372056979;5768.019436695772;5129.769160387782;5183.559397451221;5221.477852214786;5238.476152384769;5261.0267100586325;5182.455842136578;5191.325127733389;5200.193969934666;5274.683518988873;5315.36215654122;5201.921971170435;5264.710440925747;5270.130428479296;5272.446393128724;5273.789048438058;4339.2840181369875;5280.735963201824;5324.094903866352;5342.626016178869;5385.434529374437;5151.896962060775;5205.713685747282;5268.578513718893;5281.52466278033;5294.841154765363;5154.355705536808;5465.508104270595;5560;5564.387917329091;5679.261695979496;6126.670355029888;6191.102290167945;6215.658138802364;6232.657203853786;6244;6284.842878928018;6299.8740025199695;6307.400796924331;6314.810555683337;6335;5709.543236541067;5774.682392468455;5822.475977162076;5926.318473375574;5949.732262048218;6253.030780229072;6272.2159730033745;6280.340564240689;6301.40136687014;6316.210473690789;6207.472364848948;6217;6224.688765561795;6231.563790534619;6242.625442473466;6162.969185154046;6176.505879529627;6227.875442491125;6237.407446292595;6337.683115844189;6230.626162430269;6288.088227207029;6290.528210384239;6298.275698294755;6307.369263073656;6249.000159974473;6271.749130034747;6288.968555157287;6303.464205542488;6307.810765677037;4837.927431088537;4937.456879743226;4995.075910956485;5007.39911210657;5029.597632189416;4431.800568974404;4465.910681786346;4482.462104547475;4493.146302202571;4509.436320459942;5920.467157955804;5931.228940237742;5935.139404786368;5945.672987985702;5953.107033944856;6260.686965651699;6269.185005949197;6276.874462510816;6290.874182516324;6300.243970723543;5655;5752.827415177551;5757.366689664133;5795.971020144957;5850.765969361178;5448;5464.0711079116645;5480.26016487777;5480.287562616834;5492.752826122834;6349.14286571307;6366.427021568081;6374.458171055512;6377.71300291488;6391.424771770563;6049.274087109399;6184.072389141665;6222.502199824094;6291.276503202007;6305.747770089145;6216.844578885564;6298.338674439301;6307.905381419374;6388.041793730792;6405.551611387158;6225.128482012431;6277.623342599459;6284.591501552384;6289.559730818982;6302.212223472066;6159.384061593805;6233.532485063548;6245.656488893154;6277.340879207617;6300;5988.940110598838;5997.520198384032;6044.032954727399;6094.055421409688;6118.082287656887;5865.677387743715;6024.638521688713;6029.57792954489;6047.123167140652;6048.758049678139;5764.884702306014;5819.738111785065;5896.587238893237;5900.055991041413;5907.379725128972;5992.490638295793;6107.114468401968;6109.586862300561;6119.045604113885;6139.8686669797835;5822.82531524055;6024.3674414187635;6047.213862197887;6070.969645151746;6101.481374083075 07:25:29 INFO - PROCESS | 1657 | |1;ext.html;501.65385883740214;515.9200323949789;519.7401299350324;528.2208742105395;544.3560447448707;29199.562006569893;29900;38098.619013809854;38591.228175436474;38779;39833.601663983354;40042.99892502689;40093.39859902096;40099.39850902239;40169.393224271065;9152.862707059383;9318.301127415438;9328.253739700807;9331.300152488557;9387.483688397135;9205.769855753626;9277.721668349961;9278.536073196346;9292.25661947046;9304.953475232614;9256.25949924008;9333.439993600407;9343.906560934372;9343.906560934372;9357.017513161121;9256.490893000882;9298.767530811716;9314.301427392906;9321.487318197496;9329.440233586007;9226.953865230631;9309.953450232706;9325.766855828659;9327.253819694475;9340.673076442292;37965.81017094925;38240;38297.61702382968;38323.04192395212;38334;3264.9183770405693;3270.3622793555264;3338;3372.406944423646;3780.4707340972286;27143;28355.57466638002;29209.85395073032;29787.851060744775;29825.55261671055;3042.3154790172257;3060.1890499017777;3101.9224519387194;3170.7780455368134;3284.293876816496;399002;472593;474032;475945;482465.58767205937;31935.84032079825;52841;53230.935381292154;53343.93312133736;53427.73286133622;32917;34002;34027.829860850536;34120.65879341224;34318.14204644904;11985.760284794429;13579.796303055462;13589.932050339685;13948.302584870717;14144.080634758708;11844.230125041844;11925.045996320274;11932;11938.820917686242;11943.462544185533;7466.141393739681;7577.507462014952;7598.924010759822;7620.847583048308;7644.923550764421;3189.8086114833186;3219.774615776873;3227.8708851646143;3233.4341490239112;3254.6419893811662;904.2856143646445;922.5110691333604;987.3286165407449;1029.552144817007;1041.9788607165021;28709.28226794347;28927.51623498361;28963.958784327344;29628;29673.703262967094;1001.8897921228659;1008.7679833638158;1056.3239526702916;1080.897314755097;1139.8860113988535;14720.484783032542;14942.626434339229;14962.70074598502;15252.466163684217;15319.46381876629;685835;694285;694909;695092;695899;54949.62625934304;55179.44820551823;55256.44743552513;55337;55383.446165537825;1348.2584578481797;1373.1280636795507;1399.3003498250876;1401.754692928713;1403.5789263220993;28236.43527129487;28518.714812851606;28614.427711445238;29297.560536592395;29399.412011759217;46905.765471172424;52164.95670086653;53531.73234133804;53586.73206633942;57309.42690573208;621123;626551;626862;627066;629342;40248.798756006036;40624;41084.1783164329;41103.58896410998;41211.96970075772;43747;44372;45044.32433513434;45067.32399014083;45738.54261457343;36611.450828237066;36727.449088264235;37556.061098472754;38512.22975540417;38783.612163878;36646.633533664324;37230;37294.62705372911;38427.42358864675;38493.80753096216;26379.736202637727;31926.36147276995;37153.25693486061;37461;37556.624433756406;27463;32514.83742581272;32839.835800820845;33098.66901330956;33944.64221431214;24974.1269404799;25045.49909001846;25101;25112.497750045262;25587.23238302854 07:25:29 INFO - PROCESS | 1657 | |2;jquery.html;335.90762540301415;346.26591625753406;366.3314451126694;370.54052974311855;396.0218260895589;11937.880621193797;14533.854661453383;15129.621759456006;15282;19188;16064.678706425893;19471.123799429024;19598.608027839433;20280.59438811223;20416.897915510403;5609.439056094378;5870.412958704117;5894.646321220741;6006.429389208019;6012.7294271757655;5629.831105066854;5829.242198514187;5838.21184140142;5870.677112758796;5969.552283578727;5810.506106980891;5815.680137592431;5818.679972601505;5820;5824.359320474744;4884.267359896008;5439.265699130626;5472.616916815825;5768.596198266123;5800.042992906187;5082.415522214956;5105.463926287761;5122.436531981479;5126.5642420394315;5128.487151284879;24704.505909881882;25106.372340691447;25203.369915752068;25274.49451010988;25440.87279563609;2244.1584405847807;2266.8073213776847;2278.5670722562827;2372.6441033845063;2864.871080801348;14361.569152925429;15045.623859403493;15424.074555526591;15486.457973970857;15953.840461595351;1790.1496789025239;1833.926642934281;1844.7417361569392;1889.962200755991;1910.751602291707;66663.66668166677;101096.49451752768;101466.98533014649;101773;102520;10419.791604167875;10520.421376824348;10625.893741062491;10854.6431696038;11062.778744425066;13442.93278533601;13445.663858403617;13460;13468.93265533666;13469.057165998482;8135.877961830577;8401.663933442716;8410.831783364421;8514.48913065218;8564.871526927102;8404.243618074403;8437.535935523483;8440.071592124861;8585.484870907765;8621.094785047606;5555.833275012212;6366.681665916685;6511.967440162769;6527;6542.901856472156;1753.5353131420184;1799.5141311845728;1803.4409333106778;1805.8284462975996;1849.9630007399776;903.9005709371963;914.2411798207472;937.4000639590668;941.049539964627;1074.8172810622214;20385.388438346872;20912.37262882116;21554;21706.34880953574;21864;826.6156237349661;834.845553572591;933.814056148701;943.3019565521465;989.4953573677476;10776.923651018858;11238.269512481662;11505.942470287595;11564.653060408202;11574.6527604172;570435;608635;624637;624961;627425;82532.34935301381;91320;94867;112583.43708281407;117788;891.64334266294;1002.9097381235724;1008.3294609084876;1009.369144284822;1010.0152351457417;18983.62704661917;19765.40703778889;19928.50178745543;20061.29785457502;20073.79926200778;50790;51453;51936;52514.47485525248;53227.733861330446;66942.33057669361;68082;70959.29040709526;72023;72405.6379718098;7441.330280274801;7567.886481702889;7660.233976602295;7906.604669766603;8070.515769053641;11955.282683039046;12292.323922184365;12482.937585312015;12803.679908002374;12960.805587916377;10891.945540272249;11026.228164028442;11038.337699738042;11315.547378104784;11412.714682133013;10834.891651083388;10882.183836212474;10951.616693415692;11202.66392008241;11396.259243149168;11039.61361352381;11134.610288639858;11177.776444470903;11347.659570212907;11755.823662645238;7941;8097.959510202647;8135.552544610104;8303.875441868498;8333.416660833684;8723.476591404537;10976.945115274373;11146.386948717898;11280.871912808654;11319.660410187707 07:25:29 INFO - PROCESS | 1657 | |3;mootools.html;1296.9610911672653;1340.4638144742103;1457.4170331867256;1580.4705423683065;1802.3601621424393;7440.181580026193;7756.379489640823;8133.837323253539;8384.958075209615;8392.832143357144;8200;8293.709720159795;8299.004119505653;8303.792405189874;8319.708810191645;2290.5075408787065;2318.0959425823944;2319.9884000579973;2321.2339927823864;2329.1382188590246;2288.5308511755134;2290.9083636654514;2358.292512246328;2359.8702071386065;2364.4561750797325;1995.720599116125;2286.805621522164;2306.5963456395148;2324.1284518305633;2327.3832434404894;2249.853759505643;2263.4907145892125;2283.486215601493;2292.4612716011725;2294.9655755163603;2301.6432452969816;2320.9071637134493;2322.7561106083785;2323.953520929572;2331.3821837213154;7686.692532298757;8199.590020498952;8282.047564530096;8292.917070829275;8297.917020829835;4993.700377977333;5190.71451070191;5194.63637545372;5194.97402512985;5208.583313334924;3054.205906464313;3358.1604598850286;3474.7915125092322;3549.2014296783277;3575.1598374382;1043.9039009040478;1072.5012869015868;1520.2094910646401;1689.4678176374402;1778.2442461953617;10781.730456738565;10853.294535855144;10863.945680271627;10888.074513666348;10888.6188983386;3755.7934313613014;4301.849435269751;4364.60718535327;4379.868603941887;4434.224010798098;8499.532525711022;8584.227419532272;8597.18326758957;8606.268467180234;8621.784455388666;5076.416212135578;5082.034413461431;5082.618803589671;5086.0845047891735;5094.745262736922;4029.9597004029583;4274.294741367702;4386.429764130643;4606.216943119611;4751.572358487683;3609.5668519777796;3621.7464777465852;3709;3714.461403096536;3716.6283371662616;1109.2013750099916;1127.334872425273;1142.451623220842;1144.6394385768456;1145.604766355606;821.2854816309849;849.2102344819377;861.2076889261895;896.9998451726278;912.8767616371705;4641.675082744176;5447;5499.862503437446;5526.447355264522;5567.610267281332;813.5240884082759;863.3999370437485;868.491932219646;877.144783835755;900.522722956834;3456.015035714809;3473.6873681368797;3499.9475007874903;3515.261795023023;3515.5605549306338;8022.27799498048;10192.286539942133;10210.846837297446;10210.948945255226;10224.64213752515;9845.212383009486;10052.69841904744;10167.44079075658;10171.440570768531;10176.084152426318;7711.151773304932;7716.074071111502;7831.060272767304;7883.211678832071;7912.9208707912185;5305.098133317269;5335.466453354634;5339.279197308314;5509.559235261249;5603.215549822947;9268.860967085364;9313.860292095489;9363.906360936304;9386.108319709616;9404.871415430192;8570.4000719949;8897.154770296811;9080.228180604723;9359.9704032555;9441.905580944378;6618.966905165444;6909.516333856582;7078.009078728879;7137.750178743719;7137.83716901757;7739.574323412041;7888.132305446511;7951.761447156595;7968.402369822403;7975.162607926084;6998.755043573654;7015.964920175366;7118.822029449305;7142.607156606437;7225.313595208447;6206;7024.473164512579;7030.156381234285;7051.471139664443;7083.220845707071;6586.176727909012;6604.933950660432;6620.139381880517;6687.4984376171005;6720;4121.402396652528;4728.952710472851;4753.453352864327;4803.567678908915;4894.755262236803;4814.903701926012;4916.041371932439;4924.950750492592;4956.77694503741;4982.177940639754 07:25:29 INFO - PROCESS | 1657 | |4;prototype.html;297.6993236830801;299.5506739890165;307.29782447108363;311.2840466926069;312.8889244318266;3918.7648741075486;4667.509911459299;5223.3731952165745;5309.920351194731;5347.203485525277;4998.425181104165;5055.736065983504;5124.8975020499565;5235.895282094356;5276.841694749163;3472.808995505246;3514.5079688843584;3987.461692671481;4012;4080.8775736727944;3741.8877433677035;3754.624537546237;4053.8175782089875;4054.3918412238104;4083.9387409188885;3963.3856752203455;3969.96780836983;3976.1848820991772;3992.441058251847;4015.955851478607;3537.663921927413;3695.2424752925585;3833.271678381099;3972.543157536877;3992.061865461614;3026.44010857992;3166.6200055993427;3338.549295845078;3481.669241422061;3482.8928498258697;5058.696478211319;5093.847184584469;5123.948760512384;5157.7936882524655;5198.518422249678;3588.730845186595;4042.300356497354;4504.031633198878;4577.33628623851;4596.724196548218;4151;5328.8401347959625;5431.153407841313;5516.475934786189;5539.778408863641;3815.4467602197806;3820.3314419976673;3821.48409964654;3822.4839646647624;3826.789526576037;4660.440747110369;5536.667799932017;5847.473727364558;5869.501092407193;5882.588178837091;3620.420732682758;3783.432485127253;3821.617838216156;3826.9808650956566;3833.6997801319544;3864.729468937204;3874.1476875087437;3878.650921417086;3910.2961466936226;3919.3924941633522;4497.977510112429;4510.323451482304;4517.390152329459;4520.276755719069;4597.3793537872625;4938.925916111261;5267.789288428497;5277.2875661785165;5505.449455054542;5564.360098588633;1023.8720159980003;1082.826747720361;1208.323338930202;1235.1534455988356;1244.825724398585;636.8662580857979;794.1224946434222;799.9800004999921;836.8410002099581;843.8017065989487;4237.809298581509;4441.733495990251;4825.927611085836;4978.929530151035;4996.575291100225;4604.181348367376;5022.9748851256245;5044.596432285409;5402.621816472888;5432.256710361242;4167.97916010418;4962.429320628102;4969.527894849984;4970.396462564611;5009.695540051544;2558.6801649793774;2756.7656749176545;2789.4142230131492;2794.846283454389;2853.4863724529782;5236.790528378899;5370.4629537045985;5633.2961976749875;5646.927083854054;5671.461211184931;4518.932216016762;4940.505949405031;5122.692638441706;5143.485651434901;5524.447555244444;4911.3369695090705;5460.140474977274;5460.453954604508;5467.72661366938;5520.447955204448;4808.2547205183255;5227.55565776898;5264.947350526446;5271.420143784258;5291.417944026231;4829.7585120744525;5162.845114646567;5240.851250987077;5490.231367608618;5608.663480191201;4959.809645685082;5152.355955505562;5876.941230587639;5891;6019.307779605227;3548.8048157351595;3851.9037024074623;3862.416409272185;3954.7824869632445;3965.325894597868;5230.843074707765;5234.502722241381;5328.946710533;5497.670139791625;5675.177099320493;4437.933430998473;4853.6944951147925;5537.723113844372;5544.1232293768735;5568.832935011957;4894.3848529985735;5329.360476742816;5454.59090568201;5508.752106155152;5520.365158006881;4111.1366613010405;4621.560951709582;5435;5466.977218429207;5499.862503437446;5315.707636080053;5486.214511986716;5488.012157811472;5489.670619762667;5525.502704756591;4322.546132656152;4783.306420569068;5423.532292806684;5431.891362172813;5483.8080667176455 07:25:29 INFO - PROCESS | 1657 | |5;yui.html;664.1896885799324;667.8722719052691;751.9135299440562;760.9619519024051;763.3549650545287;13602.45590176393;14239.430422783076;14246.71506569868;14260.286985650728;14266.71466570668;12627.431765570549;12693;12730;12738.745225095492;12781.169224000434;627.7269387816315;647.0391468669022;649.3830860682347;794.8966634337557;806.5725165662209;785.516907102131;798.8601994650942;801.6993627389729;818.8485130250923;819.3117781063905;791.6595863778573;850.6639877248483;853.0190281176634;854.5513605357175;856.0968178571604;656.957297775643;675.3044364304725;846.5767116441779;847.4957400346784;853.7097386888456;606.9089636554507;625.2840497630233;626.2485017978444;626.4111734969115;628.4783629587431;13419;13425.597232083053;13443.865561344457;13449.193048417126;13463.798043029363;9835.360701554377;12261.141720079599;12800;12804.10371274002;12990.025748068932;11651;11735.647930562096;11850.22973506728;11991.760164796742;12020.338881361522;4304.698671093025;4307;4319.892002699926;4389.275769498029;4440.622547083502;79482.8077578831;84522;84979;85134;88040.99999999936;9647.855282170633;9911.504424778732;10109.949450252701;10200.489975501196;10512.369257844553;19078.61842763137;19159.04204789755;19172.041397930327;19347.226110955406;19476.51308717265;6552.213734351908;7446.925530744732;7449.962750186214;7504.287092726182;7636.465447418738;4168.791560421967;4175.248455278079;4205.558416366238;4242.957570424318;4453.087117140978;3377.3583019226758;3491.650834916488;3503.2818272254126;3507.7544571880235;3508.4211105167874;648.070019521978;649.3084864619166;650.973961041553;668.0280192320163;672.6098862659645;572.7909313100688;637.8309747916805;649.7498463091744;655.4625207329943;693.5457275484565;8951.641934322553;9020.503872286956;9046.86429703555;9228;9301.627934882665;548.9843788990336;596.9194158788595;625.6527627166967;669.7086767256259;674.1741366825697;4245.724027938174;4434.756088415168;4478.149151661174;4479.910401791946;4498.977505112453;83619.16380836235;105705.47147264368;109366.45316773365;109754.45122774335;109951.45024274988;67062.66468667626;83201;93287;95835;99099.00900991043;83471.7479237824;83765.58117209497;85431.57284213539;87395.56302218576;88390;8663.090375510732;8767.693130740394;8781.868271976053;8832.5583720815;8929.464232146092;43764;46815.531844681114;50241;54389.91220175653;54980;63608.04587931278;65163.67418163068;68891.83311251576;70142;72005;12223.75552488963;12244.816327754912;12497.375131243583;12646.241225526497;12856.292903890377;10963.945180274048;12811.807822882478;14452.566423007327;14572.635684107981;15027.398904044154;12832.486700531874;13156.36993933391;13173.670658233621;13223.206607603575;13859.584212473643;12512.249265044127;12549.435275412447;12878.227306361649;12937.288449135387;13145.408456619667;12293.385330733607;12450.25298482094;12469.438875250817;12511.499540018298;13347.866521334663;10806.35161890289;10834.02493775564;10855.457227138453;11073.667789966314;11129.109671226444;10670.0930420912;11335.943320283346;11501.367424791717;11593.304401735923;11620.6513804586 07:25:29 INFO - PROCESS | 1657 | __end_tp_report 07:25:29 INFO - PROCESS | 1657 | __start_cc_report 07:25:29 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1938 07:25:29 INFO - PROCESS | 1657 | __end_cc_report 07:25:29 INFO - PROCESS | 1657 | __startTimestamp1481037929713__endTimestamp 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | ------- Summary: start ------- 07:25:29 INFO - PROCESS | 1657 | Number of tests: 6 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5762.78 Median:5988.94 stddev:653.18 (10.9%) stddev-sans-first:626.15 07:25:29 INFO - PROCESS | 1657 | Values: 3307.9 3318.3 3331.3 3339.5 3431.0 5674.5 5736.4 5750.2 5756.3 5762.8 4846.5 5621.5 5757.8 5760.8 5768.0 5129.8 5183.6 5221.5 5238.5 5261.0 5182.5 5191.3 5200.2 5274.7 5315.4 5201.9 5264.7 5270.1 5272.4 5273.8 4339.3 5280.7 5324.1 5342.6 5385.4 5151.9 5205.7 5268.6 5281.5 5294.8 5154.4 5465.5 5560.0 5564.4 5679.3 6126.7 6191.1 6215.7 6232.7 6244.0 6284.8 6299.9 6307.4 6314.8 6335.0 5709.5 5774.7 5822.5 5926.3 5949.7 6253.0 6272.2 6280.3 6301.4 6316.2 6207.5 6217.0 6224.7 6231.6 6242.6 6163.0 6176.5 6227.9 6237.4 6337.7 6230.6 6288.1 6290.5 6298.3 6307.4 6249.0 6271.7 6289.0 6303.5 6307.8 4837.9 4937.5 4995.1 5007.4 5029.6 4431.8 4465.9 4482.5 4493.1 4509.4 5920.5 5931.2 5935.1 5945.7 5953.1 6260.7 6269.2 6276.9 6290.9 6300.2 5655.0 5752.8 5757.4 5796.0 5850.8 5448.0 5464.1 5480.3 5480.3 5492.8 6349.1 6366.4 6374.5 6377.7 6391.4 6049.3 6184.1 6222.5 6291.3 6305.7 6216.8 6298.3 6307.9 6388.0 6405.6 6225.1 6277.6 6284.6 6289.6 6302.2 6159.4 6233.5 6245.7 6277.3 6300.0 5988.9 5997.5 6044.0 6094.1 6118.1 5865.7 6024.6 6029.6 6047.1 6048.8 5764.9 5819.7 5896.6 5900.1 5907.4 5992.5 6107.1 6109.6 6119.0 6139.9 5822.8 6024.4 6047.2 6071.0 6101.5 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:70315.19 Median:38328.52 stddev:161581.42 (421.6%) stddev-sans-first:161949.68 07:25:29 INFO - PROCESS | 1657 | Values: 501.7 515.9 519.7 528.2 544.4 29199.6 29900.0 38098.6 38591.2 38779.0 39833.6 40043.0 40093.4 40099.4 40169.4 9152.9 9318.3 9328.3 9331.3 9387.5 9205.8 9277.7 9278.5 9292.3 9305.0 9256.3 9333.4 9343.9 9343.9 9357.0 9256.5 9298.8 9314.3 9321.5 9329.4 9227.0 9310.0 9325.8 9327.3 9340.7 37965.8 38240.0 38297.6 38323.0 38334.0 3264.9 3270.4 3338.0 3372.4 3780.5 27143.0 28355.6 29209.9 29787.9 29825.6 3042.3 3060.2 3101.9 3170.8 3284.3 399002.0 472593.0 474032.0 475945.0 482465.6 31935.8 52841.0 53230.9 53343.9 53427.7 32917.0 34002.0 34027.8 34120.7 34318.1 11985.8 13579.8 13589.9 13948.3 14144.1 11844.2 11925.0 11932.0 11938.8 11943.5 7466.1 7577.5 7598.9 7620.8 7644.9 3189.8 3219.8 3227.9 3233.4 3254.6 904.3 922.5 987.3 1029.6 1042.0 28709.3 28927.5 28964.0 29628.0 29673.7 1001.9 1008.8 1056.3 1080.9 1139.9 14720.5 14942.6 14962.7 15252.5 15319.5 685835.0 694285.0 694909.0 695092.0 695899.0 54949.6 55179.4 55256.4 55337.0 55383.4 1348.3 1373.1 1399.3 1401.8 1403.6 28236.4 28518.7 28614.4 29297.6 29399.4 46905.8 52165.0 53531.7 53586.7 57309.4 621123.0 626551.0 626862.0 627066.0 629342.0 40248.8 40624.0 41084.2 41103.6 41212.0 43747.0 44372.0 45044.3 45067.3 45738.5 36611.5 36727.4 37556.1 38512.2 38783.6 36646.6 37230.0 37294.6 38427.4 38493.8 26379.7 31926.4 37153.3 37461.0 37556.6 27463.0 32514.8 32839.8 33098.7 33944.6 24974.1 25045.5 25101.0 25112.5 25587.2 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:33674.07 Median:25154.87 stddev:100837.33 (400.9%) stddev-sans-first:101089.13 07:25:29 INFO - PROCESS | 1657 | Values: 335.9 346.3 366.3 370.5 396.0 11937.9 14533.9 15129.6 15282.0 19188.0 16064.7 19471.1 19598.6 20280.6 20416.9 5609.4 5870.4 5894.6 6006.4 6012.7 5629.8 5829.2 5838.2 5870.7 5969.6 5810.5 5815.7 5818.7 5820.0 5824.4 4884.3 5439.3 5472.6 5768.6 5800.0 5082.4 5105.5 5122.4 5126.6 5128.5 24704.5 25106.4 25203.4 25274.5 25440.9 2244.2 2266.8 2278.6 2372.6 2864.9 14361.6 15045.6 15424.1 15486.5 15953.8 1790.1 1833.9 1844.7 1890.0 1910.8 66663.7 101096.5 101467.0 101773.0 102520.0 10419.8 10520.4 10625.9 10854.6 11062.8 13442.9 13445.7 13460.0 13468.9 13469.1 8135.9 8401.7 8410.8 8514.5 8564.9 8404.2 8437.5 8440.1 8585.5 8621.1 5555.8 6366.7 6512.0 6527.0 6542.9 1753.5 1799.5 1803.4 1805.8 1850.0 903.9 914.2 937.4 941.0 1074.8 20385.4 20912.4 21554.0 21706.3 21864.0 826.6 834.8 933.8 943.3 989.5 10776.9 11238.3 11505.9 11564.7 11574.7 570435.0 608635.0 624637.0 624961.0 627425.0 82532.3 91320.0 94867.0 112583.4 117788.0 891.6 1002.9 1008.3 1009.4 1010.0 18983.6 19765.4 19928.5 20061.3 20073.8 50790.0 51453.0 51936.0 52514.5 53227.7 66942.3 68082.0 70959.3 72023.0 72405.6 7441.3 7567.9 7660.2 7906.6 8070.5 11955.3 12292.3 12482.9 12803.7 12960.8 10891.9 11026.2 11038.3 11315.5 11412.7 10834.9 10882.2 10951.6 11202.7 11396.3 11039.6 11134.6 11177.8 11347.7 11755.8 7941.0 8098.0 8135.6 8303.9 8333.4 8723.5 10976.9 11146.4 11280.9 11319.7 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5348.84 Median:5079.23 stddev:2933.02 (57.7%) stddev-sans-first:2925.43 07:25:29 INFO - PROCESS | 1657 | Values: 1297.0 1340.5 1457.4 1580.5 1802.4 7440.2 7756.4 8133.8 8385.0 8392.8 8200.0 8293.7 8299.0 8303.8 8319.7 2290.5 2318.1 2320.0 2321.2 2329.1 2288.5 2290.9 2358.3 2359.9 2364.5 1995.7 2286.8 2306.6 2324.1 2327.4 2249.9 2263.5 2283.5 2292.5 2295.0 2301.6 2320.9 2322.8 2324.0 2331.4 7686.7 8199.6 8282.0 8292.9 8297.9 4993.7 5190.7 5194.6 5195.0 5208.6 3054.2 3358.2 3474.8 3549.2 3575.2 1043.9 1072.5 1520.2 1689.5 1778.2 10781.7 10853.3 10863.9 10888.1 10888.6 3755.8 4301.8 4364.6 4379.9 4434.2 8499.5 8584.2 8597.2 8606.3 8621.8 5076.4 5082.0 5082.6 5086.1 5094.7 4030.0 4274.3 4386.4 4606.2 4751.6 3609.6 3621.7 3709.0 3714.5 3716.6 1109.2 1127.3 1142.5 1144.6 1145.6 821.3 849.2 861.2 897.0 912.9 4641.7 5447.0 5499.9 5526.4 5567.6 813.5 863.4 868.5 877.1 900.5 3456.0 3473.7 3499.9 3515.3 3515.6 8022.3 10192.3 10210.8 10210.9 10224.6 9845.2 10052.7 10167.4 10171.4 10176.1 7711.2 7716.1 7831.1 7883.2 7912.9 5305.1 5335.5 5339.3 5509.6 5603.2 9268.9 9313.9 9363.9 9386.1 9404.9 8570.4 8897.2 9080.2 9360.0 9441.9 6619.0 6909.5 7078.0 7137.8 7137.8 7739.6 7888.1 7951.8 7968.4 7975.2 6998.8 7016.0 7118.8 7142.6 7225.3 6206.0 7024.5 7030.2 7051.5 7083.2 6586.2 6604.9 6620.1 6687.5 6720.0 4121.4 4729.0 4753.5 4803.6 4894.8 4814.9 4916.0 4925.0 4956.8 4982.2 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4367.60 Median:4939.72 stddev:1338.99 (27.1%) stddev-sans-first:1307.44 07:25:29 INFO - PROCESS | 1657 | Values: 297.7 299.6 307.3 311.3 312.9 3918.8 4667.5 5223.4 5309.9 5347.2 4998.4 5055.7 5124.9 5235.9 5276.8 3472.8 3514.5 3987.5 4012.0 4080.9 3741.9 3754.6 4053.8 4054.4 4083.9 3963.4 3970.0 3976.2 3992.4 4016.0 3537.7 3695.2 3833.3 3972.5 3992.1 3026.4 3166.6 3338.5 3481.7 3482.9 5058.7 5093.8 5123.9 5157.8 5198.5 3588.7 4042.3 4504.0 4577.3 4596.7 4151.0 5328.8 5431.2 5516.5 5539.8 3815.4 3820.3 3821.5 3822.5 3826.8 4660.4 5536.7 5847.5 5869.5 5882.6 3620.4 3783.4 3821.6 3827.0 3833.7 3864.7 3874.1 3878.7 3910.3 3919.4 4498.0 4510.3 4517.4 4520.3 4597.4 4938.9 5267.8 5277.3 5505.4 5564.4 1023.9 1082.8 1208.3 1235.2 1244.8 636.9 794.1 800.0 836.8 843.8 4237.8 4441.7 4825.9 4978.9 4996.6 4604.2 5023.0 5044.6 5402.6 5432.3 4168.0 4962.4 4969.5 4970.4 5009.7 2558.7 2756.8 2789.4 2794.8 2853.5 5236.8 5370.5 5633.3 5646.9 5671.5 4518.9 4940.5 5122.7 5143.5 5524.4 4911.3 5460.1 5460.5 5467.7 5520.4 4808.3 5227.6 5264.9 5271.4 5291.4 4829.8 5162.8 5240.9 5490.2 5608.7 4959.8 5152.4 5876.9 5891.0 6019.3 3548.8 3851.9 3862.4 3954.8 3965.3 5230.8 5234.5 5328.9 5497.7 5675.2 4437.9 4853.7 5537.7 5544.1 5568.8 4894.4 5329.4 5454.6 5508.8 5520.4 4111.1 4621.6 5435.0 5467.0 5499.9 5315.7 5486.2 5488.0 5489.7 5525.5 4322.5 4783.3 5423.5 5431.9 5483.8 07:25:29 INFO - PROCESS | 1657 | 07:25:29 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:19672.85 Median:4489.44 stddev:28490.71 (634.6%) stddev-sans-first:28534.88 07:25:29 INFO - PROCESS | 1657 | Values: 664.2 667.9 751.9 761.0 763.4 13602.5 14239.4 14246.7 14260.3 14266.7 12627.4 12693.0 12730.0 12738.7 12781.2 627.7 647.0 649.4 794.9 806.6 785.5 798.9 801.7 818.8 819.3 791.7 850.7 853.0 854.6 856.1 657.0 675.3 846.6 847.5 853.7 606.9 625.3 626.2 626.4 628.5 13419.0 13425.6 13443.9 13449.2 13463.8 9835.4 12261.1 12800.0 12804.1 12990.0 11651.0 11735.6 11850.2 11991.8 12020.3 4304.7 4307.0 4319.9 4389.3 4440.6 79482.8 84522.0 84979.0 85134.0 88041.0 9647.9 9911.5 10109.9 10200.5 10512.4 19078.6 19159.0 19172.0 19347.2 19476.5 6552.2 7446.9 7450.0 7504.3 7636.5 4168.8 4175.2 4205.6 4243.0 4453.1 3377.4 3491.7 3503.3 3507.8 3508.4 648.1 649.3 651.0 668.0 672.6 572.8 637.8 649.7 655.5 693.5 8951.6 9020.5 9046.9 9228.0 9301.6 549.0 596.9 625.7 669.7 674.2 4245.7 4434.8 4478.1 4479.9 4499.0 83619.2 105705.5 109366.5 109754.5 109951.5 67062.7 83201.0 93287.0 95835.0 99099.0 83471.7 83765.6 85431.6 87395.6 88390.0 8663.1 8767.7 8781.9 8832.6 8929.5 43764.0 46815.5 50241.0 54389.9 54980.0 63608.0 65163.7 68891.8 70142.0 72005.0 12223.8 12244.8 12497.4 12646.2 12856.3 10963.9 12811.8 14452.6 14572.6 15027.4 12832.5 13156.4 13173.7 13223.2 13859.6 12512.2 12549.4 12878.2 12937.3 13145.4 12293.4 12450.3 12469.4 12511.5 13347.9 10806.4 10834.0 10855.5 11073.7 11129.1 10670.1 11335.9 11501.4 11593.3 11620.7 07:25:29 INFO - PROCESS | 1657 | -------- Summary: end -------- 07:25:29 INFO - PROCESS | 1657 | 07:25:30 INFO - TEST-INFO | 1657: exit 0 07:25:30 INFO - TEST-OK | dromaeo_css | took 1120580ms 07:25:30 INFO - TEST-START | kraken 07:25:30 INFO - operating with platform_type : mac_ 07:25:30 INFO - Initialising browser for kraken test... 07:25:30 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmp1vhCpQ/profile http://localhost:49252/getInfo.html) 07:25:33 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 07:25:33 INFO - PROCESS | 1662 | colorDepth:24 07:25:33 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 07:25:33 INFO - PROCESS | 1662 | __metrics 07:25:33 INFO - PROCESS | 1662 | 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" 07:25:33 INFO - PROCESS | 1662 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:34 INFO - TEST-INFO | 1662: exit 0 07:25:34 INFO - Browser initialized. 07:25:34 INFO - Running cycle 1/1 for kraken test... 07:25:34 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmp1vhCpQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:46 INFO - PROCESS | 1663 | RSS: Main: 222654464 07:25:46 INFO - PROCESS | 1663 | 07:25:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:49 INFO - PROCESS | 1663 | RSS: Main: 272150528 07:25:49 INFO - PROCESS | 1663 | 07:25:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 07:25:53 INFO - PROCESS | 1663 | RSS: Main: 283144192 07:25:53 INFO - PROCESS | 1663 | 07:25:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 07:25:56 INFO - PROCESS | 1663 | RSS: Main: 380760064 07:25:56 INFO - PROCESS | 1663 | 07:25:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 07:25:59 INFO - PROCESS | 1663 | RSS: Main: 282472448 07:25:59 INFO - PROCESS | 1663 | 07:26:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:02 INFO - PROCESS | 1663 | RSS: Main: 284635136 07:26:02 INFO - PROCESS | 1663 | 07:26:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:05 INFO - PROCESS | 1663 | RSS: Main: 327237632 07:26:05 INFO - PROCESS | 1663 | 07:26:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:08 INFO - PROCESS | 1663 | RSS: Main: 325185536 07:26:08 INFO - PROCESS | 1663 | 07:26:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 07:26:12 INFO - PROCESS | 1663 | RSS: Main: 324059136 07:26:12 INFO - PROCESS | 1663 | 07:26:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:14 INFO - PROCESS | 1663 | RSS: Main: 299311104 07:26:14 INFO - PROCESS | 1663 | 07:26:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:17 INFO - PROCESS | 1663 | RSS: Main: 299593728 07:26:17 INFO - PROCESS | 1663 | 07:26:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:19 INFO - PROCESS | 1663 | RSS: Main: 302092288 07:26:19 INFO - PROCESS | 1663 | 07:26:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:23 INFO - PROCESS | 1663 | RSS: Main: 312578048 07:26:23 INFO - PROCESS | 1663 | 07:26:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:27 INFO - PROCESS | 1663 | RSS: Main: 312844288 07:26:27 INFO - PROCESS | 1663 | 07:26:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 07:26:29 INFO - PROCESS | 1663 | RSS: Main: 356376576 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | __start_tp_report 07:26:29 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 07:26:29 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 07:26:29 INFO - PROCESS | 1663 | |i|pagename|runs| 07:26:29 INFO - PROCESS | 1663 | |0;ai-astar;115;113;112;116;114;113;111;114;113;112 07:26:29 INFO - PROCESS | 1663 | |1;audio-beat-detection;150;116;117;148;115;114;114;118;148;114 07:26:29 INFO - PROCESS | 1663 | |2;audio-dft;183;182;184;186;183;185;184;182;182;187 07:26:29 INFO - PROCESS | 1663 | |3;audio-fft;80;58;58;93;61;59;60;62;84;60 07:26:29 INFO - PROCESS | 1663 | |4;audio-oscillator;84;71;95;70;68;69;91;68;69;92 07:26:29 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;93;134;98;85;84;87;83;86;83 07:26:29 INFO - PROCESS | 1663 | |6;imaging-darkroom;93;92;102;93;93;93;94;93;93;92 07:26:29 INFO - PROCESS | 1663 | |7;imaging-desaturate;77;102;121;101;80;83;82;85;83;82 07:26:29 INFO - PROCESS | 1663 | |8;json-parse-financial;56;55;54;54;57;59;59;57;57;57 07:26:29 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;77;67;78;72;70;70;73;72;72 07:26:29 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;86;86;86;86;84;84;84;85;88;86 07:26:29 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;147;143;146;147;144;152;153;152;219;152 07:26:29 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;169;170;168;174;169;168;168;166;160;168 07:26:29 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;69;69;69;69;70;83;83;85;86;60 07:26:29 INFO - PROCESS | 1663 | __end_tp_report 07:26:29 INFO - PROCESS | 1663 | __start_cc_report 07:26:29 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2023 07:26:29 INFO - PROCESS | 1663 | __end_cc_report 07:26:29 INFO - PROCESS | 1663 | __startTimestamp1481037989205__endTimestamp 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | ------- Summary: start ------- 07:26:29 INFO - PROCESS | 1663 | Number of tests: 14 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.49 (1.3%) stddev-sans-first:1.45 07:26:29 INFO - PROCESS | 1663 | Values: 115.0 113.0 112.0 116.0 114.0 113.0 111.0 114.0 113.0 112.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:117.50 stddev:16.12 (13.7%) stddev-sans-first:14.43 07:26:29 INFO - PROCESS | 1663 | Values: 150.0 116.0 117.0 148.0 115.0 114.0 114.0 118.0 148.0 114.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.75 (1.0%) stddev-sans-first:1.83 07:26:29 INFO - PROCESS | 1663 | Values: 183.0 182.0 184.0 186.0 183.0 185.0 184.0 182.0 182.0 187.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:67.50 Median:61.50 stddev:12.98 (21.1%) stddev-sans-first:12.96 07:26:29 INFO - PROCESS | 1663 | Values: 80.0 58.0 58.0 93.0 61.0 59.0 60.0 62.0 84.0 60.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:77.50 stddev:11.37 (14.7%) stddev-sans-first:11.83 07:26:29 INFO - PROCESS | 1663 | Values: 84.0 71.0 95.0 70.0 68.0 69.0 91.0 68.0 69.0 92.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:86.50 stddev:15.50 (17.9%) stddev-sans-first:16.33 07:26:29 INFO - PROCESS | 1663 | Values: 87.0 93.0 134.0 98.0 85.0 84.0 87.0 83.0 86.0 83.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:93.00 stddev:2.94 (3.2%) stddev-sans-first:3.10 07:26:29 INFO - PROCESS | 1663 | Values: 93.0 92.0 102.0 93.0 93.0 93.0 94.0 93.0 93.0 92.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:89.60 Median:82.00 stddev:13.92 (17.0%) stddev-sans-first:14.00 07:26:29 INFO - PROCESS | 1663 | Values: 77.0 102.0 121.0 101.0 80.0 83.0 82.0 85.0 83.0 82.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.78 (3.1%) stddev-sans-first:1.88 07:26:29 INFO - PROCESS | 1663 | Values: 56.0 55.0 54.0 54.0 57.0 59.0 59.0 57.0 57.0 57.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:3.98 (5.5%) stddev-sans-first:3.43 07:26:29 INFO - PROCESS | 1663 | Values: 65.0 77.0 67.0 78.0 72.0 70.0 70.0 73.0 72.0 72.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.27 (1.5%) stddev-sans-first:1.33 07:26:29 INFO - PROCESS | 1663 | Values: 86.0 86.0 86.0 86.0 84.0 84.0 84.0 85.0 88.0 86.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:152.00 stddev:22.60 (14.9%) stddev-sans-first:23.77 07:26:29 INFO - PROCESS | 1663 | Values: 147.0 143.0 146.0 147.0 144.0 152.0 153.0 152.0 219.0 152.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:3.50 (2.1%) stddev-sans-first:3.69 07:26:29 INFO - PROCESS | 1663 | Values: 169.0 170.0 168.0 174.0 169.0 168.0 168.0 166.0 160.0 168.0 07:26:29 INFO - PROCESS | 1663 | 07:26:29 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:76.50 stddev:9.06 (11.8%) stddev-sans-first:9.40 07:26:29 INFO - PROCESS | 1663 | Values: 69.0 69.0 69.0 69.0 70.0 83.0 83.0 85.0 86.0 60.0 07:26:29 INFO - PROCESS | 1663 | -------- Summary: end -------- 07:26:29 INFO - PROCESS | 1663 | 07:26:30 INFO - TEST-INFO | 1663: exit 0 07:26:30 INFO - TEST-OK | kraken | took 59866ms 07:26:30 INFO - SUITE-END | took 1180s 07:26:30 INFO - Completed test suite (00:19:40) 07:26:30 INFO - javascript benchmark 07:26:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.9007629771104, 3318.2533929865785, 3331.2504686445554, 3339.5324654548353, 3430.9656903430973, 5674.489295963363, 5736.426357364261, 5750.1949727038245, 5756.251687280658, 5762.827115186546, 4846.515348465152, 5621.465960733734, 5757.769689212427, 5760.798372056979, 5768.019436695772, 5129.769160387782, 5183.559397451221, 5221.477852214786, 5238.476152384769, 5261.0267100586325, 5182.455842136578, 5191.325127733389, 5200.193969934666, 5274.683518988873, 5315.36215654122, 5201.921971170435, 5264.710440925747, 5270.130428479296, 5272.446393128724, 5273.789048438058, 4339.2840181369875, 5280.735963201824, 5324.094903866352, 5342.626016178869, 5385.434529374437, 5151.896962060775, 5205.713685747282, 5268.578513718893, 5281.52466278033, 5294.841154765363, 5154.355705536808, 5465.508104270595, 5560.0, 5564.387917329091, 5679.261695979496, 6126.670355029888, 6191.102290167945, 6215.658138802364, 6232.657203853786, 6244.0, 6284.842878928018, 6299.8740025199695, 6307.400796924331, 6314.810555683337, 6335.0, 5709.543236541067, 5774.682392468455, 5822.475977162076, 5926.318473375574, 5949.732262048218, 6253.030780229072, 6272.2159730033745, 6280.340564240689, 6301.40136687014, 6316.210473690789, 6207.472364848948, 6217.0, 6224.688765561795, 6231.563790534619, 6242.625442473466, 6162.969185154046, 6176.505879529627, 6227.875442491125, 6237.407446292595, 6337.683115844189, 6230.626162430269, 6288.088227207029, 6290.528210384239, 6298.275698294755, 6307.369263073656, 6249.000159974473, 6271.749130034747, 6288.968555157287, 6303.464205542488, 6307.810765677037, 4837.927431088537, 4937.456879743226, 4995.075910956485, 5007.39911210657, 5029.597632189416, 4431.800568974404, 4465.910681786346, 4482.462104547475, 4493.146302202571, 4509.436320459942, 5920.467157955804, 5931.228940237742, 5935.139404786368, 5945.672987985702, 5953.107033944856, 6260.686965651699, 6269.185005949197, 6276.874462510816, 6290.874182516324, 6300.243970723543, 5655.0, 5752.827415177551, 5757.366689664133, 5795.971020144957, 5850.765969361178, 5448.0, 5464.0711079116645, 5480.26016487777, 5480.287562616834, 5492.752826122834, 6349.14286571307, 6366.427021568081, 6374.458171055512, 6377.71300291488, 6391.424771770563, 6049.274087109399, 6184.072389141665, 6222.502199824094, 6291.276503202007, 6305.747770089145, 6216.844578885564, 6298.338674439301, 6307.905381419374, 6388.041793730792, 6405.551611387158, 6225.128482012431, 6277.623342599459, 6284.591501552384, 6289.559730818982, 6302.212223472066, 6159.384061593805, 6233.532485063548, 6245.656488893154, 6277.340879207617, 6300.0, 5988.940110598838, 5997.520198384032, 6044.032954727399, 6094.055421409688, 6118.082287656887, 5865.677387743715, 6024.638521688713, 6029.57792954489, 6047.123167140652, 6048.758049678139, 5764.884702306014, 5819.738111785065, 5896.587238893237, 5900.055991041413, 5907.379725128972, 5992.490638295793, 6107.114468401968, 6109.586862300561, 6119.045604113885, 6139.8686669797835, 5822.82531524055, 6024.3674414187635, 6047.213862197887, 6070.969645151746, 6101.481374083075], "value": 5720.122058655955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.65385883740214, 515.9200323949789, 519.7401299350324, 528.2208742105395, 544.3560447448707, 29199.562006569893, 29900.0, 38098.619013809854, 38591.228175436474, 38779.0, 39833.601663983354, 40042.99892502689, 40093.39859902096, 40099.39850902239, 40169.393224271065, 9152.862707059383, 9318.301127415438, 9328.253739700807, 9331.300152488557, 9387.483688397135, 9205.769855753626, 9277.721668349961, 9278.536073196346, 9292.25661947046, 9304.953475232614, 9256.25949924008, 9333.439993600407, 9343.906560934372, 9343.906560934372, 9357.017513161121, 9256.490893000882, 9298.767530811716, 9314.301427392906, 9321.487318197496, 9329.440233586007, 9226.953865230631, 9309.953450232706, 9325.766855828659, 9327.253819694475, 9340.673076442292, 37965.81017094925, 38240.0, 38297.61702382968, 38323.04192395212, 38334.0, 3264.9183770405693, 3270.3622793555264, 3338.0, 3372.406944423646, 3780.4707340972286, 27143.0, 28355.57466638002, 29209.85395073032, 29787.851060744775, 29825.55261671055, 3042.3154790172257, 3060.1890499017777, 3101.9224519387194, 3170.7780455368134, 3284.293876816496, 399002.0, 472593.0, 474032.0, 475945.0, 482465.58767205937, 31935.84032079825, 52841.0, 53230.935381292154, 53343.93312133736, 53427.73286133622, 32917.0, 34002.0, 34027.829860850536, 34120.65879341224, 34318.14204644904, 11985.760284794429, 13579.796303055462, 13589.932050339685, 13948.302584870717, 14144.080634758708, 11844.230125041844, 11925.045996320274, 11932.0, 11938.820917686242, 11943.462544185533, 7466.141393739681, 7577.507462014952, 7598.924010759822, 7620.847583048308, 7644.923550764421, 3189.8086114833186, 3219.774615776873, 3227.8708851646143, 3233.4341490239112, 3254.6419893811662, 904.2856143646445, 922.5110691333604, 987.3286165407449, 1029.552144817007, 1041.9788607165021, 28709.28226794347, 28927.51623498361, 28963.958784327344, 29628.0, 29673.703262967094, 1001.8897921228659, 1008.7679833638158, 1056.3239526702916, 1080.897314755097, 1139.8860113988535, 14720.484783032542, 14942.626434339229, 14962.70074598502, 15252.466163684217, 15319.46381876629, 685835.0, 694285.0, 694909.0, 695092.0, 695899.0, 54949.62625934304, 55179.44820551823, 55256.44743552513, 55337.0, 55383.446165537825, 1348.2584578481797, 1373.1280636795507, 1399.3003498250876, 1401.754692928713, 1403.5789263220993, 28236.43527129487, 28518.714812851606, 28614.427711445238, 29297.560536592395, 29399.412011759217, 46905.765471172424, 52164.95670086653, 53531.73234133804, 53586.73206633942, 57309.42690573208, 621123.0, 626551.0, 626862.0, 627066.0, 629342.0, 40248.798756006036, 40624.0, 41084.1783164329, 41103.58896410998, 41211.96970075772, 43747.0, 44372.0, 45044.32433513434, 45067.32399014083, 45738.54261457343, 36611.450828237066, 36727.449088264235, 37556.061098472754, 38512.22975540417, 38783.612163878, 36646.633533664324, 37230.0, 37294.62705372911, 38427.42358864675, 38493.80753096216, 26379.736202637727, 31926.36147276995, 37153.25693486061, 37461.0, 37556.624433756406, 27463.0, 32514.83742581272, 32839.835800820845, 33098.66901330956, 33944.64221431214, 24974.1269404799, 25045.49909001846, 25101.0, 25112.497750045262, 25587.23238302854], "value": 18321.2976131469, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.90762540301415, 346.26591625753406, 366.3314451126694, 370.54052974311855, 396.0218260895589, 11937.880621193797, 14533.854661453383, 15129.621759456006, 15282.0, 19188.0, 16064.678706425893, 19471.123799429024, 19598.608027839433, 20280.59438811223, 20416.897915510403, 5609.439056094378, 5870.412958704117, 5894.646321220741, 6006.429389208019, 6012.7294271757655, 5629.831105066854, 5829.242198514187, 5838.21184140142, 5870.677112758796, 5969.552283578727, 5810.506106980891, 5815.680137592431, 5818.679972601505, 5820.0, 5824.359320474744, 4884.267359896008, 5439.265699130626, 5472.616916815825, 5768.596198266123, 5800.042992906187, 5082.415522214956, 5105.463926287761, 5122.436531981479, 5126.5642420394315, 5128.487151284879, 24704.505909881882, 25106.372340691447, 25203.369915752068, 25274.49451010988, 25440.87279563609, 2244.1584405847807, 2266.8073213776847, 2278.5670722562827, 2372.6441033845063, 2864.871080801348, 14361.569152925429, 15045.623859403493, 15424.074555526591, 15486.457973970857, 15953.840461595351, 1790.1496789025239, 1833.926642934281, 1844.7417361569392, 1889.962200755991, 1910.751602291707, 66663.66668166677, 101096.49451752768, 101466.98533014649, 101773.0, 102520.0, 10419.791604167875, 10520.421376824348, 10625.893741062491, 10854.6431696038, 11062.778744425066, 13442.93278533601, 13445.663858403617, 13460.0, 13468.93265533666, 13469.057165998482, 8135.877961830577, 8401.663933442716, 8410.831783364421, 8514.48913065218, 8564.871526927102, 8404.243618074403, 8437.535935523483, 8440.071592124861, 8585.484870907765, 8621.094785047606, 5555.833275012212, 6366.681665916685, 6511.967440162769, 6527.0, 6542.901856472156, 1753.5353131420184, 1799.5141311845728, 1803.4409333106778, 1805.8284462975996, 1849.9630007399776, 903.9005709371963, 914.2411798207472, 937.4000639590668, 941.049539964627, 1074.8172810622214, 20385.388438346872, 20912.37262882116, 21554.0, 21706.34880953574, 21864.0, 826.6156237349661, 834.845553572591, 933.814056148701, 943.3019565521465, 989.4953573677476, 10776.923651018858, 11238.269512481662, 11505.942470287595, 11564.653060408202, 11574.6527604172, 570435.0, 608635.0, 624637.0, 624961.0, 627425.0, 82532.34935301381, 91320.0, 94867.0, 112583.43708281407, 117788.0, 891.64334266294, 1002.9097381235724, 1008.3294609084876, 1009.369144284822, 1010.0152351457417, 18983.62704661917, 19765.40703778889, 19928.50178745543, 20061.29785457502, 20073.79926200778, 50790.0, 51453.0, 51936.0, 52514.47485525248, 53227.733861330446, 66942.33057669361, 68082.0, 70959.29040709526, 72023.0, 72405.6379718098, 7441.330280274801, 7567.886481702889, 7660.233976602295, 7906.604669766603, 8070.515769053641, 11955.282683039046, 12292.323922184365, 12482.937585312015, 12803.679908002374, 12960.805587916377, 10891.945540272249, 11026.228164028442, 11038.337699738042, 11315.547378104784, 11412.714682133013, 10834.891651083388, 10882.183836212474, 10951.616693415692, 11202.66392008241, 11396.259243149168, 11039.61361352381, 11134.610288639858, 11177.776444470903, 11347.659570212907, 11755.823662645238, 7941.0, 8097.959510202647, 8135.552544610104, 8303.875441868498, 8333.416660833684, 8723.476591404537, 10976.945115274373, 11146.386948717898, 11280.871912808654, 11319.660410187707], "value": 9425.16518183378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.9610911672653, 1340.4638144742103, 1457.4170331867256, 1580.4705423683065, 1802.3601621424393, 7440.181580026193, 7756.379489640823, 8133.837323253539, 8384.958075209615, 8392.832143357144, 8200.0, 8293.709720159795, 8299.004119505653, 8303.792405189874, 8319.708810191645, 2290.5075408787065, 2318.0959425823944, 2319.9884000579973, 2321.2339927823864, 2329.1382188590246, 2288.5308511755134, 2290.9083636654514, 2358.292512246328, 2359.8702071386065, 2364.4561750797325, 1995.720599116125, 2286.805621522164, 2306.5963456395148, 2324.1284518305633, 2327.3832434404894, 2249.853759505643, 2263.4907145892125, 2283.486215601493, 2292.4612716011725, 2294.9655755163603, 2301.6432452969816, 2320.9071637134493, 2322.7561106083785, 2323.953520929572, 2331.3821837213154, 7686.692532298757, 8199.590020498952, 8282.047564530096, 8292.917070829275, 8297.917020829835, 4993.700377977333, 5190.71451070191, 5194.63637545372, 5194.97402512985, 5208.583313334924, 3054.205906464313, 3358.1604598850286, 3474.7915125092322, 3549.2014296783277, 3575.1598374382, 1043.9039009040478, 1072.5012869015868, 1520.2094910646401, 1689.4678176374402, 1778.2442461953617, 10781.730456738565, 10853.294535855144, 10863.945680271627, 10888.074513666348, 10888.6188983386, 3755.7934313613014, 4301.849435269751, 4364.60718535327, 4379.868603941887, 4434.224010798098, 8499.532525711022, 8584.227419532272, 8597.18326758957, 8606.268467180234, 8621.784455388666, 5076.416212135578, 5082.034413461431, 5082.618803589671, 5086.0845047891735, 5094.745262736922, 4029.9597004029583, 4274.294741367702, 4386.429764130643, 4606.216943119611, 4751.572358487683, 3609.5668519777796, 3621.7464777465852, 3709.0, 3714.461403096536, 3716.6283371662616, 1109.2013750099916, 1127.334872425273, 1142.451623220842, 1144.6394385768456, 1145.604766355606, 821.2854816309849, 849.2102344819377, 861.2076889261895, 896.9998451726278, 912.8767616371705, 4641.675082744176, 5447.0, 5499.862503437446, 5526.447355264522, 5567.610267281332, 813.5240884082759, 863.3999370437485, 868.491932219646, 877.144783835755, 900.522722956834, 3456.015035714809, 3473.6873681368797, 3499.9475007874903, 3515.261795023023, 3515.5605549306338, 8022.27799498048, 10192.286539942133, 10210.846837297446, 10210.948945255226, 10224.64213752515, 9845.212383009486, 10052.69841904744, 10167.44079075658, 10171.440570768531, 10176.084152426318, 7711.151773304932, 7716.074071111502, 7831.060272767304, 7883.211678832071, 7912.9208707912185, 5305.098133317269, 5335.466453354634, 5339.279197308314, 5509.559235261249, 5603.215549822947, 9268.860967085364, 9313.860292095489, 9363.906360936304, 9386.108319709616, 9404.871415430192, 8570.4000719949, 8897.154770296811, 9080.228180604723, 9359.9704032555, 9441.905580944378, 6618.966905165444, 6909.516333856582, 7078.009078728879, 7137.750178743719, 7137.83716901757, 7739.574323412041, 7888.132305446511, 7951.761447156595, 7968.402369822403, 7975.162607926084, 6998.755043573654, 7015.964920175366, 7118.822029449305, 7142.607156606437, 7225.313595208447, 6206.0, 7024.473164512579, 7030.156381234285, 7051.471139664443, 7083.220845707071, 6586.176727909012, 6604.933950660432, 6620.139381880517, 6687.4984376171005, 6720.0, 4121.402396652528, 4728.952710472851, 4753.453352864327, 4803.567678908915, 4894.755262236803, 4814.903701926012, 4916.041371932439, 4924.950750492592, 4956.77694503741, 4982.177940639754], "value": 4350.830911173785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6993236830801, 299.5506739890165, 307.29782447108363, 311.2840466926069, 312.8889244318266, 3918.7648741075486, 4667.509911459299, 5223.3731952165745, 5309.920351194731, 5347.203485525277, 4998.425181104165, 5055.736065983504, 5124.8975020499565, 5235.895282094356, 5276.841694749163, 3472.808995505246, 3514.5079688843584, 3987.461692671481, 4012.0, 4080.8775736727944, 3741.8877433677035, 3754.624537546237, 4053.8175782089875, 4054.3918412238104, 4083.9387409188885, 3963.3856752203455, 3969.96780836983, 3976.1848820991772, 3992.441058251847, 4015.955851478607, 3537.663921927413, 3695.2424752925585, 3833.271678381099, 3972.543157536877, 3992.061865461614, 3026.44010857992, 3166.6200055993427, 3338.549295845078, 3481.669241422061, 3482.8928498258697, 5058.696478211319, 5093.847184584469, 5123.948760512384, 5157.7936882524655, 5198.518422249678, 3588.730845186595, 4042.300356497354, 4504.031633198878, 4577.33628623851, 4596.724196548218, 4151.0, 5328.8401347959625, 5431.153407841313, 5516.475934786189, 5539.778408863641, 3815.4467602197806, 3820.3314419976673, 3821.48409964654, 3822.4839646647624, 3826.789526576037, 4660.440747110369, 5536.667799932017, 5847.473727364558, 5869.501092407193, 5882.588178837091, 3620.420732682758, 3783.432485127253, 3821.617838216156, 3826.9808650956566, 3833.6997801319544, 3864.729468937204, 3874.1476875087437, 3878.650921417086, 3910.2961466936226, 3919.3924941633522, 4497.977510112429, 4510.323451482304, 4517.390152329459, 4520.276755719069, 4597.3793537872625, 4938.925916111261, 5267.789288428497, 5277.2875661785165, 5505.449455054542, 5564.360098588633, 1023.8720159980003, 1082.826747720361, 1208.323338930202, 1235.1534455988356, 1244.825724398585, 636.8662580857979, 794.1224946434222, 799.9800004999921, 836.8410002099581, 843.8017065989487, 4237.809298581509, 4441.733495990251, 4825.927611085836, 4978.929530151035, 4996.575291100225, 4604.181348367376, 5022.9748851256245, 5044.596432285409, 5402.621816472888, 5432.256710361242, 4167.97916010418, 4962.429320628102, 4969.527894849984, 4970.396462564611, 5009.695540051544, 2558.6801649793774, 2756.7656749176545, 2789.4142230131492, 2794.846283454389, 2853.4863724529782, 5236.790528378899, 5370.4629537045985, 5633.2961976749875, 5646.927083854054, 5671.461211184931, 4518.932216016762, 4940.505949405031, 5122.692638441706, 5143.485651434901, 5524.447555244444, 4911.3369695090705, 5460.140474977274, 5460.453954604508, 5467.72661366938, 5520.447955204448, 4808.2547205183255, 5227.55565776898, 5264.947350526446, 5271.420143784258, 5291.417944026231, 4829.7585120744525, 5162.845114646567, 5240.851250987077, 5490.231367608618, 5608.663480191201, 4959.809645685082, 5152.355955505562, 5876.941230587639, 5891.0, 6019.307779605227, 3548.8048157351595, 3851.9037024074623, 3862.416409272185, 3954.7824869632445, 3965.325894597868, 5230.843074707765, 5234.502722241381, 5328.946710533, 5497.670139791625, 5675.177099320493, 4437.933430998473, 4853.6944951147925, 5537.723113844372, 5544.1232293768735, 5568.832935011957, 4894.3848529985735, 5329.360476742816, 5454.59090568201, 5508.752106155152, 5520.365158006881, 4111.1366613010405, 4621.560951709582, 5435.0, 5466.977218429207, 5499.862503437446, 5315.707636080053, 5486.214511986716, 5488.012157811472, 5489.670619762667, 5525.502704756591, 4322.546132656152, 4783.306420569068, 5423.532292806684, 5431.891362172813, 5483.8080667176455], "value": 3933.4973905037873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.1896885799324, 667.8722719052691, 751.9135299440562, 760.9619519024051, 763.3549650545287, 13602.45590176393, 14239.430422783076, 14246.71506569868, 14260.286985650728, 14266.71466570668, 12627.431765570549, 12693.0, 12730.0, 12738.745225095492, 12781.169224000434, 627.7269387816315, 647.0391468669022, 649.3830860682347, 794.8966634337557, 806.5725165662209, 785.516907102131, 798.8601994650942, 801.6993627389729, 818.8485130250923, 819.3117781063905, 791.6595863778573, 850.6639877248483, 853.0190281176634, 854.5513605357175, 856.0968178571604, 656.957297775643, 675.3044364304725, 846.5767116441779, 847.4957400346784, 853.7097386888456, 606.9089636554507, 625.2840497630233, 626.2485017978444, 626.4111734969115, 628.4783629587431, 13419.0, 13425.597232083053, 13443.865561344457, 13449.193048417126, 13463.798043029363, 9835.360701554377, 12261.141720079599, 12800.0, 12804.10371274002, 12990.025748068932, 11651.0, 11735.647930562096, 11850.22973506728, 11991.760164796742, 12020.338881361522, 4304.698671093025, 4307.0, 4319.892002699926, 4389.275769498029, 4440.622547083502, 79482.8077578831, 84522.0, 84979.0, 85134.0, 88040.99999999936, 9647.855282170633, 9911.504424778732, 10109.949450252701, 10200.489975501196, 10512.369257844553, 19078.61842763137, 19159.04204789755, 19172.041397930327, 19347.226110955406, 19476.51308717265, 6552.213734351908, 7446.925530744732, 7449.962750186214, 7504.287092726182, 7636.465447418738, 4168.791560421967, 4175.248455278079, 4205.558416366238, 4242.957570424318, 4453.087117140978, 3377.3583019226758, 3491.650834916488, 3503.2818272254126, 3507.7544571880235, 3508.4211105167874, 648.070019521978, 649.3084864619166, 650.973961041553, 668.0280192320163, 672.6098862659645, 572.7909313100688, 637.8309747916805, 649.7498463091744, 655.4625207329943, 693.5457275484565, 8951.641934322553, 9020.503872286956, 9046.86429703555, 9228.0, 9301.627934882665, 548.9843788990336, 596.9194158788595, 625.6527627166967, 669.7086767256259, 674.1741366825697, 4245.724027938174, 4434.756088415168, 4478.149151661174, 4479.910401791946, 4498.977505112453, 83619.16380836235, 105705.47147264368, 109366.45316773365, 109754.45122774335, 109951.45024274988, 67062.66468667626, 83201.0, 93287.0, 95835.0, 99099.00900991043, 83471.7479237824, 83765.58117209497, 85431.57284213539, 87395.56302218576, 88390.0, 8663.090375510732, 8767.693130740394, 8781.868271976053, 8832.5583720815, 8929.464232146092, 43764.0, 46815.531844681114, 50241.0, 54389.91220175653, 54980.0, 63608.04587931278, 65163.67418163068, 68891.83311251576, 70142.0, 72005.0, 12223.75552488963, 12244.816327754912, 12497.375131243583, 12646.241225526497, 12856.292903890377, 10963.945180274048, 12811.807822882478, 14452.566423007327, 14572.635684107981, 15027.398904044154, 12832.486700531874, 13156.36993933391, 13173.670658233621, 13223.206607603575, 13859.584212473643, 12512.249265044127, 12549.435275412447, 12878.227306361649, 12937.288449135387, 13145.408456619667, 12293.385330733607, 12450.25298482094, 12469.438875250817, 12511.499540018298, 13347.866521334663, 10806.35161890289, 10834.02493775564, 10855.457227138453, 11073.667789966314, 11129.109671226444, 10670.0930420912, 11335.943320283346, 11501.367424791717, 11593.304401735923, 11620.6513804586], "value": 7124.725060586041, "unit": "score"}], "name": "dromaeo_css", "value": 7027.528681221789, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 112.0, 116.0, 114.0, 113.0, 111.0, 114.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 117.0, 148.0, 115.0, 114.0, 114.0, 118.0, 148.0, 114.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 186.0, 183.0, 185.0, 184.0, 182.0, 182.0, 187.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 93.0, 61.0, 59.0, 60.0, 62.0, 84.0, 60.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 95.0, 70.0, 68.0, 69.0, 91.0, 68.0, 69.0, 92.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 134.0, 98.0, 85.0, 84.0, 87.0, 83.0, 86.0, 83.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 102.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 92.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 102.0, 121.0, 101.0, 80.0, 83.0, 82.0, 85.0, 83.0, 82.0], "value": 89.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 57.0, 59.0, 59.0, 57.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 67.0, 78.0, 72.0, 70.0, 70.0, 73.0, 72.0, 72.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 84.0, 84.0, 84.0, 85.0, 88.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 143.0, 146.0, 147.0, 144.0, 152.0, 153.0, 152.0, 219.0, 152.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 168.0, 174.0, 169.0, 168.0, 168.0, 166.0, 160.0, 168.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 83.0, 83.0, 85.0, 86.0, 60.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1454.5, "alertThreshold": 2.0}]} 07:26:30 INFO - Return code: 0 07:26:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:30 INFO - # TBPL SUCCESS # 07:26:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:26:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:26:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:26:30 INFO - 2016-12-06 07:26:30.530 screenresolution[1667:13127] starting screenresolution argv=screenresolution get 07:26:30 INFO - 2016-12-06 07:26:30.534 screenresolution[1667:13127] Display 0: 1600x1200x32@60 07:26:30 INFO - 2016-12-06 07:26:30.540 screenresolution[1668:13130] starting screenresolution argv=screenresolution list 07:26:30 INFO - Available Modes on Display 0 07:26:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:26:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:26:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:26:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:26:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:26:30 INFO - Intel Iris: 07:26:30 INFO - Chipset Model: Intel Iris 07:26:30 INFO - Type: GPU 07:26:30 INFO - Bus: Built-In 07:26:30 INFO - VRAM (Dynamic, Max): 1536 MB 07:26:30 INFO - Vendor: Intel (0x8086) 07:26:30 INFO - Device ID: 0x0a2e 07:26:30 INFO - Revision ID: 0x0009 07:26:30 INFO - Displays: 07:26:30 INFO - Display: 07:26:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:26:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:26:30 INFO - Display Serial Number: 1600x1200 60 07:26:30 INFO - Main Display: Yes 07:26:30 INFO - Mirror: Off 07:26:30 INFO - Online: Yes 07:26:30 INFO - Rotation: Supported 07:26:30 INFO - Return code: 0 07:26:30 INFO - Running post-action listener: _resource_record_post_action 07:26:30 INFO - [mozharness: 2016-12-06 15:26:30.796496Z] Finished run-tests step (success) 07:26:30 INFO - Running post-run listener: _resource_record_post_run 07:26:30 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 32369664; Write bytes: 658531840; Read time: 195; Write time: 1904 07:26:30 INFO - TinderboxPrint: CPU usage
53.5% 07:26:30 INFO - TinderboxPrint: I/O read bytes / time
32,369,664 / 195 07:26:30 INFO - TinderboxPrint: I/O write bytes / time
658,531,840 / 1,904 07:26:30 INFO - TinderboxPrint: CPU idle
2,256.2 (46.5%) 07:26:30 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 07:26:30 INFO - TinderboxPrint: CPU user
1,623.7 (33.5%) 07:26:30 INFO - TinderboxPrint: Swap in / out
376,815,616 / 0 07:26:30 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345844224; Write bytes: 345077760; Read time: 27113; Write time: 725 07:26:30 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 30391296; Write bytes: 306470400; Read time: 176; Write time: 1150 07:26:31 INFO - Running post-run listener: _upload_blobber_files 07:26:31 INFO - Blob upload gear active. 07:26:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:31 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 07:26:31 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'] 07:26:31 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 07:26:31 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:32 INFO - (blobuploader) - INFO - Done attempting. 07:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:33 INFO - (blobuploader) - INFO - Done attempting. 07:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:36 INFO - (blobuploader) - INFO - Done attempting. 07:26:36 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:36 INFO - Return code: 0 07:26:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7320c989c063ddd8d0c078bce374f895862041af60f2d155a3136a3098c8a54d3ac689efa0110f1744cbbcb9129a12538450a11091e0855148d8752f604ac281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/592ed8fa36f4b198116971e1e18afea9a0bf16620d940909587a2175a8faceb90ed9896975e2a8be119bae603e28b935d99d243b52119531c2d66967fa50f619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f17a0333a22c7df904814ad5b86f49c6958f418fa3238fc3bb8843f617bd485497ead60d0c92fbf57c057a9aee69c0fbb19cf82d7ece9b64c539ccd93877930a"} 07:26:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:36 INFO - Contents: 07:26:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7320c989c063ddd8d0c078bce374f895862041af60f2d155a3136a3098c8a54d3ac689efa0110f1744cbbcb9129a12538450a11091e0855148d8752f604ac281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/592ed8fa36f4b198116971e1e18afea9a0bf16620d940909587a2175a8faceb90ed9896975e2a8be119bae603e28b935d99d243b52119531c2d66967fa50f619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f17a0333a22c7df904814ad5b86f49c6958f418fa3238fc3bb8843f617bd485497ead60d0c92fbf57c057a9aee69c0fbb19cf82d7ece9b64c539ccd93877930a"} 07:26:36 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:36 INFO - Copying logs to upload dir... 07:26:36 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.977558 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-06 07:26:36.455746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 07:26:36.460116) ========= 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.qXMMSeYnkJ/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.B0G952zSXe/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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/7320c989c063ddd8d0c078bce374f895862041af60f2d155a3136a3098c8a54d3ac689efa0110f1744cbbcb9129a12538450a11091e0855148d8752f604ac281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/592ed8fa36f4b198116971e1e18afea9a0bf16620d940909587a2175a8faceb90ed9896975e2a8be119bae603e28b935d99d243b52119531c2d66967fa50f619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f17a0333a22c7df904814ad5b86f49c6958f418fa3238fc3bb8843f617bd485497ead60d0c92fbf57c057a9aee69c0fbb19cf82d7ece9b64c539ccd93877930a"} build_url:https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010905 build_url: 'https://queue.taskcluster.net/v1/task/SkLhjayTR9-NWgRFP32wBg/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/7320c989c063ddd8d0c078bce374f895862041af60f2d155a3136a3098c8a54d3ac689efa0110f1744cbbcb9129a12538450a11091e0855148d8752f604ac281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/592ed8fa36f4b198116971e1e18afea9a0bf16620d940909587a2175a8faceb90ed9896975e2a8be119bae603e28b935d99d243b52119531c2d66967fa50f619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f17a0333a22c7df904814ad5b86f49c6958f418fa3238fc3bb8843f617bd485497ead60d0c92fbf57c057a9aee69c0fbb19cf82d7ece9b64c539ccd93877930a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 07:26:36.494440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:26:36.494772) ========= 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.qXMMSeYnkJ/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.B0G952zSXe/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 07:26:36.543953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 07:26:36.544291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 07:26:36.544627) ========= ========= Total master_lag: 0.18 =========