builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0160 starttime: 1479841880.16 results: success (0) buildid: 20161122080051 builduid: 26307b912cfa4309950486d45f79a099 revision: 5c755c22be9668a5e8d60e520c68601635243142 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:20.157233) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:20.157755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:20.158075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:21.122653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:21.122980) ========= 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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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-11-22 11:11:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.0M=0s 2016-11-22 11:11:21 (29.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098374 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:21.247624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:21.247961) ========= 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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.021639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:21.295983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 11:11:21.299348) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 5c755c22be9668a5e8d60e520c68601635243142 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 5c755c22be9668a5e8d60e520c68601635243142 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3I3S8ZQCZc/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.OOftYCZWc6/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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-11-22 11:11:21,375 truncating revision to first 12 chars 2016-11-22 11:11:21,376 Setting DEBUG logging. 2016-11-22 11:11:21,376 attempt 1/10 2016-11-22 11:11:21,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/5c755c22be96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 11:11:22,749 unpacking tar archive at: graphics-5c755c22be96/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626773 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 11:11:22.952838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:22.953202) ========= script_repo_revision: 5c755c22be9668a5e8d60e520c68601635243142 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:22.953630) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:22.953906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 11:11:22.973453) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-22 11:11:22.973811) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3I3S8ZQCZc/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.OOftYCZWc6/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:11:23 INFO - MultiFileLogger online at 20161122 11:11:23 in /builds/slave/test 11:11:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 11:11:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:23 INFO - {'append_to_log': False, 11:11:23 INFO - 'base_work_dir': '/builds/slave/test', 11:11:23 INFO - 'blob_upload_branch': 'Graphics', 11:11:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:23 INFO - 'branch': 'Graphics', 11:11:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:23 INFO - 'config_files': ('talos/mac_config.py',), 11:11:23 INFO - 'default_actions': ('clobber', 11:11:23 INFO - 'read-buildbot-config', 11:11:23 INFO - 'download-and-extract', 11:11:23 INFO - 'populate-webroot', 11:11:23 INFO - 'create-virtualenv', 11:11:23 INFO - 'install', 11:11:23 INFO - 'run-tests'), 11:11:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:23 INFO - 'download_minidump_stackwalk': True, 11:11:23 INFO - 'download_symbols': 'ondemand', 11:11:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:23 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:23 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:23 INFO - 'installer_path': 'installer.exe', 11:11:23 INFO - 'log_level': 'info', 11:11:23 INFO - 'log_name': 'talos', 11:11:23 INFO - 'log_to_console': True, 11:11:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:11:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:11:23 INFO - 'opt_config_files': (), 11:11:23 INFO - 'pip_index': False, 11:11:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:23 INFO - 'cmd': ('bash', 11:11:23 INFO - '-c', 11:11:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:23 INFO - 'enabled': True, 11:11:23 INFO - 'halt_on_failure': False, 11:11:23 INFO - 'name': 'check_screen_resolution'},), 11:11:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:11:23 INFO - 'cmd': ('bash', 11:11:23 INFO - '-c', 11:11:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:11:23 INFO - 'enabled': True, 11:11:23 INFO - 'halt_on_failure': False, 11:11:23 INFO - 'name': 'check_screen_resolution'},), 11:11:23 INFO - 'run_cmd_checks_enabled': True, 11:11:23 INFO - 'sps_profile': False, 11:11:23 INFO - 'sps_profile_interval': 0, 11:11:23 INFO - 'suite': 'dromaeojs', 11:11:23 INFO - 'system_bits': '32', 11:11:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:23 INFO - 'title': 't-yosemite-r7-0160', 11:11:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:23 INFO - 'use_talos_json': True, 11:11:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:23 INFO - 'work_dir': 'build'} 11:11:23 INFO - [mozharness: 2016-11-22 19:11:23.174574Z] Running clobber step. 11:11:23 INFO - Running pre-action listener: _resource_record_pre_action 11:11:23 INFO - Running main action method: clobber 11:11:23 INFO - rmtree: /builds/slave/test/build 11:11:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:23 INFO - Running post-action listener: _resource_record_post_action 11:11:23 INFO - [mozharness: 2016-11-22 19:11:23.398895Z] Finished clobber step (success) 11:11:23 INFO - [mozharness: 2016-11-22 19:11:23.399086Z] Running read-buildbot-config step. 11:11:23 INFO - Running pre-action listener: _resource_record_pre_action 11:11:23 INFO - Running main action method: read_buildbot_config 11:11:23 INFO - Using buildbot properties: 11:11:23 INFO - { 11:11:23 INFO - "project": "", 11:11:23 INFO - "product": "firefox", 11:11:23 INFO - "script_repo_revision": "default", 11:11:23 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 11:11:23 INFO - "repository": "", 11:11:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 11:11:23 INFO - "buildid": "20161122080051", 11:11:23 INFO - "pgo_build": "False", 11:11:23 INFO - "basedir": "/builds/slave/test", 11:11:23 INFO - "buildnumber": 2, 11:11:23 INFO - "slavename": "t-yosemite-r7-0160", 11:11:23 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:11:23 INFO - "platform": "yosemite_r7", 11:11:23 INFO - "scheduler": "tests-graphics-macosx64-talos", 11:11:23 INFO - "branch": "graphics", 11:11:23 INFO - "repo_path": "projects/graphics", 11:11:23 INFO - "revision": "5c755c22be9668a5e8d60e520c68601635243142", 11:11:23 INFO - "stage_platform": "macosx64", 11:11:23 INFO - "builduid": "26307b912cfa4309950486d45f79a099", 11:11:23 INFO - "slavebuilddir": "test" 11:11:23 INFO - } 11:11:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 11:11:23 INFO - Running post-action listener: _resource_record_post_action 11:11:23 INFO - [mozharness: 2016-11-22 19:11:23.403140Z] Finished read-buildbot-config step (success) 11:11:23 INFO - [mozharness: 2016-11-22 19:11:23.403279Z] Running download-and-extract step. 11:11:23 INFO - Running pre-action listener: _resource_record_pre_action 11:11:23 INFO - Running main action method: download_and_extract 11:11:23 INFO - mkdir: /builds/slave/test/build/tests 11:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:23 INFO - trying https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 11:11:23 INFO - Downloading https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 11:11:24 INFO - Downloaded 1199 bytes. 11:11:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:11:24 INFO - Using the following test package requirements: 11:11:24 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:11:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 11:11:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 11:11:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'jsshell-mac.zip'], 11:11:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 11:11:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:11:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 11:11:24 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 11:11:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 11:11:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:11:24 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 11:11:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:11:25 INFO - Http code: 200 11:11:25 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 11:11:25 INFO - x-amz-cf-id: ZbH8EIJUwf8luV3ZGSsMWqja9ek3chVKzLpS2hWhfkicrgcN1Ygpig== 11:11:25 INFO - x-amz-version-id: tbhknbsf0VXdb0b9WcZkgA9FyOiHFrEI 11:11:25 INFO - Expected file size: 16248562 11:11:25 INFO - Obtained file size: 16248562 11:11:32 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:11:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:11:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:11:32 INFO - Fetch https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:11:33 INFO - Http code: 200 11:11:33 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 11:11:33 INFO - x-amz-cf-id: 9fmUXI2CDO4g86KgQQdY-rmXeVGjhCV-FVEEPDFBaP3_L9GUFvSzVg== 11:11:33 INFO - x-amz-version-id: tbhknbsf0VXdb0b9WcZkgA9FyOiHFrEI 11:11:33 INFO - Expected file size: 16248562 11:11:33 INFO - Obtained file size: 16248562 11:11:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 11:11:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:11:39 INFO - Fetch https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 11:11:40 INFO - Http code: 200 11:11:40 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 11:11:40 INFO - x-amz-cf-id: QQ0X7y8eJBPEFGSjTpWwLxxvOI8D1eUmoHzzasxJnc5heZGRsD61Lw== 11:11:40 INFO - x-amz-version-id: HRAf.qLl3M8YsuXYUuyQTgbrgu5IK0gO 11:11:40 INFO - Expected file size: 14409392 11:11:40 INFO - Obtained file size: 14409392 11:11:40 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')]} 11:11:40 INFO - trying https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:11:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 11:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 11:11:43 INFO - Downloaded 107622417 bytes. 11:11:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:11:43 INFO - mkdir: /builds/slave/test/properties 11:11:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:43 INFO - Contents: 11:11:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:11:44 INFO - Running post-action listener: _resource_record_post_action 11:11:44 INFO - Running post-action listener: set_extra_try_arguments 11:11:44 INFO - [mozharness: 2016-11-22 19:11:44.331797Z] Finished download-and-extract step (success) 11:11:44 INFO - [mozharness: 2016-11-22 19:11:44.331928Z] Running populate-webroot step. 11:11:44 INFO - Running pre-action listener: _resource_record_pre_action 11:11:44 INFO - Running main action method: populate_webroot 11:11:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:11:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:11:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:11:44 INFO - '--tppagecycles', 11:11:44 INFO - '7'], 11:11:44 INFO - 'tests': ['tsvgm']}}, 11:11:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:11:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:11:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['damp', 'tps']}, 11:11:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'tests': ['damp', 'tps']}, 11:11:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['dromaeo_dom']}, 11:11:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['basic_compositor_video']}, 11:11:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:11:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['a11yr', 11:11:44 INFO - 'ts_paint', 11:11:44 INFO - 'tpaint', 11:11:44 INFO - 'sessionrestore', 11:11:44 INFO - 'sessionrestore_no_auto_restore', 11:11:44 INFO - 'tabpaint']}, 11:11:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:44 INFO - 'ts_paint', 11:11:44 INFO - 'tpaint', 11:11:44 INFO - 'sessionrestore', 11:11:44 INFO - 'sessionrestore_no_auto_restore', 11:11:44 INFO - 'tabpaint']}, 11:11:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:11:44 INFO - 'ts_paint', 11:11:44 INFO - 'tpaint', 11:11:44 INFO - 'sessionrestore', 11:11:44 INFO - 'sessionrestore_no_auto_restore', 11:11:44 INFO - 'tabpaint']}, 11:11:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:11:44 INFO - 'ts_paint', 11:11:44 INFO - 'tpaint', 11:11:44 INFO - 'sessionrestore', 11:11:44 INFO - 'sessionrestore_no_auto_restore', 11:11:44 INFO - 'tabpaint']}, 11:11:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['a11yr', 11:11:44 INFO - 'ts_paint', 11:11:44 INFO - 'tpaint', 11:11:44 INFO - 'sessionrestore', 11:11:44 INFO - 'sessionrestore_no_auto_restore', 11:11:44 INFO - 'tabpaint']}, 11:11:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['a11yr', 11:11:44 INFO - 'ts_paint', 11:11:44 INFO - 'tpaint', 11:11:44 INFO - 'sessionrestore', 11:11:44 INFO - 'sessionrestore_no_auto_restore', 11:11:44 INFO - 'tabpaint']}, 11:11:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['tsvgx', 11:11:44 INFO - 'tsvgr_opacity', 11:11:44 INFO - 'tart', 11:11:44 INFO - 'tscrollx', 11:11:44 INFO - 'cart']}, 11:11:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:44 INFO - 'tsvgr_opacity', 11:11:44 INFO - 'tart', 11:11:44 INFO - 'tscrollx', 11:11:44 INFO - 'cart']}, 11:11:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'talos_options': ['--disable-e10s'], 11:11:44 INFO - 'tests': ['tp5o']}, 11:11:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:11:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'talos_options': ['--disable-e10s', 11:11:44 INFO - '--xperf_path', 11:11:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:44 INFO - 'tests': ['tp5n']}, 11:11:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:11:44 INFO - 'talos_options': ['--xperf_path', 11:11:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:44 INFO - 'tests': ['tp5n']}}, 11:11:44 INFO - 'talos.zip': {'path': '', 11:11:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:44 INFO - Running post-action listener: _resource_record_post_action 11:11:44 INFO - [mozharness: 2016-11-22 19:11:44.350253Z] Finished populate-webroot step (success) 11:11:44 INFO - [mozharness: 2016-11-22 19:11:44.350336Z] Running create-virtualenv step. 11:11:44 INFO - Running pre-action listener: _resource_record_pre_action 11:11:44 INFO - Running main action method: create_virtualenv 11:11:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:44 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 11:11:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:11:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:44 INFO - Using real prefix '/tools/python27' 11:11:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:48 INFO - Installing pip.................done. 11:11:48 INFO - Return code: 0 11:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:11:48 INFO - Reading from file tmpfile_stdout 11:11:48 INFO - Output received: 11:11:48 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) 11:11:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:11: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', 'pip>=1.5'] in /builds/slave/test/build 11:11: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 pip>=1.5 11:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:48 INFO - 'HOME': '/Users/cltbld', 11:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:48 INFO - 'LOGNAME': 'cltbld', 11:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:48 INFO - 'MOZ_NO_REMOTE': '1', 11:11:48 INFO - 'NO_EM_RESTART': '1', 11:11:48 INFO - 'PAGER': '/bin/cat', 11:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:48 INFO - 'PWD': '/builds/slave/test', 11:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:48 INFO - 'SHELL': '/bin/bash', 11:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:11:48 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:48 INFO - 'USER': 'cltbld', 11:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:48 INFO - 'XPC_FLAGS': '0x0', 11:11:48 INFO - 'XPC_SERVICE_NAME': '0', 11:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11: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 11:11:48 INFO - Cleaning up... 11:11:48 INFO - Return code: 0 11:11:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:11: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 11:11: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 11:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:48 INFO - 'HOME': '/Users/cltbld', 11:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:48 INFO - 'LOGNAME': 'cltbld', 11:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:48 INFO - 'MOZ_NO_REMOTE': '1', 11:11:48 INFO - 'NO_EM_RESTART': '1', 11:11:48 INFO - 'PAGER': '/bin/cat', 11:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:48 INFO - 'PWD': '/builds/slave/test', 11:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:48 INFO - 'SHELL': '/bin/bash', 11:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:11:48 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:48 INFO - 'USER': 'cltbld', 11:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:48 INFO - 'XPC_FLAGS': '0x0', 11:11:48 INFO - 'XPC_SERVICE_NAME': '0', 11:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:48 INFO - Downloading/unpacking psutil>=3.1.1 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:52 INFO - Installing collected packages: psutil 11:11:52 INFO - Running setup.py install for psutil 11:11:52 INFO - building 'psutil._psutil_osx' extension 11:11: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:11: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 11:11: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 11:11: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 11:11:52 INFO - building 'psutil._psutil_posix' extension 11:11: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 11:11:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:11:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:11:52 INFO - ^ 11:11:52 INFO - 1 warning generated. 11:11: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 11:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:11:53 INFO - Successfully installed psutil 11:11:53 INFO - Cleaning up... 11:11:53 INFO - Return code: 0 11:11:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:11: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 11:11: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 11:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:53 INFO - 'HOME': '/Users/cltbld', 11:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:53 INFO - 'LOGNAME': 'cltbld', 11:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:53 INFO - 'MOZ_NO_REMOTE': '1', 11:11:53 INFO - 'NO_EM_RESTART': '1', 11:11:53 INFO - 'PAGER': '/bin/cat', 11:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:53 INFO - 'PWD': '/builds/slave/test', 11:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:53 INFO - 'SHELL': '/bin/bash', 11:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:11:53 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:53 INFO - 'USER': 'cltbld', 11:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:53 INFO - 'XPC_FLAGS': '0x0', 11:11:53 INFO - 'XPC_SERVICE_NAME': '0', 11:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:11:56 INFO - Installing collected packages: mozsystemmonitor 11:11:56 INFO - Running setup.py install for mozsystemmonitor 11:11:56 INFO - Successfully installed mozsystemmonitor 11:11:56 INFO - Cleaning up... 11:11:56 INFO - Return code: 0 11:11:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:11: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 11:11: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 11:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:56 INFO - 'HOME': '/Users/cltbld', 11:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:56 INFO - 'LOGNAME': 'cltbld', 11:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:56 INFO - 'MOZ_NO_REMOTE': '1', 11:11:56 INFO - 'NO_EM_RESTART': '1', 11:11:56 INFO - 'PAGER': '/bin/cat', 11:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:56 INFO - 'PWD': '/builds/slave/test', 11:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:56 INFO - 'SHELL': '/bin/bash', 11:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:11:56 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:56 INFO - 'USER': 'cltbld', 11:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:56 INFO - 'XPC_FLAGS': '0x0', 11:11:56 INFO - 'XPC_SERVICE_NAME': '0', 11:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11: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 11:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:11:59 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 11:11:59 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 11:11:59 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 11:11:59 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 11:11:59 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 11:11:59 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 11:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:11:59 INFO - warning: no files found matching '*.txt' 11:11:59 INFO - no previously-included directories found matching 'build' 11:11:59 INFO - no previously-included directories found matching 'dist' 11:11:59 INFO - no previously-included directories found matching '.git*' 11:11:59 INFO - Installing collected packages: jsonschema, functools32 11:11:59 INFO - Running setup.py install for functools32 11:11:59 INFO - warning: no files found matching '*.txt' 11:11:59 INFO - no previously-included directories found matching 'build' 11:11:59 INFO - no previously-included directories found matching 'dist' 11:11:59 INFO - no previously-included directories found matching '.git*' 11:11:59 INFO - Successfully installed jsonschema functools32 11:11:59 INFO - Cleaning up... 11:11:59 INFO - Return code: 0 11:11:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:11: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')]} 11:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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')]} 11:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:11: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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:11: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 11:11: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 11:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:11:59 INFO - 'HOME': '/Users/cltbld', 11:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:11:59 INFO - 'LOGNAME': 'cltbld', 11:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:59 INFO - 'MOZ_NO_REMOTE': '1', 11:11:59 INFO - 'NO_EM_RESTART': '1', 11:11:59 INFO - 'PAGER': '/bin/cat', 11:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:59 INFO - 'PWD': '/builds/slave/test', 11:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:11:59 INFO - 'SHELL': '/bin/bash', 11:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:11:59 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:11:59 INFO - 'USER': 'cltbld', 11:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:59 INFO - 'XPC_FLAGS': '0x0', 11:11:59 INFO - 'XPC_SERVICE_NAME': '0', 11:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:00 INFO - Cleaning up... 11:12:00 INFO - Return code: 0 11:12:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:00 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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:12:00 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 11:12:00 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 11:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:00 INFO - 'HOME': '/Users/cltbld', 11:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:00 INFO - 'LOGNAME': 'cltbld', 11:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:00 INFO - 'MOZ_NO_REMOTE': '1', 11:12:00 INFO - 'NO_EM_RESTART': '1', 11:12:00 INFO - 'PAGER': '/bin/cat', 11:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:00 INFO - 'PWD': '/builds/slave/test', 11:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:00 INFO - 'SHELL': '/bin/bash', 11:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:12:00 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:00 INFO - 'USER': 'cltbld', 11:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:00 INFO - 'XPC_FLAGS': '0x0', 11:12:00 INFO - 'XPC_SERVICE_NAME': '0', 11:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:04 INFO - Downloading docopt-0.6.1.tar.gz 11:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:04 INFO - Running setup.py install for blobuploader 11:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:04 INFO - Running setup.py install for requests 11:12:04 INFO - Running setup.py install for docopt 11:12:04 INFO - Successfully installed blobuploader requests docopt 11:12:04 INFO - Cleaning up... 11:12:05 INFO - Return code: 0 11:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:05 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')]} 11:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:05 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')]} 11:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:05 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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:12:05 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 11:12:05 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 11:12:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:12:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:05 INFO - 'HOME': '/Users/cltbld', 11:12:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:05 INFO - 'LOGNAME': 'cltbld', 11:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:05 INFO - 'MOZ_NO_REMOTE': '1', 11:12:05 INFO - 'NO_EM_RESTART': '1', 11:12:05 INFO - 'PAGER': '/bin/cat', 11:12:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:05 INFO - 'PWD': '/builds/slave/test', 11:12:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:05 INFO - 'SHELL': '/bin/bash', 11:12:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:12:05 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:12:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:05 INFO - 'USER': 'cltbld', 11:12:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:05 INFO - 'XPC_FLAGS': '0x0', 11:12:05 INFO - 'XPC_SERVICE_NAME': '0', 11:12:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-lzl2Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-pPzI7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ZPL4fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-NjAoJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-TLjX2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-FKgSle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:05 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-njNQLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-wkkxRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ybuvOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-U2OEhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-sQWcAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-S_Vo3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-aGkXSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-6yPMg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-VNlAUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-7zpkFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:06 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-cnL9ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:07 INFO - Running setup.py install for manifestparser 11:12:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Running setup.py install for mozcrash 11:12:07 INFO - Running setup.py install for mozdebug 11:12:07 INFO - Running setup.py install for mozdevice 11:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Running setup.py install for mozfile 11:12:07 INFO - Running setup.py install for mozhttpd 11:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:07 INFO - Running setup.py install for mozinfo 11:12:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozInstall 11:12:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozleak 11:12:08 INFO - Running setup.py install for mozlog 11:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for moznetwork 11:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Running setup.py install for mozprocess 11:12:08 INFO - Running setup.py install for mozprofile 11:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:09 INFO - Running setup.py install for mozrunner 11:12:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:12:09 INFO - Running setup.py install for mozscreenshot 11:12:09 INFO - Running setup.py install for moztest 11:12:09 INFO - Running setup.py install for mozversion 11:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:09 INFO - Cleaning up... 11:12:09 INFO - Return code: 0 11:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 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')]} 11:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:10 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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:12:10 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 11:12:10 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 11:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:10 INFO - 'HOME': '/Users/cltbld', 11:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:10 INFO - 'LOGNAME': 'cltbld', 11:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:10 INFO - 'MOZ_NO_REMOTE': '1', 11:12:10 INFO - 'NO_EM_RESTART': '1', 11:12:10 INFO - 'PAGER': '/bin/cat', 11:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:10 INFO - 'PWD': '/builds/slave/test', 11:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:10 INFO - 'SHELL': '/bin/bash', 11:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:12:10 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:10 INFO - 'USER': 'cltbld', 11:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:10 INFO - 'XPC_FLAGS': '0x0', 11:12:10 INFO - 'XPC_SERVICE_NAME': '0', 11:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:10 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-oydLrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12: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)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:10 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-RsMDaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:10 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-l_VXt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-q0LgQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-Klfmb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-MFUU9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-N8XCOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-nCMiv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:11 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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-KzCn_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12: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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-FcOowb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12: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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-M_0eUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12: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)) 11:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:11 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-sBSY7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:12 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)) 11:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:12 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-W1nN5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:12 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)) 11:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:12 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-mutA6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:12 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-MkbgkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:12 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)) 11:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:12 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-eF_DoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:12 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)) 11:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:12 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-PmaCwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:12 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)) 11:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:12:12 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)) 11:12:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:15 INFO - Downloading blessings-1.6.tar.gz 11:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:15 INFO - Installing collected packages: blessings 11:12:15 INFO - Running setup.py install for blessings 11:12:15 INFO - Successfully installed blessings 11:12:15 INFO - Cleaning up... 11:12:15 INFO - Return code: 0 11:12:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:16 INFO - Reading from file tmpfile_stdout 11:12:16 INFO - Current package versions: 11:12:16 INFO - blessings == 1.6 11:12:16 INFO - blobuploader == 1.2.4 11:12:16 INFO - docopt == 0.6.1 11:12:16 INFO - functools32 == 3.2.3-2 11:12:16 INFO - jsonschema == 2.5.1 11:12:16 INFO - manifestparser == 1.1 11:12:16 INFO - mozInstall == 1.12 11:12:16 INFO - mozcrash == 1.0 11:12:16 INFO - mozdebug == 0.1 11:12:16 INFO - mozdevice == 0.49 11:12:16 INFO - mozfile == 1.2 11:12:16 INFO - mozhttpd == 0.7 11:12:16 INFO - mozinfo == 0.9 11:12:16 INFO - mozleak == 0.1 11:12:16 INFO - mozlog == 3.4 11:12:16 INFO - moznetwork == 0.27 11:12:16 INFO - mozprocess == 0.23 11:12:16 INFO - mozprofile == 0.28 11:12:16 INFO - mozrunner == 6.13 11:12:16 INFO - mozscreenshot == 0.1 11:12:16 INFO - mozsystemmonitor == 0.3 11:12:16 INFO - moztest == 0.7 11:12:16 INFO - mozversion == 1.4 11:12:16 INFO - psutil == 3.1.1 11:12:16 INFO - requests == 1.2.3 11:12:16 INFO - wsgiref == 0.1.2 11:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:16 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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:12:16 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 11:12:16 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 11:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:16 INFO - 'HOME': '/Users/cltbld', 11:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:16 INFO - 'LOGNAME': 'cltbld', 11:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:16 INFO - 'MOZ_NO_REMOTE': '1', 11:12:16 INFO - 'NO_EM_RESTART': '1', 11:12:16 INFO - 'PAGER': '/bin/cat', 11:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:16 INFO - 'PWD': '/builds/slave/test', 11:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:16 INFO - 'SHELL': '/bin/bash', 11:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:12:16 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:16 INFO - 'USER': 'cltbld', 11:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:16 INFO - 'XPC_FLAGS': '0x0', 11:12:16 INFO - 'XPC_SERVICE_NAME': '0', 11:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12: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)) 11:12:16 INFO - Cleaning up... 11:12:16 INFO - Return code: 0 11:12:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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 0x10a6543f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5ca570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef624c3ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, '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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 11:12: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 11:12: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 11:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:16 INFO - 'HOME': '/Users/cltbld', 11:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:16 INFO - 'LOGNAME': 'cltbld', 11:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:16 INFO - 'MOZ_NO_REMOTE': '1', 11:12:16 INFO - 'NO_EM_RESTART': '1', 11:12:16 INFO - 'PAGER': '/bin/cat', 11:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:16 INFO - 'PWD': '/builds/slave/test', 11:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:16 INFO - 'SHELL': '/bin/bash', 11:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:12:16 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:16 INFO - 'USER': 'cltbld', 11:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:16 INFO - 'XPC_FLAGS': '0x0', 11:12:16 INFO - 'XPC_SERVICE_NAME': '0', 11:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:12:16 INFO - Cleaning up... 11:12:16 INFO - Return code: 0 11:12:16 INFO - Running post-action listener: _resource_record_post_action 11:12:16 INFO - Running post-action listener: _start_resource_monitoring 11:12:16 INFO - Starting resource monitoring. 11:12:16 INFO - [mozharness: 2016-11-22 19:12:16.598430Z] Finished create-virtualenv step (success) 11:12:16 INFO - [mozharness: 2016-11-22 19:12:16.599405Z] Running install step. 11:12:16 INFO - Running pre-action listener: _resource_record_pre_action 11:12:16 INFO - Running main action method: install 11:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:16 INFO - Reading from file tmpfile_stdout 11:12:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:16 INFO - Reading from file tmpfile_stdout 11:12:16 INFO - Output received: 11:12:16 INFO - Usage: mozinstall [options] installer 11:12:16 INFO - Options: 11:12:16 INFO - -h, --help show this help message and exit 11:12:16 INFO - -d DEST, --destination=DEST 11:12:16 INFO - Directory to install application into. [default: 11:12:16 INFO - "/builds/slave/test"] 11:12:16 INFO - --app=APP Application being installed. [default: firefox] 11:12:16 INFO - mkdir: /builds/slave/test/build/application 11:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:12:49 INFO - Reading from file tmpfile_stdout 11:12:49 INFO - Output received: 11:12:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:12:49 INFO - Running post-action listener: _resource_record_post_action 11:12:49 INFO - [mozharness: 2016-11-22 19:12:49.525259Z] Finished install step (success) 11:12:49 INFO - [mozharness: 2016-11-22 19:12:49.525390Z] Running run-tests step. 11:12:49 INFO - Running pre-action listener: _resource_record_pre_action 11:12:49 INFO - Running main action method: run_tests 11:12:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:49 INFO - 2016-11-22 11:12:49.540 screenresolution[1883:9173] starting screenresolution argv=screenresolution get 11:12:49 INFO - 2016-11-22 11:12:49.542 screenresolution[1883:9173] Display 0: 1600x1200x32@60 11:12:49 INFO - 2016-11-22 11:12:49.548 screenresolution[1884:9175] starting screenresolution argv=screenresolution list 11:12:49 INFO - Available Modes on Display 0 11:12:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:49 INFO - Intel Iris: 11:12:49 INFO - Chipset Model: Intel Iris 11:12:49 INFO - Type: GPU 11:12:49 INFO - Bus: Built-In 11:12:49 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:49 INFO - Vendor: Intel (0x8086) 11:12:49 INFO - Device ID: 0x0a2e 11:12:49 INFO - Revision ID: 0x0009 11:12:49 INFO - Displays: 11:12:49 INFO - Display: 11:12:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:49 INFO - Display Serial Number: 1600x1200 60 11:12:49 INFO - Main Display: Yes 11:12:49 INFO - Mirror: Off 11:12:49 INFO - Online: Yes 11:12:49 INFO - Rotation: Supported 11:12:49 INFO - Return code: 0 11:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:49 INFO - Python 2.7.3 11:12:49 INFO - Return code: 0 11:12:49 INFO - grabbing minidump binary from tooltool 11:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a46ad30>, '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 0x10a2d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a462b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:12:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:12:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:12:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:49 INFO - Return code: 0 11:12:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:12:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:12:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 11:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0160 --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 11:12:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3I3S8ZQCZc/Render', 11:12:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:49 INFO - 'HOME': '/Users/cltbld', 11:12:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:49 INFO - 'LOGNAME': 'cltbld', 11:12:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:49 INFO - 'MOZ_NO_REMOTE': '1', 11:12:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:49 INFO - 'NO_EM_RESTART': '1', 11:12:49 INFO - 'PAGER': '/bin/cat', 11:12:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:49 INFO - 'PWD': '/builds/slave/test', 11:12:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:49 INFO - 'SHELL': '/bin/bash', 11:12:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OOftYCZWc6/Listeners', 11:12:49 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 11:12:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:49 INFO - 'USER': 'cltbld', 11:12:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:49 INFO - 'XPC_FLAGS': '0x0', 11:12:49 INFO - 'XPC_SERVICE_NAME': '0', 11:12:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 11:12:50 INFO - mozversion application_buildid: 20161122080051 11:12:50 INFO - mozversion application_changeset: 5c755c22be9668a5e8d60e520c68601635243142 11:12:50 INFO - mozversion application_display_name: Nightly 11:12:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:50 INFO - mozversion application_name: Firefox 11:12:50 INFO - mozversion application_remotingname: firefox 11:12:50 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 11:12:50 INFO - mozversion application_vendor: Mozilla 11:12:50 INFO - mozversion application_version: 53.0a1 11:12:50 INFO - mozversion platform_buildid: 20161122080051 11:12:50 INFO - mozversion platform_changeset: 5c755c22be9668a5e8d60e520c68601635243142 11:12:50 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 11:12:50 INFO - mozversion platform_version: 53.0a1 11:12:50 INFO - using testdate: 1479841970 11:12:50 INFO - actual date: 1479841970 11:12:50 INFO - starting webserver on 'localhost:49375' 11:12:50 INFO - SUITE-START | Running 2 tests 11:12:50 INFO - TEST-START | dromaeo_css 11:12:50 INFO - operating with platform_type : mac_ 11:12:50 INFO - Initialising browser for dromaeo_css test... 11:12:50 INFO - TEST-INFO | started process 1894 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpw_ON6q/profile http://localhost:49375/getInfo.html) 11:12:52 INFO - PROCESS | 1894 | __metrics Screen width/height:1600/1200 11:12:52 INFO - PROCESS | 1894 | colorDepth:24 11:12:52 INFO - PROCESS | 1894 | Browser inner width/height: 1024/689 11:12:52 INFO - PROCESS | 1894 | __metrics 11:12:53 INFO - PROCESS | 1894 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:12:53 INFO - PROCESS | 1894 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:12:54 INFO - TEST-INFO | 1894: exit 0 11:12:54 INFO - Browser initialized. 11:12:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:54 INFO - TEST-INFO | started process 1896 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpw_ON6q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:06 INFO - PROCESS | 1896 | RSS: Main: 242860032 11:13:06 INFO - PROCESS | 1896 | 11:13:57 INFO - PROCESS | 1896 | 1479842037131 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] 11:16:10 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49375/tests/dromaeo/cssquery-ext.html) 11:16:12 INFO - PROCESS | 1896 | RSS: Main: 435486720 11:16:12 INFO - PROCESS | 1896 | 11:19:15 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-ext.html (next: http://localhost:49375/tests/dromaeo/cssquery-jquery.html) 11:19:15 INFO - PROCESS | 1896 | RSS: Main: 367534080 11:19:15 INFO - PROCESS | 1896 | 11:22:18 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49375/tests/dromaeo/cssquery-mootools.html) 11:22:19 INFO - PROCESS | 1896 | RSS: Main: 337805312 11:22:19 INFO - PROCESS | 1896 | 11:25:21 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49375/tests/dromaeo/cssquery-prototype.html) 11:25:21 INFO - PROCESS | 1896 | RSS: Main: 342028288 11:25:21 INFO - PROCESS | 1896 | 11:28:25 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49375/tests/dromaeo/cssquery-yui.html) 11:28:25 INFO - PROCESS | 1896 | RSS: Main: 319094784 11:28:25 INFO - PROCESS | 1896 | 11:31:28 INFO - PROCESS | 1896 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-yui.html (next: http://localhost:49375/tests/dromaeo/cssquery-dojo.html) 11:31:29 INFO - PROCESS | 1896 | RSS: Main: 512770048 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | __start_tp_report 11:31:29 INFO - PROCESS | 1896 | _x_x_mozilla_page_load 11:31:29 INFO - PROCESS | 1896 | _x_x_mozilla_page_load_details 11:31:29 INFO - PROCESS | 1896 | |i|pagename|runs| 11:31:29 INFO - PROCESS | 1896 | |0;dojo.html;3289.6874796894294;3292.753043521735;3299.505074238864;3321.8006919584814;3350.61467931188;5586.385497595272;5643.5767317451255;5677.37548869624;5703.372629010811;5731.684757338345;5618.410066942974;5686.886262274752;5774.740136693848;5774.989376859044;5798.478136967683;5094.1085310070775;5139.640225184238;5171.120909445403;5189.247559103927;5248.186531087687;5261.500157485033;5323.148296272597;5333.893322133555;5341.278927344817;5342.813001544947;5280.419153893069;5291.100512912775;5340.332458442695;5349.973250133744;5386.353637563498;5071.087204303224;5147.176451767737;5157.819476318311;5173.974130129325;5237.031149237365;5210.244514545369;5216.2958000669805;5239.659422137549;5264.842054738326;5277.762500687479;5658.122990936411;5667.886642267132;5685.744141513642;5709.714514274269;5723.998300297431;6080.878382432326;6120.785772497986;6136.079588061782;6139.109829074804;6166.7533298667995;6206.317305096436;6277.654728989904;6279.780207692755;6321.968390158066;6342.207224096988;4797.664163508521;4818.253170758538;5726.9713651431475;5771.961047011536;5829.737661805187;6204.503639708812;6278.089676996809;6320.841978950563;6327.398897104859;6332.525060620472;5993.790217342372;6026.0659597762415;6060.060690592965;6136.539759518054;6142.539309551801;6280.811575652738;6283;6285.151504546828;6287.1198032275515;6303.558750887486;6121.387861213932;6192.566520343533;6194.876102478015;6208.192934918432;6230.003199488151;5875.353711091777;5926.111083337534;6201.255849298113;6251.874962500725;6257.499400047986;4204.13815167896;4225.767582782915;4804.711717296974;4879;4921.975390123098;4404.801783919731;4413.426254586947;4426.84506042287;4461.375407442961;4473.507914129443;5677.1200463927335;5723.399043100415;5751.252337196222;5755.625884317506;5766.308043034779;6128.411459112376;6170.50635949123;6179.3202747697715;6208.379162083756;6280.120783090371;5687.744051517691;5734.311882574035;5743.023685973395;5767.192593036894;5778.191053252548;5380.461953804588;5389.191621256843;5394.8921021579345;5395.082835917903;5396.541293990055;6178.845528861814;6282.057691346335;6294.874102518015;6313.96843015782;6348.619082855043;6177.907331389943;6192.969035154975;6241.78153764616;6269.0909818075215;6319.652419116993;6282.3089460158435;6291.182146320949;6309.148264984168;6309.463695585743;6315.715792789428;6178.165947597017;6223.751049957951;6233.438990490697;6235.220597425322;6237.28271248794;6110.419510146529;6137.68343894035;6204.782832601018;6206.10011548332;6269.435750782452;6104.580421837985;6126.731429653803;6142.04798256271;6142.464383904024;6150.415710507495;6024.307204671519;6028.8794224116145;6088.726007329592;6094.299155597163;6128.938710612837;5759.366469688414;5796.246487956539;5796.478316951495;5888.499477544286;5913.58604897653;5962.135490353961;6000.789972350947;6005.039193728982;6010.4891084258325;6010.609310394811;5824.5340372770925;5837.474627283565;5845.3570107289015;5846.239988801599;5846.590738648254 11:31:29 INFO - PROCESS | 1896 | |1;ext.html;456.99086018279627;466.80627539571077;467.2663917649292;477.36033714822133;510.0767610624769;29970.400591988175;39207.411888821654;40170.79914600427;40242;40392.39411408831;41810.7909460453;42057.579424205745;42165.78917105418;42195.78902105485;42428.363574546405;8522.446041007346;9291.535423228828;9460.479673617949;9477.905220947805;9508.762280942963;8549.487030778142;11083.833742493869;11410.714732131722;11413.31520108792;11528;11244.606438774645;11322.150838687132;11368.31790092593;11379.943100284487;11453.541858325658;11286.097112231002;11356.659300220965;11356.943215283953;11357.488912998851;11374.37440940748;10344.172466202686;11158.609448669258;11220.943895280552;11235.269707468988;11235.83146252807;35579.644203557895;39364.60635393638;39409;39469;39488.40767388492;3146.7797254192214;3161.984190079058;3251;3398.0315610051016;3406.812625305607;29162;29290;30539.847300763355;30641.846790765903;30996.225094372596;3081.245094951729;3171.413288541627;3234.3854667613077;3237.8542965566608;3303.6035675719068;455673.721631393;478290;478765;478992;484357.57821210666;58305.41694583;58491.70754146287;58593;58956.41043589509;59007.40992590019;62915;62968.68515657393;63014.68492657507;63032.68483657644;63058.684706576176;15953.920230398773;16035.839641603434;16093.758593621105;16101.355945762272;16109.597260068593;11087;11348;11379.975802177843;12406.81389779154;12518.12373133872;12396.582666379969;15241.771373429407;15354.23228838576;15356.769648455282;16679.916600417164;5659.349174844946;6709.765158219537;6733.124693789874;6809.897851532231;6824.112865327475;848.2026894718945;933.262722449271;940.6049459227141;957.090763774417;967.583938906263;26891.327716807235;28664.570031449544;28969;29148.125556233346;29549.556756648668;1044.2116202267391;1058.9894101058892;1099.1866019145934;1107.6732363952653;1172.7771723372703;14172.291385430688;14857.925710371379;14960.551183464513;15169.696606067817;15290;623993;627532;628599;629492;895421;47669;56160.719196403756;57310.7134464325;57419;60603.69698151481;1331.9334033298296;1350.9324533773272;1373.2447154065223;1373.32020649781;1373.684052667872;29724;29729.40541189121;30245;30252.5462118064;30666.693333066385;49768;50625;50724.74637626788;50809.491905080475;50838;473556;475118;475674;475982;476502;36885.81557092197;37799.05502362463;38379.424308634836;38672;38839.80580097081;45063.32405013862;45791;45957;46250;46402.535974639824;37170.6282937178;37219.62780372162;37949;38142.42786358151;38879.61120388873;28074.57888131639;29613.5557966635;37383.327084114484;38383.61616383801;38557.421638676;36769.03870162297;37053.85042271437;37431.81284093562;37578.812105939294;37613.435798462495;30727;31675;32974;33057.33885322328;33421.83289083539;23832.046718131773;24170.637440438055;24452.388690282885;24585;24687.38281542976 11:31:29 INFO - PROCESS | 1896 | |2;jquery.html;350.2836698950646;368.08714388316974;368.90408493791625;377.12318858653634;394.8756141815328;14755.48355807547;14864.55406337809;15926.362945482197;19730.605387892232;20230.797692023076;16673.333066677318;19054.047297635134;19838.107285172166;20031.899840500813;20159.092840822163;5447.992121457533;5815.621984570989;5827.650340979555;5831;5840.737166827482;5584.078627026536;5584.591753276557;5707.971460142693;5747.856303592402;5778.27771528559;4050.3519436890106;4278.5935336143175;5717.3710891802075;5727.312722473309;6016.819495415145;6307.653079080649;6310.873782524323;6413.615183088983;6415.422611964946;6419.069234960904;5399.676019438846;5523.6409633373705;5564.443555644443;5566.332040155207;5577.3028371453565;24385.512289754104;25008.124715634865;25022.4995500089;25148.24555263345;25482.49035019308;2374.2521105851774;2513.648089267486;3020.758339332848;3034.696530346948;3075.8308293043874;15279.465218717292;15300.08199508022;15339.156346400943;15755.842441575667;15838.128902910335;1801.8918864868149;1828.6982647863088;1874.6625607390665;1906.3994841624844;1915.4923945154544;123420.1263898886;127681.08478372832;127981;129570.3521482396;129809.35095324463;10985.890141098487;11371.204015718986;11404.429778511041;11409.885901140882;11622.360770157553;13703.383347749375;13816.171029738249;14098.224597647022;14144;14178.291085445893;6793.966030169818;8130.959345203236;8436.28291595209;8547.444416112932;8557.529335886586;8354.498730076215;8355.248027677417;8373.455725377831;8539.957300213458;8541.658333666708;4337.37108119321;4424.6239069678795;4432.534583868712;4500.684952053325;4527.139843429738;1826.844718198968;1876.5214870208283;1879.1262063140432;1879.2389082421641;1882.2565086790914;816.346922462028;829.4981536170529;844.0630899701326;903.2999425445332;925.6346888339646;19719.60560788805;20699.58600827975;20829.58340833205;20942.685859712117;21164.682529762067;870.4037734152126;897.4166791585391;898.1018981018981;942.3074040580168;956.36401792807;7950.602469876483;9780.070893265129;10346.120579750805;10847.945760271148;10874;483439;510472;564115;583529;590782;122902;132888;134771.32614337062;137054.94417583745;140542;953.7091187187974;954.289054654287;955.8805149356331;956.3926906414338;964.6623681711345;18025.909870450563;18309.725354119433;18400;18675.38416442687;18782.342618008304;51996.74001629968;54804;56223;56230.71884640551;57035.429645703014;58602.82794344174;81911.59044204741;82227.7665835025;83328.3340332366;84091.17042710427;7749.147593764794;7849.215078492105;7945.205479452008;8024.277814996678;8139.715109971123;10444.895551044392;12124;12540.435680394221;12644.494220231089;13006.219626822422;9735;10625.618669572907;11282.323060616389;11479.25384849982;11576.594819181288;9200.723978280663;11165.665030049111;11191;11192.552297907992;11447.656570302905;11327.943360283145;11387.259828111146;11548.653540393801;11588.420578971187;11813.995810356217;6955.513114081966;7978;8136.7152149674475;8248.13394593559;8370.16298370158;9310.906890931004;10475.476226188812;11009.724756880822;11134.55461781552;11306.152038596974 11:31:29 INFO - PROCESS | 1896 | |3;mootools.html;1333.7665908466015;1487.018567745288;1508.2081906998824;1666.1918969299888;1832.1755210155425;7512;7912.881306780403;8096.635651395694;8459.619317130728;8471.957640211791;7038.225795162528;8254.339652827774;8316.1268066853;8372.665093396272;8373.665053397872;2276.68126462295;2309.8383113182085;2315.143396943125;2319.083961835074;2322.1175953137868;1945.6303302372503;2285.325828880476;2324.081987614891;2343.2735851885886;2348.518553696488;2284.440312123532;2293.2776175504664;2309.2264091529273;2310.919117830876;2319.6868422762964;2265.886705664718;2268.9773102269096;2295.437617783637;2303.3090072978125;2311.3643747969445;2300.332903457995;2325.953480930372;2326.2904814031713;2326.918557850467;2327.895244713992;6975.895361569581;8519.957400213021;8524.573771311472;8531.317494600416;8563.95718021406;5039.546440820307;5252.002119597302;5255.08036093682;5276.577873770128;5290.021346050993;2998.745106665936;3448.2930999145115;3614.9096272593133;3615.8734444294587;3640.2355505343908;1074.8119079161115;1102.8511150994593;1707.8292170782947;1755.4558086993072;1826.0687049604664;11161;11200.047995920357;11215.271007384412;11222.551097956071;11223;4518.615917647036;4749.026449577828;4769.976150119227;4783.4499032611;4805.183118869801;8235.794105147419;8900.821983560292;8905.777355566162;8908.376413651113;8908.599113039929;5142.76857541404;5144.7942082316285;5145.3568303962;5150.819721309736;5151.587872970228;4208.768517731554;4483.901444146205;4833.468318484964;4849.224124140121;4851.708897466164;3558.5551806024246;3664.853405863789;3681.1349332906743;3708.1841994761107;3716.331060409152;968.2060710217554;1127.9436028198556;1138.3170097941334;1146.8050431426677;1147.208426185929;815.8776183572393;842.2209456252941;843.9662413503391;848.134902399549;893.334465822953;4991.4758950310425;5312.681239125587;5456.71767134723;5568.248286481355;5759.539236861041;443.60740744440756;448.27155871708476;453.5419226581111;967.8741763570831;992.9900700992897;3229.531717900891;3448;3838.7120965927666;3906.125378848326;4020.537638171648;10282.588696452207;10293.43386113771;10488.160947124212;10499.632512862167;10525.578976840994;10484.580616775396;10487.161027117812;10490.423026733602;10508.737281568023;10528;6740.730370785113;7517.699292028257;7844.176361481962;7954.164812694699;8073.596320184085;4971.776270067928;5590.217369568345;5780.971095144498;5845.766169353178;5899.764009439575;9034.186923176945;9188.448693078437;9533.23734101284;9575.377600455948;9595.568199430903;9539;9655.275854310814;9663.661771837951;9747.122758951728;9832.705018849447;7180.676869540987;7203.099612548432;7337.889931651136;7350.411967042731;7360.742374016883;7811.687532498637;8006.639701213343;8008.6396112173925;8009.599520024092;8021.117677055403;7028.402585780266;7125.928740712734;7136.215016348094;7231.63841807897;7305.086864141982;7014.824629384306;7057.435405167472;7065.682044307916;7132.6790294437915;7157.534760240567;6376.139221205078;6566.9014964774615;6668.366505182;6742.6628668567355;6751.696173672295;4847.151748443937;4893.828715994923;4897.559219670246;4926.088673595396;5048.444671086251;4844.709317440824;4872.707637541759;4939.876503087452;4993.575546078624;5010.924836127534 11:31:29 INFO - PROCESS | 1896 | |4;prototype.html;283.33557806942713;297.6041864320454;298.16067769229625;307.13235110811956;311.02338656618224;4451.821927122911;4931.358923339965;4938.654139283838;5185.222216667502;5214.765335559909;4043.67650587953;4856.417229932405;5109.850283686169;5135.897282054357;5145.3568303962;3907.8436862525537;3933.704972127088;3954.4068389741483;3963.7819919904396;3993.2845664947968;3708.7033037357082;3892.143728379752;3915.3735402335633;3923.312975420568;3954.319414248947;3425.314937012595;3655.981720091409;3882.669973052294;3899.298126337258;3905;3335.816530090844;3684;3792.355299599061;3892.143728379752;3895.10412605101;2830.7593854522393;3178.1577881861326;3372.2749608833974;3374.7637665363436;3391.796492210475;4722.622190224808;4947.406311242638;4976.4277108132665;4980.452150263468;5049.368828896388;3724.7206459515646;4040.2324407780766;4217.725847819882;4301.333293339538;4428.018479210888;4760.833370832004;4962.957778866443;5294.258803767476;5339.252504649352;5353.411124776271;3104.161876293388;3388.915277118067;3533.010756988022;3620.366435873738;3721;4901.554041557749;4913.87715307113;5684;5694.430556944314;5709.74306156224;3200.77594568378;3718.754217337168;3727.4036154215737;3763.6612704856693;3768.4724138620613;3184.681531846843;3185.761067919915;3327.8169700666695;3660.9566273611895;3803.6196380361744;3542.8405721742583;4340.590972010501;4388;4393.1872603568445;4395.824167033283;4824.614030877521;5288.942211557704;5379;5414.539764120015;5487.478689524489;1140.0024978144124;1185.5062621097306;1213.9514419423124;1217.5373358124034;1229.8378032758958;704.5279662626053;793.3732351442296;829.8049958259804;830.8712149616819;847.7160151349367;4268.40242366069;4476.955230447654;4704.976475117671;4763;4785.736784476818;4463.732176069446;4693.741844198534;5264.6051546134195;5265.789368425297;5273.947260527422;3949.1311911379453;4307.913841723148;4483.932741008887;4736.265878788793;4770;2226.7995880370845;2277.5103352779233;2778.3332000320183;2780.0408858943633;2815.633967584242;4437.2234858899565;5154.407243167008;5180.6891586504935;5495.368032676213;5513.8345849624575;4588.26587745959;5107.361579802525;5209.661372010807;5451.05642952809;5464.480874316933;4830.8792280193275;4902.754862256873;5263.578753773307;5453.3278693439925;5483.369412517612;4694.92957605643;4741.691790033775;5307.469253074816;5315.750798562258;5323.30796996388;4656.464506581787;5116.4627714090975;5212.400573934046;5238.580913526833;5284.8901730637;5064.620153488429;5087.2623469595965;5696.629719068247;5735.426457354231;5739.126089889392;3198.168476196159;3743.36362818327;3743.9251214975;3751.643593858579;3783.5838057813066;4428.778561071869;4962.808925857696;5027.8575890068705;5555.944440555704;5621.835593296529;4885.926711099265;4901.656884018084;5202.1416466282635;5353.277307563585;5381.704006279692;4433.911321773611;4941.50584941503;5191.091558977239;5422.864428389322;5433.4566543345345;4811.879703007453;5010.048090862724;5317.867053323698;5394.757235924471;5400.972995134999;5034.924476132935;5402.27069345649;5421.512063914267;5485.753141108739;5499.917501237404;4497.775111244359;4545.06826100642;4775.761211939459;5278.97360513195;5284.207368894697 11:31:29 INFO - PROCESS | 1896 | |5;yui.html;672.3310306245287;726.69115625859;751.7218629107231;759.0245937877216;798.6086817459443;14212.928935355321;14522.346494407751;14829.18439485828;14861.851381486182;14867.182304973236;12749.10756247063;13077.476900923975;13415.060945733803;13603.795943060863;13683;648.6789039425468;820.1962077164397;833.7873842170238;836.9330453563731;837.4347315562002;668.9531732778707;682.1643486728767;806.6007326373424;840.1220724343076;846.9068402475754;880.5861245214771;881.2113158722939;881.858902575588;882.2060145868705;883.002207505521;867.7136544940155;872.3457406944729;874.300559552362;874.7725591346264;877.6050777150308;501.12079701120797;519.187471606934;625.4214851262564;641.2209165863452;652.8498445357546;11631.59289424866;13794.379252933642;13842.515511957134;13853.445862165501;13868.514601988882;10774.622888198875;12136.635900922987;12460;12647.367631618474;12980.675483112904;11563.884361156364;11784.469698863571;11880.287182769061;11940.223885447418;12192.268463892106;4272.423222864904;4284.935725964113;4286.892827679302;4388.539203383631;4400.273954797454;86716.13283867143;90866.5456672719;91310;91647;91688.54155729245;10073.798524029478;10093.899061009295;10120;10120.493975301206;10488.31825931312;18495.44513664592;18575.53561160982;19221.61556768857;19227.423177304703;19247.13387897548;7293.744718934812;7300.160481544584;7311.086114235721;7388.44586656003;7567.886481702779;4104.52797928242;4170.124273902454;4176.248275310412;4184.205001049791;4192.413062171298;2715.321169707573;3078.569000339954;3174.206448387903;3181.66592507788;3214.244652506659;611.6666416802854;620.4044117647019;628.136312570216;659.1760299625469;683.9213490448562;540.4757385336218;553.4023254884714;604.4680681000691;650.3951325267547;659.6800551732406;8140.104588495261;8143.185681431928;8475.406721529556;8486.363522735819;9215.44707317563;573.3950682030497;608.8538750699801;608.9988773756378;628.9059018114456;674.6323253826677;3827.770333779982;4224.239636865394;4350.521442641307;4550.681452298373;4565.086982603492;79115;111069;111712;113336;114828.85171148181;95823;98504;100600.496997516;101217.481737774;101704;89118;89759.55120224357;90611.54694226486;91652;91675.54162229146;8239.95880020596;8891.19979201875;9308.208802251613;9318.440893546138;9356.485393303434;51916;56197.71901140468;57366.7131664339;57774.13420779067;59386.70306648439;80415.1958480431;81519.18480815353;83118.75321870297;84651.73022404546;84883.33141677266;11941.16411851162;11967.461464233957;12014.323815578433;12048.277103373826;12090.879091208975;13840.792388114387;14019.228942408265;14196.858031419553;14237.928810356296;14316.928415357857;11072.944635276772;12831.422585983466;13119.737605248032;13332.133411328232;13430.93284533571;10884.945575272073;12701.555445559361;12816.743665126833;12937.223766574036;13455.259960702255;12587.559435419716;12654.43055062506;12765.553205637758;12925.418356174183;13016.47934082664;10249.9487502562;10564.735881603021;10847.728806779895;11093.057090147428;11221.55113795439;9982.155140615243;10870.239083264096;11116.944415277872;11184.552617895519;11264.718382040515 11:31:29 INFO - PROCESS | 1896 | __end_tp_report 11:31:29 INFO - PROCESS | 1896 | __start_cc_report 11:31:29 INFO - PROCESS | 1896 | _x_x_mozilla_cycle_collect,1992 11:31:29 INFO - PROCESS | 1896 | __end_cc_report 11:31:29 INFO - PROCESS | 1896 | __startTimestamp1479843089122__endTimestamp 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | ------- Summary: start ------- 11:31:29 INFO - PROCESS | 1896 | Number of tests: 6 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | [#0] dojo.html Cycles:165 Average:5714.44 Median:5846.59 stddev:656.24 (11.2%) stddev-sans-first:630.09 11:31:29 INFO - PROCESS | 1896 | Values: 3289.7 3292.8 3299.5 3321.8 3350.6 5586.4 5643.6 5677.4 5703.4 5731.7 5618.4 5686.9 5774.7 5775.0 5798.5 5094.1 5139.6 5171.1 5189.2 5248.2 5261.5 5323.1 5333.9 5341.3 5342.8 5280.4 5291.1 5340.3 5350.0 5386.4 5071.1 5147.2 5157.8 5174.0 5237.0 5210.2 5216.3 5239.7 5264.8 5277.8 5658.1 5667.9 5685.7 5709.7 5724.0 6080.9 6120.8 6136.1 6139.1 6166.8 6206.3 6277.7 6279.8 6322.0 6342.2 4797.7 4818.3 5727.0 5772.0 5829.7 6204.5 6278.1 6320.8 6327.4 6332.5 5993.8 6026.1 6060.1 6136.5 6142.5 6280.8 6283.0 6285.2 6287.1 6303.6 6121.4 6192.6 6194.9 6208.2 6230.0 5875.4 5926.1 6201.3 6251.9 6257.5 4204.1 4225.8 4804.7 4879.0 4922.0 4404.8 4413.4 4426.8 4461.4 4473.5 5677.1 5723.4 5751.3 5755.6 5766.3 6128.4 6170.5 6179.3 6208.4 6280.1 5687.7 5734.3 5743.0 5767.2 5778.2 5380.5 5389.2 5394.9 5395.1 5396.5 6178.8 6282.1 6294.9 6314.0 6348.6 6177.9 6193.0 6241.8 6269.1 6319.7 6282.3 6291.2 6309.1 6309.5 6315.7 6178.2 6223.8 6233.4 6235.2 6237.3 6110.4 6137.7 6204.8 6206.1 6269.4 6104.6 6126.7 6142.0 6142.5 6150.4 6024.3 6028.9 6088.7 6094.3 6128.9 5759.4 5796.2 5796.5 5888.5 5913.6 5962.1 6000.8 6005.0 6010.5 6010.6 5824.5 5837.5 5845.4 5846.2 5846.6 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | [#1] ext.html Cycles:180 Average:67944.34 Median:37112.24 stddev:148754.70 (400.8%) stddev-sans-first:149085.70 11:31:29 INFO - PROCESS | 1896 | Values: 457.0 466.8 467.3 477.4 510.1 29970.4 39207.4 40170.8 40242.0 40392.4 41810.8 42057.6 42165.8 42195.8 42428.4 8522.4 9291.5 9460.5 9477.9 9508.8 8549.5 11083.8 11410.7 11413.3 11528.0 11244.6 11322.2 11368.3 11379.9 11453.5 11286.1 11356.7 11356.9 11357.5 11374.4 10344.2 11158.6 11220.9 11235.3 11235.8 35579.6 39364.6 39409.0 39469.0 39488.4 3146.8 3162.0 3251.0 3398.0 3406.8 29162.0 29290.0 30539.8 30641.8 30996.2 3081.2 3171.4 3234.4 3237.9 3303.6 455673.7 478290.0 478765.0 478992.0 484357.6 58305.4 58491.7 58593.0 58956.4 59007.4 62915.0 62968.7 63014.7 63032.7 63058.7 15953.9 16035.8 16093.8 16101.4 16109.6 11087.0 11348.0 11380.0 12406.8 12518.1 12396.6 15241.8 15354.2 15356.8 16679.9 5659.3 6709.8 6733.1 6809.9 6824.1 848.2 933.3 940.6 957.1 967.6 26891.3 28664.6 28969.0 29148.1 29549.6 1044.2 1059.0 1099.2 1107.7 1172.8 14172.3 14857.9 14960.6 15169.7 15290.0 623993.0 627532.0 628599.0 629492.0 895421.0 47669.0 56160.7 57310.7 57419.0 60603.7 1331.9 1350.9 1373.2 1373.3 1373.7 29724.0 29729.4 30245.0 30252.5 30666.7 49768.0 50625.0 50724.7 50809.5 50838.0 473556.0 475118.0 475674.0 475982.0 476502.0 36885.8 37799.1 38379.4 38672.0 38839.8 45063.3 45791.0 45957.0 46250.0 46402.5 37170.6 37219.6 37949.0 38142.4 38879.6 28074.6 29613.6 37383.3 38383.6 38557.4 36769.0 37053.9 37431.8 37578.8 37613.4 30727.0 31675.0 32974.0 33057.3 33421.8 23832.0 24170.6 24452.4 24585.0 24687.4 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | [#2] jquery.html Cycles:180 Average:33982.20 Median:359.19 stddev:92468.51 (25743.9%) stddev-sans-first:92693.43 11:31:29 INFO - PROCESS | 1896 | Values: 350.3 368.1 368.9 377.1 394.9 14755.5 14864.6 15926.4 19730.6 20230.8 16673.3 19054.0 19838.1 20031.9 20159.1 5448.0 5815.6 5827.7 5831.0 5840.7 5584.1 5584.6 5708.0 5747.9 5778.3 4050.4 4278.6 5717.4 5727.3 6016.8 6307.7 6310.9 6413.6 6415.4 6419.1 5399.7 5523.6 5564.4 5566.3 5577.3 24385.5 25008.1 25022.5 25148.2 25482.5 2374.3 2513.6 3020.8 3034.7 3075.8 15279.5 15300.1 15339.2 15755.8 15838.1 1801.9 1828.7 1874.7 1906.4 1915.5 123420.1 127681.1 127981.0 129570.4 129809.4 10985.9 11371.2 11404.4 11409.9 11622.4 13703.4 13816.2 14098.2 14144.0 14178.3 6794.0 8131.0 8436.3 8547.4 8557.5 8354.5 8355.2 8373.5 8540.0 8541.7 4337.4 4424.6 4432.5 4500.7 4527.1 1826.8 1876.5 1879.1 1879.2 1882.3 816.3 829.5 844.1 903.3 925.6 19719.6 20699.6 20829.6 20942.7 21164.7 870.4 897.4 898.1 942.3 956.4 7950.6 9780.1 10346.1 10847.9 10874.0 483439.0 510472.0 564115.0 583529.0 590782.0 122902.0 132888.0 134771.3 137054.9 140542.0 953.7 954.3 955.9 956.4 964.7 18025.9 18309.7 18400.0 18675.4 18782.3 51996.7 54804.0 56223.0 56230.7 57035.4 58602.8 81911.6 82227.8 83328.3 84091.2 7749.1 7849.2 7945.2 8024.3 8139.7 10444.9 12124.0 12540.4 12644.5 13006.2 9735.0 10625.6 11282.3 11479.3 11576.6 9200.7 11165.7 11191.0 11192.6 11447.7 11327.9 11387.3 11548.7 11588.4 11814.0 6955.5 7978.0 8136.7 8248.1 8370.2 9310.9 10475.5 11009.7 11134.6 11306.2 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | [#3] mootools.html Cycles:180 Average:5463.98 Median:4992.53 stddev:3028.10 (60.7%) stddev-sans-first:3020.69 11:31:29 INFO - PROCESS | 1896 | Values: 1333.8 1487.0 1508.2 1666.2 1832.2 7512.0 7912.9 8096.6 8459.6 8472.0 7038.2 8254.3 8316.1 8372.7 8373.7 2276.7 2309.8 2315.1 2319.1 2322.1 1945.6 2285.3 2324.1 2343.3 2348.5 2284.4 2293.3 2309.2 2310.9 2319.7 2265.9 2269.0 2295.4 2303.3 2311.4 2300.3 2326.0 2326.3 2326.9 2327.9 6975.9 8520.0 8524.6 8531.3 8564.0 5039.5 5252.0 5255.1 5276.6 5290.0 2998.7 3448.3 3614.9 3615.9 3640.2 1074.8 1102.9 1707.8 1755.5 1826.1 11161.0 11200.0 11215.3 11222.6 11223.0 4518.6 4749.0 4770.0 4783.4 4805.2 8235.8 8900.8 8905.8 8908.4 8908.6 5142.8 5144.8 5145.4 5150.8 5151.6 4208.8 4483.9 4833.5 4849.2 4851.7 3558.6 3664.9 3681.1 3708.2 3716.3 968.2 1127.9 1138.3 1146.8 1147.2 815.9 842.2 844.0 848.1 893.3 4991.5 5312.7 5456.7 5568.2 5759.5 443.6 448.3 453.5 967.9 993.0 3229.5 3448.0 3838.7 3906.1 4020.5 10282.6 10293.4 10488.2 10499.6 10525.6 10484.6 10487.2 10490.4 10508.7 10528.0 6740.7 7517.7 7844.2 7954.2 8073.6 4971.8 5590.2 5781.0 5845.8 5899.8 9034.2 9188.4 9533.2 9575.4 9595.6 9539.0 9655.3 9663.7 9747.1 9832.7 7180.7 7203.1 7337.9 7350.4 7360.7 7811.7 8006.6 8008.6 8009.6 8021.1 7028.4 7125.9 7136.2 7231.6 7305.1 7014.8 7057.4 7065.7 7132.7 7157.5 6376.1 6566.9 6668.4 6742.7 6751.7 4847.2 4893.8 4897.6 4926.1 5048.4 4844.7 4872.7 4939.9 4993.6 5010.9 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | [#4] prototype.html Cycles:180 Average:4234.99 Median:4751.26 stddev:1308.66 (27.5%) stddev-sans-first:1278.28 11:31:29 INFO - PROCESS | 1896 | Values: 283.3 297.6 298.2 307.1 311.0 4451.8 4931.4 4938.7 5185.2 5214.8 4043.7 4856.4 5109.9 5135.9 5145.4 3907.8 3933.7 3954.4 3963.8 3993.3 3708.7 3892.1 3915.4 3923.3 3954.3 3425.3 3656.0 3882.7 3899.3 3905.0 3335.8 3684.0 3792.4 3892.1 3895.1 2830.8 3178.2 3372.3 3374.8 3391.8 4722.6 4947.4 4976.4 4980.5 5049.4 3724.7 4040.2 4217.7 4301.3 4428.0 4760.8 4963.0 5294.3 5339.3 5353.4 3104.2 3388.9 3533.0 3620.4 3721.0 4901.6 4913.9 5684.0 5694.4 5709.7 3200.8 3718.8 3727.4 3763.7 3768.5 3184.7 3185.8 3327.8 3661.0 3803.6 3542.8 4340.6 4388.0 4393.2 4395.8 4824.6 5288.9 5379.0 5414.5 5487.5 1140.0 1185.5 1214.0 1217.5 1229.8 704.5 793.4 829.8 830.9 847.7 4268.4 4477.0 4705.0 4763.0 4785.7 4463.7 4693.7 5264.6 5265.8 5273.9 3949.1 4307.9 4483.9 4736.3 4770.0 2226.8 2277.5 2778.3 2780.0 2815.6 4437.2 5154.4 5180.7 5495.4 5513.8 4588.3 5107.4 5209.7 5451.1 5464.5 4830.9 4902.8 5263.6 5453.3 5483.4 4694.9 4741.7 5307.5 5315.8 5323.3 4656.5 5116.5 5212.4 5238.6 5284.9 5064.6 5087.3 5696.6 5735.4 5739.1 3198.2 3743.4 3743.9 3751.6 3783.6 4428.8 4962.8 5027.9 5555.9 5621.8 4885.9 4901.7 5202.1 5353.3 5381.7 4433.9 4941.5 5191.1 5422.9 5433.5 4811.9 5010.0 5317.9 5394.8 5401.0 5034.9 5402.3 5421.5 5485.8 5499.9 4497.8 4545.1 4775.8 5279.0 5284.2 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - PROCESS | 1896 | [#5] yui.html Cycles:180 Average:20938.63 Median:4318.71 stddev:31129.25 (720.8%) stddev-sans-first:31179.38 11:31:29 INFO - PROCESS | 1896 | Values: 672.3 726.7 751.7 759.0 798.6 14212.9 14522.3 14829.2 14861.9 14867.2 12749.1 13077.5 13415.1 13603.8 13683.0 648.7 820.2 833.8 836.9 837.4 669.0 682.2 806.6 840.1 846.9 880.6 881.2 881.9 882.2 883.0 867.7 872.3 874.3 874.8 877.6 501.1 519.2 625.4 641.2 652.8 11631.6 13794.4 13842.5 13853.4 13868.5 10774.6 12136.6 12460.0 12647.4 12980.7 11563.9 11784.5 11880.3 11940.2 12192.3 4272.4 4284.9 4286.9 4388.5 4400.3 86716.1 90866.5 91310.0 91647.0 91688.5 10073.8 10093.9 10120.0 10120.5 10488.3 18495.4 18575.5 19221.6 19227.4 19247.1 7293.7 7300.2 7311.1 7388.4 7567.9 4104.5 4170.1 4176.2 4184.2 4192.4 2715.3 3078.6 3174.2 3181.7 3214.2 611.7 620.4 628.1 659.2 683.9 540.5 553.4 604.5 650.4 659.7 8140.1 8143.2 8475.4 8486.4 9215.4 573.4 608.9 609.0 628.9 674.6 3827.8 4224.2 4350.5 4550.7 4565.1 79115.0 111069.0 111712.0 113336.0 114828.9 95823.0 98504.0 100600.5 101217.5 101704.0 89118.0 89759.6 90611.5 91652.0 91675.5 8240.0 8891.2 9308.2 9318.4 9356.5 51916.0 56197.7 57366.7 57774.1 59386.7 80415.2 81519.2 83118.8 84651.7 84883.3 11941.2 11967.5 12014.3 12048.3 12090.9 13840.8 14019.2 14196.9 14237.9 14316.9 11072.9 12831.4 13119.7 13332.1 13430.9 10884.9 12701.6 12816.7 12937.2 13455.3 12587.6 12654.4 12765.6 12925.4 13016.5 10249.9 10564.7 10847.7 11093.1 11221.6 9982.2 10870.2 11116.9 11184.6 11264.7 11:31:29 INFO - PROCESS | 1896 | -------- Summary: end -------- 11:31:29 INFO - PROCESS | 1896 | 11:31:29 INFO - TEST-INFO | 1896: exit 0 11:31:29 INFO - TEST-OK | dromaeo_css | took 1119684ms 11:31:29 INFO - TEST-START | kraken 11:31:29 INFO - operating with platform_type : mac_ 11:31:29 INFO - Initialising browser for kraken test... 11:31:29 INFO - TEST-INFO | started process 1902 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpX1Pset/profile http://localhost:49375/getInfo.html) 11:31:32 INFO - PROCESS | 1902 | __metrics Screen width/height:1600/1200 11:31:32 INFO - PROCESS | 1902 | colorDepth:24 11:31:32 INFO - PROCESS | 1902 | Browser inner width/height: 1024/689 11:31:32 INFO - PROCESS | 1902 | __metrics 11:31:32 INFO - PROCESS | 1902 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:31:32 INFO - PROCESS | 1902 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:33 INFO - TEST-INFO | 1902: exit 0 11:31:33 INFO - Browser initialized. 11:31:33 INFO - Running cycle 1/1 for kraken test... 11:31:33 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpX1Pset/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:45 INFO - PROCESS | 1903 | RSS: Main: 243818496 11:31:45 INFO - PROCESS | 1903 | 11:31:48 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:49 INFO - PROCESS | 1903 | RSS: Main: 294072320 11:31:49 INFO - PROCESS | 1903 | 11:31:51 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-dft) 11:31:52 INFO - PROCESS | 1903 | RSS: Main: 293974016 11:31:52 INFO - PROCESS | 1903 | 11:31:55 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-fft) 11:31:56 INFO - PROCESS | 1903 | RSS: Main: 384045056 11:31:56 INFO - PROCESS | 1903 | 11:31:58 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator) 11:31:59 INFO - PROCESS | 1903 | RSS: Main: 289357824 11:31:59 INFO - PROCESS | 1903 | 11:32:01 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:01 INFO - PROCESS | 1903 | RSS: Main: 291700736 11:32:01 INFO - PROCESS | 1903 | 11:32:04 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:05 INFO - PROCESS | 1903 | RSS: Main: 333910016 11:32:05 INFO - PROCESS | 1903 | 11:32:08 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:08 INFO - PROCESS | 1903 | RSS: Main: 335769600 11:32:08 INFO - PROCESS | 1903 | 11:32:11 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial) 11:32:12 INFO - PROCESS | 1903 | RSS: Main: 333860864 11:32:12 INFO - PROCESS | 1903 | 11:32:13 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:14 INFO - PROCESS | 1903 | RSS: Main: 309059584 11:32:14 INFO - PROCESS | 1903 | 11:32:16 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:17 INFO - PROCESS | 1903 | RSS: Main: 310566912 11:32:17 INFO - PROCESS | 1903 | 11:32:19 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:20 INFO - PROCESS | 1903 | RSS: Main: 313053184 11:32:20 INFO - PROCESS | 1903 | 11:32:23 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:24 INFO - PROCESS | 1903 | RSS: Main: 323436544 11:32:24 INFO - PROCESS | 1903 | 11:32:26 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:27 INFO - PROCESS | 1903 | RSS: Main: 323444736 11:32:27 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49375/tests/kraken/driver.html?testName=ai-astar) 11:32:29 INFO - PROCESS | 1903 | RSS: Main: 367947776 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | __start_tp_report 11:32:29 INFO - PROCESS | 1903 | _x_x_mozilla_page_load 11:32:29 INFO - PROCESS | 1903 | _x_x_mozilla_page_load_details 11:32:29 INFO - PROCESS | 1903 | |i|pagename|runs| 11:32:29 INFO - PROCESS | 1903 | |0;ai-astar;112;114;114;113;114;114;114;114;114;114 11:32:29 INFO - PROCESS | 1903 | |1;audio-beat-detection;144;112;113;150;112;122;140;144;146;109 11:32:29 INFO - PROCESS | 1903 | |2;audio-dft;185;183;180;173;177;183;185;184;181;163 11:32:29 INFO - PROCESS | 1903 | |3;audio-fft;79;60;61;114;59;58;71;59;82;59 11:32:29 INFO - PROCESS | 1903 | |4;audio-oscillator;93;72;96;70;67;70;90;68;69;93 11:32:29 INFO - PROCESS | 1903 | |5;imaging-gaussian-blur;89;84;88;85;87;84;89;85;88;84 11:32:29 INFO - PROCESS | 1903 | |6;imaging-darkroom;95;96;97;96;96;96;97;126;158;95 11:32:29 INFO - PROCESS | 1903 | |7;imaging-desaturate;84;87;86;85;100;131;113;84;85;84 11:32:29 INFO - PROCESS | 1903 | |8;json-parse-financial;58;55;56;56;57;55;55;56;73;83 11:32:29 INFO - PROCESS | 1903 | |9;json-stringify-tinderbox;64;72;76;75;74;71;71;74;70;72 11:32:29 INFO - PROCESS | 1903 | |10;stanford-crypto-aes;88;89;88;87;79;104;97;109;86;89 11:32:29 INFO - PROCESS | 1903 | |11;stanford-crypto-ccm;172;171;167;148;148;147;149;152;221;174 11:32:29 INFO - PROCESS | 1903 | |12;stanford-crypto-pbkdf2;171;173;173;175;171;171;171;171;172;184 11:32:29 INFO - PROCESS | 1903 | |13;stanford-crypto-sha256-iterative;68;67;66;68;66;67;68;66;67;65 11:32:29 INFO - PROCESS | 1903 | __end_tp_report 11:32:29 INFO - PROCESS | 1903 | __start_cc_report 11:32:29 INFO - PROCESS | 1903 | _x_x_mozilla_cycle_collect,2112 11:32:29 INFO - PROCESS | 1903 | __end_cc_report 11:32:29 INFO - PROCESS | 1903 | __startTimestamp1479843149548__endTimestamp 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | ------- Summary: start ------- 11:32:29 INFO - PROCESS | 1903 | Number of tests: 14 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.33 11:32:29 INFO - PROCESS | 1903 | Values: 112.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:142.00 stddev:16.94 (11.9%) stddev-sans-first:17.10 11:32:29 INFO - PROCESS | 1903 | Values: 144.0 112.0 113.0 150.0 112.0 122.0 140.0 144.0 146.0 109.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#2] audio-dft Cycles:10 Average:179.40 Median:183.00 stddev:6.90 (3.8%) stddev-sans-first:7.01 11:32:29 INFO - PROCESS | 1903 | Values: 185.0 183.0 180.0 173.0 177.0 183.0 185.0 184.0 181.0 163.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#3] audio-fft Cycles:10 Average:70.20 Median:60.50 stddev:17.79 (29.4%) stddev-sans-first:18.59 11:32:29 INFO - PROCESS | 1903 | Values: 79.0 60.0 61.0 114.0 59.0 58.0 71.0 59.0 82.0 59.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:81.00 stddev:12.37 (15.3%) stddev-sans-first:12.01 11:32:29 INFO - PROCESS | 1903 | Values: 93.0 72.0 96.0 70.0 67.0 70.0 90.0 68.0 69.0 93.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:2.11 (2.4%) stddev-sans-first:2.00 11:32:29 INFO - PROCESS | 1903 | Values: 89.0 84.0 88.0 85.0 87.0 84.0 89.0 85.0 88.0 84.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:96.00 stddev:20.82 (21.7%) stddev-sans-first:21.75 11:32:29 INFO - PROCESS | 1903 | Values: 95.0 96.0 97.0 96.0 96.0 96.0 97.0 126.0 158.0 95.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:84.50 stddev:16.13 (19.1%) stddev-sans-first:16.70 11:32:29 INFO - PROCESS | 1903 | Values: 84.0 87.0 86.0 85.0 100.0 131.0 113.0 84.0 85.0 84.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:56.50 stddev:9.62 (17.0%) stddev-sans-first:10.16 11:32:29 INFO - PROCESS | 1903 | Values: 58.0 55.0 56.0 56.0 57.0 55.0 55.0 56.0 73.0 83.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:73.00 stddev:3.38 (4.6%) stddev-sans-first:2.05 11:32:29 INFO - PROCESS | 1903 | Values: 64.0 72.0 76.0 75.0 74.0 71.0 71.0 74.0 70.0 72.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:88.00 stddev:9.05 (10.3%) stddev-sans-first:9.50 11:32:29 INFO - PROCESS | 1903 | Values: 88.0 89.0 88.0 87.0 79.0 104.0 97.0 109.0 86.0 89.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#11] stanford-crypto-ccm Cycles:10 Average:164.90 Median:169.00 stddev:22.69 (13.4%) stddev-sans-first:23.92 11:32:29 INFO - PROCESS | 1903 | Values: 172.0 171.0 167.0 148.0 148.0 147.0 149.0 152.0 221.0 174.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:172.50 stddev:4.02 (2.3%) stddev-sans-first:4.19 11:32:29 INFO - PROCESS | 1903 | Values: 171.0 173.0 173.0 175.0 171.0 171.0 171.0 171.0 172.0 184.0 11:32:29 INFO - PROCESS | 1903 | 11:32:29 INFO - PROCESS | 1903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 11:32:29 INFO - PROCESS | 1903 | Values: 68.0 67.0 66.0 68.0 66.0 67.0 68.0 66.0 67.0 65.0 11:32:29 INFO - PROCESS | 1903 | -------- Summary: end -------- 11:32:29 INFO - PROCESS | 1903 | 11:32:30 INFO - TEST-INFO | 1903: exit 0 11:32:30 INFO - TEST-OK | kraken | took 60910ms 11:32:30 INFO - SUITE-END | took 1180s 11:32:31 INFO - Completed test suite (00:19:41) 11:32:31 INFO - javascript benchmark 11:32:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.6874796894294, 3292.753043521735, 3299.505074238864, 3321.8006919584814, 3350.61467931188, 5586.385497595272, 5643.5767317451255, 5677.37548869624, 5703.372629010811, 5731.684757338345, 5618.410066942974, 5686.886262274752, 5774.740136693848, 5774.989376859044, 5798.478136967683, 5094.1085310070775, 5139.640225184238, 5171.120909445403, 5189.247559103927, 5248.186531087687, 5261.500157485033, 5323.148296272597, 5333.893322133555, 5341.278927344817, 5342.813001544947, 5280.419153893069, 5291.100512912775, 5340.332458442695, 5349.973250133744, 5386.353637563498, 5071.087204303224, 5147.176451767737, 5157.819476318311, 5173.974130129325, 5237.031149237365, 5210.244514545369, 5216.2958000669805, 5239.659422137549, 5264.842054738326, 5277.762500687479, 5658.122990936411, 5667.886642267132, 5685.744141513642, 5709.714514274269, 5723.998300297431, 6080.878382432326, 6120.785772497986, 6136.079588061782, 6139.109829074804, 6166.7533298667995, 6206.317305096436, 6277.654728989904, 6279.780207692755, 6321.968390158066, 6342.207224096988, 4797.664163508521, 4818.253170758538, 5726.9713651431475, 5771.961047011536, 5829.737661805187, 6204.503639708812, 6278.089676996809, 6320.841978950563, 6327.398897104859, 6332.525060620472, 5993.790217342372, 6026.0659597762415, 6060.060690592965, 6136.539759518054, 6142.539309551801, 6280.811575652738, 6283.0, 6285.151504546828, 6287.1198032275515, 6303.558750887486, 6121.387861213932, 6192.566520343533, 6194.876102478015, 6208.192934918432, 6230.003199488151, 5875.353711091777, 5926.111083337534, 6201.255849298113, 6251.874962500725, 6257.499400047986, 4204.13815167896, 4225.767582782915, 4804.711717296974, 4879.0, 4921.975390123098, 4404.801783919731, 4413.426254586947, 4426.84506042287, 4461.375407442961, 4473.507914129443, 5677.1200463927335, 5723.399043100415, 5751.252337196222, 5755.625884317506, 5766.308043034779, 6128.411459112376, 6170.50635949123, 6179.3202747697715, 6208.379162083756, 6280.120783090371, 5687.744051517691, 5734.311882574035, 5743.023685973395, 5767.192593036894, 5778.191053252548, 5380.461953804588, 5389.191621256843, 5394.8921021579345, 5395.082835917903, 5396.541293990055, 6178.845528861814, 6282.057691346335, 6294.874102518015, 6313.96843015782, 6348.619082855043, 6177.907331389943, 6192.969035154975, 6241.78153764616, 6269.0909818075215, 6319.652419116993, 6282.3089460158435, 6291.182146320949, 6309.148264984168, 6309.463695585743, 6315.715792789428, 6178.165947597017, 6223.751049957951, 6233.438990490697, 6235.220597425322, 6237.28271248794, 6110.419510146529, 6137.68343894035, 6204.782832601018, 6206.10011548332, 6269.435750782452, 6104.580421837985, 6126.731429653803, 6142.04798256271, 6142.464383904024, 6150.415710507495, 6024.307204671519, 6028.8794224116145, 6088.726007329592, 6094.299155597163, 6128.938710612837, 5759.366469688414, 5796.246487956539, 5796.478316951495, 5888.499477544286, 5913.58604897653, 5962.135490353961, 6000.789972350947, 6005.039193728982, 6010.4891084258325, 6010.609310394811, 5824.5340372770925, 5837.474627283565, 5845.3570107289015, 5846.239988801599, 5846.590738648254], "value": 5670.949849900798, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.99086018279627, 466.80627539571077, 467.2663917649292, 477.36033714822133, 510.0767610624769, 29970.400591988175, 39207.411888821654, 40170.79914600427, 40242.0, 40392.39411408831, 41810.7909460453, 42057.579424205745, 42165.78917105418, 42195.78902105485, 42428.363574546405, 8522.446041007346, 9291.535423228828, 9460.479673617949, 9477.905220947805, 9508.762280942963, 8549.487030778142, 11083.833742493869, 11410.714732131722, 11413.31520108792, 11528.0, 11244.606438774645, 11322.150838687132, 11368.31790092593, 11379.943100284487, 11453.541858325658, 11286.097112231002, 11356.659300220965, 11356.943215283953, 11357.488912998851, 11374.37440940748, 10344.172466202686, 11158.609448669258, 11220.943895280552, 11235.269707468988, 11235.83146252807, 35579.644203557895, 39364.60635393638, 39409.0, 39469.0, 39488.40767388492, 3146.7797254192214, 3161.984190079058, 3251.0, 3398.0315610051016, 3406.812625305607, 29162.0, 29290.0, 30539.847300763355, 30641.846790765903, 30996.225094372596, 3081.245094951729, 3171.413288541627, 3234.3854667613077, 3237.8542965566608, 3303.6035675719068, 455673.721631393, 478290.0, 478765.0, 478992.0, 484357.57821210666, 58305.41694583, 58491.70754146287, 58593.0, 58956.41043589509, 59007.40992590019, 62915.0, 62968.68515657393, 63014.68492657507, 63032.68483657644, 63058.684706576176, 15953.920230398773, 16035.839641603434, 16093.758593621105, 16101.355945762272, 16109.597260068593, 11087.0, 11348.0, 11379.975802177843, 12406.81389779154, 12518.12373133872, 12396.582666379969, 15241.771373429407, 15354.23228838576, 15356.769648455282, 16679.916600417164, 5659.349174844946, 6709.765158219537, 6733.124693789874, 6809.897851532231, 6824.112865327475, 848.2026894718945, 933.262722449271, 940.6049459227141, 957.090763774417, 967.583938906263, 26891.327716807235, 28664.570031449544, 28969.0, 29148.125556233346, 29549.556756648668, 1044.2116202267391, 1058.9894101058892, 1099.1866019145934, 1107.6732363952653, 1172.7771723372703, 14172.291385430688, 14857.925710371379, 14960.551183464513, 15169.696606067817, 15290.0, 623993.0, 627532.0, 628599.0, 629492.0, 895421.0, 47669.0, 56160.719196403756, 57310.7134464325, 57419.0, 60603.69698151481, 1331.9334033298296, 1350.9324533773272, 1373.2447154065223, 1373.32020649781, 1373.684052667872, 29724.0, 29729.40541189121, 30245.0, 30252.5462118064, 30666.693333066385, 49768.0, 50625.0, 50724.74637626788, 50809.491905080475, 50838.0, 473556.0, 475118.0, 475674.0, 475982.0, 476502.0, 36885.81557092197, 37799.05502362463, 38379.424308634836, 38672.0, 38839.80580097081, 45063.32405013862, 45791.0, 45957.0, 46250.0, 46402.535974639824, 37170.6282937178, 37219.62780372162, 37949.0, 38142.42786358151, 38879.61120388873, 28074.57888131639, 29613.5557966635, 37383.327084114484, 38383.61616383801, 38557.421638676, 36769.03870162297, 37053.85042271437, 37431.81284093562, 37578.812105939294, 37613.435798462495, 30727.0, 31675.0, 32974.0, 33057.33885322328, 33421.83289083539, 23832.046718131773, 24170.637440438055, 24452.388690282885, 24585.0, 24687.38281542976], "value": 19791.927663762257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.2836698950646, 368.08714388316974, 368.90408493791625, 377.12318858653634, 394.8756141815328, 14755.48355807547, 14864.55406337809, 15926.362945482197, 19730.605387892232, 20230.797692023076, 16673.333066677318, 19054.047297635134, 19838.107285172166, 20031.899840500813, 20159.092840822163, 5447.992121457533, 5815.621984570989, 5827.650340979555, 5831.0, 5840.737166827482, 5584.078627026536, 5584.591753276557, 5707.971460142693, 5747.856303592402, 5778.27771528559, 4050.3519436890106, 4278.5935336143175, 5717.3710891802075, 5727.312722473309, 6016.819495415145, 6307.653079080649, 6310.873782524323, 6413.615183088983, 6415.422611964946, 6419.069234960904, 5399.676019438846, 5523.6409633373705, 5564.443555644443, 5566.332040155207, 5577.3028371453565, 24385.512289754104, 25008.124715634865, 25022.4995500089, 25148.24555263345, 25482.49035019308, 2374.2521105851774, 2513.648089267486, 3020.758339332848, 3034.696530346948, 3075.8308293043874, 15279.465218717292, 15300.08199508022, 15339.156346400943, 15755.842441575667, 15838.128902910335, 1801.8918864868149, 1828.6982647863088, 1874.6625607390665, 1906.3994841624844, 1915.4923945154544, 123420.1263898886, 127681.08478372832, 127981.0, 129570.3521482396, 129809.35095324463, 10985.890141098487, 11371.204015718986, 11404.429778511041, 11409.885901140882, 11622.360770157553, 13703.383347749375, 13816.171029738249, 14098.224597647022, 14144.0, 14178.291085445893, 6793.966030169818, 8130.959345203236, 8436.28291595209, 8547.444416112932, 8557.529335886586, 8354.498730076215, 8355.248027677417, 8373.455725377831, 8539.957300213458, 8541.658333666708, 4337.37108119321, 4424.6239069678795, 4432.534583868712, 4500.684952053325, 4527.139843429738, 1826.844718198968, 1876.5214870208283, 1879.1262063140432, 1879.2389082421641, 1882.2565086790914, 816.346922462028, 829.4981536170529, 844.0630899701326, 903.2999425445332, 925.6346888339646, 19719.60560788805, 20699.58600827975, 20829.58340833205, 20942.685859712117, 21164.682529762067, 870.4037734152126, 897.4166791585391, 898.1018981018981, 942.3074040580168, 956.36401792807, 7950.602469876483, 9780.070893265129, 10346.120579750805, 10847.945760271148, 10874.0, 483439.0, 510472.0, 564115.0, 583529.0, 590782.0, 122902.0, 132888.0, 134771.32614337062, 137054.94417583745, 140542.0, 953.7091187187974, 954.289054654287, 955.8805149356331, 956.3926906414338, 964.6623681711345, 18025.909870450563, 18309.725354119433, 18400.0, 18675.38416442687, 18782.342618008304, 51996.74001629968, 54804.0, 56223.0, 56230.71884640551, 57035.429645703014, 58602.82794344174, 81911.59044204741, 82227.7665835025, 83328.3340332366, 84091.17042710427, 7749.147593764794, 7849.215078492105, 7945.205479452008, 8024.277814996678, 8139.715109971123, 10444.895551044392, 12124.0, 12540.435680394221, 12644.494220231089, 13006.219626822422, 9735.0, 10625.618669572907, 11282.323060616389, 11479.25384849982, 11576.594819181288, 9200.723978280663, 11165.665030049111, 11191.0, 11192.552297907992, 11447.656570302905, 11327.943360283145, 11387.259828111146, 11548.653540393801, 11588.420578971187, 11813.995810356217, 6955.513114081966, 7978.0, 8136.7152149674475, 8248.13394593559, 8370.16298370158, 9310.906890931004, 10475.476226188812, 11009.724756880822, 11134.55461781552, 11306.152038596974], "value": 9520.859202751422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.7665908466015, 1487.018567745288, 1508.2081906998824, 1666.1918969299888, 1832.1755210155425, 7512.0, 7912.881306780403, 8096.635651395694, 8459.619317130728, 8471.957640211791, 7038.225795162528, 8254.339652827774, 8316.1268066853, 8372.665093396272, 8373.665053397872, 2276.68126462295, 2309.8383113182085, 2315.143396943125, 2319.083961835074, 2322.1175953137868, 1945.6303302372503, 2285.325828880476, 2324.081987614891, 2343.2735851885886, 2348.518553696488, 2284.440312123532, 2293.2776175504664, 2309.2264091529273, 2310.919117830876, 2319.6868422762964, 2265.886705664718, 2268.9773102269096, 2295.437617783637, 2303.3090072978125, 2311.3643747969445, 2300.332903457995, 2325.953480930372, 2326.2904814031713, 2326.918557850467, 2327.895244713992, 6975.895361569581, 8519.957400213021, 8524.573771311472, 8531.317494600416, 8563.95718021406, 5039.546440820307, 5252.002119597302, 5255.08036093682, 5276.577873770128, 5290.021346050993, 2998.745106665936, 3448.2930999145115, 3614.9096272593133, 3615.8734444294587, 3640.2355505343908, 1074.8119079161115, 1102.8511150994593, 1707.8292170782947, 1755.4558086993072, 1826.0687049604664, 11161.0, 11200.047995920357, 11215.271007384412, 11222.551097956071, 11223.0, 4518.615917647036, 4749.026449577828, 4769.976150119227, 4783.4499032611, 4805.183118869801, 8235.794105147419, 8900.821983560292, 8905.777355566162, 8908.376413651113, 8908.599113039929, 5142.76857541404, 5144.7942082316285, 5145.3568303962, 5150.819721309736, 5151.587872970228, 4208.768517731554, 4483.901444146205, 4833.468318484964, 4849.224124140121, 4851.708897466164, 3558.5551806024246, 3664.853405863789, 3681.1349332906743, 3708.1841994761107, 3716.331060409152, 968.2060710217554, 1127.9436028198556, 1138.3170097941334, 1146.8050431426677, 1147.208426185929, 815.8776183572393, 842.2209456252941, 843.9662413503391, 848.134902399549, 893.334465822953, 4991.4758950310425, 5312.681239125587, 5456.71767134723, 5568.248286481355, 5759.539236861041, 443.60740744440756, 448.27155871708476, 453.5419226581111, 967.8741763570831, 992.9900700992897, 3229.531717900891, 3448.0, 3838.7120965927666, 3906.125378848326, 4020.537638171648, 10282.588696452207, 10293.43386113771, 10488.160947124212, 10499.632512862167, 10525.578976840994, 10484.580616775396, 10487.161027117812, 10490.423026733602, 10508.737281568023, 10528.0, 6740.730370785113, 7517.699292028257, 7844.176361481962, 7954.164812694699, 8073.596320184085, 4971.776270067928, 5590.217369568345, 5780.971095144498, 5845.766169353178, 5899.764009439575, 9034.186923176945, 9188.448693078437, 9533.23734101284, 9575.377600455948, 9595.568199430903, 9539.0, 9655.275854310814, 9663.661771837951, 9747.122758951728, 9832.705018849447, 7180.676869540987, 7203.099612548432, 7337.889931651136, 7350.411967042731, 7360.742374016883, 7811.687532498637, 8006.639701213343, 8008.6396112173925, 8009.599520024092, 8021.117677055403, 7028.402585780266, 7125.928740712734, 7136.215016348094, 7231.63841807897, 7305.086864141982, 7014.824629384306, 7057.435405167472, 7065.682044307916, 7132.6790294437915, 7157.534760240567, 6376.139221205078, 6566.9014964774615, 6668.366505182, 6742.6628668567355, 6751.696173672295, 4847.151748443937, 4893.828715994923, 4897.559219670246, 4926.088673595396, 5048.444671086251, 4844.709317440824, 4872.707637541759, 4939.876503087452, 4993.575546078624, 5010.924836127534], "value": 4401.380212020039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.33557806942713, 297.6041864320454, 298.16067769229625, 307.13235110811956, 311.02338656618224, 4451.821927122911, 4931.358923339965, 4938.654139283838, 5185.222216667502, 5214.765335559909, 4043.67650587953, 4856.417229932405, 5109.850283686169, 5135.897282054357, 5145.3568303962, 3907.8436862525537, 3933.704972127088, 3954.4068389741483, 3963.7819919904396, 3993.2845664947968, 3708.7033037357082, 3892.143728379752, 3915.3735402335633, 3923.312975420568, 3954.319414248947, 3425.314937012595, 3655.981720091409, 3882.669973052294, 3899.298126337258, 3905.0, 3335.816530090844, 3684.0, 3792.355299599061, 3892.143728379752, 3895.10412605101, 2830.7593854522393, 3178.1577881861326, 3372.2749608833974, 3374.7637665363436, 3391.796492210475, 4722.622190224808, 4947.406311242638, 4976.4277108132665, 4980.452150263468, 5049.368828896388, 3724.7206459515646, 4040.2324407780766, 4217.725847819882, 4301.333293339538, 4428.018479210888, 4760.833370832004, 4962.957778866443, 5294.258803767476, 5339.252504649352, 5353.411124776271, 3104.161876293388, 3388.915277118067, 3533.010756988022, 3620.366435873738, 3721.0, 4901.554041557749, 4913.87715307113, 5684.0, 5694.430556944314, 5709.74306156224, 3200.77594568378, 3718.754217337168, 3727.4036154215737, 3763.6612704856693, 3768.4724138620613, 3184.681531846843, 3185.761067919915, 3327.8169700666695, 3660.9566273611895, 3803.6196380361744, 3542.8405721742583, 4340.590972010501, 4388.0, 4393.1872603568445, 4395.824167033283, 4824.614030877521, 5288.942211557704, 5379.0, 5414.539764120015, 5487.478689524489, 1140.0024978144124, 1185.5062621097306, 1213.9514419423124, 1217.5373358124034, 1229.8378032758958, 704.5279662626053, 793.3732351442296, 829.8049958259804, 830.8712149616819, 847.7160151349367, 4268.40242366069, 4476.955230447654, 4704.976475117671, 4763.0, 4785.736784476818, 4463.732176069446, 4693.741844198534, 5264.6051546134195, 5265.789368425297, 5273.947260527422, 3949.1311911379453, 4307.913841723148, 4483.932741008887, 4736.265878788793, 4770.0, 2226.7995880370845, 2277.5103352779233, 2778.3332000320183, 2780.0408858943633, 2815.633967584242, 4437.2234858899565, 5154.407243167008, 5180.6891586504935, 5495.368032676213, 5513.8345849624575, 4588.26587745959, 5107.361579802525, 5209.661372010807, 5451.05642952809, 5464.480874316933, 4830.8792280193275, 4902.754862256873, 5263.578753773307, 5453.3278693439925, 5483.369412517612, 4694.92957605643, 4741.691790033775, 5307.469253074816, 5315.750798562258, 5323.30796996388, 4656.464506581787, 5116.4627714090975, 5212.400573934046, 5238.580913526833, 5284.8901730637, 5064.620153488429, 5087.2623469595965, 5696.629719068247, 5735.426457354231, 5739.126089889392, 3198.168476196159, 3743.36362818327, 3743.9251214975, 3751.643593858579, 3783.5838057813066, 4428.778561071869, 4962.808925857696, 5027.8575890068705, 5555.944440555704, 5621.835593296529, 4885.926711099265, 4901.656884018084, 5202.1416466282635, 5353.277307563585, 5381.704006279692, 4433.911321773611, 4941.50584941503, 5191.091558977239, 5422.864428389322, 5433.4566543345345, 4811.879703007453, 5010.048090862724, 5317.867053323698, 5394.757235924471, 5400.972995134999, 5034.924476132935, 5402.27069345649, 5421.512063914267, 5485.753141108739, 5499.917501237404, 4497.775111244359, 4545.06826100642, 4775.761211939459, 5278.97360513195, 5284.207368894697], "value": 3818.753795854866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.3310306245287, 726.69115625859, 751.7218629107231, 759.0245937877216, 798.6086817459443, 14212.928935355321, 14522.346494407751, 14829.18439485828, 14861.851381486182, 14867.182304973236, 12749.10756247063, 13077.476900923975, 13415.060945733803, 13603.795943060863, 13683.0, 648.6789039425468, 820.1962077164397, 833.7873842170238, 836.9330453563731, 837.4347315562002, 668.9531732778707, 682.1643486728767, 806.6007326373424, 840.1220724343076, 846.9068402475754, 880.5861245214771, 881.2113158722939, 881.858902575588, 882.2060145868705, 883.002207505521, 867.7136544940155, 872.3457406944729, 874.300559552362, 874.7725591346264, 877.6050777150308, 501.12079701120797, 519.187471606934, 625.4214851262564, 641.2209165863452, 652.8498445357546, 11631.59289424866, 13794.379252933642, 13842.515511957134, 13853.445862165501, 13868.514601988882, 10774.622888198875, 12136.635900922987, 12460.0, 12647.367631618474, 12980.675483112904, 11563.884361156364, 11784.469698863571, 11880.287182769061, 11940.223885447418, 12192.268463892106, 4272.423222864904, 4284.935725964113, 4286.892827679302, 4388.539203383631, 4400.273954797454, 86716.13283867143, 90866.5456672719, 91310.0, 91647.0, 91688.54155729245, 10073.798524029478, 10093.899061009295, 10120.0, 10120.493975301206, 10488.31825931312, 18495.44513664592, 18575.53561160982, 19221.61556768857, 19227.423177304703, 19247.13387897548, 7293.744718934812, 7300.160481544584, 7311.086114235721, 7388.44586656003, 7567.886481702779, 4104.52797928242, 4170.124273902454, 4176.248275310412, 4184.205001049791, 4192.413062171298, 2715.321169707573, 3078.569000339954, 3174.206448387903, 3181.66592507788, 3214.244652506659, 611.6666416802854, 620.4044117647019, 628.136312570216, 659.1760299625469, 683.9213490448562, 540.4757385336218, 553.4023254884714, 604.4680681000691, 650.3951325267547, 659.6800551732406, 8140.104588495261, 8143.185681431928, 8475.406721529556, 8486.363522735819, 9215.44707317563, 573.3950682030497, 608.8538750699801, 608.9988773756378, 628.9059018114456, 674.6323253826677, 3827.770333779982, 4224.239636865394, 4350.521442641307, 4550.681452298373, 4565.086982603492, 79115.0, 111069.0, 111712.0, 113336.0, 114828.85171148181, 95823.0, 98504.0, 100600.496997516, 101217.481737774, 101704.0, 89118.0, 89759.55120224357, 90611.54694226486, 91652.0, 91675.54162229146, 8239.95880020596, 8891.19979201875, 9308.208802251613, 9318.440893546138, 9356.485393303434, 51916.0, 56197.71901140468, 57366.7131664339, 57774.13420779067, 59386.70306648439, 80415.1958480431, 81519.18480815353, 83118.75321870297, 84651.73022404546, 84883.33141677266, 11941.16411851162, 11967.461464233957, 12014.323815578433, 12048.277103373826, 12090.879091208975, 13840.792388114387, 14019.228942408265, 14196.858031419553, 14237.928810356296, 14316.928415357857, 11072.944635276772, 12831.422585983466, 13119.737605248032, 13332.133411328232, 13430.93284533571, 10884.945575272073, 12701.555445559361, 12816.743665126833, 12937.223766574036, 13455.259960702255, 12587.559435419716, 12654.43055062506, 12765.553205637758, 12925.418356174183, 13016.47934082664, 10249.9487502562, 10564.735881603021, 10847.728806779895, 11093.057090147428, 11221.55113795439, 9982.155140615243, 10870.239083264096, 11116.944415277872, 11184.552617895519, 11264.718382040515], "value": 7219.4837475312615, "unit": "score"}], "name": "dromaeo_css", "value": 7114.556937055985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 113.0, 150.0, 112.0, 122.0, 140.0, 144.0, 146.0, 109.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 180.0, 173.0, 177.0, 183.0, 185.0, 184.0, 181.0, 163.0], "value": 179.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 61.0, 114.0, 59.0, 58.0, 71.0, 59.0, 82.0, 59.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 72.0, 96.0, 70.0, 67.0, 70.0, 90.0, 68.0, 69.0, 93.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 88.0, 85.0, 87.0, 84.0, 89.0, 85.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 126.0, 158.0, 95.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 86.0, 85.0, 100.0, 131.0, 113.0, 84.0, 85.0, 84.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 56.0, 57.0, 55.0, 55.0, 56.0, 73.0, 83.0], "value": 60.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 76.0, 75.0, 74.0, 71.0, 71.0, 74.0, 70.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 87.0, 79.0, 104.0, 97.0, 109.0, 86.0, 89.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 167.0, 148.0, 148.0, 147.0, 149.0, 152.0, 221.0, 174.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 173.0, 175.0, 171.0, 171.0, 171.0, 171.0, 172.0, 184.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 68.0, 66.0, 67.0, 68.0, 66.0, 67.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1485.5, "alertThreshold": 2.0}]} 11:32:31 INFO - Return code: 0 11:32:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:31 INFO - # TBPL SUCCESS # 11:32:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:32:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:32:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:32:31 INFO - 2016-11-22 11:32:31.392 screenresolution[1907:11299] starting screenresolution argv=screenresolution get 11:32:31 INFO - 2016-11-22 11:32:31.394 screenresolution[1907:11299] Display 0: 1600x1200x32@60 11:32:31 INFO - 2016-11-22 11:32:31.400 screenresolution[1908:11302] starting screenresolution argv=screenresolution list 11:32:31 INFO - Available Modes on Display 0 11:32:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:32:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:32:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:32:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:32:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:32:31 INFO - Intel Iris: 11:32:31 INFO - Chipset Model: Intel Iris 11:32:31 INFO - Type: GPU 11:32:31 INFO - Bus: Built-In 11:32:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:32:31 INFO - Vendor: Intel (0x8086) 11:32:31 INFO - Device ID: 0x0a2e 11:32:31 INFO - Revision ID: 0x0009 11:32:31 INFO - Displays: 11:32:31 INFO - Display: 11:32:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:32:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:32:31 INFO - Display Serial Number: 1600x1200 60 11:32:31 INFO - Main Display: Yes 11:32:31 INFO - Mirror: Off 11:32:31 INFO - Online: Yes 11:32:31 INFO - Rotation: Supported 11:32:31 INFO - Return code: 0 11:32:31 INFO - Running post-action listener: _resource_record_post_action 11:32:31 INFO - [mozharness: 2016-11-22 19:32:31.642196Z] Finished run-tests step (success) 11:32:31 INFO - Running post-run listener: _resource_record_post_run 11:32:31 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 2469888; Write bytes: 693190144; Read time: 23; Write time: 2564 11:32:31 INFO - TinderboxPrint: CPU usage
53.6% 11:32:31 INFO - TinderboxPrint: I/O read bytes / time
2,469,888 / 23 11:32:31 INFO - TinderboxPrint: I/O write bytes / time
693,190,144 / 2,564 11:32:31 INFO - TinderboxPrint: CPU idle
2,252.0 (46.4%) 11:32:31 INFO - TinderboxPrint: CPU system
975.4 (20.1%) 11:32:31 INFO - TinderboxPrint: CPU user
1,630.3 (33.6%) 11:32:31 INFO - TinderboxPrint: Swap in / out
385,826,816 / 0 11:32:31 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 365541888; Write bytes: 358049280; Read time: 27715; Write time: 891 11:32:31 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 2465792; Write bytes: 308062208; Read time: 23; Write time: 1589 11:32:32 INFO - Running post-run listener: _upload_blobber_files 11:32:32 INFO - Blob upload gear active. 11:32:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32: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 11:32: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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:32: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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:32:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:33 INFO - (blobuploader) - INFO - Done attempting. 11:32:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:32:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:34 INFO - (blobuploader) - INFO - Done attempting. 11:32:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:32:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:36 INFO - (blobuploader) - INFO - Done attempting. 11:32:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:36 INFO - Return code: 0 11:32:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e0b0ccd9738a7901289da83018cfb36569ec5a42795ceb58c216d6b9d9f9f8da24c28ec0e3761a2a3d8e998a0b04a041ef8f211f1fb644c6060f0994583f2347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9563495d66fede7b57863b57a1b0369189cda1dfa91774879590d75e9cb74ccee399d10a31f17e388e49069ab33229cbd6aa6ea497c696392351ac878009723", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0f8187a99ecae9695f613807f807df6224deeb9c2a136faf777ec0a4141fb6fa4bb604dd6be8f110f121af884006ac0457c7cdd6a570c4d309ba4d99ede7fd52"} 11:32:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:36 INFO - Contents: 11:32:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e0b0ccd9738a7901289da83018cfb36569ec5a42795ceb58c216d6b9d9f9f8da24c28ec0e3761a2a3d8e998a0b04a041ef8f211f1fb644c6060f0994583f2347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9563495d66fede7b57863b57a1b0369189cda1dfa91774879590d75e9cb74ccee399d10a31f17e388e49069ab33229cbd6aa6ea497c696392351ac878009723", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0f8187a99ecae9695f613807f807df6224deeb9c2a136faf777ec0a4141fb6fa4bb604dd6be8f110f121af884006ac0457c7cdd6a570c4d309ba4d99ede7fd52"} 11:32:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:36 INFO - Copying logs to upload dir... 11:32:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.975816 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-22 11:32:37.185981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 11:32:37.193623) ========= 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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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/Graphics/sha512/e0b0ccd9738a7901289da83018cfb36569ec5a42795ceb58c216d6b9d9f9f8da24c28ec0e3761a2a3d8e998a0b04a041ef8f211f1fb644c6060f0994583f2347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9563495d66fede7b57863b57a1b0369189cda1dfa91774879590d75e9cb74ccee399d10a31f17e388e49069ab33229cbd6aa6ea497c696392351ac878009723", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0f8187a99ecae9695f613807f807df6224deeb9c2a136faf777ec0a4141fb6fa4bb604dd6be8f110f121af884006ac0457c7cdd6a570c4d309ba4d99ede7fd52"} build_url:https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011001 build_url: 'https://queue.taskcluster.net/v1/task/PNkwHm5qS6SpvwablSAk8A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e0b0ccd9738a7901289da83018cfb36569ec5a42795ceb58c216d6b9d9f9f8da24c28ec0e3761a2a3d8e998a0b04a041ef8f211f1fb644c6060f0994583f2347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b9563495d66fede7b57863b57a1b0369189cda1dfa91774879590d75e9cb74ccee399d10a31f17e388e49069ab33229cbd6aa6ea497c696392351ac878009723", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0f8187a99ecae9695f613807f807df6224deeb9c2a136faf777ec0a4141fb6fa4bb604dd6be8f110f121af884006ac0457c7cdd6a570c4d309ba4d99ede7fd52"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 11:32:37.227005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 11:32:37.230350) ========= 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.3I3S8ZQCZc/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.OOftYCZWc6/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005147 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 11:32:37.279023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 11:32:37.282374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 11:32:37.282935) ========= ========= Total master_lag: 0.38 =========