builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0377 starttime: 1484261927.35 results: success (0) buildid: 20170112124316 builduid: 9ed2943f86134e62ad4f68e08c61b769 revision: 91be97c8b0acd6d30ef826677996804941f2bbc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.351554) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.352278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.352668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.380436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.380859) ========= 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.jectfRpSRe/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.HnnDrd5tS9/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-12 14:58:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2017-01-12 14:58:47 (8.31 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174525 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.581347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.581917) ========= 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.jectfRpSRe/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.HnnDrd5tS9/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.020635 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:47.632902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 14:58:47.633403) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 91be97c8b0acd6d30ef826677996804941f2bbc0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 91be97c8b0acd6d30ef826677996804941f2bbc0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jectfRpSRe/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.HnnDrd5tS9/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-12 14:58:47,719 truncating revision to first 12 chars 2017-01-12 14:58:47,719 Setting DEBUG logging. 2017-01-12 14:58:47,719 attempt 1/10 2017-01-12 14:58:47,719 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/91be97c8b0ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 14:58:49,916 unpacking tar archive at: mozilla-beta-91be97c8b0ac/testing/mozharness/ program finished with exit code 0 elapsedTime=2.485176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 14:58:50.143142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:50.143484) ========= script_repo_revision: 91be97c8b0acd6d30ef826677996804941f2bbc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:50.143971) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:50.144249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 14:58:50.164149) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-12 14:58:50.164528) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jectfRpSRe/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.HnnDrd5tS9/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:58:50 INFO - MultiFileLogger online at 20170112 14:58:50 in /builds/slave/test 14:58:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:58:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:58:50 INFO - {'append_to_log': False, 14:58:50 INFO - 'base_work_dir': '/builds/slave/test', 14:58:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:58:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:58:50 INFO - 'branch': 'Mozilla-Beta', 14:58:50 INFO - 'buildbot_json_path': 'buildprops.json', 14:58:50 INFO - 'config_files': ('talos/mac_config.py',), 14:58:50 INFO - 'default_actions': ('clobber', 14:58:50 INFO - 'read-buildbot-config', 14:58:50 INFO - 'download-and-extract', 14:58:50 INFO - 'populate-webroot', 14:58:50 INFO - 'create-virtualenv', 14:58:50 INFO - 'install', 14:58:50 INFO - 'run-tests'), 14:58:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:58:50 INFO - 'download_minidump_stackwalk': True, 14:58:50 INFO - 'download_symbols': 'ondemand', 14:58:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:58:50 INFO - 'tooltool.py': '/tools/tooltool.py', 14:58:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:58:50 INFO - '/tools/misc-python/virtualenv.py')}, 14:58:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:58:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:58:50 INFO - 'installer_path': 'installer.exe', 14:58:50 INFO - 'log_level': 'info', 14:58:50 INFO - 'log_name': 'talos', 14:58:50 INFO - 'log_to_console': True, 14:58:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:58:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:58:50 INFO - 'opt_config_files': (), 14:58:50 INFO - 'pip_index': False, 14:58:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:58:50 INFO - 'cmd': ('bash', 14:58:50 INFO - '-c', 14:58:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:58:50 INFO - 'enabled': True, 14:58:50 INFO - 'halt_on_failure': False, 14:58:50 INFO - 'name': 'check_screen_resolution'},), 14:58:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:58:50 INFO - 'cmd': ('bash', 14:58:50 INFO - '-c', 14:58:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:58:50 INFO - 'enabled': True, 14:58:50 INFO - 'halt_on_failure': False, 14:58:50 INFO - 'name': 'check_screen_resolution'},), 14:58:50 INFO - 'run_cmd_checks_enabled': True, 14:58:50 INFO - 'sps_profile': False, 14:58:50 INFO - 'sps_profile_interval': 0, 14:58:50 INFO - 'suite': 'dromaeojs', 14:58:50 INFO - 'system_bits': '32', 14:58:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:58:50 INFO - 'title': 't-yosemite-r7-0377', 14:58:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:58:50 INFO - 'use_talos_json': True, 14:58:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:58:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:58:50 INFO - 'work_dir': 'build'} 14:58:50 INFO - [mozharness: 2017-01-12 22:58:50.361815Z] Running clobber step. 14:58:50 INFO - Running pre-action listener: _resource_record_pre_action 14:58:50 INFO - Running main action method: clobber 14:58:50 INFO - rmtree: /builds/slave/test/build 14:58:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:58:51 INFO - Running post-action listener: _resource_record_post_action 14:58:51 INFO - [mozharness: 2017-01-12 22:58:51.931637Z] Finished clobber step (success) 14:58:51 INFO - [mozharness: 2017-01-12 22:58:51.931813Z] Running read-buildbot-config step. 14:58:51 INFO - Running pre-action listener: _resource_record_pre_action 14:58:51 INFO - Running main action method: read_buildbot_config 14:58:51 INFO - Using buildbot properties: 14:58:51 INFO - { 14:58:51 INFO - "project": "", 14:58:51 INFO - "product": "firefox", 14:58:51 INFO - "script_repo_revision": "production", 14:58:51 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:58:51 INFO - "repository": "", 14:58:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:58:51 INFO - "buildid": "20170112124316", 14:58:51 INFO - "pgo_build": "False", 14:58:51 INFO - "basedir": "/builds/slave/test", 14:58:51 INFO - "buildnumber": 21, 14:58:51 INFO - "slavename": "t-yosemite-r7-0377", 14:58:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:58:51 INFO - "platform": "yosemite_r7", 14:58:51 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:58:51 INFO - "branch": "mozilla-beta", 14:58:51 INFO - "repo_path": "releases/mozilla-beta", 14:58:51 INFO - "revision": "91be97c8b0acd6d30ef826677996804941f2bbc0", 14:58:51 INFO - "stage_platform": "macosx64", 14:58:51 INFO - "builduid": "9ed2943f86134e62ad4f68e08c61b769", 14:58:51 INFO - "slavebuilddir": "test" 14:58:51 INFO - } 14:58:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 14:58:51 INFO - Running post-action listener: _resource_record_post_action 14:58:51 INFO - [mozharness: 2017-01-12 22:58:51.935058Z] Finished read-buildbot-config step (success) 14:58:51 INFO - [mozharness: 2017-01-12 22:58:51.935189Z] Running download-and-extract step. 14:58:51 INFO - Running pre-action listener: _resource_record_pre_action 14:58:51 INFO - Running main action method: download_and_extract 14:58:51 INFO - mkdir: /builds/slave/test/build/tests 14:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:51 INFO - trying https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 14:58:51 INFO - Downloading https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 14:58:52 INFO - Downloaded 1165 bytes. 14:58:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:58:52 INFO - Using the following test package requirements: 14:58:52 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:58:52 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 14:58:52 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 14:58:52 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:58:52 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 14:58:52 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:58:52 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 14:58:52 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 14:58:52 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 14:58:52 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:58:52 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 14:58:52 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 14:58:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:58:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:58:52 INFO - Fetch https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:58:53 INFO - Expected file size: 16236151 14:59:00 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:59:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:59:01 INFO - Expected file size: 16236151 14:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 14:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 14:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 14:59:09 INFO - Expected file size: 14414089 14:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:09 INFO - trying https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:59:09 INFO - Downloading https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 14:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 14:59:12 INFO - Downloaded 86170609 bytes. 14:59:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:59:12 INFO - mkdir: /builds/slave/test/properties 14:59:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:59:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:59:12 INFO - Contents: 14:59:12 INFO - build_url:https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:59:13 INFO - Running post-action listener: _resource_record_post_action 14:59:13 INFO - Running post-action listener: set_extra_try_arguments 14:59:13 INFO - [mozharness: 2017-01-12 22:59:13.477986Z] Finished download-and-extract step (success) 14:59:13 INFO - [mozharness: 2017-01-12 22:59:13.478116Z] Running populate-webroot step. 14:59:13 INFO - Running pre-action listener: _resource_record_pre_action 14:59:13 INFO - Running main action method: populate_webroot 14:59:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:59:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:59:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:59:13 INFO - '--tppagecycles', 14:59:13 INFO - '7'], 14:59:13 INFO - 'tests': ['tsvgm']}}, 14:59:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:59:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:59:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:59:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:59:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['damp', 'tps']}, 14:59:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'tests': ['damp', 'tps']}, 14:59:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['dromaeo_dom']}, 14:59:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:59:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['basic_compositor_video']}, 14:59:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:59:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['a11yr', 14:59:13 INFO - 'ts_paint', 14:59:13 INFO - 'tpaint', 14:59:13 INFO - 'sessionrestore', 14:59:13 INFO - 'sessionrestore_no_auto_restore', 14:59:13 INFO - 'tabpaint']}, 14:59:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tsvgx', 14:59:13 INFO - 'tsvgr_opacity', 14:59:13 INFO - 'tart', 14:59:13 INFO - 'tscrollx', 14:59:13 INFO - 'cart']}, 14:59:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:59:13 INFO - 'tsvgr_opacity', 14:59:13 INFO - 'tart', 14:59:13 INFO - 'tscrollx', 14:59:13 INFO - 'cart']}, 14:59:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s'], 14:59:13 INFO - 'tests': ['tp5o']}, 14:59:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'tests': ['tp5o']}, 14:59:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--disable-e10s', 14:59:13 INFO - '--xperf_path', 14:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:13 INFO - 'tests': ['tp5n']}, 14:59:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:59:13 INFO - 'talos_options': ['--xperf_path', 14:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:13 INFO - 'tests': ['tp5n']}}, 14:59:13 INFO - 'talos.zip': {'path': '', 14:59:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:59:13 INFO - Running post-action listener: _resource_record_post_action 14:59:13 INFO - [mozharness: 2017-01-12 22:59:13.496560Z] Finished populate-webroot step (success) 14:59:13 INFO - [mozharness: 2017-01-12 22:59:13.496688Z] Running create-virtualenv step. 14:59:13 INFO - Running pre-action listener: _resource_record_pre_action 14:59:13 INFO - Running main action method: create_virtualenv 14:59:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:59:13 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 14:59:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:59:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:59:13 INFO - Using real prefix '/tools/python27' 14:59:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:59:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:59:17 INFO - Installing pip.................done. 14:59:17 INFO - Return code: 0 14:59:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:17 INFO - 'HOME': '/Users/cltbld', 14:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:17 INFO - 'LOGNAME': 'cltbld', 14:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:17 INFO - 'MOZ_NO_REMOTE': '1', 14:59:17 INFO - 'NO_EM_RESTART': '1', 14:59:17 INFO - 'PAGER': '/bin/cat', 14:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:17 INFO - 'PWD': '/builds/slave/test', 14:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:17 INFO - 'SHELL': '/bin/bash', 14:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:17 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:17 INFO - 'USER': 'cltbld', 14:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:17 INFO - 'XPC_FLAGS': '0x0', 14:59:17 INFO - 'XPC_SERVICE_NAME': '0', 14:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:17 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 14:59:17 INFO - Cleaning up... 14:59:17 INFO - Return code: 0 14:59:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:17 INFO - 'HOME': '/Users/cltbld', 14:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:17 INFO - 'LOGNAME': 'cltbld', 14:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:17 INFO - 'MOZ_NO_REMOTE': '1', 14:59:17 INFO - 'NO_EM_RESTART': '1', 14:59:17 INFO - 'PAGER': '/bin/cat', 14:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:17 INFO - 'PWD': '/builds/slave/test', 14:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:17 INFO - 'SHELL': '/bin/bash', 14:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:17 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:17 INFO - 'USER': 'cltbld', 14:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:17 INFO - 'XPC_FLAGS': '0x0', 14:59:17 INFO - 'XPC_SERVICE_NAME': '0', 14:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:17 INFO - Downloading/unpacking psutil>=3.1.1 14:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:20 INFO - Installing collected packages: psutil 14:59:20 INFO - Running setup.py install for psutil 14:59:20 INFO - building 'psutil._psutil_osx' extension 14:59:20 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 14:59:21 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 14:59:21 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 14:59:21 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 14:59:21 INFO - building 'psutil._psutil_posix' extension 14:59:21 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 14:59:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:59:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:59:21 INFO - ^ 14:59:21 INFO - 1 warning generated. 14:59:21 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 14:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:21 INFO - Successfully installed psutil 14:59:21 INFO - Cleaning up... 14:59:21 INFO - Return code: 0 14:59:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59:21 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')]} 14:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:21 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')]} 14:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:21 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:21 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 14:59:21 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 14:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:21 INFO - 'HOME': '/Users/cltbld', 14:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:21 INFO - 'LOGNAME': 'cltbld', 14:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:21 INFO - 'MOZ_NO_REMOTE': '1', 14:59:21 INFO - 'NO_EM_RESTART': '1', 14:59:21 INFO - 'PAGER': '/bin/cat', 14:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:21 INFO - 'PWD': '/builds/slave/test', 14:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:21 INFO - 'SHELL': '/bin/bash', 14:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:21 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:21 INFO - 'USER': 'cltbld', 14:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:21 INFO - 'XPC_FLAGS': '0x0', 14:59:21 INFO - 'XPC_SERVICE_NAME': '0', 14:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:24 INFO - Installing collected packages: mozsystemmonitor 14:59:24 INFO - Running setup.py install for mozsystemmonitor 14:59:24 INFO - Successfully installed mozsystemmonitor 14:59:24 INFO - Cleaning up... 14:59:24 INFO - Return code: 0 14:59:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59: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==2.5.1'] in /builds/slave/test/build 14:59: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==2.5.1 14:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:24 INFO - 'HOME': '/Users/cltbld', 14:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:24 INFO - 'LOGNAME': 'cltbld', 14:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:24 INFO - 'MOZ_NO_REMOTE': '1', 14:59:24 INFO - 'NO_EM_RESTART': '1', 14:59:24 INFO - 'PAGER': '/bin/cat', 14:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:24 INFO - 'PWD': '/builds/slave/test', 14:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:24 INFO - 'SHELL': '/bin/bash', 14:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:24 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:24 INFO - 'USER': 'cltbld', 14:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:24 INFO - 'XPC_FLAGS': '0x0', 14:59:24 INFO - 'XPC_SERVICE_NAME': '0', 14:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:59:25 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 14:59:25 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 14:59:25 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 14:59:25 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 14:59:25 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 14:59:25 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 14:59:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:59:27 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 14:59:27 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 14:59:27 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 14:59:27 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 14:59:27 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 14:59:27 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 14:59:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:28 INFO - warning: no files found matching '*.txt' 14:59:28 INFO - no previously-included directories found matching 'build' 14:59:28 INFO - no previously-included directories found matching 'dist' 14:59:28 INFO - no previously-included directories found matching '.git*' 14:59:28 INFO - Installing collected packages: jsonschema, functools32 14:59:28 INFO - Running setup.py install for functools32 14:59:28 INFO - warning: no files found matching '*.txt' 14:59:28 INFO - no previously-included directories found matching 'build' 14:59:28 INFO - no previously-included directories found matching 'dist' 14:59:28 INFO - no previously-included directories found matching '.git*' 14:59:28 INFO - Successfully installed jsonschema functools32 14:59:28 INFO - Cleaning up... 14:59:28 INFO - Return code: 0 14:59:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:28 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 14:59:28 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 14:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:28 INFO - 'HOME': '/Users/cltbld', 14:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:28 INFO - 'LOGNAME': 'cltbld', 14:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:28 INFO - 'MOZ_NO_REMOTE': '1', 14:59:28 INFO - 'NO_EM_RESTART': '1', 14:59:28 INFO - 'PAGER': '/bin/cat', 14:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:28 INFO - 'PWD': '/builds/slave/test', 14:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:28 INFO - 'SHELL': '/bin/bash', 14:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:28 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:28 INFO - 'USER': 'cltbld', 14:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:28 INFO - 'XPC_FLAGS': '0x0', 14:59:28 INFO - 'XPC_SERVICE_NAME': '0', 14:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:59:28 INFO - Cleaning up... 14:59:28 INFO - Return code: 0 14:59:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:28 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 14:59:28 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 14:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:28 INFO - 'HOME': '/Users/cltbld', 14:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:28 INFO - 'LOGNAME': 'cltbld', 14:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:28 INFO - 'MOZ_NO_REMOTE': '1', 14:59:28 INFO - 'NO_EM_RESTART': '1', 14:59:28 INFO - 'PAGER': '/bin/cat', 14:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:28 INFO - 'PWD': '/builds/slave/test', 14:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:28 INFO - 'SHELL': '/bin/bash', 14:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:28 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:28 INFO - 'USER': 'cltbld', 14:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:28 INFO - 'XPC_FLAGS': '0x0', 14:59:28 INFO - 'XPC_SERVICE_NAME': '0', 14:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:59:29 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 14:59:29 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 14:59:29 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 14:59:29 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 14:59:29 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 14:59:29 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 14:59:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59:31 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 14:59:31 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 14:59:31 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 14:59:31 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 14:59:31 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 14:59:31 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 14:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 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 14:59:32 INFO - Downloading docopt-0.6.1.tar.gz 14:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:33 INFO - Running setup.py install for blobuploader 14:59:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:33 INFO - Running setup.py install for requests 14:59:33 INFO - Running setup.py install for docopt 14:59:33 INFO - Successfully installed blobuploader requests docopt 14:59:33 INFO - Cleaning up... 14:59:34 INFO - Return code: 0 14:59:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:34 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:34 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 14:59:34 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 14:59:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:34 INFO - 'HOME': '/Users/cltbld', 14:59:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:34 INFO - 'LOGNAME': 'cltbld', 14:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:34 INFO - 'MOZ_NO_REMOTE': '1', 14:59:34 INFO - 'NO_EM_RESTART': '1', 14:59:34 INFO - 'PAGER': '/bin/cat', 14:59:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:34 INFO - 'PWD': '/builds/slave/test', 14:59:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:34 INFO - 'SHELL': '/bin/bash', 14:59:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:34 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:34 INFO - 'USER': 'cltbld', 14:59:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:34 INFO - 'XPC_FLAGS': '0x0', 14:59:34 INFO - 'XPC_SERVICE_NAME': '0', 14:59:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-eclHy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-U6QzCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-xaJK0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-4g2RhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Amv8PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-vkSAq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:34 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-k7CMeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Y7Yl6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DwRMYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-SRFMEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-1j85pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-gEoMVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-D7n_bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-_F_hpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-I2q4Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:35 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-qSBfKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:36 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-HriUnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:36 INFO - Running setup.py install for manifestparser 14:59:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:36 INFO - Running setup.py install for mozcrash 14:59:36 INFO - Running setup.py install for mozdebug 14:59:36 INFO - Running setup.py install for mozdevice 14:59:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:36 INFO - Running setup.py install for mozfile 14:59:36 INFO - Running setup.py install for mozhttpd 14:59:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Running setup.py install for mozinfo 14:59:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Running setup.py install for mozInstall 14:59:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Running setup.py install for mozleak 14:59:37 INFO - Running setup.py install for mozlog 14:59:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Running setup.py install for moznetwork 14:59:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:37 INFO - Running setup.py install for mozprocess 14:59:37 INFO - Running setup.py install for mozprofile 14:59:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:38 INFO - Running setup.py install for mozrunner 14:59:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:38 INFO - Running setup.py install for mozscreenshot 14:59:38 INFO - Running setup.py install for moztest 14:59:38 INFO - Running setup.py install for mozversion 14:59:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:38 INFO - Cleaning up... 14:59:38 INFO - Return code: 0 14:59:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:38 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:38 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 14:59:38 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 14:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:38 INFO - 'HOME': '/Users/cltbld', 14:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:38 INFO - 'LOGNAME': 'cltbld', 14:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:38 INFO - 'MOZ_NO_REMOTE': '1', 14:59:38 INFO - 'NO_EM_RESTART': '1', 14:59:38 INFO - 'PAGER': '/bin/cat', 14:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:38 INFO - 'PWD': '/builds/slave/test', 14:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:38 INFO - 'SHELL': '/bin/bash', 14:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:38 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:38 INFO - 'USER': 'cltbld', 14:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:38 INFO - 'XPC_FLAGS': '0x0', 14:59:38 INFO - 'XPC_SERVICE_NAME': '0', 14:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:38 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-C28Czn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5Jl5PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-t3sXeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-qRjcGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-fjfQRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-CBOYGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DC6qKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-uICGZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ZQfNZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:39 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)) 14:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:39 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5vG8kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:40 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)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-TU2xUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:40 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)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-n0k0AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-B2IUCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:40 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)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ORJfGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-P91Vi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:40 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)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-iTgh1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:40 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-C2KGLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:40 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)) 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:59:40 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)) 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:59:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59:40 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 14:59:40 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 14:59:40 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 14:59:40 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 14:59:40 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 14:59:40 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 14:59:43 INFO - Downloading blessings-1.6.tar.gz 14:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:43 INFO - Installing collected packages: blessings 14:59:43 INFO - Running setup.py install for blessings 14:59:43 INFO - Successfully installed blessings 14:59:43 INFO - Cleaning up... 14:59:43 INFO - Return code: 0 14:59:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:44 INFO - Reading from file tmpfile_stdout 14:59:44 INFO - Current package versions: 14:59:44 INFO - blessings == 1.6 14:59:44 INFO - blobuploader == 1.2.4 14:59:44 INFO - docopt == 0.6.1 14:59:44 INFO - functools32 == 3.2.3-2 14:59:44 INFO - jsonschema == 2.5.1 14:59:44 INFO - manifestparser == 1.1 14:59:44 INFO - mozInstall == 1.12 14:59:44 INFO - mozcrash == 0.17 14:59:44 INFO - mozdebug == 0.1 14:59:44 INFO - mozdevice == 0.48 14:59:44 INFO - mozfile == 1.2 14:59:44 INFO - mozhttpd == 0.7 14:59:44 INFO - mozinfo == 0.9 14:59:44 INFO - mozleak == 0.1 14:59:44 INFO - mozlog == 3.4 14:59:44 INFO - moznetwork == 0.27 14:59:44 INFO - mozprocess == 0.23 14:59:44 INFO - mozprofile == 0.28 14:59:44 INFO - mozrunner == 6.12 14:59:44 INFO - mozscreenshot == 0.1 14:59:44 INFO - mozsystemmonitor == 0.3 14:59:44 INFO - moztest == 0.7 14:59:44 INFO - mozversion == 1.4 14:59:44 INFO - psutil == 3.1.1 14:59:44 INFO - requests == 1.2.3 14:59:44 INFO - wsgiref == 0.1.2 14:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:44 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')]} 14:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 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')]} 14:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:44 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 14:59:44 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 14:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:44 INFO - 'HOME': '/Users/cltbld', 14:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:44 INFO - 'LOGNAME': 'cltbld', 14:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:44 INFO - 'MOZ_NO_REMOTE': '1', 14:59:44 INFO - 'NO_EM_RESTART': '1', 14:59:44 INFO - 'PAGER': '/bin/cat', 14:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:44 INFO - 'PWD': '/builds/slave/test', 14:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:44 INFO - 'SHELL': '/bin/bash', 14:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:44 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:44 INFO - 'USER': 'cltbld', 14:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:44 INFO - 'XPC_FLAGS': '0x0', 14:59:44 INFO - 'XPC_SERVICE_NAME': '0', 14:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 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)) 14:59:44 INFO - Cleaning up... 14:59:44 INFO - Return code: 0 14:59:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:44 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')]} 14:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 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')]} 14:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:44 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 0x102913490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102889570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8cb589df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, '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.jectfRpSRe/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.HnnDrd5tS9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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 14:59:44 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 14:59:44 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 14:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 14:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:44 INFO - 'HOME': '/Users/cltbld', 14:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:44 INFO - 'LOGNAME': 'cltbld', 14:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:44 INFO - 'MOZ_NO_REMOTE': '1', 14:59:44 INFO - 'NO_EM_RESTART': '1', 14:59:44 INFO - 'PAGER': '/bin/cat', 14:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:44 INFO - 'PWD': '/builds/slave/test', 14:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:44 INFO - 'SHELL': '/bin/bash', 14:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 14:59:44 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 14:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:44 INFO - 'USER': 'cltbld', 14:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:44 INFO - 'XPC_FLAGS': '0x0', 14:59:44 INFO - 'XPC_SERVICE_NAME': '0', 14:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:59:45 INFO - Cleaning up... 14:59:45 INFO - Return code: 0 14:59:45 INFO - Running post-action listener: _resource_record_post_action 14:59:45 INFO - Running post-action listener: _start_resource_monitoring 14:59:45 INFO - Starting resource monitoring. 14:59:45 INFO - [mozharness: 2017-01-12 22:59:45.054969Z] Finished create-virtualenv step (success) 14:59:45 INFO - [mozharness: 2017-01-12 22:59:45.055888Z] Running install step. 14:59:45 INFO - Running pre-action listener: _resource_record_pre_action 14:59:45 INFO - Running main action method: install 14:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:45 INFO - Reading from file tmpfile_stdout 14:59:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:45 INFO - Reading from file tmpfile_stdout 14:59:45 INFO - Output received: 14:59:45 INFO - Usage: mozinstall [options] installer 14:59:45 INFO - Options: 14:59:45 INFO - -h, --help show this help message and exit 14:59:45 INFO - -d DEST, --destination=DEST 14:59:45 INFO - Directory to install application into. [default: 14:59:45 INFO - "/builds/slave/test"] 14:59:45 INFO - --app=APP Application being installed. [default: firefox] 14:59:45 INFO - mkdir: /builds/slave/test/build/application 14:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:00:07 INFO - Reading from file tmpfile_stdout 15:00:07 INFO - Output received: 15:00:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:00:07 INFO - Running post-action listener: _resource_record_post_action 15:00:07 INFO - [mozharness: 2017-01-12 23:00:07.424149Z] Finished install step (success) 15:00:07 INFO - [mozharness: 2017-01-12 23:00:07.424302Z] Running run-tests step. 15:00:07 INFO - Running pre-action listener: _resource_record_pre_action 15:00:07 INFO - Running main action method: run_tests 15:00:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:00:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:00:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:00:07 INFO - 2017-01-12 15:00:07.439 screenresolution[2154:14560] starting screenresolution argv=screenresolution get 15:00:07 INFO - 2017-01-12 15:00:07.441 screenresolution[2154:14560] Display 0: 1600x1200x32@60 15:00:07 INFO - 2017-01-12 15:00:07.447 screenresolution[2155:14562] starting screenresolution argv=screenresolution list 15:00:07 INFO - Available Modes on Display 0 15:00:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:00:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:00:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:00:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:00:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:00:07 INFO - Intel Iris: 15:00:07 INFO - Chipset Model: Intel Iris 15:00:07 INFO - Type: GPU 15:00:07 INFO - Bus: Built-In 15:00:07 INFO - VRAM (Dynamic, Max): 1536 MB 15:00:07 INFO - Vendor: Intel (0x8086) 15:00:07 INFO - Device ID: 0x0a2e 15:00:07 INFO - Revision ID: 0x0009 15:00:07 INFO - Displays: 15:00:07 INFO - Display: 15:00:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:00:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:00:07 INFO - Display Serial Number: 1600x1200 60 15:00:07 INFO - Main Display: Yes 15:00:07 INFO - Mirror: Off 15:00:07 INFO - Online: Yes 15:00:07 INFO - Rotation: Supported 15:00:07 INFO - Return code: 0 15:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:00:07 INFO - Python 2.7.3 15:00:07 INFO - Return code: 0 15:00:07 INFO - grabbing minidump binary from tooltool 15:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:07 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 0x102727d30>, '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 0x10258ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:00:07 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 15:00:07 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 15:00:07 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 15:00:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:00:07 INFO - Return code: 0 15:00:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:00:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:00:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:00:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:00:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 15:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --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 15:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jectfRpSRe/Render', 15:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:00:07 INFO - 'HOME': '/Users/cltbld', 15:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:00:07 INFO - 'LOGNAME': 'cltbld', 15:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:07 INFO - 'MOZ_NO_REMOTE': '1', 15:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:00:07 INFO - 'NO_EM_RESTART': '1', 15:00:07 INFO - 'PAGER': '/bin/cat', 15:00:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:07 INFO - 'PWD': '/builds/slave/test', 15:00:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:00:07 INFO - 'SHELL': '/bin/bash', 15:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnnDrd5tS9/Listeners', 15:00:07 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 15:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:00:07 INFO - 'USER': 'cltbld', 15:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:07 INFO - 'XPC_FLAGS': '0x0', 15:00:07 INFO - 'XPC_SERVICE_NAME': '0', 15:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:00:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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 15:00:08 INFO - mozversion application_buildid: 20170112124316 15:00:08 INFO - mozversion application_changeset: 91be97c8b0acd6d30ef826677996804941f2bbc0 15:00:08 INFO - mozversion application_display_name: Firefox 15:00:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:00:08 INFO - mozversion application_name: Firefox 15:00:08 INFO - mozversion application_remotingname: firefox 15:00:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:00:08 INFO - mozversion application_vendor: Mozilla 15:00:08 INFO - mozversion application_version: 51.0 15:00:08 INFO - mozversion platform_buildid: 20170112124316 15:00:08 INFO - mozversion platform_changeset: 91be97c8b0acd6d30ef826677996804941f2bbc0 15:00:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:00:08 INFO - mozversion platform_version: 51.0 15:00:08 INFO - using testdate: 1484262008 15:00:08 INFO - actual date: 1484262008 15:00:08 INFO - starting webserver on 'localhost:51750' 15:00:08 INFO - SUITE-START | Running 2 tests 15:00:08 INFO - TEST-START | dromaeo_css 15:00:08 INFO - operating with platform_type : mac_ 15:00:08 INFO - Initialising browser for dromaeo_css test... 15:00:08 INFO - TEST-INFO | started process 2165 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpwxdXPf/profile http://localhost:51750/getInfo.html) 15:00:10 INFO - PROCESS | 2165 | __metrics Screen width/height:1600/1200 15:00:10 INFO - PROCESS | 2165 | colorDepth:24 15:00:10 INFO - PROCESS | 2165 | Browser inner width/height: 1024/689 15:00:10 INFO - PROCESS | 2165 | __metrics 15:00:10 INFO - PROCESS | 2165 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:00:10 INFO - PROCESS | 2165 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:00:11 INFO - TEST-INFO | 2165: exit 0 15:00:11 INFO - Browser initialized. 15:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:00:11 INFO - TEST-INFO | started process 2168 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpwxdXPf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:22 INFO - PROCESS | 2168 | RSS: Main: 169148416 15:00:22 INFO - PROCESS | 2168 | 15:01:14 INFO - PROCESS | 2168 | 1484262074608 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:03:25 INFO - PROCESS | 2168 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51750/tests/dromaeo/cssquery-ext.html) 15:03:26 INFO - PROCESS | 2168 | RSS: Main: 304246784 15:03:26 INFO - PROCESS | 2168 | 15:06:29 INFO - PROCESS | 2168 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-ext.html (next: http://localhost:51750/tests/dromaeo/cssquery-jquery.html) 15:06:30 INFO - PROCESS | 2168 | RSS: Main: 299864064 15:06:30 INFO - PROCESS | 2168 | 15:09:32 INFO - PROCESS | 2168 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51750/tests/dromaeo/cssquery-mootools.html) 15:09:32 INFO - PROCESS | 2168 | RSS: Main: 272142336 15:09:32 INFO - PROCESS | 2168 | 15:12:35 INFO - PROCESS | 2168 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51750/tests/dromaeo/cssquery-prototype.html) 15:12:35 INFO - PROCESS | 2168 | RSS: Main: 269832192 15:12:35 INFO - PROCESS | 2168 | 15:15:39 INFO - PROCESS | 2168 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51750/tests/dromaeo/cssquery-yui.html) 15:15:39 INFO - PROCESS | 2168 | RSS: Main: 261427200 15:15:39 INFO - PROCESS | 2168 | 15:18:42 INFO - PROCESS | 2168 | Cycle 1(1): loaded http://localhost:51750/tests/dromaeo/cssquery-yui.html (next: http://localhost:51750/tests/dromaeo/cssquery-dojo.html) 15:18:43 INFO - PROCESS | 2168 | RSS: Main: 419872768 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | __start_tp_report 15:18:43 INFO - PROCESS | 2168 | _x_x_mozilla_page_load 15:18:43 INFO - PROCESS | 2168 | _x_x_mozilla_page_load_details 15:18:43 INFO - PROCESS | 2168 | |i|pagename|runs| 15:18:43 INFO - PROCESS | 2168 | |0;dojo.html;2862.613547171132;3409.232922592417;3457.654234576543;3459.6021457532393;3506.719462443005;5663.801766938158;5666.886662266752;5696.917585658722;5730.05454100074;5765.048766953448;5679.318481782192;5788.942110578893;5790.797322093727;5808.941910580893;5816.912746308809;5219.739013049351;5248.265242865992;5250.501202385767;5265.7893684252585;5311.920321195185;5179.223116532513;5186.974065129669;5325.20121981702;5336.4930331618625;5376.274202982606;5287.180487024498;5302.787888484456;5309.8938021239555;5310.787568497255;5323.627346085776;5185.196294574328;5224.910035985598;5251.396089449724;5266.341707286609;5267.130923397634;5200;5228;5261.684298942076;5274.208868669692;5281.339832520935;5658.377578466366;5695.430456954313;5814.127880817869;5825.592208545403;5931.466168044896;6161.229846269216;6161.4146656067605;6249.968750156266;6250.406211409909;6259.092431597438;6229.750809967596;6269.780557680459;6295.716692748837;6322.209723784527;6324.3359447257835;5708.257926469532;5840.948629246776;5856.736446859859;5883.058710606325;5891.263592050994;6216.627002379872;6238.1266622672865;6292.339304373067;6296.905546416808;6299.527535434769;6207.193064901534;6225.066240064027;6229.003359462465;6233.2208473940755;6240.157578726905;6169.105479705508;6318.336574659686;6341.365863413622;6342.714577844008;6349.396807303298;6155.815325540241;6171.660558669227;6190.969045154836;6216.44052035319;6299.716512756937;6240.188775459162;6301.6534090625455;6320.683965801692;6325.746970121236;6343.777967771106;4987.177115775857;5037.874053148627;5044.0920634286185;5047.141985862412;5069.340985671913;4431.711938723973;4444.511103778582;4498.775061246924;4522.615577675869;4527.886802829956;5779.075347944308;5815.5929084963645;5826.475617194388;5969.671668058211;5971.4924231439945;6282.1519094921605;6295.307516173218;6296.433321001132;6300.747970081237;6319.58922670025;5860.706964651836;5886.6173698709445;5894.086416605433;5915.852103697442;5941.732622032019;5371.973140134274;5380.838574842761;5431.782728690808;5437.972810135924;5504.0643090674685;5888.17565540816;6269.8746025079245;6343.016832390987;6346.904796428057;6357.300696923242;6249.093881387264;6290.24517057956;6310.6213627182515;6317.810465686037;6319.747210111544;5182.948170518397;6232.065190221322;6325.430711236011;6339.841503962438;6341.587796793194;6157.4458298753325;6171.938280617136;6218.844528886814;6234.594751341148;6286.9371306288185;6173.259208894961;6174.845628859314;6179.81460556184;6197.752089916353;6293.937060629518;6071.848203794941;6087;6136.907946380718;6148.200733904564;6167.629942203482;4610.377599024089;6085.513158947185;6108.35862234459;6117.12715980571;6135.07973803933;6123.050927106306;6135.875804921736;6136.907946380718;6150.723217455315;6158.291796443466;6177.876442471215;6190.535709821871;6193.504519638328;6198.411150940653;6210.378962103753;5860.882782344414;5989.790357337472;6006.279246490449;6024.156618073385;6078.209832721718 15:18:43 INFO - PROCESS | 2168 | |1;ext.html;470.95996840268594;483.7653737937102;528.9814856480024;533.6984603698911;538.4077514733793;30649.701272404574;32297.51553726696;44346.999999999956;44407.66776996695;46300;45277;45564.54435455644;45684.857878553055;45705.771471142594;45745.77127114368;9153.633854645806;9889.258305627089;10223;10225.897741022569;10228.590856365736;9212.631494740202;12152.939235303811;12468.438920248565;12471.37643117845;12570.68573285666;12363.876361236407;12387.690307742288;12407.50369985204;12420.62738117858;12422.19255748378;10513;12399;12453.564125255663;12502.062345324137;12508.81236781449;12363.07276954223;12411.317377544232;12421;12432;12477.75044499114;43344.3498347525;43613.78193109046;43692.781536092436;43701.78149109266;43741.56258437406;3413.6586341365914;3547.5388199534154;3670.4310831821113;3862.246861861938;4110.136871257039;31379.37241255162;32241.51637725436;32375;32784.50823237653;33232.0030399086;3381.8647254109806;3399.5070714746225;3421.5894092709036;3435.639257877912;3491.4064609016273;523881;525743;526166;527363;527506;35374.29251414957;35594.822025889705;35914;36950.26099477996;64942.675286623264;37422.690205842664;37493.812530937714;37523;37583.62416375856;37613.247735045145;16051.759223611421;16218.513444596681;16248.837511624968;16256.43102491407;16263;12507.56223532172;12720.427580758887;12806.35968201605;13613.387397567134;13765.862341376658;7790.9220907790195;7856.371490280764;8096.635651395702;8264;8276.917230827736;2989.8505074746176;3350.865965361407;3373.6795004474534;3442.6557344265875;3462.913427164341;963.8746962894919;1010.2271762101851;1056.0495554001461;1062.628080171949;1161.3582626318803;31901.68098318987;31956.881509147534;31970.360592788013;32468.83765581157;32784;906.6237511432681;906.8413027720254;1067.5836423794726;1165.5221359242669;1177.5172179406402;15738.527844164693;16397;16485.752713709306;16592.83407165913;16722.498325050266;679181;687285;688278;688873;689335;61780;62246.688766555875;62445.68777156176;62445.68777156176;62564;1308.718625495504;1344.153183494412;1408.1551069358304;1419.6237996930822;1447.5006122887798;31106.53340199944;32796;32991.83504082464;33036;33468.8285909992;53173;53509;53535;53597.73201134126;53672.92654146974;534557;535512;535696.3215183899;641649;656344;28046.018389356275;28576.42847143087;28577.857110715144;29362.265943350732;29375.853120735115;49430;49860.501394985586;50123;50528.74735626298;51445.48554514407;40151;40943;42411.78794106133;42610;43993.78003109964;41976.58023419727;42409.5759042418;42569.148617028106;43634.781826090664;43995.12009759851;40625.79687101664;41247.381289280085;41403.79298103611;41555.792221038704;41725.79137104295;34875.825620871736;36325.636743632225;37139.257214856094;37180;37187.442188367735;27158.72841271562;27330;27420.314492137855;27437;27766 15:18:43 INFO - PROCESS | 2168 | |2;jquery.html;377.5205489028933;380.36479079936504;390.6328051631467;397.9462772525712;410.32911190204027;15445.536633900987;22134.557308853855;22396.656200627975;22650.43373915651;22951.311460656165;20943.895280523615;21202.46993825155;21660;21715.78284217161;21903.780962190373;5845.210896528978;6193.721282542274;6199.597026193283;6255.12428260044;6259.655718935457;5968.224130862982;6136.171616831737;6157.322694503601;6276.874462510747;6284.717187726564;6125.111858780474;6137.846553836145;6148.723307451153;6149.5080393568405;6188.597741146834;6034.788782392639;6108.969455152718;6117.143599896018;6130.203073600425;6202.069689546559;5287.021900948337;5334.093204155303;5390.946090539083;5395.514403703646;5395.973020134874;26062;26313.473730525475;26697.599536006976;26802.86598567014;27251.318717032034;2415.40822498489;2426.6845310109748;2426.8665223412704;2583.250857251395;2784.1786672931535;10394.01256880595;10520.789584208273;10566.207534434949;10871.945640271828;10929.56281748729;1923.9230430782752;1997.5505511259996;2005.0676435457583;2012.2856385983057;2027.4829918370722;85739;107418.46290768497;122261;134955;135210;11475.598354057567;11714.70713232159;11789.115816313812;11883.227590206609;11895.799277133585;14886.404543818126;14918.17950012738;15077;15100.244987750568;15145.242737863064;8986.32602554798;9017.188453039258;9038.231750301167;9091.499967501852;9127.315451341176;8137.918620813834;8462.915370846213;9052.185303322733;9126.634934602675;9288.34981551285;4098.118904435561;4357.934630980538;4627.236505976476;4645.883852903705;4716.575508204278;1611.5170813855793;1767.6818172728774;1790.185465613143;1887.2168050259263;1929.411529483521;776.4719990406578;888.8000199954959;918.7197904639015;931.4132096778986;973.4013581647235;20548.58902821935;20944.895275523526;21004.894975525025;21030.78969210319;21181.55762498385;916.8716379706847;929.330881765128;934.6448349627099;941.4915945389413;946.8390373636498;10661.626843060456;11397.886021139682;11446.370449625185;11448.397224388593;11508.309501429942;655603;661193;667726.6613666901;676692;680831;138291.30854345663;139190.99999999796;143995.84006239916;145391.2730436341;147645;960.9759756006016;963.3834346018554;978.3982850546862;980.509745127422;980.843065109579;18003.09984500796;18778.06109694537;19482.512937176685;19495.415137545897;19564.706529402356;51584.710382240744;53616.46383536271;53892.730536347066;53990;54259.18611220756;76851.2314876844;78549;78606.13938606094;79092;79612.60193699226;7692.499987500794;8131.918680813116;8234.629441675259;8282.254597086292;8316.168383161636;10919.508622111865;12807.487700491876;12829.294388808705;12836.101472896808;12942.12339210828;9059.456432614064;10630.52162652667;10986.835197471884;11281.943590281997;11665.716771155336;10960.506777194885;11046.226764126755;11055.834162487408;11281;11413;8930.910690893268;11191.2725672831;11587.304761714324;11824.940875295568;11914.344711040976;6571.441427478718;8087.242133803854;8259.079517880604;8301.875471868048;8453.915460845314;9900.801983960424;10443.634472793416;10709.946450267698;11219.382933938712;11355.829662555234 15:18:43 INFO - PROCESS | 2168 | |3;mootools.html;1384.9169049857003;1555.5644419562523;1579.2972127403302;1822.2528763207079;1969.1631056800857;8129.91870081299;8635.827283454335;8851.6016779245;9218.86171707425;9234.261259099272;9081.500517471537;9169.724908252747;9171;9183.724488265347;9185.90814091859;1996.5308152584169;2475.405902583385;2479.5536803375385;2482.553140434721;2482.565551028563;2414.6378043293557;2457.3856535866034;2460.3480077779313;2460.766227208412;2464.544059349017;2425.708914930211;2445.730969593343;2447.1068060158004;2458.963115553268;2462.224399314219;2401.807855371566;2435.5737745894485;2438.366024833538;2441.2432146034607;2445.9266222013366;2389.976100238993;2426.1144682191048;2429.854208747463;2434.415740222352;2435.6346548017764;9017.23353514952;9041.864372034424;9077.68228112013;9125.908740912639;9137.81724365509;5420.268263784378;5625.268715067015;5638.605297629127;5642.4075472075665;5661.179129026268;3681.9263614727824;3712.6472985066375;3738.6261373862394;3780.8487660493547;3788.280226756935;1106.811841986856;1107.4794846422249;1129.7514546799691;1150.9942450287779;1154.584349634131;12022.51909923602;12071.155019148664;12142.392880356036;12163;12179.756404871852;4529.614982726439;4555.749433781174;4754.881127971828;4762.761861906891;4773.11697335987;9356;9361.485118318558;9364.484953327496;9370;9377.1091746284;5421.241026256327;5434.592405569598;5434.83695489136;5435.510804027656;5436.266104075979;4614.953850461519;4772.665913386029;4929.2359684248995;5055.0648130095315;5089.821856235014;3864.072622570619;3885.0287428142965;3976.1848820991627;3996.7202295839593;3998.4402183694306;1167.3754541320352;1178.793711100554;1180.4451907603413;1189.9345535995603;1193.958211462612;887.5029983209423;895.1987970766259;899.8740176375313;900.144862380741;904.9547522623842;5646.548276137899;5876.147958546072;5881.120137322584;5919.526437885045;6077.969610151921;443.57416879795113;449.7301619028557;459.17348772210556;978.5498670611598;1010.5149528226492;3827.775111964145;3887.378019516864;3930.194310166409;3956.584558621303;3980.144268982183;10786.892131078746;11250.324980501196;11278.15413843965;11282.379469129277;11285.548578056785;8523.872141917876;11049.889501105046;11121.332720036662;11171.21801473889;11261.268017578832;8450.197231263142;8511.106333834858;8568.35737319691;8635.827283454295;8650.87023694645;5759.539236861125;5985.940140598713;5993.430624090704;6000.669963152069;6042.274927008787;10180.389176649425;10316.793664126826;10366.948165259428;10436.895631043591;10462.843057354297;10181.33821301613;10304.021117993778;10362.481875906326;10642;10648.201384896009;6749.595024298362;6962.268961758942;6978.441724662116;7219.422446204396;7391.778246652609;8425.831483370175;8547.529885856338;8649.524276164871;8798.604062817316;8805.559722014003;6596;7658.8085297868;7819.921800782147;7856.803579910548;7943.841123177389;7590.506617069873;7653;7723.806904827425;7728.227177282227;7843.529388236724;7201.027861238876;7344.081989751281;7350.816229594303;7353.0441042664115;7363.558186508827;4462.464504259509;4898.8775280618265;4997.750112494434;5127.128388174094;5144.125498665161;5050.545450909289;5053.0399224147295;5174.249733788504;5191.558717508903;5261.026710058652 15:18:43 INFO - PROCESS | 2168 | |4;prototype.html;267.3450047383909;305.3541759179336;312.5046800820699;315.4054607065682;320.29854618385747;4572.58846703797;5363.6245462817615;5380.461953804617;5382.434844341346;5429.647072940256;4276.615104640582;4656.743879086649;5014.448410674832;5339.691775514994;5346.117890548055;3665.157013886808;4011.83952641894;4073.022474606103;4073.1446396256747;4113.218488487193;3559.4516385372444;3664.2305115925687;3701.8519259229734;3733.216024634816;4075.657960472414;3682.6190178682996;3998.3402738548107;4042.4138499917494;4051.6758659307184;4067.776272305037;4028.1742242840146;4071.470708807836;4072.3891416287647;4076.184763047402;4117.435374557664;2904.6057892211857;3314.3537010283003;3333.666633336671;3349.43059679855;3532.929341413183;3919.8432062717457;4435.868853442384;5189.3772747270195;5196.92204616931;5224.817131400421;4030.9318030721884;4580.0152967112235;4669.719816811003;4716.52834716529;4735.73953432561;4631.698939568917;5319.255304257407;5647.971760141214;5658.34928983164;5670.716464176775;3095.891643792479;3712.2946640138557;3936.350502167139;3936.488256526633;3955.4857868476915;5511.795281887237;5793.420657934215;5840.299164100293;5900.551271222437;5912.137676631847;3472.756907016535;3956.33833789809;3970.166265084307;3974.5230572331507;3991.7006224532697;3032.3935212957495;3538.327717733622;4006.7395619284653;4064.6138616831354;4069.959300406958;3566.233259849093;3959.4654721612214;4175.185838761473;4602.792874320664;4697.553732395417;5667.376588575254;5672.234248376416;5675.971620141873;5700.629459085146;5709.771609135588;1333.2533781082432;1356.8982326325565;1358.2258112875566;1358.639960410492;1364.324659293656;811.9809638903139;836.7113345895656;837.6314421654453;863.710656929923;866.8049688819965;5269.71016594091;5284.943011397736;5313.282706834605;5331.226972089025;5331.86670333237;4844;5073.365829271341;5742.425757424224;5757.309122905194;5762.933857236341;4407.140607581555;4863.003084367696;5223.085959957069;5254.92117618236;5285.31290932184;2773.0865702665096;2773.1680495851165;2882.855857207131;2990.9551356729667;3010.1872494426384;5120.206368012964;5295.391030031596;5887.143920731927;5899.321578018583;5948.821535353946;4859.757012149378;5123.923141152885;5787.469643517536;5864.325602555676;5877.5591830612875;4856.4415092264135;5548.4451554845;5851.414858514285;5893.3222679391565;5904.704764761745;5341.866453338697;5486.972565137149;5697.8860422790485;5758.107493338539;5770.394108618535;4872.512748725099;5219.0856857356985;5642.855714828504;5659.603827732019;5684.317881854204;5796.840631873726;5824.767009319579;5859.794907178229;5878.412158784087;5906.911396329145;3163.8734450622637;3623.7498063168164;3675.320065787838;3876.8175706409816;3889.9805500972316;4605.411133159055;5303.632193557042;5683.630564013326;5684.658920464785;5688.573356998324;4711.246200608023;5548.944510554843;5556.527695145796;5561.4716601922755;5562.360328562268;4267.125239325868;4995.875103122451;5216.426193118678;5514.724263786875;5579.2746942897165;5057.641132152782;5153.974230128825;5279.551238144801;5410.78356865721;5452.646622327161;5212.175738491497;5497.670139791625;5658.632188907708;5668.647511282771;5693.174489698888;5266.499682530153;5375.19372094189;5547.001539722889;5548.778048878161;5562.860928476659 15:18:43 INFO - PROCESS | 2168 | |5;yui.html;709.2021475839678;731.630526584075;789.5138386418787;799.5682331540968;873.785922449;15815.762763558541;16873.24070416831;16897.324107035703;16948.152592370392;16949.40677076301;14939.402423903031;15073.547793566184;15109.471168509104;15129.31918063687;15130.09219446834;708.9999999999987;731.4148681055161;735.4447392218867;871.8430682477151;887.8268737596171;870.6256309786789;888.0453512474116;893.9687110951118;894.1818236313765;894.8165626046645;955.4315182466456;955.5174636808403;956.3305686019814;957.6360982826516;959.8896126945386;943.6697155995415;944.8535477001076;945.0549450549416;946.9715908522755;947.0624082158613;709.7622296530668;709.7764204275637;710.1017213225274;710.3287393413226;712.654362634122;15530.301136448774;15861.603459913595;15879.682406351923;15883.28525216368;15908.920455397765;15094.546943831167;15303.693926121527;15379;15425.537233883002;15499.612509687235;11420.200585958986;11709.355985420883;11833;12078.758424831454;12243.877561224452;4665.136949664323;4941.752912354368;5106.336176297094;5109;5114.641975061747;115968;117087.41456292749;121727.39136304263;122560.77439225583;125756;11104.61133860311;11354.48904799286;11360.149522995664;11911.52353905834;12068.6310113076;22943.426414339774;23075.07699692027;23772.762272377055;24190.790460476906;24488.877555612107;8524.147585241426;8566.057733649293;8698.956125264882;8854.114588541222;8940.284777217938;4560.338750881104;4651.279051746985;4772.976135119372;4791.712497250176;4797.280407938837;3695.150115473456;3860.613938606173;3862.1117143057254;3869.5936926622862;3869.6323849234277;686.2108575138631;691.5193940211606;701.9964900175569;703.3423748794893;723.6634964741315;568.2868000659146;585.2041223935445;588.2441063233724;607.60505671314;694.0630149298406;8317.41778075529;8460.238578527962;8956.776080598038;9952.601895924226;10008.44953527563;688.2704333406605;695.3116414749463;695.9512834101665;704.3484776581641;709.0817391478048;4915.232353729899;4972.025493983322;4988.448065982674;5009.348784657971;5010.123228435009;106689;130157;138265.54336141676;163836;166208.3379166217;136112.31943840216;141678;141853;146786;149790;110048;116904.41547792207;121551.39224303822;128943;130307;10154.289199755945;10273.589056437957;10329.741756455847;10475.004874536908;10585.470726463493;50797.74601126971;60200.69899650474;65155;68421.65789171221;69272.6536367315;98867.50566247123;101218;101494.49252753689;102157;105382;13827.585172444842;13874.722505549631;14088;14199.219042952323;14244.572662820132;14704.705905882036;14861.702765944405;15553;15997.760033599738;16877.156142193086;14089;14134.15195088298;14504.564863054125;15487.5353739388;15643.84356156424;13997.720045598828;14620.342084606431;14698.41206351734;14737.1894545801;15080;12187.51249949992;12217.694557635774;12475.251484910934;14745.041572297767;15295.388184472497;10242.231832612435;11718.88281117178;11725.88274117248;11791.115666324888;12393;10299.794004120025;11982.58060967862;12159.148859579744;12258.754824903273;12389.070819688739 15:18:43 INFO - PROCESS | 2168 | __end_tp_report 15:18:43 INFO - PROCESS | 2168 | __start_cc_report 15:18:43 INFO - PROCESS | 2168 | _x_x_mozilla_cycle_collect,1236 15:18:43 INFO - PROCESS | 2168 | __end_cc_report 15:18:43 INFO - PROCESS | 2168 | __startTimestamp1484263123257__endTimestamp 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | ------- Summary: start ------- 15:18:43 INFO - PROCESS | 2168 | Number of tests: 6 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | [#0] dojo.html Cycles:165 Average:5785.29 Median:6071.85 stddev:645.78 (10.6%) stddev-sans-first:605.69 15:18:43 INFO - PROCESS | 2168 | Values: 2862.6 3409.2 3457.7 3459.6 3506.7 5663.8 5666.9 5696.9 5730.1 5765.0 5679.3 5788.9 5790.8 5808.9 5816.9 5219.7 5248.3 5250.5 5265.8 5311.9 5179.2 5187.0 5325.2 5336.5 5376.3 5287.2 5302.8 5309.9 5310.8 5323.6 5185.2 5224.9 5251.4 5266.3 5267.1 5200.0 5228.0 5261.7 5274.2 5281.3 5658.4 5695.4 5814.1 5825.6 5931.5 6161.2 6161.4 6250.0 6250.4 6259.1 6229.8 6269.8 6295.7 6322.2 6324.3 5708.3 5840.9 5856.7 5883.1 5891.3 6216.6 6238.1 6292.3 6296.9 6299.5 6207.2 6225.1 6229.0 6233.2 6240.2 6169.1 6318.3 6341.4 6342.7 6349.4 6155.8 6171.7 6191.0 6216.4 6299.7 6240.2 6301.7 6320.7 6325.7 6343.8 4987.2 5037.9 5044.1 5047.1 5069.3 4431.7 4444.5 4498.8 4522.6 4527.9 5779.1 5815.6 5826.5 5969.7 5971.5 6282.2 6295.3 6296.4 6300.7 6319.6 5860.7 5886.6 5894.1 5915.9 5941.7 5372.0 5380.8 5431.8 5438.0 5504.1 5888.2 6269.9 6343.0 6346.9 6357.3 6249.1 6290.2 6310.6 6317.8 6319.7 5182.9 6232.1 6325.4 6339.8 6341.6 6157.4 6171.9 6218.8 6234.6 6286.9 6173.3 6174.8 6179.8 6197.8 6293.9 6071.8 6087.0 6136.9 6148.2 6167.6 4610.4 6085.5 6108.4 6117.1 6135.1 6123.1 6135.9 6136.9 6150.7 6158.3 6177.9 6190.5 6193.5 6198.4 6210.4 5860.9 5989.8 6006.3 6024.2 6078.2 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | [#1] ext.html Cycles:180 Average:72521.05 Median:35754.41 stddev:161205.94 (450.9%) stddev-sans-first:161567.39 15:18:43 INFO - PROCESS | 2168 | Values: 471.0 483.8 529.0 533.7 538.4 30649.7 32297.5 44347.0 44407.7 46300.0 45277.0 45564.5 45684.9 45705.8 45745.8 9153.6 9889.3 10223.0 10225.9 10228.6 9212.6 12152.9 12468.4 12471.4 12570.7 12363.9 12387.7 12407.5 12420.6 12422.2 10513.0 12399.0 12453.6 12502.1 12508.8 12363.1 12411.3 12421.0 12432.0 12477.8 43344.3 43613.8 43692.8 43701.8 43741.6 3413.7 3547.5 3670.4 3862.2 4110.1 31379.4 32241.5 32375.0 32784.5 33232.0 3381.9 3399.5 3421.6 3435.6 3491.4 523881.0 525743.0 526166.0 527363.0 527506.0 35374.3 35594.8 35914.0 36950.3 64942.7 37422.7 37493.8 37523.0 37583.6 37613.2 16051.8 16218.5 16248.8 16256.4 16263.0 12507.6 12720.4 12806.4 13613.4 13765.9 7790.9 7856.4 8096.6 8264.0 8276.9 2989.9 3350.9 3373.7 3442.7 3462.9 963.9 1010.2 1056.0 1062.6 1161.4 31901.7 31956.9 31970.4 32468.8 32784.0 906.6 906.8 1067.6 1165.5 1177.5 15738.5 16397.0 16485.8 16592.8 16722.5 679181.0 687285.0 688278.0 688873.0 689335.0 61780.0 62246.7 62445.7 62445.7 62564.0 1308.7 1344.2 1408.2 1419.6 1447.5 31106.5 32796.0 32991.8 33036.0 33468.8 53173.0 53509.0 53535.0 53597.7 53672.9 534557.0 535512.0 535696.3 641649.0 656344.0 28046.0 28576.4 28577.9 29362.3 29375.9 49430.0 49860.5 50123.0 50528.7 51445.5 40151.0 40943.0 42411.8 42610.0 43993.8 41976.6 42409.6 42569.1 43634.8 43995.1 40625.8 41247.4 41403.8 41555.8 41725.8 34875.8 36325.6 37139.3 37180.0 37187.4 27158.7 27330.0 27420.3 27437.0 27766.0 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | [#2] jquery.html Cycles:180 Average:37567.69 Median:1580.85 stddev:111334.59 (7042.7%) stddev-sans-first:111611.89 15:18:43 INFO - PROCESS | 2168 | Values: 377.5 380.4 390.6 397.9 410.3 15445.5 22134.6 22396.7 22650.4 22951.3 20943.9 21202.5 21660.0 21715.8 21903.8 5845.2 6193.7 6199.6 6255.1 6259.7 5968.2 6136.2 6157.3 6276.9 6284.7 6125.1 6137.8 6148.7 6149.5 6188.6 6034.8 6109.0 6117.1 6130.2 6202.1 5287.0 5334.1 5390.9 5395.5 5396.0 26062.0 26313.5 26697.6 26802.9 27251.3 2415.4 2426.7 2426.9 2583.3 2784.2 10394.0 10520.8 10566.2 10871.9 10929.6 1923.9 1997.6 2005.1 2012.3 2027.5 85739.0 107418.5 122261.0 134955.0 135210.0 11475.6 11714.7 11789.1 11883.2 11895.8 14886.4 14918.2 15077.0 15100.2 15145.2 8986.3 9017.2 9038.2 9091.5 9127.3 8137.9 8462.9 9052.2 9126.6 9288.3 4098.1 4357.9 4627.2 4645.9 4716.6 1611.5 1767.7 1790.2 1887.2 1929.4 776.5 888.8 918.7 931.4 973.4 20548.6 20944.9 21004.9 21030.8 21181.6 916.9 929.3 934.6 941.5 946.8 10661.6 11397.9 11446.4 11448.4 11508.3 655603.0 661193.0 667726.7 676692.0 680831.0 138291.3 139191.0 143995.8 145391.3 147645.0 961.0 963.4 978.4 980.5 980.8 18003.1 18778.1 19482.5 19495.4 19564.7 51584.7 53616.5 53892.7 53990.0 54259.2 76851.2 78549.0 78606.1 79092.0 79612.6 7692.5 8131.9 8234.6 8282.3 8316.2 10919.5 12807.5 12829.3 12836.1 12942.1 9059.5 10630.5 10986.8 11281.9 11665.7 10960.5 11046.2 11055.8 11281.0 11413.0 8930.9 11191.3 11587.3 11824.9 11914.3 6571.4 8087.2 8259.1 8301.9 8453.9 9900.8 10443.6 10709.9 11219.4 11355.8 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | [#3] mootools.html Cycles:180 Average:5827.14 Median:4836.00 stddev:3295.03 (68.1%) stddev-sans-first:3287.36 15:18:43 INFO - PROCESS | 2168 | Values: 1384.9 1555.6 1579.3 1822.3 1969.2 8129.9 8635.8 8851.6 9218.9 9234.3 9081.5 9169.7 9171.0 9183.7 9185.9 1996.5 2475.4 2479.6 2482.6 2482.6 2414.6 2457.4 2460.3 2460.8 2464.5 2425.7 2445.7 2447.1 2459.0 2462.2 2401.8 2435.6 2438.4 2441.2 2445.9 2390.0 2426.1 2429.9 2434.4 2435.6 9017.2 9041.9 9077.7 9125.9 9137.8 5420.3 5625.3 5638.6 5642.4 5661.2 3681.9 3712.6 3738.6 3780.8 3788.3 1106.8 1107.5 1129.8 1151.0 1154.6 12022.5 12071.2 12142.4 12163.0 12179.8 4529.6 4555.7 4754.9 4762.8 4773.1 9356.0 9361.5 9364.5 9370.0 9377.1 5421.2 5434.6 5434.8 5435.5 5436.3 4615.0 4772.7 4929.2 5055.1 5089.8 3864.1 3885.0 3976.2 3996.7 3998.4 1167.4 1178.8 1180.4 1189.9 1194.0 887.5 895.2 899.9 900.1 905.0 5646.5 5876.1 5881.1 5919.5 6078.0 443.6 449.7 459.2 978.5 1010.5 3827.8 3887.4 3930.2 3956.6 3980.1 10786.9 11250.3 11278.2 11282.4 11285.5 8523.9 11049.9 11121.3 11171.2 11261.3 8450.2 8511.1 8568.4 8635.8 8650.9 5759.5 5985.9 5993.4 6000.7 6042.3 10180.4 10316.8 10366.9 10436.9 10462.8 10181.3 10304.0 10362.5 10642.0 10648.2 6749.6 6962.3 6978.4 7219.4 7391.8 8425.8 8547.5 8649.5 8798.6 8805.6 6596.0 7658.8 7819.9 7856.8 7943.8 7590.5 7653.0 7723.8 7728.2 7843.5 7201.0 7344.1 7350.8 7353.0 7363.6 4462.5 4898.9 4997.8 5127.1 5144.1 5050.5 5053.0 5174.2 5191.6 5261.0 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | [#4] prototype.html Cycles:180 Average:4487.23 Median:5138.95 stddev:1398.34 (27.2%) stddev-sans-first:1365.92 15:18:43 INFO - PROCESS | 2168 | Values: 267.3 305.4 312.5 315.4 320.3 4572.6 5363.6 5380.5 5382.4 5429.6 4276.6 4656.7 5014.4 5339.7 5346.1 3665.2 4011.8 4073.0 4073.1 4113.2 3559.5 3664.2 3701.9 3733.2 4075.7 3682.6 3998.3 4042.4 4051.7 4067.8 4028.2 4071.5 4072.4 4076.2 4117.4 2904.6 3314.4 3333.7 3349.4 3532.9 3919.8 4435.9 5189.4 5196.9 5224.8 4030.9 4580.0 4669.7 4716.5 4735.7 4631.7 5319.3 5648.0 5658.3 5670.7 3095.9 3712.3 3936.4 3936.5 3955.5 5511.8 5793.4 5840.3 5900.6 5912.1 3472.8 3956.3 3970.2 3974.5 3991.7 3032.4 3538.3 4006.7 4064.6 4070.0 3566.2 3959.5 4175.2 4602.8 4697.6 5667.4 5672.2 5676.0 5700.6 5709.8 1333.3 1356.9 1358.2 1358.6 1364.3 812.0 836.7 837.6 863.7 866.8 5269.7 5284.9 5313.3 5331.2 5331.9 4844.0 5073.4 5742.4 5757.3 5762.9 4407.1 4863.0 5223.1 5254.9 5285.3 2773.1 2773.2 2882.9 2991.0 3010.2 5120.2 5295.4 5887.1 5899.3 5948.8 4859.8 5123.9 5787.5 5864.3 5877.6 4856.4 5548.4 5851.4 5893.3 5904.7 5341.9 5487.0 5697.9 5758.1 5770.4 4872.5 5219.1 5642.9 5659.6 5684.3 5796.8 5824.8 5859.8 5878.4 5906.9 3163.9 3623.7 3675.3 3876.8 3890.0 4605.4 5303.6 5683.6 5684.7 5688.6 4711.2 5548.9 5556.5 5561.5 5562.4 4267.1 4995.9 5216.4 5514.7 5579.3 5057.6 5154.0 5279.6 5410.8 5452.6 5212.2 5497.7 5658.6 5668.6 5693.2 5266.5 5375.2 5547.0 5548.8 5562.9 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - PROCESS | 2168 | [#5] yui.html Cycles:180 Average:26408.52 Median:16875.20 stddev:41978.17 (248.8%) stddev-sans-first:42051.58 15:18:43 INFO - PROCESS | 2168 | Values: 709.2 731.6 789.5 799.6 873.8 15815.8 16873.2 16897.3 16948.2 16949.4 14939.4 15073.5 15109.5 15129.3 15130.1 709.0 731.4 735.4 871.8 887.8 870.6 888.0 894.0 894.2 894.8 955.4 955.5 956.3 957.6 959.9 943.7 944.9 945.1 947.0 947.1 709.8 709.8 710.1 710.3 712.7 15530.3 15861.6 15879.7 15883.3 15908.9 15094.5 15303.7 15379.0 15425.5 15499.6 11420.2 11709.4 11833.0 12078.8 12243.9 4665.1 4941.8 5106.3 5109.0 5114.6 115968.0 117087.4 121727.4 122560.8 125756.0 11104.6 11354.5 11360.1 11911.5 12068.6 22943.4 23075.1 23772.8 24190.8 24488.9 8524.1 8566.1 8699.0 8854.1 8940.3 4560.3 4651.3 4773.0 4791.7 4797.3 3695.2 3860.6 3862.1 3869.6 3869.6 686.2 691.5 702.0 703.3 723.7 568.3 585.2 588.2 607.6 694.1 8317.4 8460.2 8956.8 9952.6 10008.4 688.3 695.3 696.0 704.3 709.1 4915.2 4972.0 4988.4 5009.3 5010.1 106689.0 130157.0 138265.5 163836.0 166208.3 136112.3 141678.0 141853.0 146786.0 149790.0 110048.0 116904.4 121551.4 128943.0 130307.0 10154.3 10273.6 10329.7 10475.0 10585.5 50797.7 60200.7 65155.0 68421.7 69272.7 98867.5 101218.0 101494.5 102157.0 105382.0 13827.6 13874.7 14088.0 14199.2 14244.6 14704.7 14861.7 15553.0 15997.8 16877.2 14089.0 14134.2 14504.6 15487.5 15643.8 13997.7 14620.3 14698.4 14737.2 15080.0 12187.5 12217.7 12475.3 14745.0 15295.4 10242.2 11718.9 11725.9 11791.1 12393.0 10299.8 11982.6 12159.1 12258.8 12389.1 15:18:43 INFO - PROCESS | 2168 | -------- Summary: end -------- 15:18:43 INFO - PROCESS | 2168 | 15:18:43 INFO - TEST-INFO | 2168: exit 0 15:18:43 INFO - TEST-OK | dromaeo_css | took 1115830ms 15:18:43 INFO - TEST-START | kraken 15:18:43 INFO - operating with platform_type : mac_ 15:18:43 INFO - Initialising browser for kraken test... 15:18:43 INFO - TEST-INFO | started process 2170 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmp1D3DgD/profile http://localhost:51750/getInfo.html) 15:18:46 INFO - PROCESS | 2170 | __metrics Screen width/height:1600/1200 15:18:46 INFO - PROCESS | 2170 | colorDepth:24 15:18:46 INFO - PROCESS | 2170 | Browser inner width/height: 1024/689 15:18:46 INFO - PROCESS | 2170 | __metrics 15:18:46 INFO - PROCESS | 2170 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:18:46 INFO - PROCESS | 2170 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:46 INFO - TEST-INFO | 2170: exit 0 15:18:46 INFO - Browser initialized. 15:18:46 INFO - Running cycle 1/1 for kraken test... 15:18:46 INFO - TEST-INFO | started process 2172 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmp1D3DgD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:58 INFO - PROCESS | 2172 | RSS: Main: 168906752 15:18:58 INFO - PROCESS | 2172 | 15:19:01 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-beat-detection) 15:19:02 INFO - PROCESS | 2172 | RSS: Main: 218468352 15:19:02 INFO - PROCESS | 2172 | 15:19:05 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-dft) 15:19:05 INFO - PROCESS | 2172 | RSS: Main: 232968192 15:19:05 INFO - PROCESS | 2172 | 15:19:08 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-fft) 15:19:09 INFO - PROCESS | 2172 | RSS: Main: 329363456 15:19:09 INFO - PROCESS | 2172 | 15:19:11 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51750/tests/kraken/driver.html?testName=audio-oscillator) 15:19:12 INFO - PROCESS | 2172 | RSS: Main: 228093952 15:19:12 INFO - PROCESS | 2172 | 15:19:14 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:19:14 INFO - PROCESS | 2172 | RSS: Main: 228601856 15:19:14 INFO - PROCESS | 2172 | 15:19:17 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51750/tests/kraken/driver.html?testName=imaging-darkroom) 15:19:17 INFO - PROCESS | 2172 | RSS: Main: 267689984 15:19:17 INFO - PROCESS | 2172 | 15:19:21 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51750/tests/kraken/driver.html?testName=imaging-desaturate) 15:19:21 INFO - PROCESS | 2172 | RSS: Main: 267644928 15:19:21 INFO - PROCESS | 2172 | 15:19:24 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51750/tests/kraken/driver.html?testName=json-parse-financial) 15:19:24 INFO - PROCESS | 2172 | RSS: Main: 268333056 15:19:24 INFO - PROCESS | 2172 | 15:19:26 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:19:27 INFO - PROCESS | 2172 | RSS: Main: 240013312 15:19:27 INFO - PROCESS | 2172 | 15:19:28 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:29 INFO - PROCESS | 2172 | RSS: Main: 244412416 15:19:29 INFO - PROCESS | 2172 | 15:19:31 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:32 INFO - PROCESS | 2172 | RSS: Main: 251965440 15:19:32 INFO - PROCESS | 2172 | 15:19:35 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:36 INFO - PROCESS | 2172 | RSS: Main: 259493888 15:19:36 INFO - PROCESS | 2172 | 15:19:38 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:19:39 INFO - PROCESS | 2172 | RSS: Main: 259448832 15:19:39 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | Cycle 1(1): loaded http://localhost:51750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51750/tests/kraken/driver.html?testName=ai-astar) 15:19:41 INFO - PROCESS | 2172 | RSS: Main: 303595520 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | __start_tp_report 15:19:41 INFO - PROCESS | 2172 | _x_x_mozilla_page_load 15:19:41 INFO - PROCESS | 2172 | _x_x_mozilla_page_load_details 15:19:41 INFO - PROCESS | 2172 | |i|pagename|runs| 15:19:41 INFO - PROCESS | 2172 | |0;ai-astar;114;115;114;113;113;113;113;114;112;113 15:19:41 INFO - PROCESS | 2172 | |1;audio-beat-detection;144;124;141;140;98;113;137;139;176;121 15:19:41 INFO - PROCESS | 2172 | |2;audio-dft;181;181;182;183;183;183;182;183;186;183 15:19:41 INFO - PROCESS | 2172 | |3;audio-fft;80;59;59;90;63;59;59;59;82;57 15:19:41 INFO - PROCESS | 2172 | |4;audio-oscillator;85;72;94;70;67;68;92;67;69;89 15:19:41 INFO - PROCESS | 2172 | |5;imaging-gaussian-blur;88;85;87;85;125;84;88;85;87;84 15:19:41 INFO - PROCESS | 2172 | |6;imaging-darkroom;97;96;135;161;162;97;96;96;96;96 15:19:41 INFO - PROCESS | 2172 | |7;imaging-desaturate;84;83;84;84;83;83;83;84;83;85 15:19:41 INFO - PROCESS | 2172 | |8;json-parse-financial;54;51;52;52;55;57;59;58;58;57 15:19:41 INFO - PROCESS | 2172 | |9;json-stringify-tinderbox;72;67;64;74;70;68;68;68;69;70 15:19:41 INFO - PROCESS | 2172 | |10;stanford-crypto-aes;84;83;85;84;85;88;83;86;99;92 15:19:41 INFO - PROCESS | 2172 | |11;stanford-crypto-ccm;136;135;136;134;134;138;134;138;177;140 15:19:41 INFO - PROCESS | 2172 | |12;stanford-crypto-pbkdf2;144;196;225;165;165;160;162;160;161;161 15:19:41 INFO - PROCESS | 2172 | |13;stanford-crypto-sha256-iterative;59;63;83;66;66;66;65;67;66;64 15:19:41 INFO - PROCESS | 2172 | __end_tp_report 15:19:41 INFO - PROCESS | 2172 | __start_cc_report 15:19:41 INFO - PROCESS | 2172 | _x_x_mozilla_cycle_collect,1920 15:19:41 INFO - PROCESS | 2172 | __end_cc_report 15:19:41 INFO - PROCESS | 2172 | __startTimestamp1484263181448__endTimestamp 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | ------- Summary: start ------- 15:19:41 INFO - PROCESS | 2172 | Number of tests: 14 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 15:19:41 INFO - PROCESS | 2172 | Values: 114.0 115.0 114.0 113.0 113.0 113.0 113.0 114.0 112.0 113.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:140.50 stddev:21.04 (15.0%) stddev-sans-first:21.96 15:19:41 INFO - PROCESS | 2172 | Values: 144.0 124.0 141.0 140.0 98.0 113.0 137.0 139.0 176.0 121.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.42 (0.8%) stddev-sans-first:1.36 15:19:41 INFO - PROCESS | 2172 | Values: 181.0 181.0 182.0 183.0 183.0 183.0 182.0 183.0 186.0 183.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.00 stddev:12.28 (20.1%) stddev-sans-first:12.05 15:19:41 INFO - PROCESS | 2172 | Values: 80.0 59.0 59.0 90.0 63.0 59.0 59.0 59.0 82.0 57.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.50 stddev:11.26 (14.3%) stddev-sans-first:11.59 15:19:41 INFO - PROCESS | 2172 | Values: 85.0 72.0 94.0 70.0 67.0 68.0 92.0 67.0 69.0 89.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:86.00 stddev:12.46 (14.5%) stddev-sans-first:13.20 15:19:41 INFO - PROCESS | 2172 | Values: 88.0 85.0 87.0 85.0 125.0 84.0 88.0 85.0 87.0 84.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#6] imaging-darkroom Cycles:10 Average:113.20 Median:96.00 stddev:28.18 (29.4%) stddev-sans-first:29.27 15:19:41 INFO - PROCESS | 2172 | Values: 97.0 96.0 135.0 161.0 162.0 97.0 96.0 96.0 96.0 96.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 15:19:41 INFO - PROCESS | 2172 | Values: 84.0 83.0 84.0 84.0 83.0 83.0 83.0 84.0 83.0 85.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:57.00 stddev:2.91 (5.1%) stddev-sans-first:3.05 15:19:41 INFO - PROCESS | 2172 | Values: 54.0 51.0 52.0 52.0 55.0 57.0 59.0 58.0 58.0 57.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.50 stddev:2.75 (4.0%) stddev-sans-first:2.69 15:19:41 INFO - PROCESS | 2172 | Values: 72.0 67.0 64.0 74.0 70.0 68.0 68.0 68.0 69.0 70.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:85.50 stddev:5.04 (5.9%) stddev-sans-first:5.24 15:19:41 INFO - PROCESS | 2172 | Values: 84.0 83.0 85.0 84.0 85.0 88.0 83.0 86.0 99.0 92.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:137.00 stddev:13.09 (9.6%) stddev-sans-first:13.79 15:19:41 INFO - PROCESS | 2172 | Values: 136.0 135.0 136.0 134.0 134.0 138.0 134.0 138.0 177.0 140.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:163.50 stddev:23.22 (14.2%) stddev-sans-first:22.66 15:19:41 INFO - PROCESS | 2172 | Values: 144.0 196.0 225.0 165.0 165.0 160.0 162.0 160.0 161.0 161.0 15:19:41 INFO - PROCESS | 2172 | 15:19:41 INFO - PROCESS | 2172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:6.24 (9.5%) stddev-sans-first:6.00 15:19:41 INFO - PROCESS | 2172 | Values: 59.0 63.0 83.0 66.0 66.0 66.0 65.0 67.0 66.0 64.0 15:19:41 INFO - PROCESS | 2172 | -------- Summary: end -------- 15:19:41 INFO - PROCESS | 2172 | 15:19:42 INFO - TEST-INFO | 2172: exit 0 15:19:42 INFO - TEST-OK | kraken | took 58402ms 15:19:42 INFO - SUITE-END | took 1174s 15:19:42 INFO - Completed test suite (00:19:34) 15:19:42 INFO - javascript benchmark 15:19:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2862.613547171132, 3409.232922592417, 3457.654234576543, 3459.6021457532393, 3506.719462443005, 5663.801766938158, 5666.886662266752, 5696.917585658722, 5730.05454100074, 5765.048766953448, 5679.318481782192, 5788.942110578893, 5790.797322093727, 5808.941910580893, 5816.912746308809, 5219.739013049351, 5248.265242865992, 5250.501202385767, 5265.7893684252585, 5311.920321195185, 5179.223116532513, 5186.974065129669, 5325.20121981702, 5336.4930331618625, 5376.274202982606, 5287.180487024498, 5302.787888484456, 5309.8938021239555, 5310.787568497255, 5323.627346085776, 5185.196294574328, 5224.910035985598, 5251.396089449724, 5266.341707286609, 5267.130923397634, 5200.0, 5228.0, 5261.684298942076, 5274.208868669692, 5281.339832520935, 5658.377578466366, 5695.430456954313, 5814.127880817869, 5825.592208545403, 5931.466168044896, 6161.229846269216, 6161.4146656067605, 6249.968750156266, 6250.406211409909, 6259.092431597438, 6229.750809967596, 6269.780557680459, 6295.716692748837, 6322.209723784527, 6324.3359447257835, 5708.257926469532, 5840.948629246776, 5856.736446859859, 5883.058710606325, 5891.263592050994, 6216.627002379872, 6238.1266622672865, 6292.339304373067, 6296.905546416808, 6299.527535434769, 6207.193064901534, 6225.066240064027, 6229.003359462465, 6233.2208473940755, 6240.157578726905, 6169.105479705508, 6318.336574659686, 6341.365863413622, 6342.714577844008, 6349.396807303298, 6155.815325540241, 6171.660558669227, 6190.969045154836, 6216.44052035319, 6299.716512756937, 6240.188775459162, 6301.6534090625455, 6320.683965801692, 6325.746970121236, 6343.777967771106, 4987.177115775857, 5037.874053148627, 5044.0920634286185, 5047.141985862412, 5069.340985671913, 4431.711938723973, 4444.511103778582, 4498.775061246924, 4522.615577675869, 4527.886802829956, 5779.075347944308, 5815.5929084963645, 5826.475617194388, 5969.671668058211, 5971.4924231439945, 6282.1519094921605, 6295.307516173218, 6296.433321001132, 6300.747970081237, 6319.58922670025, 5860.706964651836, 5886.6173698709445, 5894.086416605433, 5915.852103697442, 5941.732622032019, 5371.973140134274, 5380.838574842761, 5431.782728690808, 5437.972810135924, 5504.0643090674685, 5888.17565540816, 6269.8746025079245, 6343.016832390987, 6346.904796428057, 6357.300696923242, 6249.093881387264, 6290.24517057956, 6310.6213627182515, 6317.810465686037, 6319.747210111544, 5182.948170518397, 6232.065190221322, 6325.430711236011, 6339.841503962438, 6341.587796793194, 6157.4458298753325, 6171.938280617136, 6218.844528886814, 6234.594751341148, 6286.9371306288185, 6173.259208894961, 6174.845628859314, 6179.81460556184, 6197.752089916353, 6293.937060629518, 6071.848203794941, 6087.0, 6136.907946380718, 6148.200733904564, 6167.629942203482, 4610.377599024089, 6085.513158947185, 6108.35862234459, 6117.12715980571, 6135.07973803933, 6123.050927106306, 6135.875804921736, 6136.907946380718, 6150.723217455315, 6158.291796443466, 6177.876442471215, 6190.535709821871, 6193.504519638328, 6198.411150940653, 6210.378962103753, 5860.882782344414, 5989.790357337472, 6006.279246490449, 6024.156618073385, 6078.209832721718], "value": 5744.19258581663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.95996840268594, 483.7653737937102, 528.9814856480024, 533.6984603698911, 538.4077514733793, 30649.701272404574, 32297.51553726696, 44346.999999999956, 44407.66776996695, 46300.0, 45277.0, 45564.54435455644, 45684.857878553055, 45705.771471142594, 45745.77127114368, 9153.633854645806, 9889.258305627089, 10223.0, 10225.897741022569, 10228.590856365736, 9212.631494740202, 12152.939235303811, 12468.438920248565, 12471.37643117845, 12570.68573285666, 12363.876361236407, 12387.690307742288, 12407.50369985204, 12420.62738117858, 12422.19255748378, 10513.0, 12399.0, 12453.564125255663, 12502.062345324137, 12508.81236781449, 12363.07276954223, 12411.317377544232, 12421.0, 12432.0, 12477.75044499114, 43344.3498347525, 43613.78193109046, 43692.781536092436, 43701.78149109266, 43741.56258437406, 3413.6586341365914, 3547.5388199534154, 3670.4310831821113, 3862.246861861938, 4110.136871257039, 31379.37241255162, 32241.51637725436, 32375.0, 32784.50823237653, 33232.0030399086, 3381.8647254109806, 3399.5070714746225, 3421.5894092709036, 3435.639257877912, 3491.4064609016273, 523881.0, 525743.0, 526166.0, 527363.0, 527506.0, 35374.29251414957, 35594.822025889705, 35914.0, 36950.26099477996, 64942.675286623264, 37422.690205842664, 37493.812530937714, 37523.0, 37583.62416375856, 37613.247735045145, 16051.759223611421, 16218.513444596681, 16248.837511624968, 16256.43102491407, 16263.0, 12507.56223532172, 12720.427580758887, 12806.35968201605, 13613.387397567134, 13765.862341376658, 7790.9220907790195, 7856.371490280764, 8096.635651395702, 8264.0, 8276.917230827736, 2989.8505074746176, 3350.865965361407, 3373.6795004474534, 3442.6557344265875, 3462.913427164341, 963.8746962894919, 1010.2271762101851, 1056.0495554001461, 1062.628080171949, 1161.3582626318803, 31901.68098318987, 31956.881509147534, 31970.360592788013, 32468.83765581157, 32784.0, 906.6237511432681, 906.8413027720254, 1067.5836423794726, 1165.5221359242669, 1177.5172179406402, 15738.527844164693, 16397.0, 16485.752713709306, 16592.83407165913, 16722.498325050266, 679181.0, 687285.0, 688278.0, 688873.0, 689335.0, 61780.0, 62246.688766555875, 62445.68777156176, 62445.68777156176, 62564.0, 1308.718625495504, 1344.153183494412, 1408.1551069358304, 1419.6237996930822, 1447.5006122887798, 31106.53340199944, 32796.0, 32991.83504082464, 33036.0, 33468.8285909992, 53173.0, 53509.0, 53535.0, 53597.73201134126, 53672.92654146974, 534557.0, 535512.0, 535696.3215183899, 641649.0, 656344.0, 28046.018389356275, 28576.42847143087, 28577.857110715144, 29362.265943350732, 29375.853120735115, 49430.0, 49860.501394985586, 50123.0, 50528.74735626298, 51445.48554514407, 40151.0, 40943.0, 42411.78794106133, 42610.0, 43993.78003109964, 41976.58023419727, 42409.5759042418, 42569.148617028106, 43634.781826090664, 43995.12009759851, 40625.79687101664, 41247.381289280085, 41403.79298103611, 41555.792221038704, 41725.79137104295, 34875.825620871736, 36325.636743632225, 37139.257214856094, 37180.0, 37187.442188367735, 27158.72841271562, 27330.0, 27420.314492137855, 27437.0, 27766.0], "value": 19962.333747089506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5205489028933, 380.36479079936504, 390.6328051631467, 397.9462772525712, 410.32911190204027, 15445.536633900987, 22134.557308853855, 22396.656200627975, 22650.43373915651, 22951.311460656165, 20943.895280523615, 21202.46993825155, 21660.0, 21715.78284217161, 21903.780962190373, 5845.210896528978, 6193.721282542274, 6199.597026193283, 6255.12428260044, 6259.655718935457, 5968.224130862982, 6136.171616831737, 6157.322694503601, 6276.874462510747, 6284.717187726564, 6125.111858780474, 6137.846553836145, 6148.723307451153, 6149.5080393568405, 6188.597741146834, 6034.788782392639, 6108.969455152718, 6117.143599896018, 6130.203073600425, 6202.069689546559, 5287.021900948337, 5334.093204155303, 5390.946090539083, 5395.514403703646, 5395.973020134874, 26062.0, 26313.473730525475, 26697.599536006976, 26802.86598567014, 27251.318717032034, 2415.40822498489, 2426.6845310109748, 2426.8665223412704, 2583.250857251395, 2784.1786672931535, 10394.01256880595, 10520.789584208273, 10566.207534434949, 10871.945640271828, 10929.56281748729, 1923.9230430782752, 1997.5505511259996, 2005.0676435457583, 2012.2856385983057, 2027.4829918370722, 85739.0, 107418.46290768497, 122261.0, 134955.0, 135210.0, 11475.598354057567, 11714.70713232159, 11789.115816313812, 11883.227590206609, 11895.799277133585, 14886.404543818126, 14918.17950012738, 15077.0, 15100.244987750568, 15145.242737863064, 8986.32602554798, 9017.188453039258, 9038.231750301167, 9091.499967501852, 9127.315451341176, 8137.918620813834, 8462.915370846213, 9052.185303322733, 9126.634934602675, 9288.34981551285, 4098.118904435561, 4357.934630980538, 4627.236505976476, 4645.883852903705, 4716.575508204278, 1611.5170813855793, 1767.6818172728774, 1790.185465613143, 1887.2168050259263, 1929.411529483521, 776.4719990406578, 888.8000199954959, 918.7197904639015, 931.4132096778986, 973.4013581647235, 20548.58902821935, 20944.895275523526, 21004.894975525025, 21030.78969210319, 21181.55762498385, 916.8716379706847, 929.330881765128, 934.6448349627099, 941.4915945389413, 946.8390373636498, 10661.626843060456, 11397.886021139682, 11446.370449625185, 11448.397224388593, 11508.309501429942, 655603.0, 661193.0, 667726.6613666901, 676692.0, 680831.0, 138291.30854345663, 139190.99999999796, 143995.84006239916, 145391.2730436341, 147645.0, 960.9759756006016, 963.3834346018554, 978.3982850546862, 980.509745127422, 980.843065109579, 18003.09984500796, 18778.06109694537, 19482.512937176685, 19495.415137545897, 19564.706529402356, 51584.710382240744, 53616.46383536271, 53892.730536347066, 53990.0, 54259.18611220756, 76851.2314876844, 78549.0, 78606.13938606094, 79092.0, 79612.60193699226, 7692.499987500794, 8131.918680813116, 8234.629441675259, 8282.254597086292, 8316.168383161636, 10919.508622111865, 12807.487700491876, 12829.294388808705, 12836.101472896808, 12942.12339210828, 9059.456432614064, 10630.52162652667, 10986.835197471884, 11281.943590281997, 11665.716771155336, 10960.506777194885, 11046.226764126755, 11055.834162487408, 11281.0, 11413.0, 8930.910690893268, 11191.2725672831, 11587.304761714324, 11824.940875295568, 11914.344711040976, 6571.441427478718, 8087.242133803854, 8259.079517880604, 8301.875471868048, 8453.915460845314, 9900.801983960424, 10443.634472793416, 10709.946450267698, 11219.382933938712, 11355.829662555234], "value": 9773.765231035575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.9169049857003, 1555.5644419562523, 1579.2972127403302, 1822.2528763207079, 1969.1631056800857, 8129.91870081299, 8635.827283454335, 8851.6016779245, 9218.86171707425, 9234.261259099272, 9081.500517471537, 9169.724908252747, 9171.0, 9183.724488265347, 9185.90814091859, 1996.5308152584169, 2475.405902583385, 2479.5536803375385, 2482.553140434721, 2482.565551028563, 2414.6378043293557, 2457.3856535866034, 2460.3480077779313, 2460.766227208412, 2464.544059349017, 2425.708914930211, 2445.730969593343, 2447.1068060158004, 2458.963115553268, 2462.224399314219, 2401.807855371566, 2435.5737745894485, 2438.366024833538, 2441.2432146034607, 2445.9266222013366, 2389.976100238993, 2426.1144682191048, 2429.854208747463, 2434.415740222352, 2435.6346548017764, 9017.23353514952, 9041.864372034424, 9077.68228112013, 9125.908740912639, 9137.81724365509, 5420.268263784378, 5625.268715067015, 5638.605297629127, 5642.4075472075665, 5661.179129026268, 3681.9263614727824, 3712.6472985066375, 3738.6261373862394, 3780.8487660493547, 3788.280226756935, 1106.811841986856, 1107.4794846422249, 1129.7514546799691, 1150.9942450287779, 1154.584349634131, 12022.51909923602, 12071.155019148664, 12142.392880356036, 12163.0, 12179.756404871852, 4529.614982726439, 4555.749433781174, 4754.881127971828, 4762.761861906891, 4773.11697335987, 9356.0, 9361.485118318558, 9364.484953327496, 9370.0, 9377.1091746284, 5421.241026256327, 5434.592405569598, 5434.83695489136, 5435.510804027656, 5436.266104075979, 4614.953850461519, 4772.665913386029, 4929.2359684248995, 5055.0648130095315, 5089.821856235014, 3864.072622570619, 3885.0287428142965, 3976.1848820991627, 3996.7202295839593, 3998.4402183694306, 1167.3754541320352, 1178.793711100554, 1180.4451907603413, 1189.9345535995603, 1193.958211462612, 887.5029983209423, 895.1987970766259, 899.8740176375313, 900.144862380741, 904.9547522623842, 5646.548276137899, 5876.147958546072, 5881.120137322584, 5919.526437885045, 6077.969610151921, 443.57416879795113, 449.7301619028557, 459.17348772210556, 978.5498670611598, 1010.5149528226492, 3827.775111964145, 3887.378019516864, 3930.194310166409, 3956.584558621303, 3980.144268982183, 10786.892131078746, 11250.324980501196, 11278.15413843965, 11282.379469129277, 11285.548578056785, 8523.872141917876, 11049.889501105046, 11121.332720036662, 11171.21801473889, 11261.268017578832, 8450.197231263142, 8511.106333834858, 8568.35737319691, 8635.827283454295, 8650.87023694645, 5759.539236861125, 5985.940140598713, 5993.430624090704, 6000.669963152069, 6042.274927008787, 10180.389176649425, 10316.793664126826, 10366.948165259428, 10436.895631043591, 10462.843057354297, 10181.33821301613, 10304.021117993778, 10362.481875906326, 10642.0, 10648.201384896009, 6749.595024298362, 6962.268961758942, 6978.441724662116, 7219.422446204396, 7391.778246652609, 8425.831483370175, 8547.529885856338, 8649.524276164871, 8798.604062817316, 8805.559722014003, 6596.0, 7658.8085297868, 7819.921800782147, 7856.803579910548, 7943.841123177389, 7590.506617069873, 7653.0, 7723.806904827425, 7728.227177282227, 7843.529388236724, 7201.027861238876, 7344.081989751281, 7350.816229594303, 7353.0441042664115, 7363.558186508827, 4462.464504259509, 4898.8775280618265, 4997.750112494434, 5127.128388174094, 5144.125498665161, 5050.545450909289, 5053.0399224147295, 5174.249733788504, 5191.558717508903, 5261.026710058652], "value": 4636.02305999971, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.3450047383909, 305.3541759179336, 312.5046800820699, 315.4054607065682, 320.29854618385747, 4572.58846703797, 5363.6245462817615, 5380.461953804617, 5382.434844341346, 5429.647072940256, 4276.615104640582, 4656.743879086649, 5014.448410674832, 5339.691775514994, 5346.117890548055, 3665.157013886808, 4011.83952641894, 4073.022474606103, 4073.1446396256747, 4113.218488487193, 3559.4516385372444, 3664.2305115925687, 3701.8519259229734, 3733.216024634816, 4075.657960472414, 3682.6190178682996, 3998.3402738548107, 4042.4138499917494, 4051.6758659307184, 4067.776272305037, 4028.1742242840146, 4071.470708807836, 4072.3891416287647, 4076.184763047402, 4117.435374557664, 2904.6057892211857, 3314.3537010283003, 3333.666633336671, 3349.43059679855, 3532.929341413183, 3919.8432062717457, 4435.868853442384, 5189.3772747270195, 5196.92204616931, 5224.817131400421, 4030.9318030721884, 4580.0152967112235, 4669.719816811003, 4716.52834716529, 4735.73953432561, 4631.698939568917, 5319.255304257407, 5647.971760141214, 5658.34928983164, 5670.716464176775, 3095.891643792479, 3712.2946640138557, 3936.350502167139, 3936.488256526633, 3955.4857868476915, 5511.795281887237, 5793.420657934215, 5840.299164100293, 5900.551271222437, 5912.137676631847, 3472.756907016535, 3956.33833789809, 3970.166265084307, 3974.5230572331507, 3991.7006224532697, 3032.3935212957495, 3538.327717733622, 4006.7395619284653, 4064.6138616831354, 4069.959300406958, 3566.233259849093, 3959.4654721612214, 4175.185838761473, 4602.792874320664, 4697.553732395417, 5667.376588575254, 5672.234248376416, 5675.971620141873, 5700.629459085146, 5709.771609135588, 1333.2533781082432, 1356.8982326325565, 1358.2258112875566, 1358.639960410492, 1364.324659293656, 811.9809638903139, 836.7113345895656, 837.6314421654453, 863.710656929923, 866.8049688819965, 5269.71016594091, 5284.943011397736, 5313.282706834605, 5331.226972089025, 5331.86670333237, 4844.0, 5073.365829271341, 5742.425757424224, 5757.309122905194, 5762.933857236341, 4407.140607581555, 4863.003084367696, 5223.085959957069, 5254.92117618236, 5285.31290932184, 2773.0865702665096, 2773.1680495851165, 2882.855857207131, 2990.9551356729667, 3010.1872494426384, 5120.206368012964, 5295.391030031596, 5887.143920731927, 5899.321578018583, 5948.821535353946, 4859.757012149378, 5123.923141152885, 5787.469643517536, 5864.325602555676, 5877.5591830612875, 4856.4415092264135, 5548.4451554845, 5851.414858514285, 5893.3222679391565, 5904.704764761745, 5341.866453338697, 5486.972565137149, 5697.8860422790485, 5758.107493338539, 5770.394108618535, 4872.512748725099, 5219.0856857356985, 5642.855714828504, 5659.603827732019, 5684.317881854204, 5796.840631873726, 5824.767009319579, 5859.794907178229, 5878.412158784087, 5906.911396329145, 3163.8734450622637, 3623.7498063168164, 3675.320065787838, 3876.8175706409816, 3889.9805500972316, 4605.411133159055, 5303.632193557042, 5683.630564013326, 5684.658920464785, 5688.573356998324, 4711.246200608023, 5548.944510554843, 5556.527695145796, 5561.4716601922755, 5562.360328562268, 4267.125239325868, 4995.875103122451, 5216.426193118678, 5514.724263786875, 5579.2746942897165, 5057.641132152782, 5153.974230128825, 5279.551238144801, 5410.78356865721, 5452.646622327161, 5212.175738491497, 5497.670139791625, 5658.632188907708, 5668.647511282771, 5693.174489698888, 5266.499682530153, 5375.19372094189, 5547.001539722889, 5548.778048878161, 5562.860928476659], "value": 4043.3915715081484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2021475839678, 731.630526584075, 789.5138386418787, 799.5682331540968, 873.785922449, 15815.762763558541, 16873.24070416831, 16897.324107035703, 16948.152592370392, 16949.40677076301, 14939.402423903031, 15073.547793566184, 15109.471168509104, 15129.31918063687, 15130.09219446834, 708.9999999999987, 731.4148681055161, 735.4447392218867, 871.8430682477151, 887.8268737596171, 870.6256309786789, 888.0453512474116, 893.9687110951118, 894.1818236313765, 894.8165626046645, 955.4315182466456, 955.5174636808403, 956.3305686019814, 957.6360982826516, 959.8896126945386, 943.6697155995415, 944.8535477001076, 945.0549450549416, 946.9715908522755, 947.0624082158613, 709.7622296530668, 709.7764204275637, 710.1017213225274, 710.3287393413226, 712.654362634122, 15530.301136448774, 15861.603459913595, 15879.682406351923, 15883.28525216368, 15908.920455397765, 15094.546943831167, 15303.693926121527, 15379.0, 15425.537233883002, 15499.612509687235, 11420.200585958986, 11709.355985420883, 11833.0, 12078.758424831454, 12243.877561224452, 4665.136949664323, 4941.752912354368, 5106.336176297094, 5109.0, 5114.641975061747, 115968.0, 117087.41456292749, 121727.39136304263, 122560.77439225583, 125756.0, 11104.61133860311, 11354.48904799286, 11360.149522995664, 11911.52353905834, 12068.6310113076, 22943.426414339774, 23075.07699692027, 23772.762272377055, 24190.790460476906, 24488.877555612107, 8524.147585241426, 8566.057733649293, 8698.956125264882, 8854.114588541222, 8940.284777217938, 4560.338750881104, 4651.279051746985, 4772.976135119372, 4791.712497250176, 4797.280407938837, 3695.150115473456, 3860.613938606173, 3862.1117143057254, 3869.5936926622862, 3869.6323849234277, 686.2108575138631, 691.5193940211606, 701.9964900175569, 703.3423748794893, 723.6634964741315, 568.2868000659146, 585.2041223935445, 588.2441063233724, 607.60505671314, 694.0630149298406, 8317.41778075529, 8460.238578527962, 8956.776080598038, 9952.601895924226, 10008.44953527563, 688.2704333406605, 695.3116414749463, 695.9512834101665, 704.3484776581641, 709.0817391478048, 4915.232353729899, 4972.025493983322, 4988.448065982674, 5009.348784657971, 5010.123228435009, 106689.0, 130157.0, 138265.54336141676, 163836.0, 166208.3379166217, 136112.31943840216, 141678.0, 141853.0, 146786.0, 149790.0, 110048.0, 116904.41547792207, 121551.39224303822, 128943.0, 130307.0, 10154.289199755945, 10273.589056437957, 10329.741756455847, 10475.004874536908, 10585.470726463493, 50797.74601126971, 60200.69899650474, 65155.0, 68421.65789171221, 69272.6536367315, 98867.50566247123, 101218.0, 101494.49252753689, 102157.0, 105382.0, 13827.585172444842, 13874.722505549631, 14088.0, 14199.219042952323, 14244.572662820132, 14704.705905882036, 14861.702765944405, 15553.0, 15997.760033599738, 16877.156142193086, 14089.0, 14134.15195088298, 14504.564863054125, 15487.5353739388, 15643.84356156424, 13997.720045598828, 14620.342084606431, 14698.41206351734, 14737.1894545801, 15080.0, 12187.51249949992, 12217.694557635774, 12475.251484910934, 14745.041572297767, 15295.388184472497, 10242.231832612435, 11718.88281117178, 11725.88274117248, 11791.115666324888, 12393.0, 10299.794004120025, 11982.58060967862, 12159.148859579744, 12258.754824903273, 12389.070819688739], "value": 8309.637525819844, "unit": "score"}], "name": "dromaeo_css", "value": 7476.018660265706, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 112.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 141.0, 140.0, 98.0, 113.0, 137.0, 139.0, 176.0, 121.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 182.0, 183.0, 183.0, 183.0, 182.0, 183.0, 186.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 90.0, 63.0, 59.0, 59.0, 59.0, 82.0, 57.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 94.0, 70.0, 67.0, 68.0, 92.0, 67.0, 69.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 125.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 135.0, 161.0, 162.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 113.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 85.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 52.0, 55.0, 57.0, 59.0, 58.0, 58.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 64.0, 74.0, 70.0, 68.0, 68.0, 68.0, 69.0, 70.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 84.0, 85.0, 88.0, 83.0, 86.0, 99.0, 92.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 136.0, 134.0, 134.0, 138.0, 134.0, 138.0, 177.0, 140.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 196.0, 225.0, 165.0, 165.0, 160.0, 162.0, 160.0, 161.0, 161.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 83.0, 66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1447.8000000000002, "alertThreshold": 2.0}]} 15:19:42 INFO - Return code: 0 15:19:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:19:42 INFO - # TBPL SUCCESS # 15:19:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:19:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:19:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:19:42 INFO - 2017-01-12 15:19:42.772 screenresolution[2176:16583] starting screenresolution argv=screenresolution get 15:19:42 INFO - 2017-01-12 15:19:42.774 screenresolution[2176:16583] Display 0: 1600x1200x32@60 15:19:42 INFO - 2017-01-12 15:19:42.780 screenresolution[2177:16586] starting screenresolution argv=screenresolution list 15:19:42 INFO - Available Modes on Display 0 15:19:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:19:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:19:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:19:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:19:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:19:43 INFO - Intel Iris: 15:19:43 INFO - Chipset Model: Intel Iris 15:19:43 INFO - Type: GPU 15:19:43 INFO - Bus: Built-In 15:19:43 INFO - VRAM (Dynamic, Max): 1536 MB 15:19:43 INFO - Vendor: Intel (0x8086) 15:19:43 INFO - Device ID: 0x0a2e 15:19:43 INFO - Revision ID: 0x0009 15:19:43 INFO - Displays: 15:19:43 INFO - Display: 15:19:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:19:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:19:43 INFO - Display Serial Number: 1600x1200 60 15:19:43 INFO - Main Display: Yes 15:19:43 INFO - Mirror: Off 15:19:43 INFO - Online: Yes 15:19:43 INFO - Rotation: Supported 15:19:43 INFO - Return code: 0 15:19:43 INFO - Running post-action listener: _resource_record_post_action 15:19:43 INFO - [mozharness: 2017-01-12 23:19:43.024852Z] Finished run-tests step (success) 15:19:43 INFO - Running post-run listener: _resource_record_post_run 15:19:43 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 1089536; Write bytes: 495621632; Read time: 18; Write time: 1563 15:19:43 INFO - TinderboxPrint: CPU usage
53.1% 15:19:43 INFO - TinderboxPrint: I/O read bytes / time
1,089,536 / 18 15:19:43 INFO - TinderboxPrint: I/O write bytes / time
495,621,632 / 1,563 15:19:43 INFO - TinderboxPrint: CPU idle
2,247.9 (46.9%) 15:19:43 INFO - TinderboxPrint: CPU system
956.3 (20.0%) 15:19:43 INFO - TinderboxPrint: CPU user
1,585.4 (33.1%) 15:19:43 INFO - TinderboxPrint: Swap in / out
196,276,224 / 0 15:19:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192532992; Write bytes: 189302784; Read time: 17586; Write time: 398 15:19:43 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 245760; Write bytes: 295030272; Read time: 16; Write time: 1125 15:19:43 INFO - Running post-run listener: _upload_blobber_files 15:19:43 INFO - Blob upload gear active. 15:19:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:43 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 15:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:19:43 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:19:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:45 INFO - (blobuploader) - INFO - Done attempting. 15:19:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:19:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:19:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:46 INFO - (blobuploader) - INFO - Done attempting. 15:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:48 INFO - (blobuploader) - INFO - Done attempting. 15:19:48 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:48 INFO - Return code: 0 15:19:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/625a5a34d98ed934718b0b872d60dd3d269b61a8509920d3474596058d7d166fda930a2fa815e0aad763d8bed272d9b550950741739eb9504bf2746bd410c124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da23e8c783b2b1dea3fbf626fc34b506b1b69cb6e94876f70740b0e66344e5523f427ceec2150efaa4e8fef2a1fc374fd80f2740ce2b940372f3183e235882cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30865906e9a01415b66a4527e69eebcf00c9f2b56093e850fda2ca169ed0e7de7c1e233ef721fb4d820f61ca67caf87328fe53e93451b5f8ac7729c2451d560b"} 15:19:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:48 INFO - Contents: 15:19:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/625a5a34d98ed934718b0b872d60dd3d269b61a8509920d3474596058d7d166fda930a2fa815e0aad763d8bed272d9b550950741739eb9504bf2746bd410c124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da23e8c783b2b1dea3fbf626fc34b506b1b69cb6e94876f70740b0e66344e5523f427ceec2150efaa4e8fef2a1fc374fd80f2740ce2b940372f3183e235882cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30865906e9a01415b66a4527e69eebcf00c9f2b56093e850fda2ca169ed0e7de7c1e233ef721fb4d820f61ca67caf87328fe53e93451b5f8ac7729c2451d560b"} 15:19:48 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:48 INFO - Copying logs to upload dir... 15:19:48 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.177553 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-12 15:19:48.383757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 15:19:48.387414) ========= 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.jectfRpSRe/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.HnnDrd5tS9/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/625a5a34d98ed934718b0b872d60dd3d269b61a8509920d3474596058d7d166fda930a2fa815e0aad763d8bed272d9b550950741739eb9504bf2746bd410c124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da23e8c783b2b1dea3fbf626fc34b506b1b69cb6e94876f70740b0e66344e5523f427ceec2150efaa4e8fef2a1fc374fd80f2740ce2b940372f3183e235882cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30865906e9a01415b66a4527e69eebcf00c9f2b56093e850fda2ca169ed0e7de7c1e233ef721fb4d820f61ca67caf87328fe53e93451b5f8ac7729c2451d560b"} build_url:https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011500 build_url: 'https://queue.taskcluster.net/v1/task/JPaoUPPZTByFanX527isMA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/625a5a34d98ed934718b0b872d60dd3d269b61a8509920d3474596058d7d166fda930a2fa815e0aad763d8bed272d9b550950741739eb9504bf2746bd410c124", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da23e8c783b2b1dea3fbf626fc34b506b1b69cb6e94876f70740b0e66344e5523f427ceec2150efaa4e8fef2a1fc374fd80f2740ce2b940372f3183e235882cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30865906e9a01415b66a4527e69eebcf00c9f2b56093e850fda2ca169ed0e7de7c1e233ef721fb4d820f61ca67caf87328fe53e93451b5f8ac7729c2451d560b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 15:19:48.424472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 15:19:48.425031) ========= 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.jectfRpSRe/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.HnnDrd5tS9/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.004495 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 15:19:48.474152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 15:19:48.474522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 15:19:48.474896) ========= ========= Total master_lag: 0.19 =========