builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1477659739.08 results: success (0) buildid: 20161028022800 builduid: 0d111bbf92724cd08363c66298e5248d revision: 9de99520eefdde708a90ee480e68b42b75b88163 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.076322) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.076784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.077201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.103975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.104442) ========= 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.H5MRY5zuiY/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.azpeW7QfHI/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-28 06:02:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.8M=0.001s 2016-10-28 06:02:19 (12.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.207183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.207518) ========= 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.H5MRY5zuiY/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.azpeW7QfHI/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.025774 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:19.256832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 06:02:19.257264) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 9de99520eefdde708a90ee480e68b42b75b88163 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 9de99520eefdde708a90ee480e68b42b75b88163 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H5MRY5zuiY/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.azpeW7QfHI/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-28 06:02:19,333 truncating revision to first 12 chars 2016-10-28 06:02:19,333 Setting DEBUG logging. 2016-10-28 06:02:19,333 attempt 1/10 2016-10-28 06:02:19,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/9de99520eefd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 06:02:20,180 unpacking tar archive at: cedar-9de99520eefd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.096771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-28 06:02:20.377014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:20.377385) ========= script_repo_revision: 9de99520eefdde708a90ee480e68b42b75b88163 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:20.377804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:20.378073) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 06:02:20.398531) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-28 06:02:20.398949) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H5MRY5zuiY/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.azpeW7QfHI/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:20 INFO - MultiFileLogger online at 20161028 06:02:20 in /builds/slave/test 06:02:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:02:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:20 INFO - {'append_to_log': False, 06:02:20 INFO - 'base_work_dir': '/builds/slave/test', 06:02:20 INFO - 'blob_upload_branch': 'Cedar', 06:02:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:20 INFO - 'branch': 'Cedar', 06:02:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:20 INFO - 'config_files': ('talos/mac_config.py',), 06:02:20 INFO - 'default_actions': ('clobber', 06:02:20 INFO - 'read-buildbot-config', 06:02:20 INFO - 'download-and-extract', 06:02:20 INFO - 'populate-webroot', 06:02:20 INFO - 'create-virtualenv', 06:02:20 INFO - 'install', 06:02:20 INFO - 'run-tests'), 06:02:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:20 INFO - 'download_minidump_stackwalk': True, 06:02:20 INFO - 'download_symbols': 'ondemand', 06:02:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:20 INFO - 'installer_path': 'installer.exe', 06:02:20 INFO - 'log_level': 'info', 06:02:20 INFO - 'log_name': 'talos', 06:02:20 INFO - 'log_to_console': True, 06:02:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:02:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:02:20 INFO - 'opt_config_files': (), 06:02:20 INFO - 'pip_index': False, 06:02:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:02:20 INFO - 'cmd': ('bash', 06:02:20 INFO - '-c', 06:02:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:02:20 INFO - 'enabled': True, 06:02:20 INFO - 'halt_on_failure': False, 06:02:20 INFO - 'name': 'check_screen_resolution'},), 06:02:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:02:20 INFO - 'cmd': ('bash', 06:02:20 INFO - '-c', 06:02:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:02:20 INFO - 'enabled': True, 06:02:20 INFO - 'halt_on_failure': False, 06:02:20 INFO - 'name': 'check_screen_resolution'},), 06:02:20 INFO - 'run_cmd_checks_enabled': True, 06:02:20 INFO - 'sps_profile': False, 06:02:20 INFO - 'sps_profile_interval': 0, 06:02:20 INFO - 'suite': 'dromaeojs', 06:02:20 INFO - 'system_bits': '32', 06:02:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:20 INFO - 'title': 't-yosemite-r7-0038', 06:02:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:20 INFO - 'use_talos_json': True, 06:02:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:20 INFO - 'work_dir': 'build'} 06:02:20 INFO - [mozharness: 2016-10-28 13:02:20.605105Z] Running clobber step. 06:02:20 INFO - Running pre-action listener: _resource_record_pre_action 06:02:20 INFO - Running main action method: clobber 06:02:20 INFO - rmtree: /builds/slave/test/build 06:02:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:22 INFO - Running post-action listener: _resource_record_post_action 06:02:22 INFO - [mozharness: 2016-10-28 13:02:22.753337Z] Finished clobber step (success) 06:02:22 INFO - [mozharness: 2016-10-28 13:02:22.753502Z] Running read-buildbot-config step. 06:02:22 INFO - Running pre-action listener: _resource_record_pre_action 06:02:22 INFO - Running main action method: read_buildbot_config 06:02:22 INFO - Using buildbot properties: 06:02:22 INFO - { 06:02:22 INFO - "project": "", 06:02:22 INFO - "product": "firefox", 06:02:22 INFO - "script_repo_revision": "default", 06:02:22 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 06:02:22 INFO - "repository": "", 06:02:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 06:02:22 INFO - "buildid": "20161028022800", 06:02:22 INFO - "pgo_build": "False", 06:02:22 INFO - "basedir": "/builds/slave/test", 06:02:22 INFO - "buildnumber": 0, 06:02:22 INFO - "slavename": "t-yosemite-r7-0038", 06:02:22 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:02:22 INFO - "platform": "yosemite_r7", 06:02:22 INFO - "scheduler": "tests-cedar-macosx64-talos", 06:02:22 INFO - "branch": "cedar", 06:02:22 INFO - "repo_path": "projects/cedar", 06:02:22 INFO - "revision": "9de99520eefdde708a90ee480e68b42b75b88163", 06:02:22 INFO - "stage_platform": "macosx64", 06:02:22 INFO - "builduid": "0d111bbf92724cd08363c66298e5248d", 06:02:22 INFO - "slavebuilddir": "test" 06:02:22 INFO - } 06:02:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:02:22 INFO - Running post-action listener: _resource_record_post_action 06:02:22 INFO - [mozharness: 2016-10-28 13:02:22.757858Z] Finished read-buildbot-config step (success) 06:02:22 INFO - [mozharness: 2016-10-28 13:02:22.757975Z] Running download-and-extract step. 06:02:22 INFO - Running pre-action listener: _resource_record_pre_action 06:02:22 INFO - Running main action method: download_and_extract 06:02:22 INFO - mkdir: /builds/slave/test/build/tests 06:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:22 INFO - trying https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:02:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:02:23 INFO - Downloaded 1199 bytes. 06:02:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:02:23 INFO - Using the following test package requirements: 06:02:23 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:02:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:02:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:02:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'jsshell-mac.zip'], 06:02:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:02:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:02:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:02:23 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:02:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:02:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:02:23 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:02:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:02:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:02:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:02:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:02:23 INFO - Http code: 200 06:02:23 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 06:02:23 INFO - x-amz-cf-id: e2BtT4OI5Q6Vm6brPiey6-KuFZHgMl7dTC1TbpOyV65I9nx8aKJhNQ== 06:02:23 INFO - x-amz-version-id: GGcxnDzmD25isgEcAvmoISTrYKMJzTjC 06:02:24 INFO - Expected file size: 16377268 06:02:24 INFO - Obtained file size: 16377268 06:02:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:02:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:02:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:02:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:02:31 INFO - Http code: 200 06:02:31 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 06:02:31 INFO - x-amz-cf-id: jzXXnudfnJk09dIw-xT9DmANVHWDe5-oUAAir7saOc6yFEfSctw2JQ== 06:02:31 INFO - x-amz-version-id: GGcxnDzmD25isgEcAvmoISTrYKMJzTjC 06:02:31 INFO - Expected file size: 16377268 06:02:31 INFO - Obtained file size: 16377268 06:02:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:02:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:02:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:02:38 INFO - Http code: 200 06:02:38 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 06:02:38 INFO - x-amz-cf-id: 1otUan5zQybn-2HyGVJjqYhcWIFojsj_vMYdnq0_9_qWpyuFEo8cnA== 06:02:38 INFO - x-amz-version-id: A3bUJbWTwlcPLIEO8Bbx9V0v_ZaSu3lb 06:02:39 INFO - Expected file size: 14409028 06:02:39 INFO - Obtained file size: 14409028 06:02:39 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')]} 06:02:39 INFO - trying https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:02:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:02:42 INFO - Downloaded 111527707 bytes. 06:02:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:02:42 INFO - mkdir: /builds/slave/test/properties 06:02:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:02:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:02:42 INFO - Contents: 06:02:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:02:43 INFO - Running post-action listener: _resource_record_post_action 06:02:43 INFO - Running post-action listener: set_extra_try_arguments 06:02:43 INFO - [mozharness: 2016-10-28 13:02:43.889817Z] Finished download-and-extract step (success) 06:02:43 INFO - [mozharness: 2016-10-28 13:02:43.889972Z] Running populate-webroot step. 06:02:43 INFO - Running pre-action listener: _resource_record_pre_action 06:02:43 INFO - Running main action method: populate_webroot 06:02:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:02:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:02:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:02:43 INFO - '--tppagecycles', 06:02:43 INFO - '7'], 06:02:43 INFO - 'tests': ['tsvgm']}}, 06:02:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:02:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:02:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:02:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:02:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['damp', 'tps']}, 06:02:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'tests': ['damp', 'tps']}, 06:02:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['dromaeo_dom']}, 06:02:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:02:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['basic_compositor_video']}, 06:02:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:02:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['a11yr', 06:02:43 INFO - 'ts_paint', 06:02:43 INFO - 'tpaint', 06:02:43 INFO - 'sessionrestore', 06:02:43 INFO - 'sessionrestore_no_auto_restore', 06:02:43 INFO - 'tabpaint']}, 06:02:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:02:43 INFO - 'ts_paint', 06:02:43 INFO - 'tpaint', 06:02:43 INFO - 'sessionrestore', 06:02:43 INFO - 'sessionrestore_no_auto_restore', 06:02:43 INFO - 'tabpaint']}, 06:02:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:02:43 INFO - 'ts_paint', 06:02:43 INFO - 'tpaint', 06:02:43 INFO - 'sessionrestore', 06:02:43 INFO - 'sessionrestore_no_auto_restore', 06:02:43 INFO - 'tabpaint']}, 06:02:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:02:43 INFO - 'ts_paint', 06:02:43 INFO - 'tpaint', 06:02:43 INFO - 'sessionrestore', 06:02:43 INFO - 'sessionrestore_no_auto_restore', 06:02:43 INFO - 'tabpaint']}, 06:02:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['a11yr', 06:02:43 INFO - 'ts_paint', 06:02:43 INFO - 'tpaint', 06:02:43 INFO - 'sessionrestore', 06:02:43 INFO - 'sessionrestore_no_auto_restore', 06:02:43 INFO - 'tabpaint']}, 06:02:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['a11yr', 06:02:43 INFO - 'ts_paint', 06:02:43 INFO - 'tpaint', 06:02:43 INFO - 'sessionrestore', 06:02:43 INFO - 'sessionrestore_no_auto_restore', 06:02:43 INFO - 'tabpaint']}, 06:02:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['tsvgx', 06:02:43 INFO - 'tsvgr_opacity', 06:02:43 INFO - 'tart', 06:02:43 INFO - 'tscrollx', 06:02:43 INFO - 'cart']}, 06:02:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:02:43 INFO - 'tsvgr_opacity', 06:02:43 INFO - 'tart', 06:02:43 INFO - 'tscrollx', 06:02:43 INFO - 'cart']}, 06:02:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'talos_options': ['--disable-e10s'], 06:02:43 INFO - 'tests': ['tp5o']}, 06:02:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'tests': ['tp5o']}, 06:02:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'talos_options': ['--disable-e10s', 06:02:43 INFO - '--xperf_path', 06:02:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:43 INFO - 'tests': ['tp5n']}, 06:02:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:02:43 INFO - 'talos_options': ['--xperf_path', 06:02:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:43 INFO - 'tests': ['tp5n']}}, 06:02:43 INFO - 'talos.zip': {'path': '', 06:02:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:02:43 INFO - Running post-action listener: _resource_record_post_action 06:02:43 INFO - [mozharness: 2016-10-28 13:02:43.908340Z] Finished populate-webroot step (success) 06:02:43 INFO - [mozharness: 2016-10-28 13:02:43.908457Z] Running create-virtualenv step. 06:02:43 INFO - Running pre-action listener: _resource_record_pre_action 06:02:43 INFO - Running main action method: create_virtualenv 06:02:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:02:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:02:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:02:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:02:44 INFO - Using real prefix '/tools/python27' 06:02:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:02:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:02:47 INFO - Installing pip.................done. 06:02:47 INFO - Return code: 0 06:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:02:47 INFO - Reading from file tmpfile_stdout 06:02:47 INFO - Output received: 06:02:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:02:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:02:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:02:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:47 INFO - 'HOME': '/Users/cltbld', 06:02:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:47 INFO - 'LOGNAME': 'cltbld', 06:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:47 INFO - 'MOZ_NO_REMOTE': '1', 06:02:47 INFO - 'NO_EM_RESTART': '1', 06:02:47 INFO - 'PAGER': '/bin/cat', 06:02:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:47 INFO - 'PWD': '/builds/slave/test', 06:02:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:47 INFO - 'SHELL': '/bin/bash', 06:02:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:02:47 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:02:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:47 INFO - 'USER': 'cltbld', 06:02:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:47 INFO - 'XPC_FLAGS': '0x0', 06:02:47 INFO - 'XPC_SERVICE_NAME': '0', 06:02:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:48 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 06:02:48 INFO - Cleaning up... 06:02:48 INFO - Return code: 0 06:02:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:02:48 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')]} 06:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:48 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')]} 06:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:48 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 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:48 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 06:02:48 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 06:02:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:02:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:48 INFO - 'HOME': '/Users/cltbld', 06:02:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:48 INFO - 'LOGNAME': 'cltbld', 06:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:48 INFO - 'MOZ_NO_REMOTE': '1', 06:02:48 INFO - 'NO_EM_RESTART': '1', 06:02:48 INFO - 'PAGER': '/bin/cat', 06:02:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:48 INFO - 'PWD': '/builds/slave/test', 06:02:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:48 INFO - 'SHELL': '/bin/bash', 06:02:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:02:48 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:02:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:48 INFO - 'USER': 'cltbld', 06:02:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:48 INFO - 'XPC_FLAGS': '0x0', 06:02:48 INFO - 'XPC_SERVICE_NAME': '0', 06:02:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:48 INFO - Downloading/unpacking psutil>=3.1.1 06:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:51 INFO - Installing collected packages: psutil 06:02:51 INFO - Running setup.py install for psutil 06:02:51 INFO - building 'psutil._psutil_osx' extension 06:02:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:02:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:02:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:02:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:02:52 INFO - building 'psutil._psutil_posix' extension 06:02:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:02:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:02:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:02:52 INFO - ^ 06:02:52 INFO - 1 warning generated. 06:02:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:02:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:53 INFO - Successfully installed psutil 06:02:53 INFO - Cleaning up... 06:02:53 INFO - Return code: 0 06:02:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:02:53 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')]} 06:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:53 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')]} 06:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:53 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 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:53 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 06:02:53 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 06:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:53 INFO - 'HOME': '/Users/cltbld', 06:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:53 INFO - 'LOGNAME': 'cltbld', 06:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:53 INFO - 'MOZ_NO_REMOTE': '1', 06:02:53 INFO - 'NO_EM_RESTART': '1', 06:02:53 INFO - 'PAGER': '/bin/cat', 06:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:53 INFO - 'PWD': '/builds/slave/test', 06:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:53 INFO - 'SHELL': '/bin/bash', 06:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:02:53 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:53 INFO - 'USER': 'cltbld', 06:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:53 INFO - 'XPC_FLAGS': '0x0', 06:02:53 INFO - 'XPC_SERVICE_NAME': '0', 06:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:02:55 INFO - Installing collected packages: mozsystemmonitor 06:02:55 INFO - Running setup.py install for mozsystemmonitor 06:02:56 INFO - Successfully installed mozsystemmonitor 06:02:56 INFO - Cleaning up... 06:02:56 INFO - Return code: 0 06:02:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:56 INFO - 'HOME': '/Users/cltbld', 06:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:56 INFO - 'LOGNAME': 'cltbld', 06:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:56 INFO - 'MOZ_NO_REMOTE': '1', 06:02:56 INFO - 'NO_EM_RESTART': '1', 06:02:56 INFO - 'PAGER': '/bin/cat', 06:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:56 INFO - 'PWD': '/builds/slave/test', 06:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:56 INFO - 'SHELL': '/bin/bash', 06:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:02:56 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:56 INFO - 'USER': 'cltbld', 06:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:56 INFO - 'XPC_FLAGS': '0x0', 06:02:56 INFO - 'XPC_SERVICE_NAME': '0', 06:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:59 INFO - warning: no files found matching '*.txt' 06:02:59 INFO - no previously-included directories found matching 'build' 06:02:59 INFO - no previously-included directories found matching 'dist' 06:02:59 INFO - no previously-included directories found matching '.git*' 06:02:59 INFO - Installing collected packages: jsonschema, functools32 06:02:59 INFO - Running setup.py install for functools32 06:02:59 INFO - warning: no files found matching '*.txt' 06:02:59 INFO - no previously-included directories found matching 'build' 06:02:59 INFO - no previously-included directories found matching 'dist' 06:02:59 INFO - no previously-included directories found matching '.git*' 06:02:59 INFO - Successfully installed jsonschema functools32 06:02:59 INFO - Cleaning up... 06:02:59 INFO - Return code: 0 06:02:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:59 INFO - 'HOME': '/Users/cltbld', 06:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:59 INFO - 'LOGNAME': 'cltbld', 06:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:59 INFO - 'MOZ_NO_REMOTE': '1', 06:02:59 INFO - 'NO_EM_RESTART': '1', 06:02:59 INFO - 'PAGER': '/bin/cat', 06:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:59 INFO - 'PWD': '/builds/slave/test', 06:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:59 INFO - 'SHELL': '/bin/bash', 06:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:02:59 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:59 INFO - 'USER': 'cltbld', 06:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:59 INFO - 'XPC_FLAGS': '0x0', 06:02:59 INFO - 'XPC_SERVICE_NAME': '0', 06:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:02:59 INFO - Cleaning up... 06:02:59 INFO - Return code: 0 06:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:59 INFO - 'HOME': '/Users/cltbld', 06:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:59 INFO - 'LOGNAME': 'cltbld', 06:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:59 INFO - 'MOZ_NO_REMOTE': '1', 06:02:59 INFO - 'NO_EM_RESTART': '1', 06:02:59 INFO - 'PAGER': '/bin/cat', 06:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:59 INFO - 'PWD': '/builds/slave/test', 06:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:59 INFO - 'SHELL': '/bin/bash', 06:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:02:59 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:59 INFO - 'USER': 'cltbld', 06:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:59 INFO - 'XPC_FLAGS': '0x0', 06:02:59 INFO - 'XPC_SERVICE_NAME': '0', 06:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:00 INFO - Downloading/unpacking blobuploader==1.2.4 06:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:02 INFO - Downloading blobuploader-1.2.4.tar.gz 06:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:03:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:03:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:03 INFO - Downloading docopt-0.6.1.tar.gz 06:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:03:03 INFO - Running setup.py install for blobuploader 06:03:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:03:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:03:04 INFO - Running setup.py install for requests 06:03:04 INFO - Running setup.py install for docopt 06:03:04 INFO - Successfully installed blobuploader requests docopt 06:03:04 INFO - Cleaning up... 06:03:04 INFO - Return code: 0 06:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:04 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')]} 06:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:04 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')]} 06:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:04 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 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:03:04 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 06:03:04 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 06:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:04 INFO - 'HOME': '/Users/cltbld', 06:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:04 INFO - 'LOGNAME': 'cltbld', 06:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:04 INFO - 'MOZ_NO_REMOTE': '1', 06:03:04 INFO - 'NO_EM_RESTART': '1', 06:03:04 INFO - 'PAGER': '/bin/cat', 06:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:04 INFO - 'PWD': '/builds/slave/test', 06:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:04 INFO - 'SHELL': '/bin/bash', 06:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:03:04 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:04 INFO - 'USER': 'cltbld', 06:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:04 INFO - 'XPC_FLAGS': '0x0', 06:03:04 INFO - 'XPC_SERVICE_NAME': '0', 06:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-hV_Bdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-6AiQ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-jolRCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-13AaXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-rbw8uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-J_VQdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-bXceFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ApWqO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:05 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-TRT7o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ezM6tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-wDaPk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-aWYVZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZMGiQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-yjD0Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-T6dz_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-plTXwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:06 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-r7X9gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:03:06 INFO - Running setup.py install for manifestparser 06:03:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:03:07 INFO - Running setup.py install for mozcrash 06:03:07 INFO - Running setup.py install for mozdebug 06:03:07 INFO - Running setup.py install for mozdevice 06:03:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:03:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:03:07 INFO - Running setup.py install for mozfile 06:03:07 INFO - Running setup.py install for mozhttpd 06:03:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:03:07 INFO - Running setup.py install for mozinfo 06:03:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:03:07 INFO - Running setup.py install for mozInstall 06:03:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Running setup.py install for mozleak 06:03:08 INFO - Running setup.py install for mozlog 06:03:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Running setup.py install for moznetwork 06:03:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Running setup.py install for mozprocess 06:03:08 INFO - Running setup.py install for mozprofile 06:03:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:03:08 INFO - Running setup.py install for mozrunner 06:03:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:03:09 INFO - Running setup.py install for mozscreenshot 06:03:09 INFO - Running setup.py install for moztest 06:03:09 INFO - Running setup.py install for mozversion 06:03:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:03:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:03:09 INFO - Cleaning up... 06:03:09 INFO - Return code: 0 06:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:09 INFO - 'HOME': '/Users/cltbld', 06:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:09 INFO - 'LOGNAME': 'cltbld', 06:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:09 INFO - 'MOZ_NO_REMOTE': '1', 06:03:09 INFO - 'NO_EM_RESTART': '1', 06:03:09 INFO - 'PAGER': '/bin/cat', 06:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:09 INFO - 'PWD': '/builds/slave/test', 06:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:09 INFO - 'SHELL': '/bin/bash', 06:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:03:09 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:09 INFO - 'USER': 'cltbld', 06:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:09 INFO - 'XPC_FLAGS': '0x0', 06:03:09 INFO - 'XPC_SERVICE_NAME': '0', 06:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-aRA8UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8m9YGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-lJ_0Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-r7wp9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-daekru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4hPB4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-5nfoSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Ik0OK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:10 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-0nOAjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:11 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)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-sFCNMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Zog1ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-v74iK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-QNYEl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8XVZuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qKwPWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-HRPAbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:11 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)) 06:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:11 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-W7t8_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:03:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:14 INFO - Downloading blessings-1.6.tar.gz 06:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:03:15 INFO - Installing collected packages: blessings 06:03:15 INFO - Running setup.py install for blessings 06:03:15 INFO - Successfully installed blessings 06:03:15 INFO - Cleaning up... 06:03:15 INFO - Return code: 0 06:03:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:15 INFO - Reading from file tmpfile_stdout 06:03:15 INFO - Current package versions: 06:03:15 INFO - blessings == 1.6 06:03:15 INFO - blobuploader == 1.2.4 06:03:15 INFO - docopt == 0.6.1 06:03:15 INFO - functools32 == 3.2.3-2 06:03:15 INFO - jsonschema == 2.5.1 06:03:15 INFO - manifestparser == 1.1 06:03:15 INFO - mozInstall == 1.12 06:03:15 INFO - mozcrash == 0.17 06:03:15 INFO - mozdebug == 0.1 06:03:15 INFO - mozdevice == 0.48 06:03:15 INFO - mozfile == 1.2 06:03:15 INFO - mozhttpd == 0.7 06:03:15 INFO - mozinfo == 0.9 06:03:15 INFO - mozleak == 0.1 06:03:15 INFO - mozlog == 3.4 06:03:15 INFO - moznetwork == 0.27 06:03:15 INFO - mozprocess == 0.23 06:03:15 INFO - mozprofile == 0.28 06:03:15 INFO - mozrunner == 6.12 06:03:15 INFO - mozscreenshot == 0.1 06:03:15 INFO - mozsystemmonitor == 0.3 06:03:15 INFO - moztest == 0.7 06:03:15 INFO - mozversion == 1.4 06:03:15 INFO - psutil == 3.1.1 06:03:15 INFO - requests == 1.2.3 06:03:15 INFO - wsgiref == 0.1.2 06:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:03:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:03:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:15 INFO - 'HOME': '/Users/cltbld', 06:03:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:15 INFO - 'LOGNAME': 'cltbld', 06:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:15 INFO - 'MOZ_NO_REMOTE': '1', 06:03:15 INFO - 'NO_EM_RESTART': '1', 06:03:15 INFO - 'PAGER': '/bin/cat', 06:03:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:15 INFO - 'PWD': '/builds/slave/test', 06:03:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:15 INFO - 'SHELL': '/bin/bash', 06:03:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:03:15 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:03:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:15 INFO - 'USER': 'cltbld', 06:03:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:15 INFO - 'XPC_FLAGS': '0x0', 06:03:15 INFO - 'XPC_SERVICE_NAME': '0', 06:03:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:03:16 INFO - Cleaning up... 06:03:16 INFO - Return code: 0 06:03:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110291490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110207570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa022d92a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, '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.H5MRY5zuiY/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.azpeW7QfHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 06:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:03:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:03:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:16 INFO - 'HOME': '/Users/cltbld', 06:03:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:16 INFO - 'LOGNAME': 'cltbld', 06:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:16 INFO - 'MOZ_NO_REMOTE': '1', 06:03:16 INFO - 'NO_EM_RESTART': '1', 06:03:16 INFO - 'PAGER': '/bin/cat', 06:03:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:16 INFO - 'PWD': '/builds/slave/test', 06:03:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:16 INFO - 'SHELL': '/bin/bash', 06:03:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:03:16 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:03:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:16 INFO - 'USER': 'cltbld', 06:03:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:16 INFO - 'XPC_FLAGS': '0x0', 06:03:16 INFO - 'XPC_SERVICE_NAME': '0', 06:03:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:03:16 INFO - Cleaning up... 06:03:16 INFO - Return code: 0 06:03:16 INFO - Running post-action listener: _resource_record_post_action 06:03:16 INFO - Running post-action listener: _start_resource_monitoring 06:03:16 INFO - Starting resource monitoring. 06:03:16 INFO - [mozharness: 2016-10-28 13:03:16.545292Z] Finished create-virtualenv step (success) 06:03:16 INFO - [mozharness: 2016-10-28 13:03:16.546347Z] Running install step. 06:03:16 INFO - Running pre-action listener: _resource_record_pre_action 06:03:16 INFO - Running main action method: install 06:03:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:16 INFO - Reading from file tmpfile_stdout 06:03:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:03:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:03:16 INFO - Reading from file tmpfile_stdout 06:03:16 INFO - Output received: 06:03:16 INFO - Usage: mozinstall [options] installer 06:03:16 INFO - Options: 06:03:16 INFO - -h, --help show this help message and exit 06:03:16 INFO - -d DEST, --destination=DEST 06:03:16 INFO - Directory to install application into. [default: 06:03:16 INFO - "/builds/slave/test"] 06:03:16 INFO - --app=APP Application being installed. [default: firefox] 06:03:16 INFO - mkdir: /builds/slave/test/build/application 06:03:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:03:51 INFO - Reading from file tmpfile_stdout 06:03:51 INFO - Output received: 06:03:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:03:51 INFO - Running post-action listener: _resource_record_post_action 06:03:51 INFO - [mozharness: 2016-10-28 13:03:51.365289Z] Finished install step (success) 06:03:51 INFO - [mozharness: 2016-10-28 13:03:51.365441Z] Running run-tests step. 06:03:51 INFO - Running pre-action listener: _resource_record_pre_action 06:03:51 INFO - Running main action method: run_tests 06:03:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:03:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:03:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:03:51 INFO - 2016-10-28 06:03:51.380 screenresolution[1642:7513] starting screenresolution argv=screenresolution get 06:03:51 INFO - 2016-10-28 06:03:51.383 screenresolution[1642:7513] Display 0: 1600x1200x32@60 06:03:51 INFO - 2016-10-28 06:03:51.389 screenresolution[1643:7515] starting screenresolution argv=screenresolution list 06:03:51 INFO - Available Modes on Display 0 06:03:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:03:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:03:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:03:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:03:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:03:51 INFO - Intel Iris: 06:03:51 INFO - Chipset Model: Intel Iris 06:03:51 INFO - Type: GPU 06:03:51 INFO - Bus: Built-In 06:03:51 INFO - VRAM (Dynamic, Max): 1536 MB 06:03:51 INFO - Vendor: Intel (0x8086) 06:03:51 INFO - Device ID: 0x0a2e 06:03:51 INFO - Revision ID: 0x0009 06:03:51 INFO - Displays: 06:03:51 INFO - Display: 06:03:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:03:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:03:51 INFO - Display Serial Number: 1600x1200 60 06:03:51 INFO - Main Display: Yes 06:03:51 INFO - Mirror: Off 06:03:51 INFO - Online: Yes 06:03:51 INFO - Rotation: Supported 06:03:51 INFO - Return code: 0 06:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:03:51 INFO - Python 2.7.3 06:03:51 INFO - Return code: 0 06:03:51 INFO - grabbing minidump binary from tooltool 06:03:51 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')]} 06:03:51 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 0x1100a5d30>, '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 0x10fecbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11009db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:03:51 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 06:03:51 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 06:03:51 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 06:03:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:03:51 INFO - Return code: 0 06:03:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:03:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:03:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:03:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:03:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 06:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 06:03:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MRY5zuiY/Render', 06:03:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:51 INFO - 'HOME': '/Users/cltbld', 06:03:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:51 INFO - 'LOGNAME': 'cltbld', 06:03:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:03:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:51 INFO - 'MOZ_NO_REMOTE': '1', 06:03:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:03:51 INFO - 'NO_EM_RESTART': '1', 06:03:51 INFO - 'PAGER': '/bin/cat', 06:03:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:51 INFO - 'PWD': '/builds/slave/test', 06:03:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:03:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:51 INFO - 'SHELL': '/bin/bash', 06:03:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.azpeW7QfHI/Listeners', 06:03:51 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 06:03:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:51 INFO - 'USER': 'cltbld', 06:03:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:51 INFO - 'XPC_FLAGS': '0x0', 06:03:51 INFO - 'XPC_SERVICE_NAME': '0', 06:03:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 06:03:51 INFO - mozversion application_buildid: 20161028022800 06:03:51 INFO - mozversion application_changeset: 9de99520eefdde708a90ee480e68b42b75b88163 06:03:51 INFO - mozversion application_display_name: Nightly 06:03:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:03:51 INFO - mozversion application_name: Firefox 06:03:51 INFO - mozversion application_remotingname: firefox 06:03:51 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:03:51 INFO - mozversion application_vendor: Mozilla 06:03:51 INFO - mozversion application_version: 52.0a1 06:03:51 INFO - mozversion platform_buildid: 20161028022800 06:03:51 INFO - mozversion platform_changeset: 9de99520eefdde708a90ee480e68b42b75b88163 06:03:51 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:03:51 INFO - mozversion platform_version: 52.0a1 06:03:51 INFO - using testdate: 1477659831 06:03:51 INFO - actual date: 1477659831 06:03:51 INFO - starting webserver on 'localhost:49269' 06:03:51 INFO - SUITE-START | Running 2 tests 06:03:51 INFO - TEST-START | dromaeo_css 06:03:51 INFO - operating with platform_type : mac_ 06:03:51 INFO - Initialising browser for dromaeo_css test... 06:03:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp8kOUx0/profile http://localhost:49269/getInfo.html) 06:03:54 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 06:03:54 INFO - PROCESS | 1653 | colorDepth:24 06:03:54 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 06:03:54 INFO - PROCESS | 1653 | __metrics 06:03:54 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:03:54 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:03:55 INFO - TEST-INFO | 1653: exit 0 06:03:55 INFO - Browser initialized. 06:03:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:03:55 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp8kOUx0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:07 INFO - PROCESS | 1655 | RSS: Main: 238669824 06:04:07 INFO - PROCESS | 1655 | 06:04:58 INFO - PROCESS | 1655 | 1477659898306 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] 06:07:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 06:07:13 INFO - PROCESS | 1655 | RSS: Main: 488861696 06:07:13 INFO - PROCESS | 1655 | 06:10:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 06:10:17 INFO - PROCESS | 1655 | RSS: Main: 393760768 06:10:17 INFO - PROCESS | 1655 | 06:13:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 06:13:20 INFO - PROCESS | 1655 | RSS: Main: 338849792 06:13:20 INFO - PROCESS | 1655 | 06:16:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 06:16:23 INFO - PROCESS | 1655 | RSS: Main: 348291072 06:16:23 INFO - PROCESS | 1655 | 06:19:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 06:19:27 INFO - PROCESS | 1655 | RSS: Main: 334090240 06:19:27 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 06:22:30 INFO - PROCESS | 1655 | RSS: Main: 425525248 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | __start_tp_report 06:22:30 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 06:22:30 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 06:22:30 INFO - PROCESS | 1655 | |i|pagename|runs| 06:22:30 INFO - PROCESS | 1655 | |0;dojo.html;3035.37774756175;3314.1880239341363;3318.1372843060813;3319.784214026087;3336.0992532016357;5410.91883621746;5528.308961379827;5557.749901254443;5578.497935185833;5598.188262701911;5503.807366742165;5545.334559852823;5549.1676248562635;5649.887002259952;5651.745671444784;5042.798288068473;5086.3387759591205;5108.795648174068;5118.232265160219;5144.279800827887;5040.319556859832;5111.821086261982;5142.434332223453;5192.688438693691;5228.555572776299;5158.509941555546;5161.27742116104;5179.8446046618665;5203.089459344618;5255.211718242256;4990.326305948687;5007.524285192901;5036.874078148039;5068.391792984866;5095.464976177522;4996.125678006334;5012.674176178537;5021.146405111103;5043.873903152414;5140.331756871583;5534.446555344473;5557.833265002057;5558.833235002957;5567.49892509672;5606.943930560724;5933.288005439332;6013.51891848651;6136.048912418582;6146.815595532141;6172.197614310156;5390.19147127934;6122.663253521055;6141.877162456771;6159.353267906895;6199.132121502993;5709.343425506078;5711.257536520226;5722.914156287659;5740.311162660508;5758.165066065397;5984.940150598525;6258.43674069336;6297.307296197415;6306.842328941813;6308.116863639094;5740.6268592541355;5818;5943.821685349447;6018.518518518596;6090.299615544181;6147.692615369214;6150.969245153746;6171.382861713882;6171.444569988723;6175.660338681326;6055.636661800306;6081.57428979976;6088.512918966472;6091.842085549461;6122.663253521099;5859.765609375662;5982.192404025401;5982.9401705983255;6032.879342413127;6082.57421980466;4804.639652026112;4825.9758701206265;4833.32333473314;4839.467658557556;4842;4279.443672322578;4371.278739008092;4403.877011362146;4404.933925991113;4407.559244075631;5480.725963701799;5541.390447050821;5553.694546799884;5561.721913904288;5572.721363931787;6044.879102417927;6070.423309785563;6070.6357618543025;6081.17904082952;6089.695515224221;5553.944460555424;5557.944420555743;5562.360328562187;5584.553235741131;5590.105583106683;5248.1602943529615;5252.527272545489;5260.973695131576;5261.894762104736;5283.471652834763;6321.146645202839;6322.71547780351;6335.588186767845;6344.460720838781;6351.809445716728;5950.851228719317;6018.969905150446;6164.137020817179;6180.876382472416;6198.783042593487;6188.9690551546955;6240.375962403905;6261.154744109669;6278.874422511615;6308.306086330592;6082.148499210026;6089.5737298388685;6115.480184184216;6116.480099191618;6123.8162855114415;6024.3975602439405;6176.938230617816;6177.2587289525545;6179.165812615419;6200.472959798468;5744.080947048452;5804.477597016289;5808.680522571299;5879;5977.641341519523;5819.621724587888;5834.591578589628;5858.004139296415;5863.677497737665;5869.354371019099;5557.777688892399;5709.942900570941;5713.685747283939;5724.971375143097;5743.971280143573;5788.27646544182;5849.824505264849;5854.385289544536;5857.970710146422;5863.912041319469;5642.351129619982;5661.603687741818;5713.028785106459;5734.2258795062135;5734.770609175586 06:22:30 INFO - PROCESS | 1655 | |1;ext.html;468.9671722979389;491.65829748324916;503.3557046979865;527.7229454536368;563.0653115827727;40100;41209.17581648365;41491.75524734255;41495.58504414955;43489.78255108728;35534.11164720883;38425.65510207143;39389.60610393895;42903.570964290346;43286.78356608212;8509.2767114795;8698.304135669132;9480.194183494394;9674.56464459101;9678.75803104921;11410.258333208314;11717.945384915356;11751.823722644167;11877.406129693481;11902.583409580666;11465.541378344857;11545.826812597817;11554.53781848725;11558.653240402802;11633;8572.871406928902;8771.78070548235;11439.828402573969;11624.476898539544;11668.1832271741;11124.443777811077;11375.089992800557;11380.374079425628;11380.943095284554;11400.942995285053;39591;39984.00039998994;40057.99710014517;40117.784687990665;40119.19761604752;2890.7976441649093;3369.6630336966355;3505.263894582141;3628.4375921732176;4023.637872591481;29513.852430737923;30042.611874773742;31595.368092638248;31614.209644758834;31660.208494787585;3172.3338098999006;3215.389076075538;3262.1844538865284;3308.272180120394;3356.8825091121694;488690.113098868;489733;491176;493029;506559;62433;62791.74416511736;62867;62880.05679914805;62911.370886291465;64856.67571662112;65028;65076;65118.67440662861;65152;16024.439144629881;16238.675226495405;16269.837301626832;16282.185890705417;16291.91854040746;11181.72045698864;11432.542698291974;11446.255993360404;11682.76634467323;12451.937740311241;15082.24588770557;16895.32418703238;17072.743908841378;18736.53158671044;19204.327848525234;7767.689292428353;7939;7962.920370796218;8027.066737298798;8041.437099403102;868.4008034456205;952.6094301336419;992.265723364705;1018.9286749927434;1026.9486525673688;29737.85131074374;30031.549526757117;30426;30605.08184754461;30945.535816962765;974.28390133252;1031.7884833609091;1071.0735214039798;1088.5645741703381;1097.7749561339906;15538.378464861278;15588.922055389878;15663.608409789846;15809.181944076578;15848;615220;618534;620604;620885;621235.893820528;56491.71754141203;56995.71502142463;57181.14228286579;57226;57260;1241.2490443281865;1275.6491964709594;1352.0940969550622;1380.8895288377107;1401.7336706025822;29169.270768230963;31162;31397.372052559276;31837.522437163;32024.51963220507;49672.25491617701;55305;56758.71620641871;56856.43143568511;59684.22526197981;578345;585192;585309;585376;586021;22354.664680029487;26608;27339.589906151024;27759.44481110407;42646.36030459608;47189;47539;47567.524324757695;47721.76139119282;47857.76071119622;38773.83678489537;39018.80490597529;39107.21785564216;39713.60286397099;40888.59111408848;39322.80338598403;39848.402273966494;40041.1991760169;40472.19055618812;40645.98385040398;37634;37789;38496.80751596224;38530.22939541138;38547.80726096351;29862.506874655744;32339.19152021218;34582.328294405685;35134.82432587821;35197;24353.51292974166;25367.74632253654;25492.745072549038;25720;26147.346316342242 06:22:30 INFO - PROCESS | 1655 | |2;jquery.html;312.69512225580064;338.7577881814502;347.7617831785229;350.34485512092385;386.528435308923;15066.3220155093;15925.601859953493;19284.9035754821;19805.504862378446;20066;16190.83809161908;17573.472795816113;20299.086541105647;21259.6811047834;21321;5329.893402131955;5339.172428273624;5856.355800861902;5879.706014699269;5881.7353219105025;5691.4877661010705;5775.480206781389;5913.231279933624;5922.58541902067;5932.317783454915;5985.34161242263;6095.3599872013465;6097.298810636767;6104.450599446049;6106.511479081662;6098.4511393974535;6101.847453813646;6103.176071230416;6675.365840245169;6749.291324410915;5914.940850591525;5916.556258280646;5925.466707996258;5926.229590153295;5928.347881733006;12827.294498802563;13093.672658183526;13309;13316.400761965735;13333.266670333127;2303.57383883982;2330.650402439631;2335.637976113705;2346.741858395575;2359.941001474977;9012.819743605156;9360.3915745477;9645.373050751748;10135.695929122137;10351.120154786851;1535.3628244278611;1755.8331958463925;1846.3906910719431;1869.626074785035;1883.9434816955513;108872;116312;116633.83366166314;116842.14736378992;117837.41081294538;9276.814463710823;10759;10839.83740243897;11352.829707554229;11389.829152562717;14202.431902723982;14211.928940355232;14214.43142274318;14237.50168744089;14249.145051296955;8117.918820811835;8368.832623347498;8393.160683931557;8492.320614350838;8549.786255343666;8280.875786863202;8283.964504436944;8300.875486867702;8420.115887831813;8509.149085091565;3557.48416479609;3853.9421908671393;4408.845690400821;4487;4487.932681009787;1550.4805890026742;1893.4698284480367;1893.5171531259716;1894.1097684088456;1897.6394485047797;847.3179090831816;955.3264948211494;967.9661211857551;981.0728861226073;1000.6047611193537;17270;19715.704264436044;20353.938481649493;20935.16259349609;21197.682034769492;733.4755649710482;901.9233365163903;925.8888933328044;926.2219735422143;984.4979060679105;10603.734906627396;10767.19246056549;11148.665540033811;11173.217874748689;11208.551657933755;553047;566444;570720;586895;587666;80949;90872.5456372727;116628;120338;127020;757.8560073586001;959.3764053365369;961.1637875048613;962.153305091529;963.1957315641378;14251.21618311003;17947;18781.530461738566;18943.810561894206;19008.904955475133;53180.2022969648;53592.73203633957;53971.460285398214;55423;55426.72286638541;80060;80176.19823801688;81510.59244703739;83436.58281708795;83514.32971340661;6824.556403833735;7166.175889772743;7344.30229128232;7707.576083315472;7993.320567751806;11073.889261107608;11437;12502.249865008129;12845.743085138432;13106.148100373444;10959.945200273947;11155.386453745123;11172.273802202832;11341.943290283496;11420.428978551205;9314.34799564024;9787.608495660093;9894.604215831287;10338.811036730873;10534.683959481228;11017.283876548;11203.775924481628;11296.378699171624;11537.711557211136;11570.305781653127;7301.744438944612;7324.523905946096;7375.11498620169;7513.323800857949;7539.623018848926;9531.571079301586;10877.021068103908;11093.001629853352;11300.265482743594;11391.259568128045 06:22:30 INFO - PROCESS | 1655 | |3;mootools.html;1429.6854691967767;1561.718890599692;1784.6252287019724;1919.1267973072236;1957.0997341223037;8042.758717238485;8471.576421178946;8479.067302596724;8480.194381533744;8515;7519.323260906517;7738.110117336508;7991.120976692574;8216.137305582917;8249.711260105882;1955.5697746495748;2223.2552095048177;2269.7503274639816;2306.7116610423695;2308.4690521180137;2281.315605318406;2305.9077636894503;2310.410845234463;2329.801966832821;2329.9068037278576;2255.8308126890465;2257.424356789025;2294.4837411582344;2300.1489448903844;2302.228753367624;2268.444231163359;2278.111536500766;2292.5071109711325;2294.6672732453785;2303.8387312888103;2293.827962902789;2317.6755254264417;2318.6406107053435;2324.0936034946385;2324.8140148788225;7184.137903451619;8345.499270043756;8396.874046889241;8475.915240847575;8512.78718032048;5001.049800537922;5184.637075404723;5194.039102766001;5197.766100525486;5200.349956255468;2680.50410674024;3248.8213148276836;3496.527968724215;3508.9122771930906;3515.876944306937;983.3559018842669;1000.0399616368295;1018.6791160784329;1026;1026.2610920137488;10378.532966016472;10698.73253168677;10699.572017119306;10759.139268858473;10836.566537338496;4207.516135644379;4314.784260787011;4362.17118747437;4364.934525982113;4370.278903980871;8643.00605430371;8650.35122365825;8654.264387527004;8658.220760131619;8693.478391296543;5029.2958985742025;5066.9746651266505;5071.112555302807;5077.086124497552;5080.568151707146;4719.362886010414;4726.220173671306;4771.355866957916;4814.711117332971;4841.564259216617;2868.8995885144336;3351.731861451078;3401.034538978016;3466.6013408458352;3514.086337552255;1047.1518070363031;1056.6143357674393;1059.041567381521;1064.0689396777818;1069.0912724184382;891.1979218703219;892.723255790694;903.4308385716956;913.4062859141478;962.4273557233435;4346.413234213404;5636.549076073904;5765.068701984882;5782.219400380979;6057.242844644419;894.7852515396258;918.6187732091107;960.3325688646323;986.4919566423155;1002.8445590933417;3680.564579813875;3775.4903088082756;3836.558795738526;3867.6325749053794;3888.300105980951;8522.275606573387;9567.856482152773;10133.493325333704;10174.745631359126;10187.7453063674;10046.899531004743;10091.192704583616;10100.98990100984;10108.444035577966;10155.492225388702;7776.339011184113;7946.046474423106;7948.291117409784;7969.760907172794;7987.32107770846;5183.637145399785;5324.307839980933;5517.675757818014;5762.481376676119;5810.796622118206;9109.635614575607;9453.101955314234;9461;9465.952670236606;9477.289203309918;9278.350515463853;9440.433573985583;9500.619975200914;9526.380785249214;9647.951760241154;7124;7141.285871412817;7191.496595238283;7202.927970720435;7240.05879235717;7853.842923141391;7881.448298619271;7886.408519360956;7887.763367098996;7892.723754668559;6840.657967101525;6997.650117494207;7034.859302814018;7071.398931090915;7118.9644051779405;6929.618870962146;7019.721554686176;7020.157581090302;7020.613866237406;7060.858782824212;6535.836604084936;6583.275839657538;6663.566868153554;6664.266930637529;6665.566738162004;4805.063012712488;4865.294532292868;4900.460949295646;4909.656324057281;5015.673981191211;4858.246971719389;4884.218525035977;4916.680415772963;4970.776315065903;4978.352814134139 06:22:30 INFO - PROCESS | 1655 | |4;prototype.html;272.20516093008416;272.72727272727275;284.9145256423073;288.2778639508032;295.6836185281748;4334.523202447732;4537.319402089688;4868.294097355882;5089.134847075997;5194.974025129878;4914.4348399934015;5186.818461353853;5191.818286359978;5193.376794784631;5230.6600070995355;2970;3935.626115519021;3961.6236457536634;3974.82113304902;4005.439238506611;3716.8327425265793;3905.8868222556575;3934.5442186390933;3936.940945885814;3939.1924655445564;3859.5754467008605;3871.361225397806;3873.2253549290253;3876.4185372194256;3878.3019056569806;3515.982420087909;3788.7347885648014;3875.457435958968;3888.0668639526452;3903.6291552302487;3190.2502911815704;3233.961553332612;3308.7022168004996;3320.7177389921885;3333.683300086488;5000.274960130797;5032.396112466491;5038.84883453497;5045.763787871995;5071.945861925889;3722.7207959403154;4400.691951563392;4415.646748260131;4430.490493593214;4433.22418576751;4842.055799119174;5103.540681338697;5363.517283444469;5484.945150548523;5490.862728431781;3612.290781913565;3620.9318251115983;3623.420252759572;3668.8899333020054;3676.540432445944;4698.650674662703;5648.604597678164;5681.545476361881;5688.018387128985;5700.147452078091;3157.431662300808;3661;3670.082479380155;3671.394219953731;3679.576848662438;3511.94732079019;3739.4390841373465;3747.6252374762853;3769.4722738816586;3771.2080463102507;4137.275976704064;4270.402143699885;4270.444842170498;4279.443672322578;4440.400545926259;4744.051189761993;4838.508293087371;5025.974870125699;5482.17767334903;5543.445655434424;1224.8530176378893;1285.4536821850677;1287.6845172932503;1290.4709069281737;1290.6061453630057;708.0087876972281;793.6468271619074;822.1490757066407;841.0227793610673;870.7300736771621;4424.424824772824;4827.275908613736;5055.620828437882;5134.691918484903;5220.843374698765;4909.975450122726;5565.916511252334;5571.406442844343;5662;5676.984670441933;4440.578145076277;4495.044360962333;4739.86243301612;4965.8510244692;5096.847094587169;2396.2451827674577;2447.155731272708;2950.7426818483877;2957.7190166934106;2985.9552106718415;5081.339425874613;5688.63023903445;5720.542356611461;5740.368559458456;5832.708364581754;5086;5240;5548.250986116823;5803.7968671096305;5846.970765146147;5280.155175172031;5598.740283436195;5787.189793428924;5995.69165871134;6006.789762358297;5525.171224316385;5650.886982260249;5748.252727145445;5750.683712395691;5751.223584816164;4444.888877778081;5509.512431643514;5633.887322253614;5647.588102974257;5682.516986056232;5095.745212739423;5618.67961029166;5863.706814659336;5926.31100136459;6014.518838492822;3431.032775522349;3483.303339332093;3622.076370525499;3671;3746.7751934883995;4767.833125840718;5653.491185793298;5675.829725108253;5788.21859049023;5805.245318108618;4816.325714400057;4960.716836569042;5294.761735721979;5492.450754924475;5505.476979686923;5052.545270925634;5075.670081444694;5143.485651434976;5394.541463975606;5470.91793623104;5101.846944591668;5462.945370546244;5464.426235245242;5479.835604931858;5480.588955828409;5288.312519372457;5540.556755459473;5546.473085056913;5559.858679845875;5581.693006884498;4546.840860569864;5266.1574148136115;5328.8401347959625;5473.31583552056;5495.230667706444 06:22:30 INFO - PROCESS | 1655 | |5;yui.html;714.7784186902061;739.264431890269;773.3697036914914;781.6170076662437;816.4937738602067;14302.785458218123;14944.85055149448;14956.700865982673;14967.25163741814;14982.850171498281;13597;13610.863891361083;13616.523421680244;13630.931845340785;13862.792058119136;706.6148948822878;727.3017902813306;729.6534146280527;879.3536750488386;884.5533005832078;874.2918236228643;896.2919293757956;905.2622112977934;912.7444315591645;914.5518695839057;953.8426159683679;958.324381311174;958.6932181701858;960.1166926427703;961.0101595356758;733.5891900535717;757.1255200243727;949.9145076943039;952.4618590496382;953.3326671330062;555.5583311267552;555.5971920357749;555.8360283716313;558.0151033426006;678.2945736434102;14431.855681443156;14921.403143874231;14942.775858362133;14960.177190254532;14960.62598435037;13513.797293040612;13601.251931143783;13611.251381174032;13657.726845463036;13688.247146406944;10749.892501074968;12258.44836982338;12427;12625.936870315589;12779.680507987374;4186.602272784081;4267.317229243306;4392.275274579691;4435.512093669694;4531.818727250906;92915;95378.52310738471;96146.03853961511;96255.07489850164;96287.51856240674;10742.89257107419;10755.558221369243;10853.674389768319;11005.394703291237;11196.832047519294;21610.89194554017;21614.891925540272;21630.351089467025;21704;21709.24017659406;7284.854302914018;7390.751881192076;7496.175420703718;7648.579328136894;8004.1995800420655;4235.851745188966;4311.762853043113;4318.050028993616;4324.372965919924;4469.575390337913;3195.4248235317864;3290.7367410607094;3295.439775238215;3299.2081900343746;3310.2055506678225;553.2116733654526;557.5929571412892;562.6342877129898;570.8458716146617;573.8823541174049;605.9303180134253;611.4313688269863;617.8053913017475;624.8781487609963;625.8810825943057;8233.423660343718;8581.58893560558;8730.650773969097;8803.603837827313;8866.73399798007;531.2376739379004;560.3583896438555;572.5333852909865;585.4262822434039;633.9556231063874;3636.2182130841998;4005.239004589119;4049.5747946465785;4254.957450425456;4312.956870431318;62836;98779;103808;105519.47240263749;107195;63933.36066639274;80258;82897;91079.54460227789;92192;74645;79307;80045.59977200194;81122.59438702768;83105.16894831095;9357.953210234178;9758.414495130315;9762.707118786448;9797.265205109788;9855.802883942424;41366;47952.04095918132;49049.01901962012;54799.178012330645;56427.435725642215;72931;75966.6201668988;77404.76986570655;81302.59348703218;81626.59186704029;11274.943625281821;12114.757704845677;12116.333601651993;12456.688582785502;13075.346232688138;11852.34812085309;13872.653183670489;14329.996900216885;14390.712185756436;14623.415063397344;11262.549498019987;13350.332483375598;13550.457981680622;13623.455061797416;13647.795283070564;10088.69733907984;11115.270021409851;13095.803562946754;13194.538191163263;13441.193528388329;12388.968658711618;12633.052521060774;12677.619671409873;12701.22182894377;12770.616881493199;10577.576896924036;11149.72125696864;11329.150313726668;11562.132840036862;11605.941970290094;11211.215214935202;11236.887631123584;11281.605143820256;11475.196736228718;11490.712732181762 06:22:30 INFO - PROCESS | 1655 | __end_tp_report 06:22:30 INFO - PROCESS | 1655 | __start_cc_report 06:22:30 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,3036 06:22:30 INFO - PROCESS | 1655 | __end_cc_report 06:22:30 INFO - PROCESS | 1655 | __startTimestamp1477660950809__endTimestamp 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | ------- Summary: start ------- 06:22:30 INFO - PROCESS | 1655 | Number of tests: 6 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5611.69 Median:5734.77 stddev:628.34 (11.0%) stddev-sans-first:596.88 06:22:30 INFO - PROCESS | 1655 | Values: 3035.4 3314.2 3318.1 3319.8 3336.1 5410.9 5528.3 5557.7 5578.5 5598.2 5503.8 5545.3 5549.2 5649.9 5651.7 5042.8 5086.3 5108.8 5118.2 5144.3 5040.3 5111.8 5142.4 5192.7 5228.6 5158.5 5161.3 5179.8 5203.1 5255.2 4990.3 5007.5 5036.9 5068.4 5095.5 4996.1 5012.7 5021.1 5043.9 5140.3 5534.4 5557.8 5558.8 5567.5 5606.9 5933.3 6013.5 6136.0 6146.8 6172.2 5390.2 6122.7 6141.9 6159.4 6199.1 5709.3 5711.3 5722.9 5740.3 5758.2 5984.9 6258.4 6297.3 6306.8 6308.1 5740.6 5818.0 5943.8 6018.5 6090.3 6147.7 6151.0 6171.4 6171.4 6175.7 6055.6 6081.6 6088.5 6091.8 6122.7 5859.8 5982.2 5982.9 6032.9 6082.6 4804.6 4826.0 4833.3 4839.5 4842.0 4279.4 4371.3 4403.9 4404.9 4407.6 5480.7 5541.4 5553.7 5561.7 5572.7 6044.9 6070.4 6070.6 6081.2 6089.7 5553.9 5557.9 5562.4 5584.6 5590.1 5248.2 5252.5 5261.0 5261.9 5283.5 6321.1 6322.7 6335.6 6344.5 6351.8 5950.9 6019.0 6164.1 6180.9 6198.8 6189.0 6240.4 6261.2 6278.9 6308.3 6082.1 6089.6 6115.5 6116.5 6123.8 6024.4 6176.9 6177.3 6179.2 6200.5 5744.1 5804.5 5808.7 5879.0 5977.6 5819.6 5834.6 5858.0 5863.7 5869.4 5557.8 5709.9 5713.7 5725.0 5744.0 5788.3 5849.8 5854.4 5858.0 5863.9 5642.4 5661.6 5713.0 5734.2 5734.8 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:70520.91 Median:38461.23 stddev:151624.60 (394.2%) stddev-sans-first:151958.72 06:22:30 INFO - PROCESS | 1655 | Values: 469.0 491.7 503.4 527.7 563.1 40100.0 41209.2 41491.8 41495.6 43489.8 35534.1 38425.7 39389.6 42903.6 43286.8 8509.3 8698.3 9480.2 9674.6 9678.8 11410.3 11717.9 11751.8 11877.4 11902.6 11465.5 11545.8 11554.5 11558.7 11633.0 8572.9 8771.8 11439.8 11624.5 11668.2 11124.4 11375.1 11380.4 11380.9 11400.9 39591.0 39984.0 40058.0 40117.8 40119.2 2890.8 3369.7 3505.3 3628.4 4023.6 29513.9 30042.6 31595.4 31614.2 31660.2 3172.3 3215.4 3262.2 3308.3 3356.9 488690.1 489733.0 491176.0 493029.0 506559.0 62433.0 62791.7 62867.0 62880.1 62911.4 64856.7 65028.0 65076.0 65118.7 65152.0 16024.4 16238.7 16269.8 16282.2 16291.9 11181.7 11432.5 11446.3 11682.8 12451.9 15082.2 16895.3 17072.7 18736.5 19204.3 7767.7 7939.0 7962.9 8027.1 8041.4 868.4 952.6 992.3 1018.9 1026.9 29737.9 30031.5 30426.0 30605.1 30945.5 974.3 1031.8 1071.1 1088.6 1097.8 15538.4 15588.9 15663.6 15809.2 15848.0 615220.0 618534.0 620604.0 620885.0 621235.9 56491.7 56995.7 57181.1 57226.0 57260.0 1241.2 1275.6 1352.1 1380.9 1401.7 29169.3 31162.0 31397.4 31837.5 32024.5 49672.3 55305.0 56758.7 56856.4 59684.2 578345.0 585192.0 585309.0 585376.0 586021.0 22354.7 26608.0 27339.6 27759.4 42646.4 47189.0 47539.0 47567.5 47721.8 47857.8 38773.8 39018.8 39107.2 39713.6 40888.6 39322.8 39848.4 40041.2 40472.2 40646.0 37634.0 37789.0 38496.8 38530.2 38547.8 29862.5 32339.2 34582.3 35134.8 35197.0 24353.5 25367.7 25492.7 25720.0 26147.3 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33207.80 Median:3705.71 stddev:95529.50 (2577.9%) stddev-sans-first:95765.55 06:22:30 INFO - PROCESS | 1655 | Values: 312.7 338.8 347.8 350.3 386.5 15066.3 15925.6 19284.9 19805.5 20066.0 16190.8 17573.5 20299.1 21259.7 21321.0 5329.9 5339.2 5856.4 5879.7 5881.7 5691.5 5775.5 5913.2 5922.6 5932.3 5985.3 6095.4 6097.3 6104.5 6106.5 6098.5 6101.8 6103.2 6675.4 6749.3 5914.9 5916.6 5925.5 5926.2 5928.3 12827.3 13093.7 13309.0 13316.4 13333.3 2303.6 2330.7 2335.6 2346.7 2359.9 9012.8 9360.4 9645.4 10135.7 10351.1 1535.4 1755.8 1846.4 1869.6 1883.9 108872.0 116312.0 116633.8 116842.1 117837.4 9276.8 10759.0 10839.8 11352.8 11389.8 14202.4 14211.9 14214.4 14237.5 14249.1 8117.9 8368.8 8393.2 8492.3 8549.8 8280.9 8284.0 8300.9 8420.1 8509.1 3557.5 3853.9 4408.8 4487.0 4487.9 1550.5 1893.5 1893.5 1894.1 1897.6 847.3 955.3 968.0 981.1 1000.6 17270.0 19715.7 20353.9 20935.2 21197.7 733.5 901.9 925.9 926.2 984.5 10603.7 10767.2 11148.7 11173.2 11208.6 553047.0 566444.0 570720.0 586895.0 587666.0 80949.0 90872.5 116628.0 120338.0 127020.0 757.9 959.4 961.2 962.2 963.2 14251.2 17947.0 18781.5 18943.8 19008.9 53180.2 53592.7 53971.5 55423.0 55426.7 80060.0 80176.2 81510.6 83436.6 83514.3 6824.6 7166.2 7344.3 7707.6 7993.3 11073.9 11437.0 12502.2 12845.7 13106.1 10959.9 11155.4 11172.3 11341.9 11420.4 9314.3 9787.6 9894.6 10338.8 10534.7 11017.3 11203.8 11296.4 11537.7 11570.3 7301.7 7324.5 7375.1 7513.3 7539.6 9531.6 10877.0 11093.0 11300.3 11391.3 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5384.79 Median:5048.14 stddev:2954.52 (58.5%) stddev-sans-first:2947.85 06:22:30 INFO - PROCESS | 1655 | Values: 1429.7 1561.7 1784.6 1919.1 1957.1 8042.8 8471.6 8479.1 8480.2 8515.0 7519.3 7738.1 7991.1 8216.1 8249.7 1955.6 2223.3 2269.8 2306.7 2308.5 2281.3 2305.9 2310.4 2329.8 2329.9 2255.8 2257.4 2294.5 2300.1 2302.2 2268.4 2278.1 2292.5 2294.7 2303.8 2293.8 2317.7 2318.6 2324.1 2324.8 7184.1 8345.5 8396.9 8475.9 8512.8 5001.0 5184.6 5194.0 5197.8 5200.3 2680.5 3248.8 3496.5 3508.9 3515.9 983.4 1000.0 1018.7 1026.0 1026.3 10378.5 10698.7 10699.6 10759.1 10836.6 4207.5 4314.8 4362.2 4364.9 4370.3 8643.0 8650.4 8654.3 8658.2 8693.5 5029.3 5067.0 5071.1 5077.1 5080.6 4719.4 4726.2 4771.4 4814.7 4841.6 2868.9 3351.7 3401.0 3466.6 3514.1 1047.2 1056.6 1059.0 1064.1 1069.1 891.2 892.7 903.4 913.4 962.4 4346.4 5636.5 5765.1 5782.2 6057.2 894.8 918.6 960.3 986.5 1002.8 3680.6 3775.5 3836.6 3867.6 3888.3 8522.3 9567.9 10133.5 10174.7 10187.7 10046.9 10091.2 10101.0 10108.4 10155.5 7776.3 7946.0 7948.3 7969.8 7987.3 5183.6 5324.3 5517.7 5762.5 5810.8 9109.6 9453.1 9461.0 9466.0 9477.3 9278.4 9440.4 9500.6 9526.4 9648.0 7124.0 7141.3 7191.5 7202.9 7240.1 7853.8 7881.4 7886.4 7887.8 7892.7 6840.7 6997.7 7034.9 7071.4 7119.0 6929.6 7019.7 7020.2 7020.6 7060.9 6535.8 6583.3 6663.6 6664.3 6665.6 4805.1 4865.3 4900.5 4909.7 5015.7 4858.2 4884.2 4916.7 4970.8 4978.4 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4403.28 Median:5013.12 stddev:1387.14 (27.7%) stddev-sans-first:1355.94 06:22:30 INFO - PROCESS | 1655 | Values: 272.2 272.7 284.9 288.3 295.7 4334.5 4537.3 4868.3 5089.1 5195.0 4914.4 5186.8 5191.8 5193.4 5230.7 2970.0 3935.6 3961.6 3974.8 4005.4 3716.8 3905.9 3934.5 3936.9 3939.2 3859.6 3871.4 3873.2 3876.4 3878.3 3516.0 3788.7 3875.5 3888.1 3903.6 3190.3 3234.0 3308.7 3320.7 3333.7 5000.3 5032.4 5038.8 5045.8 5071.9 3722.7 4400.7 4415.6 4430.5 4433.2 4842.1 5103.5 5363.5 5484.9 5490.9 3612.3 3620.9 3623.4 3668.9 3676.5 4698.7 5648.6 5681.5 5688.0 5700.1 3157.4 3661.0 3670.1 3671.4 3679.6 3511.9 3739.4 3747.6 3769.5 3771.2 4137.3 4270.4 4270.4 4279.4 4440.4 4744.1 4838.5 5026.0 5482.2 5543.4 1224.9 1285.5 1287.7 1290.5 1290.6 708.0 793.6 822.1 841.0 870.7 4424.4 4827.3 5055.6 5134.7 5220.8 4910.0 5565.9 5571.4 5662.0 5677.0 4440.6 4495.0 4739.9 4965.9 5096.8 2396.2 2447.2 2950.7 2957.7 2986.0 5081.3 5688.6 5720.5 5740.4 5832.7 5086.0 5240.0 5548.3 5803.8 5847.0 5280.2 5598.7 5787.2 5995.7 6006.8 5525.2 5650.9 5748.3 5750.7 5751.2 4444.9 5509.5 5633.9 5647.6 5682.5 5095.7 5618.7 5863.7 5926.3 6014.5 3431.0 3483.3 3622.1 3671.0 3746.8 4767.8 5653.5 5675.8 5788.2 5805.2 4816.3 4960.7 5294.8 5492.5 5505.5 5052.5 5075.7 5143.5 5394.5 5470.9 5101.8 5462.9 5464.4 5479.8 5480.6 5288.3 5540.6 5546.5 5559.9 5581.7 4546.8 5266.2 5328.8 5473.3 5495.2 06:22:30 INFO - PROCESS | 1655 | 06:22:30 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:19923.93 Median:4413.89 stddev:28431.34 (644.1%) stddev-sans-first:28474.52 06:22:30 INFO - PROCESS | 1655 | Values: 714.8 739.3 773.4 781.6 816.5 14302.8 14944.9 14956.7 14967.3 14982.9 13597.0 13610.9 13616.5 13630.9 13862.8 706.6 727.3 729.7 879.4 884.6 874.3 896.3 905.3 912.7 914.6 953.8 958.3 958.7 960.1 961.0 733.6 757.1 949.9 952.5 953.3 555.6 555.6 555.8 558.0 678.3 14431.9 14921.4 14942.8 14960.2 14960.6 13513.8 13601.3 13611.3 13657.7 13688.2 10749.9 12258.4 12427.0 12625.9 12779.7 4186.6 4267.3 4392.3 4435.5 4531.8 92915.0 95378.5 96146.0 96255.1 96287.5 10742.9 10755.6 10853.7 11005.4 11196.8 21610.9 21614.9 21630.4 21704.0 21709.2 7284.9 7390.8 7496.2 7648.6 8004.2 4235.9 4311.8 4318.1 4324.4 4469.6 3195.4 3290.7 3295.4 3299.2 3310.2 553.2 557.6 562.6 570.8 573.9 605.9 611.4 617.8 624.9 625.9 8233.4 8581.6 8730.7 8803.6 8866.7 531.2 560.4 572.5 585.4 634.0 3636.2 4005.2 4049.6 4255.0 4313.0 62836.0 98779.0 103808.0 105519.5 107195.0 63933.4 80258.0 82897.0 91079.5 92192.0 74645.0 79307.0 80045.6 81122.6 83105.2 9358.0 9758.4 9762.7 9797.3 9855.8 41366.0 47952.0 49049.0 54799.2 56427.4 72931.0 75966.6 77404.8 81302.6 81626.6 11274.9 12114.8 12116.3 12456.7 13075.3 11852.3 13872.7 14330.0 14390.7 14623.4 11262.5 13350.3 13550.5 13623.5 13647.8 10088.7 11115.3 13095.8 13194.5 13441.2 12389.0 12633.1 12677.6 12701.2 12770.6 10577.6 11149.7 11329.2 11562.1 11605.9 11211.2 11236.9 11281.6 11475.2 11490.7 06:22:30 INFO - PROCESS | 1655 | -------- Summary: end -------- 06:22:30 INFO - PROCESS | 1655 | 06:22:31 INFO - TEST-INFO | 1655: exit 0 06:22:31 INFO - TEST-OK | dromaeo_css | took 1119621ms 06:22:31 INFO - TEST-START | kraken 06:22:31 INFO - operating with platform_type : mac_ 06:22:31 INFO - Initialising browser for kraken test... 06:22:31 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpHbV8a7/profile http://localhost:49269/getInfo.html) 06:22:33 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:22:33 INFO - PROCESS | 1661 | colorDepth:24 06:22:33 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:22:33 INFO - PROCESS | 1661 | __metrics 06:22:34 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:22:34 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:22:34 INFO - TEST-INFO | 1661: exit 0 06:22:34 INFO - Browser initialized. 06:22:34 INFO - Running cycle 1/1 for kraken test... 06:22:34 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpHbV8a7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:46 INFO - PROCESS | 1662 | RSS: Main: 231624704 06:22:46 INFO - PROCESS | 1662 | 06:22:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 06:22:50 INFO - PROCESS | 1662 | RSS: Main: 290521088 06:22:50 INFO - PROCESS | 1662 | 06:22:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 06:22:53 INFO - PROCESS | 1662 | RSS: Main: 291819520 06:22:53 INFO - PROCESS | 1662 | 06:22:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 06:22:57 INFO - PROCESS | 1662 | RSS: Main: 383299584 06:22:57 INFO - PROCESS | 1662 | 06:22:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 06:23:00 INFO - PROCESS | 1662 | RSS: Main: 283217920 06:23:00 INFO - PROCESS | 1662 | 06:23:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:23:03 INFO - PROCESS | 1662 | RSS: Main: 288505856 06:23:03 INFO - PROCESS | 1662 | 06:23:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 06:23:06 INFO - PROCESS | 1662 | RSS: Main: 325468160 06:23:06 INFO - PROCESS | 1662 | 06:23:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 06:23:10 INFO - PROCESS | 1662 | RSS: Main: 326483968 06:23:10 INFO - PROCESS | 1662 | 06:23:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 06:23:13 INFO - PROCESS | 1662 | RSS: Main: 325165056 06:23:13 INFO - PROCESS | 1662 | 06:23:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:23:15 INFO - PROCESS | 1662 | RSS: Main: 300867584 06:23:15 INFO - PROCESS | 1662 | 06:23:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:23:18 INFO - PROCESS | 1662 | RSS: Main: 300998656 06:23:18 INFO - PROCESS | 1662 | 06:23:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:23:21 INFO - PROCESS | 1662 | RSS: Main: 305831936 06:23:21 INFO - PROCESS | 1662 | 06:23:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:23:25 INFO - PROCESS | 1662 | RSS: Main: 320684032 06:23:25 INFO - PROCESS | 1662 | 06:23:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:23:28 INFO - PROCESS | 1662 | RSS: Main: 320069632 06:23:28 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 06:23:30 INFO - PROCESS | 1662 | RSS: Main: 364412928 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | __start_tp_report 06:23:30 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:23:30 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:23:30 INFO - PROCESS | 1662 | |i|pagename|runs| 06:23:30 INFO - PROCESS | 1662 | |0;ai-astar;105;118;161;166;113;113;111;114;113;113 06:23:30 INFO - PROCESS | 1662 | |1;audio-beat-detection;155;113;115;153;112;111;113;110;146;111 06:23:30 INFO - PROCESS | 1662 | |2;audio-dft;178;183;183;183;185;185;180;207;185;182 06:23:30 INFO - PROCESS | 1662 | |3;audio-fft;80;59;60;88;62;59;63;59;82;57 06:23:30 INFO - PROCESS | 1662 | |4;audio-oscillator;91;70;92;70;67;69;93;67;68;91 06:23:30 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;89;83;87;83;85;83;93;83;85;82 06:23:30 INFO - PROCESS | 1662 | |6;imaging-darkroom;96;95;96;95;126;166;96;97;96;95 06:23:30 INFO - PROCESS | 1662 | |7;imaging-desaturate;82;79;79;79;80;82;99;119;84;79 06:23:30 INFO - PROCESS | 1662 | |8;json-parse-financial;54;56;55;54;55;56;57;55;55;55 06:23:30 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;66;66;72;116;109;86;75;71;70;71 06:23:30 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;101;106;87;90;100;107;107;80;88;86 06:23:30 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;159;158;145;147;144;154;149;157;179;149 06:23:30 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;173;174;174;173;173;173;182;173;175;172 06:23:30 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;79;88;87;75;68;69;69;68;70 06:23:30 INFO - PROCESS | 1662 | __end_tp_report 06:23:30 INFO - PROCESS | 1662 | __start_cc_report 06:23:30 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2026 06:23:30 INFO - PROCESS | 1662 | __end_cc_report 06:23:30 INFO - PROCESS | 1662 | __startTimestamp1477661010665__endTimestamp 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:23:30 INFO - PROCESS | 1662 | Number of tests: 14 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:122.70 Median:113.50 stddev:21.77 (19.2%) stddev-sans-first:22.13 06:23:30 INFO - PROCESS | 1662 | Values: 105.0 118.0 161.0 166.0 113.0 113.0 111.0 114.0 113.0 113.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:114.00 stddev:19.11 (16.8%) stddev-sans-first:16.63 06:23:30 INFO - PROCESS | 1662 | Values: 155.0 113.0 115.0 153.0 112.0 111.0 113.0 110.0 146.0 111.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:185.10 Median:184.00 stddev:8.02 (4.4%) stddev-sans-first:8.08 06:23:30 INFO - PROCESS | 1662 | Values: 178.0 183.0 183.0 183.0 185.0 185.0 180.0 207.0 185.0 182.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.90 Median:62.50 stddev:11.63 (18.6%) stddev-sans-first:11.33 06:23:30 INFO - PROCESS | 1662 | Values: 80.0 59.0 60.0 88.0 62.0 59.0 63.0 59.0 82.0 57.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.50 stddev:12.06 (15.0%) stddev-sans-first:11.81 06:23:30 INFO - PROCESS | 1662 | Values: 91.0 70.0 92.0 70.0 67.0 69.0 93.0 67.0 68.0 91.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:85.00 stddev:3.47 (4.1%) stddev-sans-first:3.41 06:23:30 INFO - PROCESS | 1662 | Values: 89.0 83.0 87.0 83.0 85.0 83.0 93.0 83.0 85.0 82.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:96.00 stddev:23.20 (24.2%) stddev-sans-first:24.33 06:23:30 INFO - PROCESS | 1662 | Values: 96.0 95.0 96.0 95.0 126.0 166.0 96.0 97.0 96.0 95.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:81.00 stddev:13.02 (16.1%) stddev-sans-first:13.72 06:23:30 INFO - PROCESS | 1662 | Values: 82.0 79.0 79.0 79.0 80.0 82.0 99.0 119.0 84.0 79.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 06:23:30 INFO - PROCESS | 1662 | Values: 54.0 56.0 55.0 54.0 55.0 56.0 57.0 55.0 55.0 55.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:80.20 Median:71.00 stddev:18.00 (25.4%) stddev-sans-first:18.34 06:23:30 INFO - PROCESS | 1662 | Values: 66.0 66.0 72.0 116.0 109.0 86.0 75.0 71.0 70.0 71.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:95.20 Median:83.00 stddev:10.08 (12.1%) stddev-sans-first:10.47 06:23:30 INFO - PROCESS | 1662 | Values: 101.0 106.0 87.0 90.0 100.0 107.0 107.0 80.0 88.0 86.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:155.50 stddev:10.30 (6.6%) stddev-sans-first:10.77 06:23:30 INFO - PROCESS | 1662 | Values: 159.0 158.0 145.0 147.0 144.0 154.0 149.0 157.0 179.0 149.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:173.50 stddev:2.86 (1.6%) stddev-sans-first:3.00 06:23:30 INFO - PROCESS | 1662 | Values: 173.0 174.0 174.0 173.0 173.0 173.0 182.0 173.0 175.0 172.0 06:23:30 INFO - PROCESS | 1662 | 06:23:30 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:72.50 stddev:8.01 (11.1%) stddev-sans-first:8.09 06:23:30 INFO - PROCESS | 1662 | Values: 67.0 79.0 88.0 87.0 75.0 68.0 69.0 69.0 68.0 70.0 06:23:30 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:23:30 INFO - PROCESS | 1662 | 06:23:31 INFO - TEST-INFO | 1662: exit 0 06:23:31 INFO - TEST-OK | kraken | took 59915ms 06:23:31 INFO - SUITE-END | took 1179s 06:23:31 INFO - Completed test suite (00:19:39) 06:23:31 INFO - javascript benchmark 06:23:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.37774756175, 3314.1880239341363, 3318.1372843060813, 3319.784214026087, 3336.0992532016357, 5410.91883621746, 5528.308961379827, 5557.749901254443, 5578.497935185833, 5598.188262701911, 5503.807366742165, 5545.334559852823, 5549.1676248562635, 5649.887002259952, 5651.745671444784, 5042.798288068473, 5086.3387759591205, 5108.795648174068, 5118.232265160219, 5144.279800827887, 5040.319556859832, 5111.821086261982, 5142.434332223453, 5192.688438693691, 5228.555572776299, 5158.509941555546, 5161.27742116104, 5179.8446046618665, 5203.089459344618, 5255.211718242256, 4990.326305948687, 5007.524285192901, 5036.874078148039, 5068.391792984866, 5095.464976177522, 4996.125678006334, 5012.674176178537, 5021.146405111103, 5043.873903152414, 5140.331756871583, 5534.446555344473, 5557.833265002057, 5558.833235002957, 5567.49892509672, 5606.943930560724, 5933.288005439332, 6013.51891848651, 6136.048912418582, 6146.815595532141, 6172.197614310156, 5390.19147127934, 6122.663253521055, 6141.877162456771, 6159.353267906895, 6199.132121502993, 5709.343425506078, 5711.257536520226, 5722.914156287659, 5740.311162660508, 5758.165066065397, 5984.940150598525, 6258.43674069336, 6297.307296197415, 6306.842328941813, 6308.116863639094, 5740.6268592541355, 5818.0, 5943.821685349447, 6018.518518518596, 6090.299615544181, 6147.692615369214, 6150.969245153746, 6171.382861713882, 6171.444569988723, 6175.660338681326, 6055.636661800306, 6081.57428979976, 6088.512918966472, 6091.842085549461, 6122.663253521099, 5859.765609375662, 5982.192404025401, 5982.9401705983255, 6032.879342413127, 6082.57421980466, 4804.639652026112, 4825.9758701206265, 4833.32333473314, 4839.467658557556, 4842.0, 4279.443672322578, 4371.278739008092, 4403.877011362146, 4404.933925991113, 4407.559244075631, 5480.725963701799, 5541.390447050821, 5553.694546799884, 5561.721913904288, 5572.721363931787, 6044.879102417927, 6070.423309785563, 6070.6357618543025, 6081.17904082952, 6089.695515224221, 5553.944460555424, 5557.944420555743, 5562.360328562187, 5584.553235741131, 5590.105583106683, 5248.1602943529615, 5252.527272545489, 5260.973695131576, 5261.894762104736, 5283.471652834763, 6321.146645202839, 6322.71547780351, 6335.588186767845, 6344.460720838781, 6351.809445716728, 5950.851228719317, 6018.969905150446, 6164.137020817179, 6180.876382472416, 6198.783042593487, 6188.9690551546955, 6240.375962403905, 6261.154744109669, 6278.874422511615, 6308.306086330592, 6082.148499210026, 6089.5737298388685, 6115.480184184216, 6116.480099191618, 6123.8162855114415, 6024.3975602439405, 6176.938230617816, 6177.2587289525545, 6179.165812615419, 6200.472959798468, 5744.080947048452, 5804.477597016289, 5808.680522571299, 5879.0, 5977.641341519523, 5819.621724587888, 5834.591578589628, 5858.004139296415, 5863.677497737665, 5869.354371019099, 5557.777688892399, 5709.942900570941, 5713.685747283939, 5724.971375143097, 5743.971280143573, 5788.27646544182, 5849.824505264849, 5854.385289544536, 5857.970710146422, 5863.912041319469, 5642.351129619982, 5661.603687741818, 5713.028785106459, 5734.2258795062135, 5734.770609175586], "value": 5570.752510329016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.9671722979389, 491.65829748324916, 503.3557046979865, 527.7229454536368, 563.0653115827727, 40100.0, 41209.17581648365, 41491.75524734255, 41495.58504414955, 43489.78255108728, 35534.11164720883, 38425.65510207143, 39389.60610393895, 42903.570964290346, 43286.78356608212, 8509.2767114795, 8698.304135669132, 9480.194183494394, 9674.56464459101, 9678.75803104921, 11410.258333208314, 11717.945384915356, 11751.823722644167, 11877.406129693481, 11902.583409580666, 11465.541378344857, 11545.826812597817, 11554.53781848725, 11558.653240402802, 11633.0, 8572.871406928902, 8771.78070548235, 11439.828402573969, 11624.476898539544, 11668.1832271741, 11124.443777811077, 11375.089992800557, 11380.374079425628, 11380.943095284554, 11400.942995285053, 39591.0, 39984.00039998994, 40057.99710014517, 40117.784687990665, 40119.19761604752, 2890.7976441649093, 3369.6630336966355, 3505.263894582141, 3628.4375921732176, 4023.637872591481, 29513.852430737923, 30042.611874773742, 31595.368092638248, 31614.209644758834, 31660.208494787585, 3172.3338098999006, 3215.389076075538, 3262.1844538865284, 3308.272180120394, 3356.8825091121694, 488690.113098868, 489733.0, 491176.0, 493029.0, 506559.0, 62433.0, 62791.74416511736, 62867.0, 62880.05679914805, 62911.370886291465, 64856.67571662112, 65028.0, 65076.0, 65118.67440662861, 65152.0, 16024.439144629881, 16238.675226495405, 16269.837301626832, 16282.185890705417, 16291.91854040746, 11181.72045698864, 11432.542698291974, 11446.255993360404, 11682.76634467323, 12451.937740311241, 15082.24588770557, 16895.32418703238, 17072.743908841378, 18736.53158671044, 19204.327848525234, 7767.689292428353, 7939.0, 7962.920370796218, 8027.066737298798, 8041.437099403102, 868.4008034456205, 952.6094301336419, 992.265723364705, 1018.9286749927434, 1026.9486525673688, 29737.85131074374, 30031.549526757117, 30426.0, 30605.08184754461, 30945.535816962765, 974.28390133252, 1031.7884833609091, 1071.0735214039798, 1088.5645741703381, 1097.7749561339906, 15538.378464861278, 15588.922055389878, 15663.608409789846, 15809.181944076578, 15848.0, 615220.0, 618534.0, 620604.0, 620885.0, 621235.893820528, 56491.71754141203, 56995.71502142463, 57181.14228286579, 57226.0, 57260.0, 1241.2490443281865, 1275.6491964709594, 1352.0940969550622, 1380.8895288377107, 1401.7336706025822, 29169.270768230963, 31162.0, 31397.372052559276, 31837.522437163, 32024.51963220507, 49672.25491617701, 55305.0, 56758.71620641871, 56856.43143568511, 59684.22526197981, 578345.0, 585192.0, 585309.0, 585376.0, 586021.0, 22354.664680029487, 26608.0, 27339.589906151024, 27759.44481110407, 42646.36030459608, 47189.0, 47539.0, 47567.524324757695, 47721.76139119282, 47857.76071119622, 38773.83678489537, 39018.80490597529, 39107.21785564216, 39713.60286397099, 40888.59111408848, 39322.80338598403, 39848.402273966494, 40041.1991760169, 40472.19055618812, 40645.98385040398, 37634.0, 37789.0, 38496.80751596224, 38530.22939541138, 38547.80726096351, 29862.506874655744, 32339.19152021218, 34582.328294405685, 35134.82432587821, 35197.0, 24353.51292974166, 25367.74632253654, 25492.745072549038, 25720.0, 26147.346316342242], "value": 20452.588186419318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.69512225580064, 338.7577881814502, 347.7617831785229, 350.34485512092385, 386.528435308923, 15066.3220155093, 15925.601859953493, 19284.9035754821, 19805.504862378446, 20066.0, 16190.83809161908, 17573.472795816113, 20299.086541105647, 21259.6811047834, 21321.0, 5329.893402131955, 5339.172428273624, 5856.355800861902, 5879.706014699269, 5881.7353219105025, 5691.4877661010705, 5775.480206781389, 5913.231279933624, 5922.58541902067, 5932.317783454915, 5985.34161242263, 6095.3599872013465, 6097.298810636767, 6104.450599446049, 6106.511479081662, 6098.4511393974535, 6101.847453813646, 6103.176071230416, 6675.365840245169, 6749.291324410915, 5914.940850591525, 5916.556258280646, 5925.466707996258, 5926.229590153295, 5928.347881733006, 12827.294498802563, 13093.672658183526, 13309.0, 13316.400761965735, 13333.266670333127, 2303.57383883982, 2330.650402439631, 2335.637976113705, 2346.741858395575, 2359.941001474977, 9012.819743605156, 9360.3915745477, 9645.373050751748, 10135.695929122137, 10351.120154786851, 1535.3628244278611, 1755.8331958463925, 1846.3906910719431, 1869.626074785035, 1883.9434816955513, 108872.0, 116312.0, 116633.83366166314, 116842.14736378992, 117837.41081294538, 9276.814463710823, 10759.0, 10839.83740243897, 11352.829707554229, 11389.829152562717, 14202.431902723982, 14211.928940355232, 14214.43142274318, 14237.50168744089, 14249.145051296955, 8117.918820811835, 8368.832623347498, 8393.160683931557, 8492.320614350838, 8549.786255343666, 8280.875786863202, 8283.964504436944, 8300.875486867702, 8420.115887831813, 8509.149085091565, 3557.48416479609, 3853.9421908671393, 4408.845690400821, 4487.0, 4487.932681009787, 1550.4805890026742, 1893.4698284480367, 1893.5171531259716, 1894.1097684088456, 1897.6394485047797, 847.3179090831816, 955.3264948211494, 967.9661211857551, 981.0728861226073, 1000.6047611193537, 17270.0, 19715.704264436044, 20353.938481649493, 20935.16259349609, 21197.682034769492, 733.4755649710482, 901.9233365163903, 925.8888933328044, 926.2219735422143, 984.4979060679105, 10603.734906627396, 10767.19246056549, 11148.665540033811, 11173.217874748689, 11208.551657933755, 553047.0, 566444.0, 570720.0, 586895.0, 587666.0, 80949.0, 90872.5456372727, 116628.0, 120338.0, 127020.0, 757.8560073586001, 959.3764053365369, 961.1637875048613, 962.153305091529, 963.1957315641378, 14251.21618311003, 17947.0, 18781.530461738566, 18943.810561894206, 19008.904955475133, 53180.2022969648, 53592.73203633957, 53971.460285398214, 55423.0, 55426.72286638541, 80060.0, 80176.19823801688, 81510.59244703739, 83436.58281708795, 83514.32971340661, 6824.556403833735, 7166.175889772743, 7344.30229128232, 7707.576083315472, 7993.320567751806, 11073.889261107608, 11437.0, 12502.249865008129, 12845.743085138432, 13106.148100373444, 10959.945200273947, 11155.386453745123, 11172.273802202832, 11341.943290283496, 11420.428978551205, 9314.34799564024, 9787.608495660093, 9894.604215831287, 10338.811036730873, 10534.683959481228, 11017.283876548, 11203.775924481628, 11296.378699171624, 11537.711557211136, 11570.305781653127, 7301.744438944612, 7324.523905946096, 7375.11498620169, 7513.323800857949, 7539.623018848926, 9531.571079301586, 10877.021068103908, 11093.001629853352, 11300.265482743594, 11391.259568128045], "value": 9109.467833108267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.6854691967767, 1561.718890599692, 1784.6252287019724, 1919.1267973072236, 1957.0997341223037, 8042.758717238485, 8471.576421178946, 8479.067302596724, 8480.194381533744, 8515.0, 7519.323260906517, 7738.110117336508, 7991.120976692574, 8216.137305582917, 8249.711260105882, 1955.5697746495748, 2223.2552095048177, 2269.7503274639816, 2306.7116610423695, 2308.4690521180137, 2281.315605318406, 2305.9077636894503, 2310.410845234463, 2329.801966832821, 2329.9068037278576, 2255.8308126890465, 2257.424356789025, 2294.4837411582344, 2300.1489448903844, 2302.228753367624, 2268.444231163359, 2278.111536500766, 2292.5071109711325, 2294.6672732453785, 2303.8387312888103, 2293.827962902789, 2317.6755254264417, 2318.6406107053435, 2324.0936034946385, 2324.8140148788225, 7184.137903451619, 8345.499270043756, 8396.874046889241, 8475.915240847575, 8512.78718032048, 5001.049800537922, 5184.637075404723, 5194.039102766001, 5197.766100525486, 5200.349956255468, 2680.50410674024, 3248.8213148276836, 3496.527968724215, 3508.9122771930906, 3515.876944306937, 983.3559018842669, 1000.0399616368295, 1018.6791160784329, 1026.0, 1026.2610920137488, 10378.532966016472, 10698.73253168677, 10699.572017119306, 10759.139268858473, 10836.566537338496, 4207.516135644379, 4314.784260787011, 4362.17118747437, 4364.934525982113, 4370.278903980871, 8643.00605430371, 8650.35122365825, 8654.264387527004, 8658.220760131619, 8693.478391296543, 5029.2958985742025, 5066.9746651266505, 5071.112555302807, 5077.086124497552, 5080.568151707146, 4719.362886010414, 4726.220173671306, 4771.355866957916, 4814.711117332971, 4841.564259216617, 2868.8995885144336, 3351.731861451078, 3401.034538978016, 3466.6013408458352, 3514.086337552255, 1047.1518070363031, 1056.6143357674393, 1059.041567381521, 1064.0689396777818, 1069.0912724184382, 891.1979218703219, 892.723255790694, 903.4308385716956, 913.4062859141478, 962.4273557233435, 4346.413234213404, 5636.549076073904, 5765.068701984882, 5782.219400380979, 6057.242844644419, 894.7852515396258, 918.6187732091107, 960.3325688646323, 986.4919566423155, 1002.8445590933417, 3680.564579813875, 3775.4903088082756, 3836.558795738526, 3867.6325749053794, 3888.300105980951, 8522.275606573387, 9567.856482152773, 10133.493325333704, 10174.745631359126, 10187.7453063674, 10046.899531004743, 10091.192704583616, 10100.98990100984, 10108.444035577966, 10155.492225388702, 7776.339011184113, 7946.046474423106, 7948.291117409784, 7969.760907172794, 7987.32107770846, 5183.637145399785, 5324.307839980933, 5517.675757818014, 5762.481376676119, 5810.796622118206, 9109.635614575607, 9453.101955314234, 9461.0, 9465.952670236606, 9477.289203309918, 9278.350515463853, 9440.433573985583, 9500.619975200914, 9526.380785249214, 9647.951760241154, 7124.0, 7141.285871412817, 7191.496595238283, 7202.927970720435, 7240.05879235717, 7853.842923141391, 7881.448298619271, 7886.408519360956, 7887.763367098996, 7892.723754668559, 6840.657967101525, 6997.650117494207, 7034.859302814018, 7071.398931090915, 7118.9644051779405, 6929.618870962146, 7019.721554686176, 7020.157581090302, 7020.613866237406, 7060.858782824212, 6535.836604084936, 6583.275839657538, 6663.566868153554, 6664.266930637529, 6665.566738162004, 4805.063012712488, 4865.294532292868, 4900.460949295646, 4909.656324057281, 5015.673981191211, 4858.246971719389, 4884.218525035977, 4916.680415772963, 4970.776315065903, 4978.352814134139], "value": 4361.00077126443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.20516093008416, 272.72727272727275, 284.9145256423073, 288.2778639508032, 295.6836185281748, 4334.523202447732, 4537.319402089688, 4868.294097355882, 5089.134847075997, 5194.974025129878, 4914.4348399934015, 5186.818461353853, 5191.818286359978, 5193.376794784631, 5230.6600070995355, 2970.0, 3935.626115519021, 3961.6236457536634, 3974.82113304902, 4005.439238506611, 3716.8327425265793, 3905.8868222556575, 3934.5442186390933, 3936.940945885814, 3939.1924655445564, 3859.5754467008605, 3871.361225397806, 3873.2253549290253, 3876.4185372194256, 3878.3019056569806, 3515.982420087909, 3788.7347885648014, 3875.457435958968, 3888.0668639526452, 3903.6291552302487, 3190.2502911815704, 3233.961553332612, 3308.7022168004996, 3320.7177389921885, 3333.683300086488, 5000.274960130797, 5032.396112466491, 5038.84883453497, 5045.763787871995, 5071.945861925889, 3722.7207959403154, 4400.691951563392, 4415.646748260131, 4430.490493593214, 4433.22418576751, 4842.055799119174, 5103.540681338697, 5363.517283444469, 5484.945150548523, 5490.862728431781, 3612.290781913565, 3620.9318251115983, 3623.420252759572, 3668.8899333020054, 3676.540432445944, 4698.650674662703, 5648.604597678164, 5681.545476361881, 5688.018387128985, 5700.147452078091, 3157.431662300808, 3661.0, 3670.082479380155, 3671.394219953731, 3679.576848662438, 3511.94732079019, 3739.4390841373465, 3747.6252374762853, 3769.4722738816586, 3771.2080463102507, 4137.275976704064, 4270.402143699885, 4270.444842170498, 4279.443672322578, 4440.400545926259, 4744.051189761993, 4838.508293087371, 5025.974870125699, 5482.17767334903, 5543.445655434424, 1224.8530176378893, 1285.4536821850677, 1287.6845172932503, 1290.4709069281737, 1290.6061453630057, 708.0087876972281, 793.6468271619074, 822.1490757066407, 841.0227793610673, 870.7300736771621, 4424.424824772824, 4827.275908613736, 5055.620828437882, 5134.691918484903, 5220.843374698765, 4909.975450122726, 5565.916511252334, 5571.406442844343, 5662.0, 5676.984670441933, 4440.578145076277, 4495.044360962333, 4739.86243301612, 4965.8510244692, 5096.847094587169, 2396.2451827674577, 2447.155731272708, 2950.7426818483877, 2957.7190166934106, 2985.9552106718415, 5081.339425874613, 5688.63023903445, 5720.542356611461, 5740.368559458456, 5832.708364581754, 5086.0, 5240.0, 5548.250986116823, 5803.7968671096305, 5846.970765146147, 5280.155175172031, 5598.740283436195, 5787.189793428924, 5995.69165871134, 6006.789762358297, 5525.171224316385, 5650.886982260249, 5748.252727145445, 5750.683712395691, 5751.223584816164, 4444.888877778081, 5509.512431643514, 5633.887322253614, 5647.588102974257, 5682.516986056232, 5095.745212739423, 5618.67961029166, 5863.706814659336, 5926.31100136459, 6014.518838492822, 3431.032775522349, 3483.303339332093, 3622.076370525499, 3671.0, 3746.7751934883995, 4767.833125840718, 5653.491185793298, 5675.829725108253, 5788.21859049023, 5805.245318108618, 4816.325714400057, 4960.716836569042, 5294.761735721979, 5492.450754924475, 5505.476979686923, 5052.545270925634, 5075.670081444694, 5143.485651434976, 5394.541463975606, 5470.91793623104, 5101.846944591668, 5462.945370546244, 5464.426235245242, 5479.835604931858, 5480.588955828409, 5288.312519372457, 5540.556755459473, 5546.473085056913, 5559.858679845875, 5581.693006884498, 4546.840860569864, 5266.1574148136115, 5328.8401347959625, 5473.31583552056, 5495.230667706444], "value": 3952.335438588923, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.7784186902061, 739.264431890269, 773.3697036914914, 781.6170076662437, 816.4937738602067, 14302.785458218123, 14944.85055149448, 14956.700865982673, 14967.25163741814, 14982.850171498281, 13597.0, 13610.863891361083, 13616.523421680244, 13630.931845340785, 13862.792058119136, 706.6148948822878, 727.3017902813306, 729.6534146280527, 879.3536750488386, 884.5533005832078, 874.2918236228643, 896.2919293757956, 905.2622112977934, 912.7444315591645, 914.5518695839057, 953.8426159683679, 958.324381311174, 958.6932181701858, 960.1166926427703, 961.0101595356758, 733.5891900535717, 757.1255200243727, 949.9145076943039, 952.4618590496382, 953.3326671330062, 555.5583311267552, 555.5971920357749, 555.8360283716313, 558.0151033426006, 678.2945736434102, 14431.855681443156, 14921.403143874231, 14942.775858362133, 14960.177190254532, 14960.62598435037, 13513.797293040612, 13601.251931143783, 13611.251381174032, 13657.726845463036, 13688.247146406944, 10749.892501074968, 12258.44836982338, 12427.0, 12625.936870315589, 12779.680507987374, 4186.602272784081, 4267.317229243306, 4392.275274579691, 4435.512093669694, 4531.818727250906, 92915.0, 95378.52310738471, 96146.03853961511, 96255.07489850164, 96287.51856240674, 10742.89257107419, 10755.558221369243, 10853.674389768319, 11005.394703291237, 11196.832047519294, 21610.89194554017, 21614.891925540272, 21630.351089467025, 21704.0, 21709.24017659406, 7284.854302914018, 7390.751881192076, 7496.175420703718, 7648.579328136894, 8004.1995800420655, 4235.851745188966, 4311.762853043113, 4318.050028993616, 4324.372965919924, 4469.575390337913, 3195.4248235317864, 3290.7367410607094, 3295.439775238215, 3299.2081900343746, 3310.2055506678225, 553.2116733654526, 557.5929571412892, 562.6342877129898, 570.8458716146617, 573.8823541174049, 605.9303180134253, 611.4313688269863, 617.8053913017475, 624.8781487609963, 625.8810825943057, 8233.423660343718, 8581.58893560558, 8730.650773969097, 8803.603837827313, 8866.73399798007, 531.2376739379004, 560.3583896438555, 572.5333852909865, 585.4262822434039, 633.9556231063874, 3636.2182130841998, 4005.239004589119, 4049.5747946465785, 4254.957450425456, 4312.956870431318, 62836.0, 98779.0, 103808.0, 105519.47240263749, 107195.0, 63933.36066639274, 80258.0, 82897.0, 91079.54460227789, 92192.0, 74645.0, 79307.0, 80045.59977200194, 81122.59438702768, 83105.16894831095, 9357.953210234178, 9758.414495130315, 9762.707118786448, 9797.265205109788, 9855.802883942424, 41366.0, 47952.04095918132, 49049.01901962012, 54799.178012330645, 56427.435725642215, 72931.0, 75966.6201668988, 77404.76986570655, 81302.59348703218, 81626.59186704029, 11274.943625281821, 12114.757704845677, 12116.333601651993, 12456.688582785502, 13075.346232688138, 11852.34812085309, 13872.653183670489, 14329.996900216885, 14390.712185756436, 14623.415063397344, 11262.549498019987, 13350.332483375598, 13550.457981680622, 13623.455061797416, 13647.795283070564, 10088.69733907984, 11115.270021409851, 13095.803562946754, 13194.538191163263, 13441.193528388329, 12388.968658711618, 12633.052521060774, 12677.619671409873, 12701.22182894377, 12770.616881493199, 10577.576896924036, 11149.72125696864, 11329.150313726668, 11562.132840036862, 11605.941970290094, 11211.215214935202, 11236.887631123584, 11281.605143820256, 11475.196736228718, 11490.712732181762], "value": 7262.802245574725, "unit": "score"}], "name": "dromaeo_css", "value": 7116.911271209283, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 161.0, 166.0, 113.0, 113.0, 111.0, 114.0, 113.0, 113.0], "value": 122.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 113.0, 115.0, 153.0, 112.0, 111.0, 113.0, 110.0, 146.0, 111.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 183.0, 183.0, 183.0, 185.0, 185.0, 180.0, 207.0, 185.0, 182.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 88.0, 62.0, 59.0, 63.0, 59.0, 82.0, 57.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 92.0, 70.0, 67.0, 69.0, 93.0, 67.0, 68.0, 91.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 87.0, 83.0, 85.0, 83.0, 93.0, 83.0, 85.0, 82.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 126.0, 166.0, 96.0, 97.0, 96.0, 95.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 79.0, 80.0, 82.0, 99.0, 119.0, 84.0, 79.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 54.0, 55.0, 56.0, 57.0, 55.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 116.0, 109.0, 86.0, 75.0, 71.0, 70.0, 71.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 87.0, 90.0, 100.0, 107.0, 107.0, 80.0, 88.0, 86.0], "value": 95.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 145.0, 147.0, 144.0, 154.0, 149.0, 157.0, 179.0, 149.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 174.0, 173.0, 173.0, 173.0, 182.0, 173.0, 175.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 79.0, 88.0, 87.0, 75.0, 68.0, 69.0, 69.0, 68.0, 70.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1486.6, "alertThreshold": 2.0}]} 06:23:31 INFO - Return code: 0 06:23:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:23:31 INFO - # TBPL SUCCESS # 06:23:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:23:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:23:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:23:31 INFO - 2016-10-28 06:23:31.988 screenresolution[1666:9733] starting screenresolution argv=screenresolution get 06:23:31 INFO - 2016-10-28 06:23:31.991 screenresolution[1666:9733] Display 0: 1600x1200x32@60 06:23:31 INFO - 2016-10-28 06:23:31.997 screenresolution[1667:9736] starting screenresolution argv=screenresolution list 06:23:32 INFO - Available Modes on Display 0 06:23:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:23:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:23:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:23:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:23:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:23:32 INFO - Intel Iris: 06:23:32 INFO - Chipset Model: Intel Iris 06:23:32 INFO - Type: GPU 06:23:32 INFO - Bus: Built-In 06:23:32 INFO - VRAM (Dynamic, Max): 1536 MB 06:23:32 INFO - Vendor: Intel (0x8086) 06:23:32 INFO - Device ID: 0x0a2e 06:23:32 INFO - Revision ID: 0x0009 06:23:32 INFO - Displays: 06:23:32 INFO - Display: 06:23:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:23:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:23:32 INFO - Display Serial Number: 1600x1200 60 06:23:32 INFO - Main Display: Yes 06:23:32 INFO - Mirror: Off 06:23:32 INFO - Online: Yes 06:23:32 INFO - Rotation: Supported 06:23:32 INFO - Return code: 0 06:23:32 INFO - Running post-action listener: _resource_record_post_action 06:23:32 INFO - [mozharness: 2016-10-28 13:23:32.232262Z] Finished run-tests step (success) 06:23:32 INFO - Running post-run listener: _resource_record_post_run 06:23:32 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 38855680; Write bytes: 706536448; Read time: 384; Write time: 2075 06:23:32 INFO - TinderboxPrint: CPU usage
53.4% 06:23:32 INFO - TinderboxPrint: I/O read bytes / time
38,855,680 / 384 06:23:32 INFO - TinderboxPrint: I/O write bytes / time
706,536,448 / 2,075 06:23:32 INFO - TinderboxPrint: CPU idle
2,265.6 (46.6%) 06:23:32 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 06:23:32 INFO - TinderboxPrint: CPU user
1,624.5 (33.4%) 06:23:32 INFO - TinderboxPrint: Swap in / out
442,937,344 / 0 06:23:32 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392983040; Write bytes: 381593088; Read time: 28859; Write time: 832 06:23:32 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 32558080; Write bytes: 299064832; Read time: 297; Write time: 1193 06:23:32 INFO - Running post-run listener: _upload_blobber_files 06:23:32 INFO - Blob upload gear active. 06:23:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:23:32 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 06:23:32 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:23:32 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:23:33 INFO - (blobuploader) - INFO - Open directory for files ... 06:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:23:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:33 INFO - (blobuploader) - INFO - Done attempting. 06:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:23:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:34 INFO - (blobuploader) - INFO - Done attempting. 06:23:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:23:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:23:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:37 INFO - (blobuploader) - INFO - Done attempting. 06:23:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:23:37 INFO - Return code: 0 06:23:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:23:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:23:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/854750392f0310ff450e62a8b2cae8eab0246a3c253704b15d646be373d40726c3c44a81a943469bf39a9c4eab40b0183ac0ba4308ab6c949c49870e2db9a55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/53028f91a9c5fec99fa0cdf2db9cb38ffb6f0b72c12fc74630aeb5bb249f29caa9917c5a016d8421a91090e8eab43def14563ae6c4437e6f935d16962ba6fdf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a248099456f79c95947792e377ea0641befffcabcd6e60ef15d4a2ef8eea4ca60ff18f87a54889654b523ca61aaff9095fdf2bcba37bcc8adf374c8511c6ff0c"} 06:23:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:23:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:23:37 INFO - Contents: 06:23:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/854750392f0310ff450e62a8b2cae8eab0246a3c253704b15d646be373d40726c3c44a81a943469bf39a9c4eab40b0183ac0ba4308ab6c949c49870e2db9a55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/53028f91a9c5fec99fa0cdf2db9cb38ffb6f0b72c12fc74630aeb5bb249f29caa9917c5a016d8421a91090e8eab43def14563ae6c4437e6f935d16962ba6fdf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a248099456f79c95947792e377ea0641befffcabcd6e60ef15d4a2ef8eea4ca60ff18f87a54889654b523ca61aaff9095fdf2bcba37bcc8adf374c8511c6ff0c"} 06:23:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:23:37 INFO - Copying logs to upload dir... 06:23:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:23:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.997449 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-28 06:23:37.444035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 06:23:37.448022) ========= 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.H5MRY5zuiY/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.azpeW7QfHI/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/Cedar/sha512/854750392f0310ff450e62a8b2cae8eab0246a3c253704b15d646be373d40726c3c44a81a943469bf39a9c4eab40b0183ac0ba4308ab6c949c49870e2db9a55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/53028f91a9c5fec99fa0cdf2db9cb38ffb6f0b72c12fc74630aeb5bb249f29caa9917c5a016d8421a91090e8eab43def14563ae6c4437e6f935d16962ba6fdf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a248099456f79c95947792e377ea0641befffcabcd6e60ef15d4a2ef8eea4ca60ff18f87a54889654b523ca61aaff9095fdf2bcba37bcc8adf374c8511c6ff0c"} build_url:https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010860 build_url: 'https://queue.taskcluster.net/v1/task/Oi-E0HEDTL2r8ErTs9WeSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/854750392f0310ff450e62a8b2cae8eab0246a3c253704b15d646be373d40726c3c44a81a943469bf39a9c4eab40b0183ac0ba4308ab6c949c49870e2db9a55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/53028f91a9c5fec99fa0cdf2db9cb38ffb6f0b72c12fc74630aeb5bb249f29caa9917c5a016d8421a91090e8eab43def14563ae6c4437e6f935d16962ba6fdf3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a248099456f79c95947792e377ea0641befffcabcd6e60ef15d4a2ef8eea4ca60ff18f87a54889654b523ca61aaff9095fdf2bcba37bcc8adf374c8511c6ff0c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 06:23:37.484884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:23:37.485270) ========= 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.H5MRY5zuiY/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.azpeW7QfHI/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:23:37.534393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 06:23:37.534725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 06:23:37.535047) ========= ========= Total master_lag: 0.19 =========