builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0315 starttime: 1485276446.8 results: success (0) buildid: 20170124055947 builduid: ab016df99ec94aaaa707a4129f6a4c36 revision: 7b33131fed2074be7897b277335f3aa8fa198ca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:26.795689) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:26.796434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:26.799962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:26.834073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:26.834582) ========= 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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 --2017-01-24 08:47:26-- 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% 46.3M=0s 2017-01-24 08:47:27 (46.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168911 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:27.036369) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:27.036989) ========= 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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.025434 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:27.093108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-24 08:47:27.093732) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 7b33131fed2074be7897b277335f3aa8fa198ca5 --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 7b33131fed2074be7897b277335f3aa8fa198ca5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OYzB9j2Oo5/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.CiEifVNZj3/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 2017-01-24 08:47:27,210 truncating revision to first 12 chars 2017-01-24 08:47:27,210 Setting DEBUG logging. 2017-01-24 08:47:27,211 attempt 1/10 2017-01-24 08:47:27,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/7b33131fed20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 08:47:29,356 unpacking tar archive at: graphics-7b33131fed20/testing/mozharness/ program finished with exit code 0 elapsedTime=2.412178 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-24 08:47:29.535696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:29.536327) ========= script_repo_revision: 7b33131fed2074be7897b277335f3aa8fa198ca5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:29.537033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:29.537504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 08:47:29.559173) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-24 08:47:29.559827) ========= /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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:47:29 INFO - MultiFileLogger online at 20170124 08:47:29 in /builds/slave/test 08:47:29 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 08:47:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:29 INFO - {'append_to_log': False, 08:47:29 INFO - 'base_work_dir': '/builds/slave/test', 08:47:29 INFO - 'blob_upload_branch': 'Graphics', 08:47:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:29 INFO - 'branch': 'Graphics', 08:47:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:29 INFO - 'config_files': ('talos/mac_config.py',), 08:47:29 INFO - 'default_actions': ('clobber', 08:47:29 INFO - 'read-buildbot-config', 08:47:29 INFO - 'download-and-extract', 08:47:29 INFO - 'populate-webroot', 08:47:29 INFO - 'create-virtualenv', 08:47:29 INFO - 'install', 08:47:29 INFO - 'run-tests'), 08:47:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:29 INFO - 'download_minidump_stackwalk': True, 08:47:29 INFO - 'download_symbols': 'ondemand', 08:47:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:29 INFO - 'installer_path': 'installer.exe', 08:47:29 INFO - 'log_level': 'info', 08:47:29 INFO - 'log_name': 'talos', 08:47:29 INFO - 'log_to_console': True, 08:47:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:47:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:47:29 INFO - 'opt_config_files': (), 08:47:29 INFO - 'pip_index': False, 08:47:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:29 INFO - 'cmd': ('bash', 08:47:29 INFO - '-c', 08:47:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:29 INFO - 'enabled': True, 08:47:29 INFO - 'halt_on_failure': False, 08:47:29 INFO - 'name': 'check_screen_resolution'},), 08:47:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:29 INFO - 'cmd': ('bash', 08:47:29 INFO - '-c', 08:47:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:29 INFO - 'enabled': True, 08:47:29 INFO - 'halt_on_failure': False, 08:47:29 INFO - 'name': 'check_screen_resolution'},), 08:47:29 INFO - 'run_cmd_checks_enabled': True, 08:47:29 INFO - 'sps_profile': False, 08:47:29 INFO - 'sps_profile_interval': 0, 08:47:29 INFO - 'suite': 'dromaeojs', 08:47:29 INFO - 'system_bits': '32', 08:47:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:29 INFO - 'title': 't-yosemite-r7-0315', 08:47:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:29 INFO - 'use_talos_json': True, 08:47:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:29 INFO - 'work_dir': 'build'} 08:47:29 INFO - [mozharness: 2017-01-24 16:47:29.782646Z] Running clobber step. 08:47:29 INFO - Running pre-action listener: _resource_record_pre_action 08:47:29 INFO - Running main action method: clobber 08:47:29 INFO - rmtree: /builds/slave/test/build 08:47:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:32 INFO - Running post-action listener: _resource_record_post_action 08:47:32 INFO - [mozharness: 2017-01-24 16:47:32.271870Z] Finished clobber step (success) 08:47:32 INFO - [mozharness: 2017-01-24 16:47:32.272002Z] Running read-buildbot-config step. 08:47:32 INFO - Running pre-action listener: _resource_record_pre_action 08:47:32 INFO - Running main action method: read_buildbot_config 08:47:32 INFO - Using buildbot properties: 08:47:32 INFO - { 08:47:32 INFO - "project": "", 08:47:32 INFO - "product": "firefox", 08:47:32 INFO - "script_repo_revision": "default", 08:47:32 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 08:47:32 INFO - "repository": "", 08:47:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 08:47:32 INFO - "buildid": "20170124055947", 08:47:32 INFO - "pgo_build": "False", 08:47:32 INFO - "basedir": "/builds/slave/test", 08:47:32 INFO - "buildnumber": 30, 08:47:32 INFO - "slavename": "t-yosemite-r7-0315", 08:47:32 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:47:32 INFO - "platform": "yosemite_r7", 08:47:32 INFO - "scheduler": "tests-graphics-macosx64-talos", 08:47:32 INFO - "branch": "graphics", 08:47:32 INFO - "repo_path": "projects/graphics", 08:47:32 INFO - "revision": "7b33131fed2074be7897b277335f3aa8fa198ca5", 08:47:32 INFO - "stage_platform": "macosx64", 08:47:32 INFO - "builduid": "ab016df99ec94aaaa707a4129f6a4c36", 08:47:32 INFO - "slavebuilddir": "test" 08:47:32 INFO - } 08:47:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:47:32 INFO - Running post-action listener: _resource_record_post_action 08:47:32 INFO - [mozharness: 2017-01-24 16:47:32.275501Z] Finished read-buildbot-config step (success) 08:47:32 INFO - [mozharness: 2017-01-24 16:47:32.275637Z] Running download-and-extract step. 08:47:32 INFO - Running pre-action listener: _resource_record_pre_action 08:47:32 INFO - Running main action method: download_and_extract 08:47:32 INFO - mkdir: /builds/slave/test/build/tests 08:47:32 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')]} 08:47:32 INFO - trying https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:47:32 INFO - Downloading https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 08:47:33 INFO - Downloaded 1199 bytes. 08:47:33 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:47:33 INFO - Using the following test package requirements: 08:47:33 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:47:33 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:47:33 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:47:33 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'jsshell-mac.zip'], 08:47:33 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:47:33 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:47:33 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:47:33 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:47:33 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:47:33 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:47:33 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:47:33 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:47:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:47:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:47:33 INFO - Fetch https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:47:34 INFO - Expected file size: 16351044 08:47:34 INFO - Obtained file size: 16351044 08:47:41 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:47:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:47:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:47:41 INFO - Fetch https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:47:41 INFO - Expected file size: 16351044 08:47:41 INFO - Obtained file size: 16351044 08:47:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:47:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:47:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:47:49 INFO - Expected file size: 14403485 08:47:49 INFO - Obtained file size: 14403485 08:47: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')]} 08:47:49 INFO - trying https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:47:49 INFO - Downloading https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 08:47:51 INFO - Downloaded 70100384 bytes. 08:47:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:47:51 INFO - mkdir: /builds/slave/test/properties 08:47:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:51 INFO - Contents: 08:47:51 INFO - build_url:https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:47:52 INFO - Running post-action listener: _resource_record_post_action 08:47:52 INFO - Running post-action listener: set_extra_try_arguments 08:47:52 INFO - [mozharness: 2017-01-24 16:47:52.398151Z] Finished download-and-extract step (success) 08:47:52 INFO - [mozharness: 2017-01-24 16:47:52.398294Z] Running populate-webroot step. 08:47:52 INFO - Running pre-action listener: _resource_record_pre_action 08:47:52 INFO - Running main action method: populate_webroot 08:47:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:52 INFO - '--tppagecycles', 08:47:52 INFO - '7'], 08:47:52 INFO - 'tests': ['tsvgm']}}, 08:47:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:47:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:47:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['damp', 'tps']}, 08:47:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'tests': ['damp', 'tps']}, 08:47:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['dromaeo_dom']}, 08:47:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['basic_compositor_video']}, 08:47:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:47:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['a11yr', 08:47:52 INFO - 'ts_paint', 08:47:52 INFO - 'tpaint', 08:47:52 INFO - 'sessionrestore', 08:47:52 INFO - 'sessionrestore_no_auto_restore', 08:47:52 INFO - 'tabpaint']}, 08:47:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:47:52 INFO - 'ts_paint', 08:47:52 INFO - 'tpaint', 08:47:52 INFO - 'sessionrestore', 08:47:52 INFO - 'sessionrestore_no_auto_restore', 08:47:52 INFO - 'tabpaint']}, 08:47:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:47:52 INFO - 'ts_paint', 08:47:52 INFO - 'tpaint', 08:47:52 INFO - 'sessionrestore', 08:47:52 INFO - 'sessionrestore_no_auto_restore', 08:47:52 INFO - 'tabpaint']}, 08:47:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:47:52 INFO - 'ts_paint', 08:47:52 INFO - 'tpaint', 08:47:52 INFO - 'sessionrestore', 08:47:52 INFO - 'sessionrestore_no_auto_restore', 08:47:52 INFO - 'tabpaint']}, 08:47:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['a11yr', 08:47:52 INFO - 'ts_paint', 08:47:52 INFO - 'tpaint', 08:47:52 INFO - 'sessionrestore', 08:47:52 INFO - 'sessionrestore_no_auto_restore', 08:47:52 INFO - 'tabpaint']}, 08:47:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['a11yr', 08:47:52 INFO - 'ts_paint', 08:47:52 INFO - 'tpaint', 08:47:52 INFO - 'sessionrestore', 08:47:52 INFO - 'sessionrestore_no_auto_restore', 08:47:52 INFO - 'tabpaint']}, 08:47:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['tsvgx', 08:47:52 INFO - 'tsvgr_opacity', 08:47:52 INFO - 'tart', 08:47:52 INFO - 'tscrollx', 08:47:52 INFO - 'cart', 08:47:52 INFO - 'tsvg_static']}, 08:47:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:47:52 INFO - 'tsvgr_opacity', 08:47:52 INFO - 'tart', 08:47:52 INFO - 'tscrollx', 08:47:52 INFO - 'cart', 08:47:52 INFO - 'tsvg_static']}, 08:47:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'talos_options': ['--disable-e10s'], 08:47:52 INFO - 'tests': ['tp5o']}, 08:47:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:47:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'talos_options': ['--disable-e10s', 08:47:52 INFO - '--xperf_path', 08:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:52 INFO - 'tests': ['tp5n']}, 08:47:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:47:52 INFO - 'talos_options': ['--xperf_path', 08:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:52 INFO - 'tests': ['tp5n']}}, 08:47:52 INFO - 'talos.zip': {'path': '', 08:47:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:52 INFO - Running post-action listener: _resource_record_post_action 08:47:52 INFO - [mozharness: 2017-01-24 16:47:52.416551Z] Finished populate-webroot step (success) 08:47:52 INFO - [mozharness: 2017-01-24 16:47:52.416662Z] Running create-virtualenv step. 08:47:52 INFO - Running pre-action listener: _resource_record_pre_action 08:47:52 INFO - Running main action method: create_virtualenv 08:47:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:52 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 08:47:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:52 INFO - Using real prefix '/tools/python27' 08:47:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:56 INFO - Installing pip.................done. 08:47:56 INFO - Return code: 0 08:47:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:47:56 INFO - Reading from file tmpfile_stdout 08:47:56 INFO - Output received: 08:47:56 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) 08:47:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:47: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', 'pip>=1.5'] in /builds/slave/test/build 08:47: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 pip>=1.5 08:47:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:47:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:56 INFO - 'HOME': '/Users/cltbld', 08:47:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:56 INFO - 'LOGNAME': 'cltbld', 08:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:56 INFO - 'MOZ_NO_REMOTE': '1', 08:47:56 INFO - 'NO_EM_RESTART': '1', 08:47:56 INFO - 'PAGER': '/bin/cat', 08:47:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:56 INFO - 'PWD': '/builds/slave/test', 08:47:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:56 INFO - 'SHELL': '/bin/bash', 08:47:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:47:56 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:47:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:56 INFO - 'USER': 'cltbld', 08:47:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:56 INFO - 'XPC_FLAGS': '0x0', 08:47:56 INFO - 'XPC_SERVICE_NAME': '0', 08:47:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:56 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 08:47:56 INFO - Cleaning up... 08:47:56 INFO - Return code: 0 08:47:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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', '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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:47: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:47: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 psutil>=3.1.1 08:47:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:47:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:56 INFO - 'HOME': '/Users/cltbld', 08:47:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:56 INFO - 'LOGNAME': 'cltbld', 08:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:56 INFO - 'MOZ_NO_REMOTE': '1', 08:47:56 INFO - 'NO_EM_RESTART': '1', 08:47:56 INFO - 'PAGER': '/bin/cat', 08:47:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:56 INFO - 'PWD': '/builds/slave/test', 08:47:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:56 INFO - 'SHELL': '/bin/bash', 08:47:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:47:56 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:47:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:56 INFO - 'USER': 'cltbld', 08:47:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:56 INFO - 'XPC_FLAGS': '0x0', 08:47:56 INFO - 'XPC_SERVICE_NAME': '0', 08:47:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:56 INFO - Downloading/unpacking psutil>=3.1.1 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:00 INFO - Installing collected packages: psutil 08:48:00 INFO - Running setup.py install for psutil 08:48:00 INFO - building 'psutil._psutil_osx' extension 08:48:00 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 08:48:00 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 08:48:01 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 08:48:01 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 08:48:01 INFO - building 'psutil._psutil_posix' extension 08:48:01 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 08:48:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:48:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:48:01 INFO - ^ 08:48:01 INFO - 1 warning generated. 08:48:01 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 08:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:01 INFO - Successfully installed psutil 08:48:01 INFO - Cleaning up... 08:48:01 INFO - Return code: 0 08:48:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:01 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')]} 08:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:01 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')]} 08:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:01 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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:01 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 08:48:01 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 08:48:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:01 INFO - 'HOME': '/Users/cltbld', 08:48:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:01 INFO - 'LOGNAME': 'cltbld', 08:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:01 INFO - 'MOZ_NO_REMOTE': '1', 08:48:01 INFO - 'NO_EM_RESTART': '1', 08:48:01 INFO - 'PAGER': '/bin/cat', 08:48:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:01 INFO - 'PWD': '/builds/slave/test', 08:48:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:01 INFO - 'SHELL': '/bin/bash', 08:48:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:01 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:01 INFO - 'USER': 'cltbld', 08:48:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:01 INFO - 'XPC_FLAGS': '0x0', 08:48:01 INFO - 'XPC_SERVICE_NAME': '0', 08:48:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:04 INFO - Installing collected packages: mozsystemmonitor 08:48:04 INFO - Running setup.py install for mozsystemmonitor 08:48:04 INFO - Successfully installed mozsystemmonitor 08:48:04 INFO - Cleaning up... 08:48:04 INFO - Return code: 0 08:48:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:04 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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:04 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 08:48:04 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 08:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:04 INFO - 'HOME': '/Users/cltbld', 08:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:04 INFO - 'LOGNAME': 'cltbld', 08:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:04 INFO - 'MOZ_NO_REMOTE': '1', 08:48:04 INFO - 'NO_EM_RESTART': '1', 08:48:04 INFO - 'PAGER': '/bin/cat', 08:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:04 INFO - 'PWD': '/builds/slave/test', 08:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:04 INFO - 'SHELL': '/bin/bash', 08:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:04 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:04 INFO - 'USER': 'cltbld', 08:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:04 INFO - 'XPC_FLAGS': '0x0', 08:48:04 INFO - 'XPC_SERVICE_NAME': '0', 08:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:04 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:04 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 08:48:04 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 08:48:04 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 08:48:04 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 08:48:04 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 08:48:04 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 08:48:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:08 INFO - warning: no files found matching '*.txt' 08:48:08 INFO - no previously-included directories found matching 'build' 08:48:08 INFO - no previously-included directories found matching 'dist' 08:48:08 INFO - no previously-included directories found matching '.git*' 08:48:08 INFO - Installing collected packages: jsonschema, functools32 08:48:08 INFO - Running setup.py install for functools32 08:48:08 INFO - warning: no files found matching '*.txt' 08:48:08 INFO - no previously-included directories found matching 'build' 08:48:08 INFO - no previously-included directories found matching 'dist' 08:48:08 INFO - no previously-included directories found matching '.git*' 08:48:08 INFO - Successfully installed jsonschema functools32 08:48:08 INFO - Cleaning up... 08:48:08 INFO - Return code: 0 08:48:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:08 INFO - 'HOME': '/Users/cltbld', 08:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:08 INFO - 'LOGNAME': 'cltbld', 08:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:08 INFO - 'MOZ_NO_REMOTE': '1', 08:48:08 INFO - 'NO_EM_RESTART': '1', 08:48:08 INFO - 'PAGER': '/bin/cat', 08:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:08 INFO - 'PWD': '/builds/slave/test', 08:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:08 INFO - 'SHELL': '/bin/bash', 08:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:08 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:08 INFO - 'USER': 'cltbld', 08:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:08 INFO - 'XPC_FLAGS': '0x0', 08:48:08 INFO - 'XPC_SERVICE_NAME': '0', 08:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:08 INFO - Cleaning up... 08:48:08 INFO - Return code: 0 08:48:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:08 INFO - 'HOME': '/Users/cltbld', 08:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:08 INFO - 'LOGNAME': 'cltbld', 08:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:08 INFO - 'MOZ_NO_REMOTE': '1', 08:48:08 INFO - 'NO_EM_RESTART': '1', 08:48:08 INFO - 'PAGER': '/bin/cat', 08:48:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:08 INFO - 'PWD': '/builds/slave/test', 08:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:08 INFO - 'SHELL': '/bin/bash', 08:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:08 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:08 INFO - 'USER': 'cltbld', 08:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:08 INFO - 'XPC_FLAGS': '0x0', 08:48:08 INFO - 'XPC_SERVICE_NAME': '0', 08:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48: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 08:48:12 INFO - Downloading docopt-0.6.1.tar.gz 08:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:12 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:12 INFO - Running setup.py install for blobuploader 08:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:13 INFO - Running setup.py install for requests 08:48:13 INFO - Running setup.py install for docopt 08:48:13 INFO - Successfully installed blobuploader requests docopt 08:48:13 INFO - Cleaning up... 08:48:13 INFO - Return code: 0 08:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:13 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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:13 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 08:48:13 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 08:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:13 INFO - 'HOME': '/Users/cltbld', 08:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:13 INFO - 'LOGNAME': 'cltbld', 08:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:13 INFO - 'MOZ_NO_REMOTE': '1', 08:48:13 INFO - 'NO_EM_RESTART': '1', 08:48:13 INFO - 'PAGER': '/bin/cat', 08:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:13 INFO - 'PWD': '/builds/slave/test', 08:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:13 INFO - 'SHELL': '/bin/bash', 08:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:13 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:13 INFO - 'USER': 'cltbld', 08:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:13 INFO - 'XPC_FLAGS': '0x0', 08:48:13 INFO - 'XPC_SERVICE_NAME': '0', 08:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-bNfDvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-KTMyzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-CBPjt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-zMFqzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-EAfxzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Xh9GHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-PYBvQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-ZTc9y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-xsuDZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:14 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-G_C_nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-tKOZzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Xf7yuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-fKyz0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-wMmxPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-ILHe_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-EBC2zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:15 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-4Qv7iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:15 INFO - Running setup.py install for manifestparser 08:48:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozcrash 08:48:16 INFO - Running setup.py install for mozdebug 08:48:16 INFO - Running setup.py install for mozdevice 08:48:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Running setup.py install for mozfile 08:48:16 INFO - Running setup.py install for mozhttpd 08:48:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Running setup.py install for mozinfo 08:48:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Running setup.py install for mozInstall 08:48:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Running setup.py install for mozleak 08:48:17 INFO - Running setup.py install for mozlog 08:48:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:17 INFO - Running setup.py install for moznetwork 08:48:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:17 INFO - Running setup.py install for mozprocess 08:48:17 INFO - Running setup.py install for mozprofile 08:48:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:17 INFO - Running setup.py install for mozrunner 08:48:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:17 INFO - Running setup.py install for mozscreenshot 08:48:18 INFO - Running setup.py install for moztest 08:48:18 INFO - Running setup.py install for mozversion 08:48:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:18 INFO - Cleaning up... 08:48:18 INFO - Return code: 0 08:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:18 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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:18 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 08:48:18 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 08:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:18 INFO - 'HOME': '/Users/cltbld', 08:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:18 INFO - 'LOGNAME': 'cltbld', 08:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:18 INFO - 'MOZ_NO_REMOTE': '1', 08:48:18 INFO - 'NO_EM_RESTART': '1', 08:48:18 INFO - 'PAGER': '/bin/cat', 08:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:18 INFO - 'PWD': '/builds/slave/test', 08:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:18 INFO - 'SHELL': '/bin/bash', 08:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:18 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:18 INFO - 'USER': 'cltbld', 08:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:18 INFO - 'XPC_FLAGS': '0x0', 08:48:18 INFO - 'XPC_SERVICE_NAME': '0', 08:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9MNsBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:18 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)) 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-IRK5vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:18 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)) 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-LXEToH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:18 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)) 08:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-rxBTnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-A5zyUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-RTk8Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-VFBCkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-6dNs2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-mTZaqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Fw48_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-6r3Pjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:19 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-8Mk8Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:19 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-tNZRen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:20 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)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:20 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-YltjBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:20 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)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:20 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-PCzrL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:20 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)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:20 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-wX1L2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:20 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-GDKvaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:20 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)) 08:48:20 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)) 08:48:20 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)) 08:48:20 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)) 08:48:20 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)) 08:48:20 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)) 08:48:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:23 INFO - Downloading blessings-1.6.tar.gz 08:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:23 INFO - Installing collected packages: blessings 08:48:23 INFO - Running setup.py install for blessings 08:48:23 INFO - Successfully installed blessings 08:48:23 INFO - Cleaning up... 08:48:23 INFO - Return code: 0 08:48:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:24 INFO - Reading from file tmpfile_stdout 08:48:24 INFO - Current package versions: 08:48:24 INFO - blessings == 1.6 08:48:24 INFO - blobuploader == 1.2.4 08:48:24 INFO - docopt == 0.6.1 08:48:24 INFO - functools32 == 3.2.3-2 08:48:24 INFO - jsonschema == 2.5.1 08:48:24 INFO - manifestparser == 1.1 08:48:24 INFO - mozInstall == 1.12 08:48:24 INFO - mozcrash == 1.0 08:48:24 INFO - mozdebug == 0.1 08:48:24 INFO - mozdevice == 0.49 08:48:24 INFO - mozfile == 1.2 08:48:24 INFO - mozhttpd == 0.7 08:48:24 INFO - mozinfo == 0.9 08:48:24 INFO - mozleak == 0.1 08:48:24 INFO - mozlog == 3.4 08:48:24 INFO - moznetwork == 0.27 08:48:24 INFO - mozprocess == 0.24 08:48:24 INFO - mozprofile == 0.28 08:48:24 INFO - mozrunner == 6.13 08:48:24 INFO - mozscreenshot == 0.1 08:48:24 INFO - mozsystemmonitor == 0.3 08:48:24 INFO - moztest == 0.8 08:48:24 INFO - mozversion == 1.4 08:48:24 INFO - psutil == 3.1.1 08:48:24 INFO - requests == 1.2.3 08:48:24 INFO - wsgiref == 0.1.2 08:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:24 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 08:48:24 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 08:48:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:24 INFO - 'HOME': '/Users/cltbld', 08:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:24 INFO - 'LOGNAME': 'cltbld', 08:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:24 INFO - 'MOZ_NO_REMOTE': '1', 08:48:24 INFO - 'NO_EM_RESTART': '1', 08:48:24 INFO - 'PAGER': '/bin/cat', 08:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:24 INFO - 'PWD': '/builds/slave/test', 08:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:24 INFO - 'SHELL': '/bin/bash', 08:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:24 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:24 INFO - 'USER': 'cltbld', 08:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:24 INFO - 'XPC_FLAGS': '0x0', 08:48:24 INFO - 'XPC_SERVICE_NAME': '0', 08:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 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)) 08:48:24 INFO - Cleaning up... 08:48:24 INFO - Return code: 0 08:48:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 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 0x108a78b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98b4e41c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, '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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 08:48:24 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 08:48:24 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 08:48:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:24 INFO - 'HOME': '/Users/cltbld', 08:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:24 INFO - 'LOGNAME': 'cltbld', 08:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:24 INFO - 'MOZ_NO_REMOTE': '1', 08:48:24 INFO - 'NO_EM_RESTART': '1', 08:48:24 INFO - 'PAGER': '/bin/cat', 08:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:24 INFO - 'PWD': '/builds/slave/test', 08:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:24 INFO - 'SHELL': '/bin/bash', 08:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:24 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:24 INFO - 'USER': 'cltbld', 08:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:24 INFO - 'XPC_FLAGS': '0x0', 08:48:24 INFO - 'XPC_SERVICE_NAME': '0', 08:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:25 INFO - Cleaning up... 08:48:25 INFO - Return code: 0 08:48:25 INFO - Running post-action listener: _resource_record_post_action 08:48:25 INFO - Running post-action listener: _start_resource_monitoring 08:48:25 INFO - Starting resource monitoring. 08:48:25 INFO - [mozharness: 2017-01-24 16:48:25.150276Z] Finished create-virtualenv step (success) 08:48:25 INFO - [mozharness: 2017-01-24 16:48:25.151323Z] Running install step. 08:48:25 INFO - Running pre-action listener: _resource_record_pre_action 08:48:25 INFO - Running main action method: install 08:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:25 INFO - Reading from file tmpfile_stdout 08:48:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:25 INFO - Reading from file tmpfile_stdout 08:48:25 INFO - Output received: 08:48:25 INFO - Usage: mozinstall [options] installer 08:48:25 INFO - Options: 08:48:25 INFO - -h, --help show this help message and exit 08:48:25 INFO - -d DEST, --destination=DEST 08:48:25 INFO - Directory to install application into. [default: 08:48:25 INFO - "/builds/slave/test"] 08:48:25 INFO - --app=APP Application being installed. [default: firefox] 08:48:25 INFO - mkdir: /builds/slave/test/build/application 08:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:48:47 INFO - Reading from file tmpfile_stdout 08:48:47 INFO - Output received: 08:48:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:48:47 INFO - Running post-action listener: _resource_record_post_action 08:48:47 INFO - [mozharness: 2017-01-24 16:48:47.390910Z] Finished install step (success) 08:48:47 INFO - [mozharness: 2017-01-24 16:48:47.391027Z] Running run-tests step. 08:48:47 INFO - Running pre-action listener: _resource_record_pre_action 08:48:47 INFO - Running main action method: run_tests 08:48:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:47 INFO - 2017-01-24 08:48:47.405 screenresolution[1627:7388] starting screenresolution argv=screenresolution get 08:48:47 INFO - 2017-01-24 08:48:47.408 screenresolution[1627:7388] Display 0: 1600x1200x32@60 08:48:47 INFO - 2017-01-24 08:48:47.414 screenresolution[1628:7390] starting screenresolution argv=screenresolution list 08:48:47 INFO - Available Modes on Display 0 08:48:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:47 INFO - Intel Iris: 08:48:47 INFO - Chipset Model: Intel Iris 08:48:47 INFO - Type: GPU 08:48:47 INFO - Bus: Built-In 08:48:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:47 INFO - Vendor: Intel (0x8086) 08:48:47 INFO - Device ID: 0x0a2e 08:48:47 INFO - Revision ID: 0x0009 08:48:47 INFO - Displays: 08:48:47 INFO - Display: 08:48:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:47 INFO - Display Serial Number: 1600x1200 60 08:48:47 INFO - Main Display: Yes 08:48:47 INFO - Mirror: Off 08:48:47 INFO - Online: Yes 08:48:47 INFO - Rotation: Supported 08:48:47 INFO - Return code: 0 08:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:47 INFO - Python 2.7.3 08:48:47 INFO - Return code: 0 08:48:47 INFO - grabbing minidump binary from tooltool 08:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:47 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 0x108856d30>, '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 0x10877ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10884bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:47 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 08:48:47 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 08:48:47 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 08:48:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:47 INFO - Return code: 0 08:48:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:48:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:48:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:47 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/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 08:48:47 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/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0315 --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 08:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYzB9j2Oo5/Render', 08:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:47 INFO - 'HOME': '/Users/cltbld', 08:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:47 INFO - 'LOGNAME': 'cltbld', 08:48:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:47 INFO - 'MOZ_NO_REMOTE': '1', 08:48:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:47 INFO - 'NO_EM_RESTART': '1', 08:48:47 INFO - 'PAGER': '/bin/cat', 08:48:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:47 INFO - 'PWD': '/builds/slave/test', 08:48:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:47 INFO - 'SHELL': '/bin/bash', 08:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CiEifVNZj3/Listeners', 08:48:47 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 08:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:47 INFO - 'USER': 'cltbld', 08:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:47 INFO - 'XPC_FLAGS': '0x0', 08:48:47 INFO - 'XPC_SERVICE_NAME': '0', 08:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:47 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/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 08:48:47 INFO - mozversion application_buildid: 20170124055947 08:48:47 INFO - mozversion application_changeset: 7b33131fed2074be7897b277335f3aa8fa198ca5 08:48:47 INFO - mozversion application_display_name: Nightly 08:48:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:47 INFO - mozversion application_name: Firefox 08:48:47 INFO - mozversion application_remotingname: firefox 08:48:47 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 08:48:47 INFO - mozversion application_vendor: Mozilla 08:48:47 INFO - mozversion application_version: 54.0a1 08:48:47 INFO - mozversion platform_buildid: 20170124055947 08:48:47 INFO - mozversion platform_changeset: 7b33131fed2074be7897b277335f3aa8fa198ca5 08:48:47 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 08:48:47 INFO - mozversion platform_version: 54.0a1 08:48:47 INFO - using testdate: 1485276527 08:48:47 INFO - actual date: 1485276527 08:48:47 INFO - starting webserver on 'localhost:49243' 08:48:47 INFO - SUITE-START | Running 2 tests 08:48:47 INFO - TEST-START | dromaeo_css 08:48:47 INFO - operating with platform_type : mac_ 08:48:47 INFO - Initialising browser for dromaeo_css test... 08:48:48 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp0Xr6yK/profile http://localhost:49243/getInfo.html) 08:48:50 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 08:48:50 INFO - PROCESS | 1638 | colorDepth:24 08:48:50 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 08:48:50 INFO - PROCESS | 1638 | __metrics 08:48:50 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 08:48:50 INFO - PROCESS | 1638 | 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" 08:48:50 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:51 INFO - TEST-INFO | 1638: exit 0 08:48:51 INFO - Browser initialized. 08:48:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:51 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp0Xr6yK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:03 INFO - PROCESS | 1641 | RSS: Main: 236638208 08:49:03 INFO - PROCESS | 1641 | 08:52:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:52:08 INFO - PROCESS | 1641 | RSS: Main: 373571584 08:52:08 INFO - PROCESS | 1641 | 08:53:52 INFO - PROCESS | 1641 | ************************* 08:53:52 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 08:53:52 INFO - PROCESS | 1641 | 08:53:52 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:53:52 INFO - PROCESS | 1641 | Full stack: 08:53:52 INFO - PROCESS | 1641 | ************************* 08:55:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:55:12 INFO - PROCESS | 1641 | RSS: Main: 369053696 08:55:12 INFO - PROCESS | 1641 | 08:58:14 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:58:15 INFO - PROCESS | 1641 | RSS: Main: 336494592 08:58:15 INFO - PROCESS | 1641 | 09:01:17 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:01:18 INFO - PROCESS | 1641 | RSS: Main: 340459520 09:01:18 INFO - PROCESS | 1641 | 09:04:21 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:04:22 INFO - PROCESS | 1641 | RSS: Main: 333414400 09:04:22 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:07:25 INFO - PROCESS | 1641 | RSS: Main: 397201408 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | __start_tp_report 09:07:25 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 09:07:25 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 09:07:25 INFO - PROCESS | 1641 | |i|pagename|runs| 09:07:25 INFO - PROCESS | 1641 | |0;dojo.html;2852.757515611173;3326.218338690409;3331.56689630348;3350.798952062875;3384.4077286474862;5028.145215313396;5601.131824567194;5610.943890561093;5645.35078465976;5646.661200327983;4716.811327546902;5640.858978525529;5698.0883058710615;5721.799737009205;5821.243238379005;5163.096458119814;5236.528712415882;5238.816641417551;5253.711045892474;5257.5531079858065;5170;5235.397929238148;5297.099493086165;5297.576193904498;5311.1502159654465;5275.235090911796;5293.947060529403;5308.442613525582;5311.468853114677;5361.276227709248;5138.229265610151;5146.6911985281;5153.510416510426;5166.560842328407;5227.47725227478;5166.483351664841;5185.974070129663;5197.636165468419;5200.985807767487;5258.658187217857;4693.413323334583;5682.829515114553;5693.231413759131;5706.28671416073;5723.084306510938;6118.253719382578;6142.938570614281;6150.169727086831;6236.220472440945;6241.407066328737;5197;6230.221222347207;6268.529860260499;6343.048542718583;6346.460550853183;5807.970960145214;5823.5923485355615;5823.737931793079;5823.737931793079;5856.795012174596;6221.440070393686;6251.499880009588;6275.403836635513;6303.086052522359;6317.178766760292;6028.457438830526;6077.574569780073;6114.144019837227;6126.23422072241;6129.022607377628;6277.560570760094;6283.37166283368;6286.842828929313;6300.684965751694;6302.306746257908;6105.114758360013;6106.005662907935;6118.082287656798;6220.315765265817;6239.78160764371;6147.877042459126;6200;6206.255249370104;6279.058141278845;6286.968565157145;4976.154053810861;4981.2030075187795;4986.052649996489;4997.150484417658;5008.6744361616375;4446.444194475691;4475.165182275252;4475.932861007088;4477.574630410106;4497.910041799146;5662.915056274159;5717;5719.428057194331;5721.5136713379;5776.306843178845;6263.749450022039;6315.147455093504;6339.5562310637815;6351.110844481776;6355.904661430082;5759.917002927885;5789.363170051291;5818.981678206297;5826.41735826414;5850.268716410449;5350.010248104036;5379.865503362447;5379.946200537945;5438.864028399243;5448.863778405493;6230.719617617218;6262.279837818709;6273.65494897785;6308.243010838729;6313.873722525432;6343.682815859281;6353.332900045613;6357.745690172342;6360.681965901779;6369.044643303541;6249.718762655601;6256.968715156395;6265.780697675559;6303.275123360872;6306.337834527309;6076.088586712029;6119.502553941512;6121.727351053096;6149.108379284889;6244.063390491463;6293.118963345227;6301.086342480223;6302.968485157545;6306.779262725782;6313.90529142054;5907.4387933148;6079.240094988127;6117.235345581802;6140.815775526741;6143;5934.643921364732;5958.046712525975;5961.940380596138;5990.191324171181;6018.578699490994;5890.705464726832;5933.258342707161;5949.553783466171;5965.791197308074;5973.104034394875;5953.404659534185;5953.58324917269;5957.880842383215;6120.724567394389;6138.693065346804;5848.53211743051;5860.208871802252;5870.26621672291;5897.351291358033;5900.291964964232 09:07:25 INFO - PROCESS | 1641 | |1;ext.html;460.22911623031456;487.6488927971859;504.4476298453194;507.7711937112188;513.7636687123922;26180.345491362703;32115.19712007198;40873.18253634925;41945.37081943773;42051.789741051325;41623.58376416235;42051.36922946158;42124.578754212445;42201.15597688044;42219;7906.288434040949;9339.486328251944;9348.859767103499;9360.344775865693;9361.719148425558;8262.462939908886;8458.238758511732;11002.119830413547;11344.262622929524;11350.43247837609;11241.943790281037;11323.660290191267;11324.830127548094;11330.830037549444;11403.657890263265;11227.60703375382;11298.774024519464;11300.943495282554;11308.886911130865;11317;8274.627641756135;8471.70349037787;8477.66089356425;8568;10853.674389768319;38983.8050809747;40256;40300.79849600763;40379.394309085386;40454;4025.326552996305;4072.3687828386646;4079.51045874494;4126.174765047002;4196.118815048843;29699.851500742574;30187.245318866986;30935.690643093505;30940.535891961637;30941.22646933822;3147.4806656901583;3262.934741305184;3274.492453669685;3334.933301333984;3335.799852008863;484583;485453.99999999645;485649;488211;489203;58023.129653055235;58366;58438.41561584415;58565;58605.41394586085;62405.37594624086;62598.0610290846;62668.68665656734;62679.059814102824;62702;15487.225638718019;15909.920450397674;15936;15954.28205730745;15955.920220398824;11092.944535277273;11442;12286.815697764541;12321.568745094059;12360.938195308965;13046.934765326112;15274.465393711167;15717.764233536505;15909;15933.521994340188;5023.34696489454;5867.325257595346;6266.373362663697;6276.780312689125;6344.397282258178;791.8970533830565;882.7395918204145;883.787432682192;885.2740752582949;912.7170577121113;29959.951401700837;29971.250718732204;30226.54660180099;30621;30630.54054189189;1056.5087234436023;1062.2670357453333;1081.405227125078;1093.578972095749;1182.9231099978474;15413.5375938722;15419.768703469457;15491.690166196613;15783.526494205193;15894.443694470869;599007;599324;600250;600915;601025;59356.70321648364;59411.70294148502;59599.404005960256;59600.70199649061;59633.701831490565;1403.5228022472409;1429.8856091512655;1438.5324769449971;1443.3288520837862;1445.2195814260601;28504.857475712488;29265.41469170647;29555.852220738758;29974.400511990076;30042.849785750932;49061.264081039524;49424.75287623539;49630;49637.75905602389;49974.25038624496;485576;488654;489346;489465;490673;23718.881405592863;24414.63378049295;38592.8422147336;38919;38920;41752.32428412049;42558.787206063775;42782.144357113306;42862;43186;34531.4820277691;34667;35608;35806.82096589501;36567.45148822823;34047.808326708444;35027.299454010266;35150.824245878604;35480.112997175274;35823.46264806082;34138.48792268068;34467.310653786284;34678.65321346754;34705.30589388248;34832.30335393328;26157.73842261553;29081;29627;31076;31274.843625781727;20947.581048379252;22922.083116675145;23028.884855575616;23096.96063677105;23886.761132388452 09:07:25 INFO - PROCESS | 1641 | |2;jquery.html;366.1030475335429;386.246818703528;388.39604415134465;397.4812869205686;420.84849454196484;15455.995360301573;15743.842561574394;18562.164702588398;20932.16271349148;21568.245111421104;16951.237194326255;19871.801281987176;20630.793692063075;22034.779652203473;22447.887760561174;5365.919511207335;5462.426445223254;5523.061079616455;5643.6049476536655;5647.068233741427;5454.809081682142;5549.667019978794;5552.944470555303;5554.91667624986;5557.833265002037;4008.098177909976;4240.279152544075;5937.317208521011;6194.938050619504;6222.844428889269;6035.547333949928;6137.11011903276;6247.625142491443;6261.968690156566;6274.5607807453725;6087.452129308339;6087.726052327612;6105.236845394325;6108.267007959029;6134.079888016833;13706.52027179044;15354.30905609239;20609.248213901836;26150.476990460276;26472.867635661893;2549.107812265711;2628.9868550657125;2671.238696971354;2709.187243826864;2722.809403341767;9608.855867161998;10539.882713937963;10585.78828423435;15693.215339232993;16339.26473308704;1803.1174559651827;1869.1962456143854;1878.182990399167;1885.1422602715868;1893.595134179598;130528;136597;137471.31264343613;138563;139417;9990.700278991642;11212.49543770516;11569.710757230969;11780.882191177978;11930;15386.153761542999;15743;15749.921250393674;15757.763633545506;15776.842231577766;8309.086000539935;8549.059603443617;8556.700515481929;8702.30075759083;8717.869231961526;8146.389020823462;8267.421280510427;8270.172982701803;8275.875861862078;8417.494950303002;3561.4479755637917;4684.672072954861;4729.196036673774;4850.75746212688;4977.925331120036;1973;2020.090959068425;2032.1464984706458;2035.592881423721;2037.8777273363646;993.965211217604;1001.9048190421898;1002.6089824968268;1014.4015031131668;1040.5629635553087;20980.895095524425;21502.78497215008;21522.677159842617;21548.35354939354;21608.459788505097;1028.5885645741614;1039.142707266493;1053.4627340056627;1053.984190237147;1062.7874425115008;8863;10755.78488430227;11120.943510366502;11159.218854680257;11188;721015;730945;738584;753369;768279;155168;160906;162501;163402.1829890843;166227;1023.7952409517977;1041.047441590951;1081.2863510083464;1084.2681190196586;1087.380193289833;19473.61843585182;19736.70394944048;19890.90054549718;19921.00394980216;19984.60030799405;49604.75197623989;58979.70510147422;59818.10272845824;60028.399716002285;60060.69969650124;87604.5619771897;88495.55752221198;88651.55674221588;88727.11272887189;89268;7234.89147662796;7619.809504762426;8113.878291825746;8132.349412046904;8451.83096338082;12440.440180191732;13222.867771322164;13418.597442076752;13715.382807773874;13741.656458588615;11369;11418.885811141783;11684.240524365889;11767.23512971654;12013.63959081229;9872.85190722154;10677.786444271227;11465.36940468249;11469.885301147215;11659.300441973508;11497.252678575866;11600.129990250596;11905.761884762429;11986.400679965793;12114.091443141975;7523.360514356341;7550.811229719301;7644.464887457824;7705.22947705225;7839.608019599112;9609.327347085917;11323.433828308387;11361.375124367909;11479.196456248317;11777.293362398283 09:07:25 INFO - PROCESS | 1641 | |3;mootools.html;1464.414234306278;1469.3902030657277;1477.4459577658379;1489.1437423481493;1495.6559991202023;8001;8378.62296196671;8383.119772423885;8389.24496795289;8392.202740739634;7429.591372474511;7655.6937722491175;7669.194734552875;7969;8181.0591781945095;2268.9546209075806;2317.281642690763;2319.5940710375703;2324.0239099578134;2329.1847853251397;2298.5058212484314;2330.1262026739973;2332.0438620165737;2332.6734257204007;2342.4495243617735;2020.848436367271;2257.9096836126537;2282.326713619478;2299.574578702937;2320.5590937721863;2271.136967952176;2298.103739541572;2299.149314753552;2300.9424764380856;2303.447172678545;2213.347062616516;2315.120254303354;2324.1168356024773;2326.89528971195;2332.5801355756125;8229;8302.875456868152;8308.54303013334;8320.916790832074;8323.375746818952;5064.215046667772;5158.638895277332;5163.690178589259;5167.250748641426;5167.819126330561;3186.23530352716;3289.1448223461834;3489.8778542751134;3494.1439347359806;3497.562804649419;1209.9818502722467;1210.4008515784742;1252.918560293587;1264.4373253902017;1275.2858399296424;10610.681679549625;10680.198985076151;10683.78632427355;10691.679249622524;10701.090407315387;3833.674137698271;4342.6742994275555;4634.21218392874;4646.907061858744;4665.183592871234;9186;9417.858732119024;9423.575939082757;9436.245100391952;9479.810403791886;5090.872728181751;5192.532672059533;5193.454687257859;5195.116830138885;5198.688078715213;3776.4146557283666;4222.577742225814;4656.092062047868;4732.0772449372735;4761.285807128958;3183.904482865518;3775.6035616260447;3874.438206460104;3886.9222615547533;3925.0776067624083;1256.6104507602672;1266.6263452281414;1275.6874565731455;1283.4224598930518;1289.1233960906486;777.6889244302212;780.8321210939675;787.2206515549565;799.840031993592;801.3789313282252;4551.271796512542;5053.8123540967845;5197.610179236573;5399.568034557226;5623.015972204929;562.3504851896066;574.8505388598994;577.4600748300269;583.2243116654839;584.8771757930797;3651.6165802590876;3683.797391143513;3769.3026790043928;3776.15036616759;3800.7149463789774;9447.149756521945;9731.854022189673;9733.2213422926;9734.75663108428;9737.513124343754;9649.469279189712;9708.077732615391;9731.513424328898;9734.610615575439;9748.122668959686;6569.146011018537;7212.927870721331;7495.213002634645;7604.087509498895;7692.269234422721;5527.5577953762795;5666.603337766317;5690.800821971211;5698.715064246689;5869.090291004901;7799.727009554638;8861.069587693199;8908.064653211319;8923.107689231025;9154.496502692416;9019.143181397756;9073.364864459425;9244.214241789523;9330.206932410822;9331.906680933103;6534.117894084237;6773.627450490073;6778.423833974168;7021.192562855337;7253.637318134178;6761.391474767294;7550.471466997257;7790.727324543614;7795.805104872424;7919.406044546567;6993.090898183407;7070.646467676698;7115.075040244735;7132.750353737594;7229.168645605822;7000.124984376953;7014.158301003912;7038.331358520933;7054.047703559953;7159.140903091662;6252.499800015897;6348.492120630431;6429.935700642934;6442.355764423708;6447.387498187664;4893.730844803427;4917.532834380728;4950.183219768698;5046.29351890743;5119.6416250862085;4227.091175397304;4640.69835460694;4841.104395686809;5021.171506701499;5151.381834179922 09:07:25 INFO - PROCESS | 1641 | |4;prototype.html;351.3412351840299;357.17314417124345;357.4834364343523;362.6138162856556;364.9470826730124;4367.694261401703;4537.773111344428;4985.700857948516;5105.770240339184;5188.820695307971;5082;5120.231965205221;5131.281620573113;5149.922751158726;5164.011855435656;3402.8468718907584;3532.1875968527256;3848.9230215395605;3987.7407968482103;3999.640032397084;3326.850291736878;3850.8074596270076;4030.9596904031023;4046.5751096134777;4069.450624165744;4040.656544193747;4048.1498885234137;4077.408775727518;4104.610062044101;4111.8972025699295;3813.427985802124;3845.750026248285;4069.1078648428474;4071.5724848890886;4099.569545197771;2974.509205981032;3576.7675101118343;3577.3918433866306;3583.7312201584723;3619.2037751694584;4073.450084238649;4890.679516530552;4975.179095449246;4977.925331120036;5046.369203849519;4019.4774679291504;4056.255810001698;4241.2365774160635;4627.8148874045;4640.559146881041;5070.518300761421;5125.282460455539;5316.521513063804;5381.515663590296;5434.75543600535;3212.855421506038;3915.295246855565;3921.5294164700417;3934.996575873163;3939.6559047366773;5395.406505284415;5521.420250873601;5596.132599447093;5671.347795003586;5675.262215911905;3910.687145028391;4012.237674841829;4016.49793775778;4023.887459084004;4038;3604.7656902301264;3663.9589141012893;4041.595840415935;4100.815463304159;4114.506259248849;4147.274227010261;4511.433489058274;4636.791344389443;4639.652026098056;4651.488336283006;5437.700926449004;5458.808941687022;5470;5486.91769623456;5535.889282214333;1178.8054970929873;1200.7358381156307;1312.3307113372248;1324.6158614001831;1327.4557431453059;872.3239489395643;932.7434955387323;936.8360536906014;945.1115951006033;951.9190868776232;4372.453443319585;4460.843870464518;4774.976125119352;4776.785044672998;4790.359326911573;4561.566651168134;5228.9738551307;5276.894462110737;5278.973605132027;5310.389305229871;4103.876883693494;4596.563326483979;4698.130845793539;4713.9764301178275;4790.568848803624;2354.3407845803204;2419.4919066995776;2661.853598052087;2770.4043630619512;2838.134369017428;4966.478519755446;5033.018561380569;5416.891662166813;5464.644798088111;5495.323926202466;4982.779219091346;5103.2855400244;5223.921641175385;5247.239150323258;5443.747937974288;5105.2086926526445;5563.638363506359;5609.559841468974;5801.216835727123;5823.912641310469;4836.371271734652;5310.734463276744;5504.284443022541;5576.191452239322;5595.63628364155;4707.058588282289;4879.853604391874;5264.447233040629;5495.505404513613;5500.862478438071;4308.719933204332;4845.110406941366;5160.845174644766;5645.633033852787;5850.782069861474;3227.0315107784704;3758.680512156497;3815.893390916603;3825.7130715197027;3827.966449058683;5584.301962254718;5588.441155884379;5591.944080559305;5602.411746766531;5621.325440947113;5082.186850103965;5187.417837559429;5363.651362661414;5416.647917885325;5458.4541545845095;4442.511323754449;4750.5961993229585;4799.736014519235;4990.951900100874;5418.647787893774;4444.822122137572;5212.931349073507;5278.683279003272;5309;5342.786288548415;5011.523905228997;5152.201408781645;5153.484651534816;5371.650842695212;5400.62195646301;4288.399624052698;5286.524212820865;5310.787568497217;5323.441038690882;5330.840074797762 09:07:25 INFO - PROCESS | 1641 | |5;yui.html;708.5606923707302;719.2843121094512;775.6160700453277;815.4291995603078;831.0733532111693;16860.66278674426;17434.651306973854;17466.126693665297;17747.55631109223;17789.82210177898;16535.83464165361;16693.24880380383;16834.83165168351;16860.072696001716;16902.57743556412;713.6574444266755;875.829213303406;877.4165180155205;887.4098724348333;890.261083300862;689.824094855811;713.4470785141505;888.4180861535705;895.0154829687357;895.7581453007684;843.8902942617451;925.1303774451993;933.3559843707853;936.5176933879058;937.6624415210518;927.1331305229631;927.285989787863;928.0070324752551;928.6888892221114;929.5631053404957;535.2907397698027;554.1134185303522;697.6651207420466;697.7941507255372;699.5627732667083;15087.924560377238;15621.297041633154;15643.92178039114;15925.761113583305;15932.840671593252;13949.232792196424;13989.230592317419;13997.281304973569;14112.223827689473;14154.50459233932;11778.175527713063;11859.661663092613;11983.28100313984;12016.063621436675;12110.273383596925;3647.3434781739275;3657.689096426807;3739.607341229186;3817.522809648794;3868.941965870514;103934;107351;109705.45147274212;110178.89821101847;111033.88966110317;10737.677869663923;10911.290766100177;10954.740204876542;10971.396573188551;11072.612458563912;21486.785132148478;22319;22347.329580112622;22403.887980560317;22441.21455749041;7580.792947178172;7638.388928885676;7670.884936725954;7710.730124445618;7756.457048006699;4248.808803603845;4295.926122787569;4383.189110014658;4437.955620443819;4531.207038768202;3585.94621080684;3618.565772107364;3690.926181476409;3693.076730817296;3695.8891233263043;655.2431941108027;665.1286814273318;668.8495088605025;669.2136739331266;676.8612434450926;573.704705567605;675.7263308360122;678.4402867634122;701.6947627781931;702.2415790945767;8260.917390826015;9613.90386096144;9614.807703846023;10112.292139550162;10181.185505159718;568.0910543130957;612.6109920200615;613.6379536073738;657.3886285754198;723.6562632749402;4761.547652972962;5014.648974571745;5016.749162541858;5032.597392208614;5043.3191519145175;102158;106946.46526767472;107102;108352;112418.31372529418;70075.93367426028;70219;80522.59738701386;93248.53375733078;93748;71355.6432217846;78109.60945195238;78232.60883695545;78885.99999999885;80387.59806200932;10441.216908731723;10976;11018.669439916815;11104.058693881145;11178.664640060812;49774.75112624559;52360;53514.197287041505;53605.39183824491;53898;67368.6631566839;67806.64386712336;69556;70418.29581704117;70719;10357.585696572052;12781.61655150347;12826.743465130832;13014.023948203734;13640.590782276548;14390.568282951528;14391.712165756417;14486.782698259745;14791.408343666133;15089.320980555682;11387.658370248906;13713;13769.793453098411;13795.79306310386;13832.930835345758;13488.05583609138;13491.05562610608;13702.65743356424;13755.931220344235;14255.572332830032;13250.80123798163;13406.32968351559;13417.530386436818;13417.798733018817;13433.126846754929;10541.631042913461;11091;11216.607418740305;11272.549098036316;11830.408479575815;10607.681769546925;10764.730881727706;10778.784424311627;10872.891271087505;10875.347479151276 09:07:25 INFO - PROCESS | 1641 | __end_tp_report 09:07:25 INFO - PROCESS | 1641 | __start_cc_report 09:07:25 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1489 09:07:25 INFO - PROCESS | 1641 | __end_cc_report 09:07:25 INFO - PROCESS | 1641 | __startTimestamp1485277645819__endTimestamp 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | ------- Summary: start ------- 09:07:25 INFO - PROCESS | 1641 | Number of tests: 6 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5728.36 Median:5907.44 stddev:656.26 (11.1%) stddev-sans-first:618.29 09:07:25 INFO - PROCESS | 1641 | Values: 2852.8 3326.2 3331.6 3350.8 3384.4 5028.1 5601.1 5610.9 5645.4 5646.7 4716.8 5640.9 5698.1 5721.8 5821.2 5163.1 5236.5 5238.8 5253.7 5257.6 5170.0 5235.4 5297.1 5297.6 5311.2 5275.2 5293.9 5308.4 5311.5 5361.3 5138.2 5146.7 5153.5 5166.6 5227.5 5166.5 5186.0 5197.6 5201.0 5258.7 4693.4 5682.8 5693.2 5706.3 5723.1 6118.3 6142.9 6150.2 6236.2 6241.4 5197.0 6230.2 6268.5 6343.0 6346.5 5808.0 5823.6 5823.7 5823.7 5856.8 6221.4 6251.5 6275.4 6303.1 6317.2 6028.5 6077.6 6114.1 6126.2 6129.0 6277.6 6283.4 6286.8 6300.7 6302.3 6105.1 6106.0 6118.1 6220.3 6239.8 6147.9 6200.0 6206.3 6279.1 6287.0 4976.2 4981.2 4986.1 4997.2 5008.7 4446.4 4475.2 4475.9 4477.6 4497.9 5662.9 5717.0 5719.4 5721.5 5776.3 6263.7 6315.1 6339.6 6351.1 6355.9 5759.9 5789.4 5819.0 5826.4 5850.3 5350.0 5379.9 5379.9 5438.9 5448.9 6230.7 6262.3 6273.7 6308.2 6313.9 6343.7 6353.3 6357.7 6360.7 6369.0 6249.7 6257.0 6265.8 6303.3 6306.3 6076.1 6119.5 6121.7 6149.1 6244.1 6293.1 6301.1 6303.0 6306.8 6313.9 5907.4 6079.2 6117.2 6140.8 6143.0 5934.6 5958.0 5961.9 5990.2 6018.6 5890.7 5933.3 5949.6 5965.8 5973.1 5953.4 5953.6 5957.9 6120.7 6138.7 5848.5 5860.2 5870.3 5897.4 5900.3 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:65941.46 Median:35815.14 stddev:140783.06 (393.1%) stddev-sans-first:141092.15 09:07:25 INFO - PROCESS | 1641 | Values: 460.2 487.6 504.4 507.8 513.8 26180.3 32115.2 40873.2 41945.4 42051.8 41623.6 42051.4 42124.6 42201.2 42219.0 7906.3 9339.5 9348.9 9360.3 9361.7 8262.5 8458.2 11002.1 11344.3 11350.4 11241.9 11323.7 11324.8 11330.8 11403.7 11227.6 11298.8 11300.9 11308.9 11317.0 8274.6 8471.7 8477.7 8568.0 10853.7 38983.8 40256.0 40300.8 40379.4 40454.0 4025.3 4072.4 4079.5 4126.2 4196.1 29699.9 30187.2 30935.7 30940.5 30941.2 3147.5 3262.9 3274.5 3334.9 3335.8 484583.0 485454.0 485649.0 488211.0 489203.0 58023.1 58366.0 58438.4 58565.0 58605.4 62405.4 62598.1 62668.7 62679.1 62702.0 15487.2 15909.9 15936.0 15954.3 15955.9 11092.9 11442.0 12286.8 12321.6 12360.9 13046.9 15274.5 15717.8 15909.0 15933.5 5023.3 5867.3 6266.4 6276.8 6344.4 791.9 882.7 883.8 885.3 912.7 29960.0 29971.3 30226.5 30621.0 30630.5 1056.5 1062.3 1081.4 1093.6 1182.9 15413.5 15419.8 15491.7 15783.5 15894.4 599007.0 599324.0 600250.0 600915.0 601025.0 59356.7 59411.7 59599.4 59600.7 59633.7 1403.5 1429.9 1438.5 1443.3 1445.2 28504.9 29265.4 29555.9 29974.4 30042.8 49061.3 49424.8 49630.0 49637.8 49974.3 485576.0 488654.0 489346.0 489465.0 490673.0 23718.9 24414.6 38592.8 38919.0 38920.0 41752.3 42558.8 42782.1 42862.0 43186.0 34531.5 34667.0 35608.0 35806.8 36567.5 34047.8 35027.3 35150.8 35480.1 35823.5 34138.5 34467.3 34678.7 34705.3 34832.3 26157.7 29081.0 29627.0 31076.0 31274.8 20947.6 22922.1 23028.9 23097.0 23886.8 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:40892.90 Median:21512.73 stddev:124077.93 (576.8%) stddev-sans-first:124388.68 09:07:25 INFO - PROCESS | 1641 | Values: 366.1 386.2 388.4 397.5 420.8 15456.0 15743.8 18562.2 20932.2 21568.2 16951.2 19871.8 20630.8 22034.8 22447.9 5365.9 5462.4 5523.1 5643.6 5647.1 5454.8 5549.7 5552.9 5554.9 5557.8 4008.1 4240.3 5937.3 6194.9 6222.8 6035.5 6137.1 6247.6 6262.0 6274.6 6087.5 6087.7 6105.2 6108.3 6134.1 13706.5 15354.3 20609.2 26150.5 26472.9 2549.1 2629.0 2671.2 2709.2 2722.8 9608.9 10539.9 10585.8 15693.2 16339.3 1803.1 1869.2 1878.2 1885.1 1893.6 130528.0 136597.0 137471.3 138563.0 139417.0 9990.7 11212.5 11569.7 11780.9 11930.0 15386.2 15743.0 15749.9 15757.8 15776.8 8309.1 8549.1 8556.7 8702.3 8717.9 8146.4 8267.4 8270.2 8275.9 8417.5 3561.4 4684.7 4729.2 4850.8 4977.9 1973.0 2020.1 2032.1 2035.6 2037.9 994.0 1001.9 1002.6 1014.4 1040.6 20980.9 21502.8 21522.7 21548.4 21608.5 1028.6 1039.1 1053.5 1054.0 1062.8 8863.0 10755.8 11120.9 11159.2 11188.0 721015.0 730945.0 738584.0 753369.0 768279.0 155168.0 160906.0 162501.0 163402.2 166227.0 1023.8 1041.0 1081.3 1084.3 1087.4 19473.6 19736.7 19890.9 19921.0 19984.6 49604.8 58979.7 59818.1 60028.4 60060.7 87604.6 88495.6 88651.6 88727.1 89268.0 7234.9 7619.8 8113.9 8132.3 8451.8 12440.4 13222.9 13418.6 13715.4 13741.7 11369.0 11418.9 11684.2 11767.2 12013.6 9872.9 10677.8 11465.4 11469.9 11659.3 11497.3 11600.1 11905.8 11986.4 12114.1 7523.4 7550.8 7644.5 7705.2 7839.6 9609.3 11323.4 11361.4 11479.2 11777.3 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5320.73 Median:5196.36 stddev:2903.02 (55.9%) stddev-sans-first:2896.70 09:07:25 INFO - PROCESS | 1641 | Values: 1464.4 1469.4 1477.4 1489.1 1495.7 8001.0 8378.6 8383.1 8389.2 8392.2 7429.6 7655.7 7669.2 7969.0 8181.1 2269.0 2317.3 2319.6 2324.0 2329.2 2298.5 2330.1 2332.0 2332.7 2342.4 2020.8 2257.9 2282.3 2299.6 2320.6 2271.1 2298.1 2299.1 2300.9 2303.4 2213.3 2315.1 2324.1 2326.9 2332.6 8229.0 8302.9 8308.5 8320.9 8323.4 5064.2 5158.6 5163.7 5167.3 5167.8 3186.2 3289.1 3489.9 3494.1 3497.6 1210.0 1210.4 1252.9 1264.4 1275.3 10610.7 10680.2 10683.8 10691.7 10701.1 3833.7 4342.7 4634.2 4646.9 4665.2 9186.0 9417.9 9423.6 9436.2 9479.8 5090.9 5192.5 5193.5 5195.1 5198.7 3776.4 4222.6 4656.1 4732.1 4761.3 3183.9 3775.6 3874.4 3886.9 3925.1 1256.6 1266.6 1275.7 1283.4 1289.1 777.7 780.8 787.2 799.8 801.4 4551.3 5053.8 5197.6 5399.6 5623.0 562.4 574.9 577.5 583.2 584.9 3651.6 3683.8 3769.3 3776.2 3800.7 9447.1 9731.9 9733.2 9734.8 9737.5 9649.5 9708.1 9731.5 9734.6 9748.1 6569.1 7212.9 7495.2 7604.1 7692.3 5527.6 5666.6 5690.8 5698.7 5869.1 7799.7 8861.1 8908.1 8923.1 9154.5 9019.1 9073.4 9244.2 9330.2 9331.9 6534.1 6773.6 6778.4 7021.2 7253.6 6761.4 7550.5 7790.7 7795.8 7919.4 6993.1 7070.6 7115.1 7132.8 7229.2 7000.1 7014.2 7038.3 7054.0 7159.1 6252.5 6348.5 6429.9 6442.4 6447.4 4893.7 4917.5 4950.2 5046.3 5119.6 4227.1 4640.7 4841.1 5021.2 5151.4 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4358.88 Median:4818.05 stddev:1299.10 (27.0%) stddev-sans-first:1267.44 09:07:25 INFO - PROCESS | 1641 | Values: 351.3 357.2 357.5 362.6 364.9 4367.7 4537.8 4985.7 5105.8 5188.8 5082.0 5120.2 5131.3 5149.9 5164.0 3402.8 3532.2 3848.9 3987.7 3999.6 3326.9 3850.8 4031.0 4046.6 4069.5 4040.7 4048.1 4077.4 4104.6 4111.9 3813.4 3845.8 4069.1 4071.6 4099.6 2974.5 3576.8 3577.4 3583.7 3619.2 4073.5 4890.7 4975.2 4977.9 5046.4 4019.5 4056.3 4241.2 4627.8 4640.6 5070.5 5125.3 5316.5 5381.5 5434.8 3212.9 3915.3 3921.5 3935.0 3939.7 5395.4 5521.4 5596.1 5671.3 5675.3 3910.7 4012.2 4016.5 4023.9 4038.0 3604.8 3664.0 4041.6 4100.8 4114.5 4147.3 4511.4 4636.8 4639.7 4651.5 5437.7 5458.8 5470.0 5486.9 5535.9 1178.8 1200.7 1312.3 1324.6 1327.5 872.3 932.7 936.8 945.1 951.9 4372.5 4460.8 4775.0 4776.8 4790.4 4561.6 5229.0 5276.9 5279.0 5310.4 4103.9 4596.6 4698.1 4714.0 4790.6 2354.3 2419.5 2661.9 2770.4 2838.1 4966.5 5033.0 5416.9 5464.6 5495.3 4982.8 5103.3 5223.9 5247.2 5443.7 5105.2 5563.6 5609.6 5801.2 5823.9 4836.4 5310.7 5504.3 5576.2 5595.6 4707.1 4879.9 5264.4 5495.5 5500.9 4308.7 4845.1 5160.8 5645.6 5850.8 3227.0 3758.7 3815.9 3825.7 3828.0 5584.3 5588.4 5591.9 5602.4 5621.3 5082.2 5187.4 5363.7 5416.6 5458.5 4442.5 4750.6 4799.7 4991.0 5418.6 4444.8 5212.9 5278.7 5309.0 5342.8 5011.5 5152.2 5153.5 5371.7 5400.6 4288.4 5286.5 5310.8 5323.4 5330.8 09:07:25 INFO - PROCESS | 1641 | 09:07:25 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20748.45 Median:3674.31 stddev:29626.75 (806.3%) stddev-sans-first:29671.65 09:07:25 INFO - PROCESS | 1641 | Values: 708.6 719.3 775.6 815.4 831.1 16860.7 17434.7 17466.1 17747.6 17789.8 16535.8 16693.2 16834.8 16860.1 16902.6 713.7 875.8 877.4 887.4 890.3 689.8 713.4 888.4 895.0 895.8 843.9 925.1 933.4 936.5 937.7 927.1 927.3 928.0 928.7 929.6 535.3 554.1 697.7 697.8 699.6 15087.9 15621.3 15643.9 15925.8 15932.8 13949.2 13989.2 13997.3 14112.2 14154.5 11778.2 11859.7 11983.3 12016.1 12110.3 3647.3 3657.7 3739.6 3817.5 3868.9 103934.0 107351.0 109705.5 110178.9 111033.9 10737.7 10911.3 10954.7 10971.4 11072.6 21486.8 22319.0 22347.3 22403.9 22441.2 7580.8 7638.4 7670.9 7710.7 7756.5 4248.8 4295.9 4383.2 4438.0 4531.2 3585.9 3618.6 3690.9 3693.1 3695.9 655.2 665.1 668.8 669.2 676.9 573.7 675.7 678.4 701.7 702.2 8260.9 9613.9 9614.8 10112.3 10181.2 568.1 612.6 613.6 657.4 723.7 4761.5 5014.6 5016.7 5032.6 5043.3 102158.0 106946.5 107102.0 108352.0 112418.3 70075.9 70219.0 80522.6 93248.5 93748.0 71355.6 78109.6 78232.6 78886.0 80387.6 10441.2 10976.0 11018.7 11104.1 11178.7 49774.8 52360.0 53514.2 53605.4 53898.0 67368.7 67806.6 69556.0 70418.3 70719.0 10357.6 12781.6 12826.7 13014.0 13640.6 14390.6 14391.7 14486.8 14791.4 15089.3 11387.7 13713.0 13769.8 13795.8 13832.9 13488.1 13491.1 13702.7 13755.9 14255.6 13250.8 13406.3 13417.5 13417.8 13433.1 10541.6 11091.0 11216.6 11272.5 11830.4 10607.7 10764.7 10778.8 10872.9 10875.3 09:07:25 INFO - PROCESS | 1641 | -------- Summary: end -------- 09:07:25 INFO - PROCESS | 1641 | 09:07:26 INFO - TEST-INFO | 1641: exit 0 09:07:26 INFO - TEST-OK | dromaeo_css | took 1118565ms 09:07:26 INFO - TEST-START | kraken 09:07:26 INFO - operating with platform_type : mac_ 09:07:26 INFO - Initialising browser for kraken test... 09:07:26 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpKk9VVI/profile http://localhost:49243/getInfo.html) 09:07:28 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:07:28 INFO - PROCESS | 1651 | colorDepth:24 09:07:28 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:07:28 INFO - PROCESS | 1651 | __metrics 09:07:28 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:07:28 INFO - PROCESS | 1651 | 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" 09:07:28 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:29 INFO - TEST-INFO | 1651: exit 0 09:07:29 INFO - Browser initialized. 09:07:29 INFO - Running cycle 1/1 for kraken test... 09:07:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpKk9VVI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:41 INFO - PROCESS | 1652 | RSS: Main: 227844096 09:07:41 INFO - PROCESS | 1652 | 09:07:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:45 INFO - PROCESS | 1652 | RSS: Main: 289181696 09:07:45 INFO - PROCESS | 1652 | 09:07:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:07:48 INFO - PROCESS | 1652 | RSS: Main: 293441536 09:07:48 INFO - PROCESS | 1652 | 09:07:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:07:52 INFO - PROCESS | 1652 | RSS: Main: 380628992 09:07:52 INFO - PROCESS | 1652 | 09:07:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:07:55 INFO - PROCESS | 1652 | RSS: Main: 282071040 09:07:55 INFO - PROCESS | 1652 | 09:07:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:57 INFO - PROCESS | 1652 | RSS: Main: 286502912 09:07:57 INFO - PROCESS | 1652 | 09:08:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:01 INFO - PROCESS | 1652 | RSS: Main: 330035200 09:08:01 INFO - PROCESS | 1652 | 09:08:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:04 INFO - PROCESS | 1652 | RSS: Main: 329875456 09:08:04 INFO - PROCESS | 1652 | 09:08:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:08:08 INFO - PROCESS | 1652 | RSS: Main: 327909376 09:08:08 INFO - PROCESS | 1652 | 09:08:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:10 INFO - PROCESS | 1652 | RSS: Main: 303083520 09:08:10 INFO - PROCESS | 1652 | 09:08:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:13 INFO - PROCESS | 1652 | RSS: Main: 309350400 09:08:13 INFO - PROCESS | 1652 | 09:08:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:15 INFO - PROCESS | 1652 | RSS: Main: 311873536 09:08:15 INFO - PROCESS | 1652 | 09:08:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:19 INFO - PROCESS | 1652 | RSS: Main: 329977856 09:08:19 INFO - PROCESS | 1652 | 09:08:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:23 INFO - PROCESS | 1652 | RSS: Main: 323911680 09:08:23 INFO - PROCESS | 1652 | 09:08:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 09:08:25 INFO - PROCESS | 1652 | RSS: Main: 368029696 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | __start_tp_report 09:08:25 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:08:25 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:08:25 INFO - PROCESS | 1652 | |i|pagename|runs| 09:08:25 INFO - PROCESS | 1652 | |0;ai-astar;112;113;112;114;113;112;114;113;113;113 09:08:25 INFO - PROCESS | 1652 | |1;audio-beat-detection;145;138;109;146;112;112;131;138;140;110 09:08:25 INFO - PROCESS | 1652 | |2;audio-dft;183;182;184;183;185;185;216;257;184;184 09:08:25 INFO - PROCESS | 1652 | |3;audio-fft;77;58;59;88;58;58;58;58;75;59 09:08:25 INFO - PROCESS | 1652 | |4;audio-oscillator;85;71;85;68;68;69;82;67;67;83 09:08:25 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;118;131;89;85;89;85;89;87;88;85 09:08:25 INFO - PROCESS | 1652 | |6;imaging-darkroom;139;148;93;94;93;95;94;93;94;94 09:08:25 INFO - PROCESS | 1652 | |7;imaging-desaturate;124;129;86;85;86;92;85;86;85;86 09:08:25 INFO - PROCESS | 1652 | |8;json-parse-financial;56;53;54;75;81;78;79;52;54;54 09:08:25 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;67;70;78;75;76;70;70;72;71;72 09:08:25 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;88;89;87;88;87;87;88;90;88;87 09:08:25 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;141;138;140;139;159;144;156;146;196;155 09:08:25 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;177;174;174;172;172;173;173;174;171;172 09:08:25 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;67;67;67;66;66;67;68;66;66 09:08:25 INFO - PROCESS | 1652 | __end_tp_report 09:08:25 INFO - PROCESS | 1652 | __start_cc_report 09:08:25 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1962 09:08:25 INFO - PROCESS | 1652 | __end_cc_report 09:08:25 INFO - PROCESS | 1652 | __startTimestamp1485277705131__endTimestamp 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:08:25 INFO - PROCESS | 1652 | Number of tests: 14 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 09:08:25 INFO - PROCESS | 1652 | Values: 112.0 113.0 112.0 114.0 113.0 112.0 114.0 113.0 113.0 113.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:138.00 stddev:15.50 (11.2%) stddev-sans-first:15.19 09:08:25 INFO - PROCESS | 1652 | Values: 145.0 138.0 109.0 146.0 112.0 112.0 131.0 138.0 140.0 110.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:194.30 Median:184.50 stddev:24.27 (13.2%) stddev-sans-first:25.39 09:08:25 INFO - PROCESS | 1652 | Values: 183.0 182.0 184.0 183.0 185.0 185.0 216.0 257.0 184.0 184.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.00 stddev:11.00 (18.6%) stddev-sans-first:10.75 09:08:25 INFO - PROCESS | 1652 | Values: 77.0 58.0 59.0 88.0 58.0 58.0 58.0 58.0 75.0 59.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:76.50 stddev:8.09 (10.6%) stddev-sans-first:7.63 09:08:25 INFO - PROCESS | 1652 | Values: 85.0 71.0 85.0 68.0 68.0 69.0 82.0 67.0 67.0 83.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:87.50 stddev:16.14 (18.4%) stddev-sans-first:14.73 09:08:25 INFO - PROCESS | 1652 | Values: 118.0 131.0 89.0 85.0 89.0 85.0 89.0 87.0 88.0 85.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:94.00 stddev:21.09 (22.4%) stddev-sans-first:18.10 09:08:25 INFO - PROCESS | 1652 | Values: 139.0 148.0 93.0 94.0 93.0 95.0 94.0 93.0 94.0 94.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:86.00 stddev:17.08 (19.9%) stddev-sans-first:14.37 09:08:25 INFO - PROCESS | 1652 | Values: 124.0 129.0 86.0 85.0 86.0 92.0 85.0 86.0 85.0 86.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:65.50 stddev:12.73 (19.4%) stddev-sans-first:13.20 09:08:25 INFO - PROCESS | 1652 | Values: 56.0 53.0 54.0 75.0 81.0 78.0 79.0 52.0 54.0 54.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:3.31 (4.6%) stddev-sans-first:2.96 09:08:25 INFO - PROCESS | 1652 | Values: 67.0 70.0 78.0 75.0 76.0 70.0 70.0 72.0 71.0 72.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.00 stddev:0.99 (1.1%) stddev-sans-first:1.05 09:08:25 INFO - PROCESS | 1652 | Values: 88.0 89.0 87.0 88.0 87.0 87.0 88.0 90.0 88.0 87.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:150.50 stddev:17.44 (11.6%) stddev-sans-first:18.08 09:08:25 INFO - PROCESS | 1652 | Values: 141.0 138.0 140.0 139.0 159.0 144.0 156.0 146.0 196.0 155.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:1.69 (1.0%) stddev-sans-first:1.09 09:08:25 INFO - PROCESS | 1652 | Values: 177.0 174.0 174.0 172.0 172.0 173.0 173.0 174.0 171.0 172.0 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:08:25 INFO - PROCESS | 1652 | Values: 67.0 67.0 67.0 67.0 66.0 66.0 67.0 68.0 66.0 66.0 09:08:25 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:08:25 INFO - PROCESS | 1652 | 09:08:25 INFO - TEST-INFO | 1652: exit 0 09:08:26 INFO - TEST-OK | kraken | took 59463ms 09:08:26 INFO - SUITE-END | took 1178s 09:08:26 INFO - Completed test suite (00:19:38) 09:08:26 INFO - javascript benchmark 09:08:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2852.757515611173, 3326.218338690409, 3331.56689630348, 3350.798952062875, 3384.4077286474862, 5028.145215313396, 5601.131824567194, 5610.943890561093, 5645.35078465976, 5646.661200327983, 4716.811327546902, 5640.858978525529, 5698.0883058710615, 5721.799737009205, 5821.243238379005, 5163.096458119814, 5236.528712415882, 5238.816641417551, 5253.711045892474, 5257.5531079858065, 5170.0, 5235.397929238148, 5297.099493086165, 5297.576193904498, 5311.1502159654465, 5275.235090911796, 5293.947060529403, 5308.442613525582, 5311.468853114677, 5361.276227709248, 5138.229265610151, 5146.6911985281, 5153.510416510426, 5166.560842328407, 5227.47725227478, 5166.483351664841, 5185.974070129663, 5197.636165468419, 5200.985807767487, 5258.658187217857, 4693.413323334583, 5682.829515114553, 5693.231413759131, 5706.28671416073, 5723.084306510938, 6118.253719382578, 6142.938570614281, 6150.169727086831, 6236.220472440945, 6241.407066328737, 5197.0, 6230.221222347207, 6268.529860260499, 6343.048542718583, 6346.460550853183, 5807.970960145214, 5823.5923485355615, 5823.737931793079, 5823.737931793079, 5856.795012174596, 6221.440070393686, 6251.499880009588, 6275.403836635513, 6303.086052522359, 6317.178766760292, 6028.457438830526, 6077.574569780073, 6114.144019837227, 6126.23422072241, 6129.022607377628, 6277.560570760094, 6283.37166283368, 6286.842828929313, 6300.684965751694, 6302.306746257908, 6105.114758360013, 6106.005662907935, 6118.082287656798, 6220.315765265817, 6239.78160764371, 6147.877042459126, 6200.0, 6206.255249370104, 6279.058141278845, 6286.968565157145, 4976.154053810861, 4981.2030075187795, 4986.052649996489, 4997.150484417658, 5008.6744361616375, 4446.444194475691, 4475.165182275252, 4475.932861007088, 4477.574630410106, 4497.910041799146, 5662.915056274159, 5717.0, 5719.428057194331, 5721.5136713379, 5776.306843178845, 6263.749450022039, 6315.147455093504, 6339.5562310637815, 6351.110844481776, 6355.904661430082, 5759.917002927885, 5789.363170051291, 5818.981678206297, 5826.41735826414, 5850.268716410449, 5350.010248104036, 5379.865503362447, 5379.946200537945, 5438.864028399243, 5448.863778405493, 6230.719617617218, 6262.279837818709, 6273.65494897785, 6308.243010838729, 6313.873722525432, 6343.682815859281, 6353.332900045613, 6357.745690172342, 6360.681965901779, 6369.044643303541, 6249.718762655601, 6256.968715156395, 6265.780697675559, 6303.275123360872, 6306.337834527309, 6076.088586712029, 6119.502553941512, 6121.727351053096, 6149.108379284889, 6244.063390491463, 6293.118963345227, 6301.086342480223, 6302.968485157545, 6306.779262725782, 6313.90529142054, 5907.4387933148, 6079.240094988127, 6117.235345581802, 6140.815775526741, 6143.0, 5934.643921364732, 5958.046712525975, 5961.940380596138, 5990.191324171181, 6018.578699490994, 5890.705464726832, 5933.258342707161, 5949.553783466171, 5965.791197308074, 5973.104034394875, 5953.404659534185, 5953.58324917269, 5957.880842383215, 6120.724567394389, 6138.693065346804, 5848.53211743051, 5860.208871802252, 5870.26621672291, 5897.351291358033, 5900.291964964232], "value": 5685.3302634197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.22911623031456, 487.6488927971859, 504.4476298453194, 507.7711937112188, 513.7636687123922, 26180.345491362703, 32115.19712007198, 40873.18253634925, 41945.37081943773, 42051.789741051325, 41623.58376416235, 42051.36922946158, 42124.578754212445, 42201.15597688044, 42219.0, 7906.288434040949, 9339.486328251944, 9348.859767103499, 9360.344775865693, 9361.719148425558, 8262.462939908886, 8458.238758511732, 11002.119830413547, 11344.262622929524, 11350.43247837609, 11241.943790281037, 11323.660290191267, 11324.830127548094, 11330.830037549444, 11403.657890263265, 11227.60703375382, 11298.774024519464, 11300.943495282554, 11308.886911130865, 11317.0, 8274.627641756135, 8471.70349037787, 8477.66089356425, 8568.0, 10853.674389768319, 38983.8050809747, 40256.0, 40300.79849600763, 40379.394309085386, 40454.0, 4025.326552996305, 4072.3687828386646, 4079.51045874494, 4126.174765047002, 4196.118815048843, 29699.851500742574, 30187.245318866986, 30935.690643093505, 30940.535891961637, 30941.22646933822, 3147.4806656901583, 3262.934741305184, 3274.492453669685, 3334.933301333984, 3335.799852008863, 484583.0, 485453.99999999645, 485649.0, 488211.0, 489203.0, 58023.129653055235, 58366.0, 58438.41561584415, 58565.0, 58605.41394586085, 62405.37594624086, 62598.0610290846, 62668.68665656734, 62679.059814102824, 62702.0, 15487.225638718019, 15909.920450397674, 15936.0, 15954.28205730745, 15955.920220398824, 11092.944535277273, 11442.0, 12286.815697764541, 12321.568745094059, 12360.938195308965, 13046.934765326112, 15274.465393711167, 15717.764233536505, 15909.0, 15933.521994340188, 5023.34696489454, 5867.325257595346, 6266.373362663697, 6276.780312689125, 6344.397282258178, 791.8970533830565, 882.7395918204145, 883.787432682192, 885.2740752582949, 912.7170577121113, 29959.951401700837, 29971.250718732204, 30226.54660180099, 30621.0, 30630.54054189189, 1056.5087234436023, 1062.2670357453333, 1081.405227125078, 1093.578972095749, 1182.9231099978474, 15413.5375938722, 15419.768703469457, 15491.690166196613, 15783.526494205193, 15894.443694470869, 599007.0, 599324.0, 600250.0, 600915.0, 601025.0, 59356.70321648364, 59411.70294148502, 59599.404005960256, 59600.70199649061, 59633.701831490565, 1403.5228022472409, 1429.8856091512655, 1438.5324769449971, 1443.3288520837862, 1445.2195814260601, 28504.857475712488, 29265.41469170647, 29555.852220738758, 29974.400511990076, 30042.849785750932, 49061.264081039524, 49424.75287623539, 49630.0, 49637.75905602389, 49974.25038624496, 485576.0, 488654.0, 489346.0, 489465.0, 490673.0, 23718.881405592863, 24414.63378049295, 38592.8422147336, 38919.0, 38920.0, 41752.32428412049, 42558.787206063775, 42782.144357113306, 42862.0, 43186.0, 34531.4820277691, 34667.0, 35608.0, 35806.82096589501, 36567.45148822823, 34047.808326708444, 35027.299454010266, 35150.824245878604, 35480.112997175274, 35823.46264806082, 34138.48792268068, 34467.310653786284, 34678.65321346754, 34705.30589388248, 34832.30335393328, 26157.73842261553, 29081.0, 29627.0, 31076.0, 31274.843625781727, 20947.581048379252, 22922.083116675145, 23028.884855575616, 23096.96063677105, 23886.761132388452], "value": 19477.315688938048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.1030475335429, 386.246818703528, 388.39604415134465, 397.4812869205686, 420.84849454196484, 15455.995360301573, 15743.842561574394, 18562.164702588398, 20932.16271349148, 21568.245111421104, 16951.237194326255, 19871.801281987176, 20630.793692063075, 22034.779652203473, 22447.887760561174, 5365.919511207335, 5462.426445223254, 5523.061079616455, 5643.6049476536655, 5647.068233741427, 5454.809081682142, 5549.667019978794, 5552.944470555303, 5554.91667624986, 5557.833265002037, 4008.098177909976, 4240.279152544075, 5937.317208521011, 6194.938050619504, 6222.844428889269, 6035.547333949928, 6137.11011903276, 6247.625142491443, 6261.968690156566, 6274.5607807453725, 6087.452129308339, 6087.726052327612, 6105.236845394325, 6108.267007959029, 6134.079888016833, 13706.52027179044, 15354.30905609239, 20609.248213901836, 26150.476990460276, 26472.867635661893, 2549.107812265711, 2628.9868550657125, 2671.238696971354, 2709.187243826864, 2722.809403341767, 9608.855867161998, 10539.882713937963, 10585.78828423435, 15693.215339232993, 16339.26473308704, 1803.1174559651827, 1869.1962456143854, 1878.182990399167, 1885.1422602715868, 1893.595134179598, 130528.0, 136597.0, 137471.31264343613, 138563.0, 139417.0, 9990.700278991642, 11212.49543770516, 11569.710757230969, 11780.882191177978, 11930.0, 15386.153761542999, 15743.0, 15749.921250393674, 15757.763633545506, 15776.842231577766, 8309.086000539935, 8549.059603443617, 8556.700515481929, 8702.30075759083, 8717.869231961526, 8146.389020823462, 8267.421280510427, 8270.172982701803, 8275.875861862078, 8417.494950303002, 3561.4479755637917, 4684.672072954861, 4729.196036673774, 4850.75746212688, 4977.925331120036, 1973.0, 2020.090959068425, 2032.1464984706458, 2035.592881423721, 2037.8777273363646, 993.965211217604, 1001.9048190421898, 1002.6089824968268, 1014.4015031131668, 1040.5629635553087, 20980.895095524425, 21502.78497215008, 21522.677159842617, 21548.35354939354, 21608.459788505097, 1028.5885645741614, 1039.142707266493, 1053.4627340056627, 1053.984190237147, 1062.7874425115008, 8863.0, 10755.78488430227, 11120.943510366502, 11159.218854680257, 11188.0, 721015.0, 730945.0, 738584.0, 753369.0, 768279.0, 155168.0, 160906.0, 162501.0, 163402.1829890843, 166227.0, 1023.7952409517977, 1041.047441590951, 1081.2863510083464, 1084.2681190196586, 1087.380193289833, 19473.61843585182, 19736.70394944048, 19890.90054549718, 19921.00394980216, 19984.60030799405, 49604.75197623989, 58979.70510147422, 59818.10272845824, 60028.399716002285, 60060.69969650124, 87604.5619771897, 88495.55752221198, 88651.55674221588, 88727.11272887189, 89268.0, 7234.89147662796, 7619.809504762426, 8113.878291825746, 8132.349412046904, 8451.83096338082, 12440.440180191732, 13222.867771322164, 13418.597442076752, 13715.382807773874, 13741.656458588615, 11369.0, 11418.885811141783, 11684.240524365889, 11767.23512971654, 12013.63959081229, 9872.85190722154, 10677.786444271227, 11465.36940468249, 11469.885301147215, 11659.300441973508, 11497.252678575866, 11600.129990250596, 11905.761884762429, 11986.400679965793, 12114.091443141975, 7523.360514356341, 7550.811229719301, 7644.464887457824, 7705.22947705225, 7839.608019599112, 9609.327347085917, 11323.433828308387, 11361.375124367909, 11479.196456248317, 11777.293362398283], "value": 9929.688978209979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.414234306278, 1469.3902030657277, 1477.4459577658379, 1489.1437423481493, 1495.6559991202023, 8001.0, 8378.62296196671, 8383.119772423885, 8389.24496795289, 8392.202740739634, 7429.591372474511, 7655.6937722491175, 7669.194734552875, 7969.0, 8181.0591781945095, 2268.9546209075806, 2317.281642690763, 2319.5940710375703, 2324.0239099578134, 2329.1847853251397, 2298.5058212484314, 2330.1262026739973, 2332.0438620165737, 2332.6734257204007, 2342.4495243617735, 2020.848436367271, 2257.9096836126537, 2282.326713619478, 2299.574578702937, 2320.5590937721863, 2271.136967952176, 2298.103739541572, 2299.149314753552, 2300.9424764380856, 2303.447172678545, 2213.347062616516, 2315.120254303354, 2324.1168356024773, 2326.89528971195, 2332.5801355756125, 8229.0, 8302.875456868152, 8308.54303013334, 8320.916790832074, 8323.375746818952, 5064.215046667772, 5158.638895277332, 5163.690178589259, 5167.250748641426, 5167.819126330561, 3186.23530352716, 3289.1448223461834, 3489.8778542751134, 3494.1439347359806, 3497.562804649419, 1209.9818502722467, 1210.4008515784742, 1252.918560293587, 1264.4373253902017, 1275.2858399296424, 10610.681679549625, 10680.198985076151, 10683.78632427355, 10691.679249622524, 10701.090407315387, 3833.674137698271, 4342.6742994275555, 4634.21218392874, 4646.907061858744, 4665.183592871234, 9186.0, 9417.858732119024, 9423.575939082757, 9436.245100391952, 9479.810403791886, 5090.872728181751, 5192.532672059533, 5193.454687257859, 5195.116830138885, 5198.688078715213, 3776.4146557283666, 4222.577742225814, 4656.092062047868, 4732.0772449372735, 4761.285807128958, 3183.904482865518, 3775.6035616260447, 3874.438206460104, 3886.9222615547533, 3925.0776067624083, 1256.6104507602672, 1266.6263452281414, 1275.6874565731455, 1283.4224598930518, 1289.1233960906486, 777.6889244302212, 780.8321210939675, 787.2206515549565, 799.840031993592, 801.3789313282252, 4551.271796512542, 5053.8123540967845, 5197.610179236573, 5399.568034557226, 5623.015972204929, 562.3504851896066, 574.8505388598994, 577.4600748300269, 583.2243116654839, 584.8771757930797, 3651.6165802590876, 3683.797391143513, 3769.3026790043928, 3776.15036616759, 3800.7149463789774, 9447.149756521945, 9731.854022189673, 9733.2213422926, 9734.75663108428, 9737.513124343754, 9649.469279189712, 9708.077732615391, 9731.513424328898, 9734.610615575439, 9748.122668959686, 6569.146011018537, 7212.927870721331, 7495.213002634645, 7604.087509498895, 7692.269234422721, 5527.5577953762795, 5666.603337766317, 5690.800821971211, 5698.715064246689, 5869.090291004901, 7799.727009554638, 8861.069587693199, 8908.064653211319, 8923.107689231025, 9154.496502692416, 9019.143181397756, 9073.364864459425, 9244.214241789523, 9330.206932410822, 9331.906680933103, 6534.117894084237, 6773.627450490073, 6778.423833974168, 7021.192562855337, 7253.637318134178, 6761.391474767294, 7550.471466997257, 7790.727324543614, 7795.805104872424, 7919.406044546567, 6993.090898183407, 7070.646467676698, 7115.075040244735, 7132.750353737594, 7229.168645605822, 7000.124984376953, 7014.158301003912, 7038.331358520933, 7054.047703559953, 7159.140903091662, 6252.499800015897, 6348.492120630431, 6429.935700642934, 6442.355764423708, 6447.387498187664, 4893.730844803427, 4917.532834380728, 4950.183219768698, 5046.29351890743, 5119.6416250862085, 4227.091175397304, 4640.69835460694, 4841.104395686809, 5021.171506701499, 5151.381834179922], "value": 4288.456522274341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.3412351840299, 357.17314417124345, 357.4834364343523, 362.6138162856556, 364.9470826730124, 4367.694261401703, 4537.773111344428, 4985.700857948516, 5105.770240339184, 5188.820695307971, 5082.0, 5120.231965205221, 5131.281620573113, 5149.922751158726, 5164.011855435656, 3402.8468718907584, 3532.1875968527256, 3848.9230215395605, 3987.7407968482103, 3999.640032397084, 3326.850291736878, 3850.8074596270076, 4030.9596904031023, 4046.5751096134777, 4069.450624165744, 4040.656544193747, 4048.1498885234137, 4077.408775727518, 4104.610062044101, 4111.8972025699295, 3813.427985802124, 3845.750026248285, 4069.1078648428474, 4071.5724848890886, 4099.569545197771, 2974.509205981032, 3576.7675101118343, 3577.3918433866306, 3583.7312201584723, 3619.2037751694584, 4073.450084238649, 4890.679516530552, 4975.179095449246, 4977.925331120036, 5046.369203849519, 4019.4774679291504, 4056.255810001698, 4241.2365774160635, 4627.8148874045, 4640.559146881041, 5070.518300761421, 5125.282460455539, 5316.521513063804, 5381.515663590296, 5434.75543600535, 3212.855421506038, 3915.295246855565, 3921.5294164700417, 3934.996575873163, 3939.6559047366773, 5395.406505284415, 5521.420250873601, 5596.132599447093, 5671.347795003586, 5675.262215911905, 3910.687145028391, 4012.237674841829, 4016.49793775778, 4023.887459084004, 4038.0, 3604.7656902301264, 3663.9589141012893, 4041.595840415935, 4100.815463304159, 4114.506259248849, 4147.274227010261, 4511.433489058274, 4636.791344389443, 4639.652026098056, 4651.488336283006, 5437.700926449004, 5458.808941687022, 5470.0, 5486.91769623456, 5535.889282214333, 1178.8054970929873, 1200.7358381156307, 1312.3307113372248, 1324.6158614001831, 1327.4557431453059, 872.3239489395643, 932.7434955387323, 936.8360536906014, 945.1115951006033, 951.9190868776232, 4372.453443319585, 4460.843870464518, 4774.976125119352, 4776.785044672998, 4790.359326911573, 4561.566651168134, 5228.9738551307, 5276.894462110737, 5278.973605132027, 5310.389305229871, 4103.876883693494, 4596.563326483979, 4698.130845793539, 4713.9764301178275, 4790.568848803624, 2354.3407845803204, 2419.4919066995776, 2661.853598052087, 2770.4043630619512, 2838.134369017428, 4966.478519755446, 5033.018561380569, 5416.891662166813, 5464.644798088111, 5495.323926202466, 4982.779219091346, 5103.2855400244, 5223.921641175385, 5247.239150323258, 5443.747937974288, 5105.2086926526445, 5563.638363506359, 5609.559841468974, 5801.216835727123, 5823.912641310469, 4836.371271734652, 5310.734463276744, 5504.284443022541, 5576.191452239322, 5595.63628364155, 4707.058588282289, 4879.853604391874, 5264.447233040629, 5495.505404513613, 5500.862478438071, 4308.719933204332, 4845.110406941366, 5160.845174644766, 5645.633033852787, 5850.782069861474, 3227.0315107784704, 3758.680512156497, 3815.893390916603, 3825.7130715197027, 3827.966449058683, 5584.301962254718, 5588.441155884379, 5591.944080559305, 5602.411746766531, 5621.325440947113, 5082.186850103965, 5187.417837559429, 5363.651362661414, 5416.647917885325, 5458.4541545845095, 4442.511323754449, 4750.5961993229585, 4799.736014519235, 4990.951900100874, 5418.647787893774, 4444.822122137572, 5212.931349073507, 5278.683279003272, 5309.0, 5342.786288548415, 5011.523905228997, 5152.201408781645, 5153.484651534816, 5371.650842695212, 5400.62195646301, 4288.399624052698, 5286.524212820865, 5310.787568497217, 5323.441038690882, 5330.840074797762], "value": 3965.5634487859606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5606923707302, 719.2843121094512, 775.6160700453277, 815.4291995603078, 831.0733532111693, 16860.66278674426, 17434.651306973854, 17466.126693665297, 17747.55631109223, 17789.82210177898, 16535.83464165361, 16693.24880380383, 16834.83165168351, 16860.072696001716, 16902.57743556412, 713.6574444266755, 875.829213303406, 877.4165180155205, 887.4098724348333, 890.261083300862, 689.824094855811, 713.4470785141505, 888.4180861535705, 895.0154829687357, 895.7581453007684, 843.8902942617451, 925.1303774451993, 933.3559843707853, 936.5176933879058, 937.6624415210518, 927.1331305229631, 927.285989787863, 928.0070324752551, 928.6888892221114, 929.5631053404957, 535.2907397698027, 554.1134185303522, 697.6651207420466, 697.7941507255372, 699.5627732667083, 15087.924560377238, 15621.297041633154, 15643.92178039114, 15925.761113583305, 15932.840671593252, 13949.232792196424, 13989.230592317419, 13997.281304973569, 14112.223827689473, 14154.50459233932, 11778.175527713063, 11859.661663092613, 11983.28100313984, 12016.063621436675, 12110.273383596925, 3647.3434781739275, 3657.689096426807, 3739.607341229186, 3817.522809648794, 3868.941965870514, 103934.0, 107351.0, 109705.45147274212, 110178.89821101847, 111033.88966110317, 10737.677869663923, 10911.290766100177, 10954.740204876542, 10971.396573188551, 11072.612458563912, 21486.785132148478, 22319.0, 22347.329580112622, 22403.887980560317, 22441.21455749041, 7580.792947178172, 7638.388928885676, 7670.884936725954, 7710.730124445618, 7756.457048006699, 4248.808803603845, 4295.926122787569, 4383.189110014658, 4437.955620443819, 4531.207038768202, 3585.94621080684, 3618.565772107364, 3690.926181476409, 3693.076730817296, 3695.8891233263043, 655.2431941108027, 665.1286814273318, 668.8495088605025, 669.2136739331266, 676.8612434450926, 573.704705567605, 675.7263308360122, 678.4402867634122, 701.6947627781931, 702.2415790945767, 8260.917390826015, 9613.90386096144, 9614.807703846023, 10112.292139550162, 10181.185505159718, 568.0910543130957, 612.6109920200615, 613.6379536073738, 657.3886285754198, 723.6562632749402, 4761.547652972962, 5014.648974571745, 5016.749162541858, 5032.597392208614, 5043.3191519145175, 102158.0, 106946.46526767472, 107102.0, 108352.0, 112418.31372529418, 70075.93367426028, 70219.0, 80522.59738701386, 93248.53375733078, 93748.0, 71355.6432217846, 78109.60945195238, 78232.60883695545, 78885.99999999885, 80387.59806200932, 10441.216908731723, 10976.0, 11018.669439916815, 11104.058693881145, 11178.664640060812, 49774.75112624559, 52360.0, 53514.197287041505, 53605.39183824491, 53898.0, 67368.6631566839, 67806.64386712336, 69556.0, 70418.29581704117, 70719.0, 10357.585696572052, 12781.61655150347, 12826.743465130832, 13014.023948203734, 13640.590782276548, 14390.568282951528, 14391.712165756417, 14486.782698259745, 14791.408343666133, 15089.320980555682, 11387.658370248906, 13713.0, 13769.793453098411, 13795.79306310386, 13832.930835345758, 13488.05583609138, 13491.05562610608, 13702.65743356424, 13755.931220344235, 14255.572332830032, 13250.80123798163, 13406.32968351559, 13417.530386436818, 13417.798733018817, 13433.126846754929, 10541.631042913461, 11091.0, 11216.607418740305, 11272.549098036316, 11830.408479575815, 10607.681769546925, 10764.730881727706, 10778.784424311627, 10872.891271087505, 10875.347479151276], "value": 7607.861314997958, "unit": "score"}], "name": "dromaeo_css", "value": 7225.309097964529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 138.0, 109.0, 146.0, 112.0, 112.0, 131.0, 138.0, 140.0, 110.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 183.0, 185.0, 185.0, 216.0, 257.0, 184.0, 184.0], "value": 194.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 59.0, 88.0, 58.0, 58.0, 58.0, 58.0, 75.0, 59.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 85.0, 68.0, 68.0, 69.0, 82.0, 67.0, 67.0, 83.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 131.0, 89.0, 85.0, 89.0, 85.0, 89.0, 87.0, 88.0, 85.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 148.0, 93.0, 94.0, 93.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 86.0, 85.0, 86.0, 92.0, 85.0, 86.0, 85.0, 86.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 75.0, 81.0, 78.0, 79.0, 52.0, 54.0, 54.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 78.0, 75.0, 76.0, 70.0, 70.0, 72.0, 71.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 87.0, 88.0, 87.0, 87.0, 88.0, 90.0, 88.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 140.0, 139.0, 159.0, 144.0, 156.0, 146.0, 196.0, 155.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 174.0, 172.0, 172.0, 173.0, 173.0, 174.0, 171.0, 172.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 68.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1482.2000000000003, "alertThreshold": 2.0}]} 09:08:26 INFO - Return code: 0 09:08:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:26 ERROR - # TBPL SUCCESS # 09:08:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:26 INFO - 2017-01-24 09:08:26.446 screenresolution[1656:9808] starting screenresolution argv=screenresolution get 09:08:26 INFO - 2017-01-24 09:08:26.449 screenresolution[1656:9808] Display 0: 1600x1200x32@60 09:08:26 INFO - 2017-01-24 09:08:26.455 screenresolution[1657:9811] starting screenresolution argv=screenresolution list 09:08:26 INFO - Available Modes on Display 0 09:08:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:26 INFO - Intel Iris: 09:08:26 INFO - Chipset Model: Intel Iris 09:08:26 INFO - Type: GPU 09:08:26 INFO - Bus: Built-In 09:08:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:26 INFO - Vendor: Intel (0x8086) 09:08:26 INFO - Device ID: 0x0a2e 09:08:26 INFO - Revision ID: 0x0009 09:08:26 INFO - Displays: 09:08:26 INFO - Display: 09:08:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:26 INFO - Display Serial Number: 1600x1200 60 09:08:26 INFO - Main Display: Yes 09:08:26 INFO - Mirror: Off 09:08:26 INFO - Online: Yes 09:08:26 INFO - Rotation: Supported 09:08:26 INFO - Return code: 0 09:08:26 INFO - Running post-action listener: _resource_record_post_action 09:08:26 INFO - [mozharness: 2017-01-24 17:08:26.691229Z] Finished run-tests step (success) 09:08:26 INFO - Running post-run listener: _resource_record_post_run 09:08:26 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37692416; Write bytes: 553547776; Read time: 243; Write time: 1652 09:08:26 INFO - TinderboxPrint: CPU usage
53.8% 09:08:26 INFO - TinderboxPrint: I/O read bytes / time
37,692,416 / 243 09:08:26 INFO - TinderboxPrint: I/O write bytes / time
553,547,776 / 1,652 09:08:26 INFO - TinderboxPrint: CPU idle
2,218.1 (46.2%) 09:08:26 INFO - TinderboxPrint: CPU system
963.3 (20.0%) 09:08:26 INFO - TinderboxPrint: CPU user
1,624.3 (33.8%) 09:08:26 INFO - TinderboxPrint: Swap in / out
303,382,528 / 0 09:08:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249866752; Write bytes: 242233344; Read time: 18017; Write time: 508 09:08:26 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34300928; Write bytes: 299726848; Read time: 219; Write time: 1106 09:08:27 INFO - Running post-run listener: _upload_blobber_files 09:08:27 INFO - Blob upload gear active. 09:08:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:27 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 09:08:27 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'] 09:08:27 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 09:08:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:28 INFO - (blobuploader) - INFO - Done attempting. 09:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:29 INFO - (blobuploader) - INFO - Done attempting. 09:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:30 INFO - (blobuploader) - INFO - Done attempting. 09:08:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:32 INFO - (blobuploader) - INFO - Done attempting. 09:08:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:32 INFO - Return code: 0 09:08:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/75f02014a522e2926818e0dea5244e3b6a2b268489eca25076f8aa0e13f83b995adf2458d40c6dffbb3c45026f244c5d35cf59951fd69a757259468131fbefa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc161e30d9fa2d19c7d27fdbfa58b89089614217895f8de2ca74d1cd8131a8473a31ada03261458621831673fd47fbb60f29e11e12d3edeaf0a58f14dac0e3a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc3cbb7deb742dcd07c73306faa80cae91420e614684cb1bbdafd09125bee75120932df664718bb61c2b6bf768c74d6307ffb6a3ae20a7cded09bfad861f1a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61b7fbace225a5090ec6d1762e37888b8caeeff88509c29bc85b925e3c6942d30f88f044dd5f4b3e3ae961098d7e44c820b3f96aac6308999b85bfaf4f4a3fd6"} 09:08:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:32 INFO - Contents: 09:08:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/75f02014a522e2926818e0dea5244e3b6a2b268489eca25076f8aa0e13f83b995adf2458d40c6dffbb3c45026f244c5d35cf59951fd69a757259468131fbefa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc161e30d9fa2d19c7d27fdbfa58b89089614217895f8de2ca74d1cd8131a8473a31ada03261458621831673fd47fbb60f29e11e12d3edeaf0a58f14dac0e3a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc3cbb7deb742dcd07c73306faa80cae91420e614684cb1bbdafd09125bee75120932df664718bb61c2b6bf768c74d6307ffb6a3ae20a7cded09bfad861f1a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61b7fbace225a5090ec6d1762e37888b8caeeff88509c29bc85b925e3c6942d30f88f044dd5f4b3e3ae961098d7e44c820b3f96aac6308999b85bfaf4f4a3fd6"} 09:08:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:32 INFO - Copying logs to upload dir... 09:08:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.305079 ========= master_lag: 2.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-24 09:08:35.009119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 09:08:35.012243) ========= 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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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/75f02014a522e2926818e0dea5244e3b6a2b268489eca25076f8aa0e13f83b995adf2458d40c6dffbb3c45026f244c5d35cf59951fd69a757259468131fbefa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc161e30d9fa2d19c7d27fdbfa58b89089614217895f8de2ca74d1cd8131a8473a31ada03261458621831673fd47fbb60f29e11e12d3edeaf0a58f14dac0e3a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc3cbb7deb742dcd07c73306faa80cae91420e614684cb1bbdafd09125bee75120932df664718bb61c2b6bf768c74d6307ffb6a3ae20a7cded09bfad861f1a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61b7fbace225a5090ec6d1762e37888b8caeeff88509c29bc85b925e3c6942d30f88f044dd5f4b3e3ae961098d7e44c820b3f96aac6308999b85bfaf4f4a3fd6"} build_url:https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011526 build_url: 'https://queue.taskcluster.net/v1/task/FxE5WBt2TpecVlnSH3WZ1A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/75f02014a522e2926818e0dea5244e3b6a2b268489eca25076f8aa0e13f83b995adf2458d40c6dffbb3c45026f244c5d35cf59951fd69a757259468131fbefa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc161e30d9fa2d19c7d27fdbfa58b89089614217895f8de2ca74d1cd8131a8473a31ada03261458621831673fd47fbb60f29e11e12d3edeaf0a58f14dac0e3a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bc3cbb7deb742dcd07c73306faa80cae91420e614684cb1bbdafd09125bee75120932df664718bb61c2b6bf768c74d6307ffb6a3ae20a7cded09bfad861f1a3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/61b7fbace225a5090ec6d1762e37888b8caeeff88509c29bc85b925e3c6942d30f88f044dd5f4b3e3ae961098d7e44c820b3f96aac6308999b85bfaf4f4a3fd6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 09:08:35.047633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 09:08:35.048008) ========= 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.OYzB9j2Oo5/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.CiEifVNZj3/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.005199 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 09:08:35.096309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 09:08:35.096615) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 09:08:35.096910) ========= ========= Total master_lag: 2.30 =========