builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1489483151.13 results: success (0) buildid: 20170314004020 builduid: 95c77de6dc77494096f90ac461766458 revision: b364c6b8169d20e86287510bc6d3fbdb6dded75e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.129904) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.130539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.130951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.388630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.388972) ========= 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.93UNGwwOLw/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.DmyCApZrK2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-03-14 02:19:11-- 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% 15.0M=0.001s 2017-03-14 02:19:11 (15.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198857 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.613344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.613818) ========= 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.93UNGwwOLw/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.DmyCApZrK2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.028055 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:11.665669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-14 02:19:11.666298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b364c6b8169d20e86287510bc6d3fbdb6dded75e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b364c6b8169d20e86287510bc6d3fbdb6dded75e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.93UNGwwOLw/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.DmyCApZrK2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-03-14 02:19:11,770 truncating revision to first 12 chars 2017-03-14 02:19:11,770 Setting DEBUG logging. 2017-03-14 02:19:11,770 attempt 1/10 2017-03-14 02:19:11,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b364c6b8169d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 02:19:13,885 unpacking tar archive at: mozilla-aurora-b364c6b8169d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.378418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-14 02:19:14.069393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:14.069809) ========= script_repo_revision: b364c6b8169d20e86287510bc6d3fbdb6dded75e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:14.070273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:14.070612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 02:19:14.091195) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-14 02:19:14.091632) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.93UNGwwOLw/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.DmyCApZrK2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:19:14 INFO - MultiFileLogger online at 20170314 02:19:14 in /builds/slave/test 02:19:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:19:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:14 INFO - {'append_to_log': False, 02:19:14 INFO - 'base_work_dir': '/builds/slave/test', 02:19:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:19:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:14 INFO - 'branch': 'Mozilla-Aurora', 02:19:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:14 INFO - 'config_files': ('talos/mac_config.py',), 02:19:14 INFO - 'default_actions': ('clobber', 02:19:14 INFO - 'read-buildbot-config', 02:19:14 INFO - 'download-and-extract', 02:19:14 INFO - 'populate-webroot', 02:19:14 INFO - 'create-virtualenv', 02:19:14 INFO - 'install', 02:19:14 INFO - 'run-tests'), 02:19:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:14 INFO - 'download_minidump_stackwalk': True, 02:19:14 INFO - 'download_symbols': 'ondemand', 02:19:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:14 INFO - 'gecko_profile': False, 02:19:14 INFO - 'gecko_profile_interval': 0, 02:19:14 INFO - 'installer_path': 'installer.exe', 02:19:14 INFO - 'log_level': 'info', 02:19:14 INFO - 'log_name': 'talos', 02:19:14 INFO - 'log_to_console': True, 02:19:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:19:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:19:14 INFO - 'opt_config_files': (), 02:19:14 INFO - 'pip_index': False, 02:19:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:19:14 INFO - 'cmd': ('bash', 02:19:14 INFO - '-c', 02:19:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:19:14 INFO - 'enabled': True, 02:19:14 INFO - 'halt_on_failure': False, 02:19:14 INFO - 'name': 'check_screen_resolution'},), 02:19:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:19:14 INFO - 'cmd': ('bash', 02:19:14 INFO - '-c', 02:19:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:19:14 INFO - 'enabled': True, 02:19:14 INFO - 'halt_on_failure': False, 02:19:14 INFO - 'name': 'check_screen_resolution'},), 02:19:14 INFO - 'run_cmd_checks_enabled': True, 02:19:14 INFO - 'suite': 'dromaeojs', 02:19:14 INFO - 'system_bits': '32', 02:19:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:14 INFO - 'title': 't-yosemite-r7-0084', 02:19:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:14 INFO - 'use_talos_json': True, 02:19:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:14 INFO - 'work_dir': 'build'} 02:19:14 INFO - [mozharness: 2017-03-14 09:19:14.308727Z] Running clobber step. 02:19:14 INFO - Running pre-action listener: _resource_record_pre_action 02:19:14 INFO - Running main action method: clobber 02:19:14 INFO - rmtree: /builds/slave/test/build 02:19:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:16 INFO - Running post-action listener: _resource_record_post_action 02:19:16 INFO - [mozharness: 2017-03-14 09:19:16.795919Z] Finished clobber step (success) 02:19:16 INFO - [mozharness: 2017-03-14 09:19:16.796097Z] Running read-buildbot-config step. 02:19:16 INFO - Running pre-action listener: _resource_record_pre_action 02:19:16 INFO - Running main action method: read_buildbot_config 02:19:16 INFO - Using buildbot properties: 02:19:16 INFO - { 02:19:16 INFO - "project": "", 02:19:16 INFO - "product": "firefox", 02:19:16 INFO - "script_repo_revision": "production", 02:19:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:19:16 INFO - "repository": "", 02:19:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:19:16 INFO - "buildid": "20170314004020", 02:19:16 INFO - "stage_platform": "macosx64", 02:19:16 INFO - "basedir": "/builds/slave/test", 02:19:16 INFO - "nightly_build": "True", 02:19:16 INFO - "buildnumber": 84, 02:19:16 INFO - "slavename": "t-yosemite-r7-0084", 02:19:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:19:16 INFO - "platform": "yosemite_r7", 02:19:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:19:16 INFO - "branch": "mozilla-aurora", 02:19:16 INFO - "repo_path": "releases/mozilla-aurora", 02:19:16 INFO - "revision": "b364c6b8169d20e86287510bc6d3fbdb6dded75e", 02:19:16 INFO - "pgo_build": "False", 02:19:16 INFO - "builduid": "95c77de6dc77494096f90ac461766458", 02:19:16 INFO - "slavebuilddir": "test" 02:19:16 INFO - } 02:19:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:19:16 INFO - Running post-action listener: _resource_record_post_action 02:19:16 INFO - [mozharness: 2017-03-14 09:19:16.799496Z] Finished read-buildbot-config step (success) 02:19:16 INFO - [mozharness: 2017-03-14 09:19:16.799622Z] Running download-and-extract step. 02:19:16 INFO - Running pre-action listener: _resource_record_pre_action 02:19:16 INFO - Running main action method: download_and_extract 02:19:16 INFO - mkdir: /builds/slave/test/build/tests 02:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:16 INFO - trying https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:19:16 INFO - Downloading https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:19:18 INFO - Downloaded 1199 bytes. 02:19:18 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:19:18 INFO - Using the following test package requirements: 02:19:18 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:19:18 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:19:18 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:19:18 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'jsshell-mac.zip'], 02:19:18 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:19:18 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:19:18 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:19:18 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:19:18 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:19:18 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:19:18 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:19:18 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:19:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:19:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:19:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:19:20 INFO - Expected file size: 51780092 02:19:20 INFO - Obtained file size: 51780092 02:19:36 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:19:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:19:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:19:36 INFO - Fetch https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:19:37 INFO - Expected file size: 51780092 02:19:37 INFO - Obtained file size: 51780092 02:19:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:19:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:19:52 INFO - Fetch https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:19:53 INFO - Expected file size: 14404424 02:19:53 INFO - Obtained file size: 14404424 02:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:53 INFO - trying https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:19:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:19:56 INFO - Downloaded 74650750 bytes. 02:19:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:19:56 INFO - mkdir: /builds/slave/test/properties 02:19:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:56 INFO - Contents: 02:19:56 INFO - build_url:https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:19:56 INFO - Running post-action listener: _resource_record_post_action 02:19:56 INFO - Running post-action listener: set_extra_try_arguments 02:19:56 INFO - [mozharness: 2017-03-14 09:19:56.962483Z] Finished download-and-extract step (success) 02:19:56 INFO - [mozharness: 2017-03-14 09:19:56.962619Z] Running populate-webroot step. 02:19:56 INFO - Running pre-action listener: _resource_record_pre_action 02:19:56 INFO - Running main action method: populate_webroot 02:19:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:56 INFO - '--tppagecycles', 02:19:56 INFO - '7'], 02:19:56 INFO - 'tests': ['tsvgm']}}, 02:19:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['damp', 'tps']}, 02:19:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'tests': ['damp', 'tps']}, 02:19:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['dromaeo_dom']}, 02:19:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['basic_compositor_video']}, 02:19:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['a11yr', 02:19:56 INFO - 'ts_paint', 02:19:56 INFO - 'tpaint', 02:19:56 INFO - 'sessionrestore', 02:19:56 INFO - 'sessionrestore_no_auto_restore', 02:19:56 INFO - 'tabpaint']}, 02:19:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:56 INFO - 'ts_paint', 02:19:56 INFO - 'tpaint', 02:19:56 INFO - 'sessionrestore', 02:19:56 INFO - 'sessionrestore_no_auto_restore', 02:19:56 INFO - 'tabpaint']}, 02:19:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:56 INFO - 'ts_paint', 02:19:56 INFO - 'tpaint', 02:19:56 INFO - 'sessionrestore', 02:19:56 INFO - 'sessionrestore_no_auto_restore', 02:19:56 INFO - 'tabpaint']}, 02:19:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:56 INFO - 'ts_paint', 02:19:56 INFO - 'tpaint', 02:19:56 INFO - 'sessionrestore', 02:19:56 INFO - 'sessionrestore_no_auto_restore', 02:19:56 INFO - 'tabpaint']}, 02:19:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['a11yr', 02:19:56 INFO - 'ts_paint', 02:19:56 INFO - 'tpaint', 02:19:56 INFO - 'sessionrestore', 02:19:56 INFO - 'sessionrestore_no_auto_restore', 02:19:56 INFO - 'tabpaint']}, 02:19:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['a11yr', 02:19:56 INFO - 'ts_paint', 02:19:56 INFO - 'tpaint', 02:19:56 INFO - 'sessionrestore', 02:19:56 INFO - 'sessionrestore_no_auto_restore', 02:19:56 INFO - 'tabpaint']}, 02:19:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['tsvgx', 02:19:56 INFO - 'tsvgr_opacity', 02:19:56 INFO - 'tart', 02:19:56 INFO - 'tscrollx', 02:19:56 INFO - 'cart', 02:19:56 INFO - 'tsvg_static']}, 02:19:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:56 INFO - 'tsvgr_opacity', 02:19:56 INFO - 'tart', 02:19:56 INFO - 'tscrollx', 02:19:56 INFO - 'cart', 02:19:56 INFO - 'tsvg_static']}, 02:19:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'talos_options': ['--disable-e10s'], 02:19:56 INFO - 'tests': ['tp5o']}, 02:19:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:19:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'talos_options': ['--disable-e10s', 02:19:56 INFO - '--xperf_path', 02:19:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:56 INFO - 'tests': ['tp5n']}, 02:19:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:19:56 INFO - 'talos_options': ['--xperf_path', 02:19:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:56 INFO - 'tests': ['tp5n']}}, 02:19:56 INFO - 'talos.zip': {'path': '', 02:19:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:56 INFO - Running post-action listener: _resource_record_post_action 02:19:56 INFO - [mozharness: 2017-03-14 09:19:56.981096Z] Finished populate-webroot step (success) 02:19:56 INFO - [mozharness: 2017-03-14 09:19:56.981208Z] Running create-virtualenv step. 02:19:56 INFO - Running pre-action listener: _resource_record_pre_action 02:19:56 INFO - Running main action method: create_virtualenv 02:19:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:56 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 02:19:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:57 INFO - Using real prefix '/tools/python27' 02:19:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:57 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:00 INFO - Installing pip.................done. 02:20:00 INFO - Return code: 0 02:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:20:00 INFO - Reading from file tmpfile_stdout 02:20:00 INFO - Output received: 02:20:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:20:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:01 INFO - 'HOME': '/Users/cltbld', 02:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:01 INFO - 'LOGNAME': 'cltbld', 02:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:01 INFO - 'MOZ_NO_REMOTE': '1', 02:20:01 INFO - 'NO_EM_RESTART': '1', 02:20:01 INFO - 'PAGER': '/bin/cat', 02:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:01 INFO - 'PWD': '/builds/slave/test', 02:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:01 INFO - 'SHELL': '/bin/bash', 02:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:01 INFO - 'USER': 'cltbld', 02:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:01 INFO - 'XPC_FLAGS': '0x0', 02:20:01 INFO - 'XPC_SERVICE_NAME': '0', 02:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:01 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 02:20:01 INFO - Cleaning up... 02:20:01 INFO - Return code: 0 02:20:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:01 INFO - 'HOME': '/Users/cltbld', 02:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:01 INFO - 'LOGNAME': 'cltbld', 02:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:01 INFO - 'MOZ_NO_REMOTE': '1', 02:20:01 INFO - 'NO_EM_RESTART': '1', 02:20:01 INFO - 'PAGER': '/bin/cat', 02:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:01 INFO - 'PWD': '/builds/slave/test', 02:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:01 INFO - 'SHELL': '/bin/bash', 02:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:01 INFO - 'USER': 'cltbld', 02:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:01 INFO - 'XPC_FLAGS': '0x0', 02:20:01 INFO - 'XPC_SERVICE_NAME': '0', 02:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:01 INFO - Downloading/unpacking psutil>=3.1.1 02:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:05 INFO - Installing collected packages: psutil 02:20:05 INFO - Running setup.py install for psutil 02:20:05 INFO - building 'psutil._psutil_osx' extension 02:20:05 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 02:20:06 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 02:20:06 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 02:20:06 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 02:20:06 INFO - building 'psutil._psutil_posix' extension 02:20:06 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 02:20:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:20:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:20:06 INFO - ^ 02:20:06 INFO - 1 warning generated. 02:20:06 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 02:20:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:06 INFO - Successfully installed psutil 02:20:06 INFO - Cleaning up... 02:20:06 INFO - Return code: 0 02:20:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:06 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')]} 02:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:07 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:07 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 02:20:07 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 02:20:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:07 INFO - 'HOME': '/Users/cltbld', 02:20:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:07 INFO - 'LOGNAME': 'cltbld', 02:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:07 INFO - 'MOZ_NO_REMOTE': '1', 02:20:07 INFO - 'NO_EM_RESTART': '1', 02:20:07 INFO - 'PAGER': '/bin/cat', 02:20:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:07 INFO - 'PWD': '/builds/slave/test', 02:20:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:07 INFO - 'SHELL': '/bin/bash', 02:20:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:07 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:07 INFO - 'USER': 'cltbld', 02:20:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:07 INFO - 'XPC_FLAGS': '0x0', 02:20:07 INFO - 'XPC_SERVICE_NAME': '0', 02:20:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:11 INFO - Installing collected packages: mozsystemmonitor 02:20:11 INFO - Running setup.py install for mozsystemmonitor 02:20:11 INFO - Successfully installed mozsystemmonitor 02:20:11 INFO - Cleaning up... 02:20:11 INFO - Return code: 0 02:20:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:11 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:11 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 02:20:11 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 02:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:11 INFO - 'HOME': '/Users/cltbld', 02:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:11 INFO - 'LOGNAME': 'cltbld', 02:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:11 INFO - 'MOZ_NO_REMOTE': '1', 02:20:11 INFO - 'NO_EM_RESTART': '1', 02:20:11 INFO - 'PAGER': '/bin/cat', 02:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:11 INFO - 'PWD': '/builds/slave/test', 02:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:11 INFO - 'SHELL': '/bin/bash', 02:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:11 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:11 INFO - 'USER': 'cltbld', 02:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:11 INFO - 'XPC_FLAGS': '0x0', 02:20:11 INFO - 'XPC_SERVICE_NAME': '0', 02:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:14 INFO - warning: no files found matching '*.txt' 02:20:14 INFO - no previously-included directories found matching 'build' 02:20:14 INFO - no previously-included directories found matching 'dist' 02:20:14 INFO - no previously-included directories found matching '.git*' 02:20:14 INFO - Installing collected packages: jsonschema, functools32 02:20:14 INFO - Running setup.py install for functools32 02:20:15 INFO - warning: no files found matching '*.txt' 02:20:15 INFO - no previously-included directories found matching 'build' 02:20:15 INFO - no previously-included directories found matching 'dist' 02:20:15 INFO - no previously-included directories found matching '.git*' 02:20:15 INFO - Successfully installed jsonschema functools32 02:20:15 INFO - Cleaning up... 02:20:15 INFO - Return code: 0 02:20:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:15 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:15 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 02:20:15 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 02:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:15 INFO - 'HOME': '/Users/cltbld', 02:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:15 INFO - 'LOGNAME': 'cltbld', 02:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:15 INFO - 'MOZ_NO_REMOTE': '1', 02:20:15 INFO - 'NO_EM_RESTART': '1', 02:20:15 INFO - 'PAGER': '/bin/cat', 02:20:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:15 INFO - 'PWD': '/builds/slave/test', 02:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:15 INFO - 'SHELL': '/bin/bash', 02:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:15 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:15 INFO - 'USER': 'cltbld', 02:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:15 INFO - 'XPC_FLAGS': '0x0', 02:20:15 INFO - 'XPC_SERVICE_NAME': '0', 02:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:20:15 INFO - Cleaning up... 02:20:15 INFO - Return code: 0 02:20:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:15 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:15 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 02:20:15 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 02:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:15 INFO - 'HOME': '/Users/cltbld', 02:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:15 INFO - 'LOGNAME': 'cltbld', 02:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:15 INFO - 'MOZ_NO_REMOTE': '1', 02:20:15 INFO - 'NO_EM_RESTART': '1', 02:20:15 INFO - 'PAGER': '/bin/cat', 02:20:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:15 INFO - 'PWD': '/builds/slave/test', 02:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:15 INFO - 'SHELL': '/bin/bash', 02:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:15 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:15 INFO - 'USER': 'cltbld', 02:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:15 INFO - 'XPC_FLAGS': '0x0', 02:20:15 INFO - 'XPC_SERVICE_NAME': '0', 02:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:15 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 02:20:15 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 02:20:15 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 02:20:15 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 02:20:15 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 02:20:15 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 02:20:18 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:18 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 02:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:19 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 02:20:19 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 02:20:19 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 02:20:19 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 02:20:19 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 02:20:19 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 02:20:19 INFO - Downloading docopt-0.6.1.tar.gz 02:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:19 INFO - Running setup.py install for blobuploader 02:20:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:19 INFO - Running setup.py install for requests 02:20:20 INFO - Running setup.py install for docopt 02:20:20 INFO - Successfully installed blobuploader requests docopt 02:20:20 INFO - Cleaning up... 02:20:20 INFO - Return code: 0 02:20:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:20 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')]} 02:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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')]} 02:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:20 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:20 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 02:20:20 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 02:20:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:20 INFO - 'HOME': '/Users/cltbld', 02:20:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:20 INFO - 'LOGNAME': 'cltbld', 02:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:20 INFO - 'MOZ_NO_REMOTE': '1', 02:20:20 INFO - 'NO_EM_RESTART': '1', 02:20:20 INFO - 'PAGER': '/bin/cat', 02:20:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:20 INFO - 'PWD': '/builds/slave/test', 02:20:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:20 INFO - 'SHELL': '/bin/bash', 02:20:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:20 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:20 INFO - 'USER': 'cltbld', 02:20:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:20 INFO - 'XPC_FLAGS': '0x0', 02:20:20 INFO - 'XPC_SERVICE_NAME': '0', 02:20:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:20 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Njg58Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AJxDdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4LuVMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wqt2Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3klISI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-RqPsJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-D6v3jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Hj50Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3rgyWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:21 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-06lrhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-et8xaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hwz6wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-8drBrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-nT2y3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-EHqxl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-koqd9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:22 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-odgkzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:22 INFO - Running setup.py install for manifestparser 02:20:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:22 INFO - Running setup.py install for mozcrash 02:20:23 INFO - Running setup.py install for mozdebug 02:20:23 INFO - Running setup.py install for mozdevice 02:20:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Running setup.py install for mozfile 02:20:23 INFO - Running setup.py install for mozhttpd 02:20:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Running setup.py install for mozinfo 02:20:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Running setup.py install for mozInstall 02:20:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:23 INFO - Running setup.py install for mozleak 02:20:24 INFO - Running setup.py install for mozlog 02:20:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for moznetwork 02:20:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozprocess 02:20:24 INFO - Running setup.py install for mozprofile 02:20:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozrunner 02:20:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:24 INFO - Running setup.py install for mozscreenshot 02:20:25 INFO - Running setup.py install for moztest 02:20:25 INFO - Running setup.py install for mozversion 02:20:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:25 INFO - Cleaning up... 02:20:25 INFO - Return code: 0 02:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:25 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')]} 02:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:25 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')]} 02:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:25 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:25 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 02:20:25 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 02:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:25 INFO - 'HOME': '/Users/cltbld', 02:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:25 INFO - 'LOGNAME': 'cltbld', 02:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:25 INFO - 'MOZ_NO_REMOTE': '1', 02:20:25 INFO - 'NO_EM_RESTART': '1', 02:20:25 INFO - 'PAGER': '/bin/cat', 02:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:25 INFO - 'PWD': '/builds/slave/test', 02:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:25 INFO - 'SHELL': '/bin/bash', 02:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:25 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:25 INFO - 'USER': 'cltbld', 02:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:25 INFO - 'XPC_FLAGS': '0x0', 02:20:25 INFO - 'XPC_SERVICE_NAME': '0', 02:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:25 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uvrfzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:25 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)) 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:25 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-6_KLqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:25 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-80NU0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:25 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)) 02:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:25 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-6Uld5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-g34rZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-kSLdeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Mw7grq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Df6wjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JxYRus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cMpmwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YI7ndL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_CLnUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-U3aCaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:26 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)) 02:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:26 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZWSdHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:27 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-KOwJx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:27 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)) 02:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:27 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZgR7PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:27 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-SSEkQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:27 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)) 02:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:27 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)) 02:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:29 INFO - Downloading blessings-1.6.tar.gz 02:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:30 INFO - Installing collected packages: blessings 02:20:30 INFO - Running setup.py install for blessings 02:20:30 INFO - Successfully installed blessings 02:20:30 INFO - Cleaning up... 02:20:30 INFO - Return code: 0 02:20:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:30 INFO - Reading from file tmpfile_stdout 02:20:30 INFO - Current package versions: 02:20:30 INFO - blessings == 1.6 02:20:30 INFO - blobuploader == 1.2.4 02:20:30 INFO - docopt == 0.6.1 02:20:30 INFO - functools32 == 3.2.3-2 02:20:30 INFO - jsonschema == 2.5.1 02:20:30 INFO - manifestparser == 1.1 02:20:30 INFO - mozInstall == 1.12 02:20:30 INFO - mozcrash == 1.0 02:20:30 INFO - mozdebug == 0.1 02:20:30 INFO - mozdevice == 0.49 02:20:30 INFO - mozfile == 1.2 02:20:30 INFO - mozhttpd == 0.7 02:20:30 INFO - mozinfo == 0.9 02:20:30 INFO - mozleak == 0.1 02:20:30 INFO - mozlog == 3.4 02:20:30 INFO - moznetwork == 0.27 02:20:30 INFO - mozprocess == 0.25 02:20:30 INFO - mozprofile == 0.28 02:20:30 INFO - mozrunner == 6.13 02:20:30 INFO - mozscreenshot == 0.1 02:20:30 INFO - mozsystemmonitor == 0.3 02:20:30 INFO - moztest == 0.8 02:20:30 INFO - mozversion == 1.4 02:20:30 INFO - psutil == 3.1.1 02:20:30 INFO - requests == 1.2.3 02:20:30 INFO - wsgiref == 0.1.2 02:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:30 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')]} 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 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')]} 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:30 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 02:20:30 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 02:20:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:30 INFO - 'HOME': '/Users/cltbld', 02:20:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:30 INFO - 'LOGNAME': 'cltbld', 02:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:30 INFO - 'MOZ_NO_REMOTE': '1', 02:20:30 INFO - 'NO_EM_RESTART': '1', 02:20:30 INFO - 'PAGER': '/bin/cat', 02:20:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:30 INFO - 'PWD': '/builds/slave/test', 02:20:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:30 INFO - 'SHELL': '/bin/bash', 02:20:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:30 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:30 INFO - 'USER': 'cltbld', 02:20:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:30 INFO - 'XPC_FLAGS': '0x0', 02:20:30 INFO - 'XPC_SERVICE_NAME': '0', 02:20:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 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)) 02:20:30 INFO - Cleaning up... 02:20:30 INFO - Return code: 0 02:20:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:30 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')]} 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 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')]} 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 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 0x10bce7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bcea768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa231d61d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, '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.93UNGwwOLw/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.DmyCApZrK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:20:30 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 02:20:30 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 02:20:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:30 INFO - 'HOME': '/Users/cltbld', 02:20:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:30 INFO - 'LOGNAME': 'cltbld', 02:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:30 INFO - 'MOZ_NO_REMOTE': '1', 02:20:30 INFO - 'NO_EM_RESTART': '1', 02:20:30 INFO - 'PAGER': '/bin/cat', 02:20:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:30 INFO - 'PWD': '/builds/slave/test', 02:20:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:30 INFO - 'SHELL': '/bin/bash', 02:20:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:30 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:30 INFO - 'USER': 'cltbld', 02:20:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:30 INFO - 'XPC_FLAGS': '0x0', 02:20:30 INFO - 'XPC_SERVICE_NAME': '0', 02:20:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:31 INFO - Cleaning up... 02:20:31 INFO - Return code: 0 02:20:31 INFO - Running post-action listener: _resource_record_post_action 02:20:31 INFO - Running post-action listener: _start_resource_monitoring 02:20:31 INFO - Starting resource monitoring. 02:20:31 INFO - [mozharness: 2017-03-14 09:20:31.172330Z] Finished create-virtualenv step (success) 02:20:31 INFO - [mozharness: 2017-03-14 09:20:31.173286Z] Running install step. 02:20:31 INFO - Running pre-action listener: _resource_record_pre_action 02:20:31 INFO - Running main action method: install 02:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:31 INFO - Reading from file tmpfile_stdout 02:20:31 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:31 INFO - Reading from file tmpfile_stdout 02:20:31 INFO - Output received: 02:20:31 INFO - Usage: mozinstall [options] installer 02:20:31 INFO - Options: 02:20:31 INFO - -h, --help show this help message and exit 02:20:31 INFO - -d DEST, --destination=DEST 02:20:31 INFO - Directory to install application into. [default: 02:20:31 INFO - "/builds/slave/test"] 02:20:31 INFO - --app=APP Application being installed. [default: firefox] 02:20:31 INFO - mkdir: /builds/slave/test/build/application 02:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:20:51 INFO - Reading from file tmpfile_stdout 02:20:51 INFO - Output received: 02:20:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:20:51 INFO - Running post-action listener: _resource_record_post_action 02:20:51 INFO - [mozharness: 2017-03-14 09:20:51.471372Z] Finished install step (success) 02:20:51 INFO - [mozharness: 2017-03-14 09:20:51.471555Z] Running run-tests step. 02:20:51 INFO - Running pre-action listener: _resource_record_pre_action 02:20:51 INFO - Running main action method: run_tests 02:20:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:20:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:20:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:20:51 INFO - 2017-03-14 02:20:51.486 screenresolution[1628:7431] starting screenresolution argv=screenresolution get 02:20:51 INFO - 2017-03-14 02:20:51.488 screenresolution[1628:7431] Display 0: 1600x1200x32@60 02:20:51 INFO - 2017-03-14 02:20:51.494 screenresolution[1629:7434] starting screenresolution argv=screenresolution list 02:20:51 INFO - Available Modes on Display 0 02:20:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:20:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:20:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:20:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:20:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:20:51 INFO - Intel Iris: 02:20:51 INFO - Chipset Model: Intel Iris 02:20:51 INFO - Type: GPU 02:20:51 INFO - Bus: Built-In 02:20:51 INFO - VRAM (Dynamic, Max): 1536 MB 02:20:51 INFO - Vendor: Intel (0x8086) 02:20:51 INFO - Device ID: 0x0a2e 02:20:51 INFO - Revision ID: 0x0009 02:20:51 INFO - Displays: 02:20:51 INFO - Display: 02:20:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:20:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:20:51 INFO - Display Serial Number: 1600x1200 60 02:20:51 INFO - Main Display: Yes 02:20:51 INFO - Mirror: Off 02:20:51 INFO - Online: Yes 02:20:51 INFO - Rotation: Supported 02:20:51 INFO - Return code: 0 02:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:51 INFO - Python 2.7.3 02:20:51 INFO - Return code: 0 02:20:51 INFO - grabbing minidump binary from tooltool 02:20: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')]} 02:20:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac5d30>, '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 0x10b9ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bababe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:20:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:20:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:20:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:51 INFO - Return code: 0 02:20:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:20:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:51 INFO - ENV: RUST_BACKTRACE is now 1 02:20:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:20:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 02:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.93UNGwwOLw/Render', 02:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:51 INFO - 'HOME': '/Users/cltbld', 02:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:51 INFO - 'LOGNAME': 'cltbld', 02:20:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:51 INFO - 'MOZ_NO_REMOTE': '1', 02:20:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:51 INFO - 'NO_EM_RESTART': '1', 02:20:51 INFO - 'PAGER': '/bin/cat', 02:20:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:51 INFO - 'PWD': '/builds/slave/test', 02:20:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:51 INFO - 'RUST_BACKTRACE': '1', 02:20:51 INFO - 'SHELL': '/bin/bash', 02:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DmyCApZrK2/Listeners', 02:20:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:51 INFO - 'USER': 'cltbld', 02:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:51 INFO - 'XPC_FLAGS': '0x0', 02:20:51 INFO - 'XPC_SERVICE_NAME': '0', 02:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 02:20:52 INFO - mozversion application_buildid: 20170314004020 02:20:52 INFO - mozversion application_changeset: b364c6b8169d20e86287510bc6d3fbdb6dded75e 02:20:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:20:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:52 INFO - mozversion application_name: Firefox 02:20:52 INFO - mozversion application_remotingname: firefox-dev 02:20:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:20:52 INFO - mozversion application_vendor: Mozilla 02:20:52 INFO - mozversion application_version: 54.0a2 02:20:52 INFO - mozversion platform_buildid: 20170314004020 02:20:52 INFO - mozversion platform_changeset: b364c6b8169d20e86287510bc6d3fbdb6dded75e 02:20:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:20:52 INFO - mozversion platform_version: 54.0a2 02:20:52 INFO - using testdate: 1489483252 02:20:52 INFO - actual date: 1489483252 02:20:52 INFO - starting webserver on 'localhost:49250' 02:20:52 INFO - SUITE-START | Running 2 tests 02:20:52 INFO - TEST-START | dromaeo_css 02:20:52 INFO - operating with platform_type : mac_ 02:20:52 INFO - Initialising browser for dromaeo_css test... 02:20:52 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpCtAWI7/profile http://localhost:49250/getInfo.html) 02:20:54 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 02:20:54 INFO - PROCESS | 1639 | colorDepth:24 02:20:54 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 02:20:54 INFO - PROCESS | 1639 | __metrics 02:20:54 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:20:54 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:55 INFO - TEST-INFO | 1639: exit 0 02:20:55 INFO - Browser initialized. 02:20:55 INFO - Running cycle 1/1 for dromaeo_css test... 02:20:55 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpCtAWI7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:07 INFO - PROCESS | 1642 | RSS: Main: 214540288 02:21:07 INFO - PROCESS | 1642 | 02:24:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 02:24:14 INFO - PROCESS | 1642 | RSS: Main: 408395776 02:24:14 INFO - PROCESS | 1642 | 02:25:57 INFO - PROCESS | 1642 | ************************* 02:25:57 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 02:25:57 INFO - PROCESS | 1642 | 02:25:57 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:25:57 INFO - PROCESS | 1642 | Full stack: 02:25:57 INFO - PROCESS | 1642 | ************************* 02:27:17 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 02:27:17 INFO - PROCESS | 1642 | RSS: Main: 353902592 02:27:17 INFO - PROCESS | 1642 | 02:30:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 02:30:20 INFO - PROCESS | 1642 | RSS: Main: 328552448 02:30:20 INFO - PROCESS | 1642 | 02:33:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 02:33:24 INFO - PROCESS | 1642 | RSS: Main: 327946240 02:33:24 INFO - PROCESS | 1642 | 02:36:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 02:36:28 INFO - PROCESS | 1642 | RSS: Main: 326938624 02:36:28 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 02:39:31 INFO - PROCESS | 1642 | RSS: Main: 413003776 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | __start_tp_report 02:39:31 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 02:39:31 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 02:39:31 INFO - PROCESS | 1642 | |i|pagename|runs| 02:39:31 INFO - PROCESS | 1642 | |0;dojo.html;3014.366982933584;3410.6589341065896;3415.5047518109873;3450.2581944881845;3454.27460233351;5909.2022576952095;5953.523718102552;5962.34414214436;5963.791267305645;5982.491488223501;5975.970120149394;6044.214252147226;6054.969725151379;6056.212692349999;6080.908786368208;5349.786008559653;5355.9196612050655;5390.164524498709;5425.674459532421;5465.234867118586;5239.476052394749;5245.711485868275;5463.071277882769;5480.106972644272;5535.861603459925;5293.206019097128;5357.116075847481;5368.62419630626;5382.434844341346;5386.946130538684;5352.197170424448;5361.356637203521;5373.167159090347;5375.973120134413;5377.542908852753;5214.930939157463;5306.124489459235;5312.76092575835;5343.465653434664;5358.517733404013;5961.314448838396;5973.701314934236;5976.432238937294;5988.550858685616;5992.550558708114;6329.430351268408;6357.936420635827;6374.171357723466;6377.2666143393635;6378.4578310843635;6294.968525157391;6338.714757835908;6341.682915854235;6341.936580634227;6351.587146835441;5541.725403157256;6025;6081;6091.269047714302;6111.480524155408;6218.533609979269;6473.579217350857;6542.116814230066;6545.214574251025;6552.901706474407;6142.191841058572;6258;6260.436560709467;6274.435300822856;6302.716377763011;5255.3168088148295;6294.339094395023;6307.590006649553;6308.3060863305;6332.271788744353;6321.367863213642;6325.177726895474;6335.334789847;6342.112104305401;6361.61830290184;6271.6550589718;6310.305866354697;6319.58922670025;6327.96836015817;6338.397852204033;5018.272350509155;5020.096382651158;5022.573081288058;5149.536541711264;5183.3261675981885;4538.251188553918;4559.772011399416;4567.269236922077;4590;4609.423822022247;6041.78853740117;6056.152138700585;6068.848278793065;6070.150178974947;6071.058985857199;6244.438000579969;6322;6379.872402551923;6391.1371964785085;6397.392247736458;5875.618084824473;5983.910241346383;6021.488173505301;6050.183225264621;6085.5435842312;5659.094544872801;5662.801801936913;5665.575081868794;5670.603057785998;5689.374168841424;6568.047633093271;6576.934230657632;6589.17635295588;6592.208934927743;6607.504437167136;6192.690365481798;6265.8120256392385;6331.683415829098;6331.9366806331345;6333.145025421509;6379.904301435389;6453.806385808433;6503.707333170113;6641.236257830218;6645.468362531083;6341.90487142684;6350.872982540416;6356.3325850785;6358.936410635834;6367.458766004941;6354.90467642995;6363.395477429637;6369.172007638977;6376.330485298977;6376.39424254695;6124.777645458507;6132.936844521141;6134.1119512865025;6142.57002009855;6281.52888533371;6234.844128896814;6241.531885108544;6243.843903902439;6252.124702541739;6254.468370188585;6062.878367502026;6144.832481828438;6170.598911070766;6188.195534580475;6194.039923811636;6297.842553936188;6338.461230795434;6345.17512723343;6355.078513615592;6361.650109244036;4802.447718512416;6213.1922850029205;6257.9674353731125;6258.43674069336;6269.780557680459 02:39:31 INFO - PROCESS | 1642 | |1;ext.html;739.5895278120644;808.6684459371658;815.4088285992656;873.1268731268731;884.491417434975;28094.578581321297;42204.36693449601;42492.93767655806;43996.68009959698;44505.77747111268;42467.78766106165;42576.78711606446;42663.14673706524;42755.786221068855;42808.785956070176;7496.587687677175;9226.308026897976;9384.577694003787;9401.247900168004;9405.764855878624;7502.5873576953245;7575.053118360205;7575.09098908129;7579.355754760852;7579.696812127509;11109.611163609276;11382.487788049557;11461.59884404046;11486.942565287161;11529.884701153007;11196.160287978393;11255.66233013011;11261.493232804543;11268.154888383404;11274.774504509905;7466.066741657293;10963.56145754169;11021.724456888562;11023.338599684044;11023.393713345762;28430.431391372265;28567.000154994475;28599.85700071507;39773.40339894904;39887;3805.162864169878;3832.559255685576;3885.630865067814;3887.105965627893;3931.7247792654525;28079.859600701864;28092.438151237064;28191.43617127646;28375.432491350264;29418.705812942026;3120.8127512349333;3146.921326966821;3153.353562519678;3157.0213233897566;3185.3470038642254;354736;356496;357276;357278;357824;52690;52845.7357713209;52899.206511902354;52943.47056529386;52954.735226323624;55314.446855531736;55384.6153846149;55400.722996385564;55448.168277475874;55494.72252638711;14575.271236438135;14953.775693364609;14976.850231497763;14981.625459363386;15004.62488437776;12811.423485943154;12819.935900320625;12829.743405132032;12836;12859.357032148355;11227.494762735696;11235.15736319763;12426.5650702225;12858.532206179472;12971.935140324238;4696.131215725101;4839.249916262985;5318.73406329682;5365.168398898177;5483.643563168382;1088.6353071720903;1122.294112948314;1129.5425352732157;1170.607846371458;1204.4700331853956;26800.59799103015;27169.592456113172;27408.45183096327;27611.585826212624;27616.309592260353;1245.5640525815893;1256.3215863433643;1266.3731452930674;1300.518808041031;1300.570811632178;11408;13975.930120349332;14297;14392.856071439151;14587.781183282259;435314;435592;436149.8192509017;436180;436805;57333.42666573281;57351.13973290404;57415.71292143512;57614;57634.69461221588;1415.8938079644067;1446.6455718348861;1453.8764205042478;1454.810874586297;1458.1688437590471;25929.481410372064;26391;26818.329541761614;26985;27002.594961075993;47501.76249118732;47815.282770759164;47816.7609161952;47822;47883.76058119687;411767;412170;412988;413408;413870;34572.30855382929;35455.64544354523;35484.64515354813;35610;35653;38502;39862.800685996386;44140.77929610331;44512.33231501465;44845;32504.674953250164;33014;33160;33261.833690831394;34123.829380852934;32796.85211017603;33653.653853846554;33976.15059623529;33998.32003359968;34147.63409463693;33122.84070057536;33196.33607327792;33595.664043359255;33766.66233337635;33785.831070845474;28096;29922.401551969273;29935.70064299329;30034.710982514887;30461.54307685431;17044.318227271266;22785.544289114456;22911.625302481905;23468.76531234666;23523 02:39:31 INFO - PROCESS | 1642 | |2;jquery.html;369.5731430198122;428.6677824685869;429.593812307959;434.76522677754014;440.92283850326186;14910.478133265324;20582.808931616695;21859.781402185974;22128.557428851454;22399.55200895981;22427.55144897101;22786.2024829131;22974.88512557435;23233.419164520852;23406.414839628975;5534.916976245359;5887.88224235515;6550.705218265166;6790.5246632735725;6794.218664853531;4181.665466762652;4396.758178300192;4440.511543730187;4454.354118652794;4461.040876211614;4399.42807435033;4443.044745379742;4454.688171827974;4466.196084704752;4556.815228040717;7620.390368770512;7700;7744.341730952876;7753.844923101563;7763.534187948741;7209.927900720978;7460.776176714708;7523.548587084792;7542.6605802739;7566.810829729246;27159.642017899027;27984.02055928033;27989.440211195662;28301.858490707415;28471.71528284732;2951.74910132639;2958.8224706517676;3115.890943816978;3386.593608766964;3403.7277017838514;15516.14661193634;16519.66960660792;17209.569760755956;17589.824101758946;17686.823131768648;1815.664102141108;1941.6019715958196;2100.7689154193026;2107.1571371451387;2165.98917005414;127672;129561.99999999905;133615;135674;136463.31768341095;15322.467753224812;21880.562388752136;21999.2300269493;22020.779792202193;22259.664420134843;34165.829170853984;34448.82775586106;34535.30929381398;35610.28779424449;36366;11043.061339786047;11071.72320691973;11139.554417823358;11186;11339.433028348549;9052;9066.156158092432;9078.319126065571;9233.815323693489;9305.348625596143;10317.48412579368;10615.84076238857;10724.839127413095;10746.301490403099;10782.730431739112;3742.719296052807;3968.2460332536725;4070.247004304213;4169.1661667666585;4180.916381672349;796.77690246731;953.580424613168;967.9516024198762;989.094978095035;1012.3318609717699;21661;23303.883480582488;23342.766572334058;23415.88292058529;23418.531629367317;979.4524651051322;981.1365997921783;990.9405435673883;1002.1210230817218;1003.6236411345745;11770.411479425995;11956.34240116802;12060;12188.14682972201;12254.38728063611;745881;758364;760153;776240;778943;122977;128858;151963;153639;159896;1215.89961085218;1231.6859200903712;1262.5391732017747;1317.7891537353978;1322.9867701323055;13794.65513362174;19362.4191274262;20441;20727.811266363937;20775.37673869786;63726.362736372044;64314.67842660757;64670.35329646832;65739;66599;69184.65407672929;78745.60627196827;78997.60501197458;89253.55373223351;93096.06903930874;8738.91261087381;11300.152488563555;11699.122565807429;11995.520179193083;11995.940020299842;10622;12765.234085954873;12911.22532648044;13118.672033199246;13153.934230328787;9711.125998659872;10957.794642589468;11017.394043327373;11256.099512039182;11349.659510214708;9632.795900512436;10653.254272200871;10752.354858708502;11173.441327933733;11184.273022253528;11212.83180752273;11422.371769552754;11593.304401735923;11644;11651.59219427316;11476.942615286871;11546.249493782878;11569.6529104127;11641.88358116408;11782.234154779911;10697.304675196086;11074;11153.49809258569;11182.049525790399;11194.832077519006 02:39:31 INFO - PROCESS | 1642 | |3;mootools.html;1448.2758620689663;1513.160196091169;1561.984380156198;1602.1828867277684;1605.9678806423872;10542.78914421712;11109.83335249972;11144.108471322295;11149.888501114976;11161.274517156378;10710.089642380388;10808;11097.778044439106;11197.440127993608;11259.21185517014;2405.56699794037;2428.2229686500327;2441.316431399211;2444.1445494077107;2448.3511869354547;2382.9642555361684;2420.5037967216767;2427.927162185137;2431.051889762985;2431.3678443604613;2378.4053986503372;2401.651760494727;2406.8074554035634;2407.963880541793;2411.252511721372;2352.5059737455153;2373.5134297468976;2379.428937055103;2387.6776635154206;2389.330987323535;1961.7842037375876;1992.7907569705117;2376.4534157143953;2405.230326295586;2405.8315917885757;10966.232363734542;11203.831942520868;11210.831837522444;11213;11248.437578121062;4715.717056976592;5932.466078052953;5935.584509084366;5946.672932988684;5949.6727679977585;3561.893143205708;3584.480250363709;3672.100335417813;3689.24370504046;3717.5724791649036;1159.9710007249803;1160.1414952934851;1205.4876677412065;1212.7331986962854;1226.7423840993401;13745.969052321116;14147.575572732732;14512.709745805236;15383.692326153527;15685;4252;4375.212461756851;4379.5182529921685;4380.496242932104;4388.514357053683;10354.11989980845;11697.707557311136;11700.122490813223;11725.179237453467;11754.177207595387;5750.281214848144;5766.481016708516;5768.336641286306;5776.537876969916;5778.739956701958;5013.5989120870245;5230.267762513251;5234.2933703949475;5315.574754019669;5322.0952438085615;3879.767213967171;3915.4909861717792;3954.209158168378;3988.4615576897327;3998.7800670962793;1043.76515284062;1045.6183493025144;1051.1800795379615;1063.7021633942509;1067.80779459698;895.5208963204784;919.8528235482424;921.0697195832124;926.4672813132341;957.7749228931195;6331.145295385156;6432.356764323624;6594.604323740495;6636.203655561363;6680.565763225375;977.1791694976254;978.7797745507346;997.2719914462483;999.1856636840952;1010.3887148275335;3509.964900351015;4006.559278479365;4093.815778289984;4159.1265834175165;4241.85469923119;13362;13776.311184440738;13832.30838458073;14051.71896562063;14089.788653170212;13670.31648417595;13717.725645487035;13961.441542338396;13963.232022238875;13967.580972570637;7272.527285726516;10107.39355638664;10281.588736450607;10282.331648442827;10285.177185825116;6507.256364925724;6548.410643042149;6597.109390232449;6721.462283017249;6794.286599906938;11813.527458901548;12179.695507612027;12254.571090011807;12330.136890417585;12333.444994975069;12107.81838272409;12445.62663120108;12447.253164810141;12492.500299987898;12526.436310366238;9189.356745027784;9233.261339092722;9426.434413935185;9430.387024843363;9445.0554944505;10210.540525676213;10240.846387304346;10335.431551264752;10341.896581034094;10409.47952602382;8939.865902011345;9122.361434699507;9161.77095572616;9168;9179.49512776777;8798.208161265517;8830.984436789851;8871.157240062184;8882.511461869659;8898.42160259581;7704.229577042251;7754.612269386621;7826.373890088666;7841.529508229524;7847.764567062997;5673.631213971244;5680.829575112753;5681.431856814285;5829.941700583109;5849.239598852122;5772.163036359789;5862.149988251595;5911.201987731602;6044.848878778066;6184.226971628546 02:39:31 INFO - PROCESS | 1642 | |4;prototype.html;379.56350197273133;384.85567912032985;385.43918598439274;393.52187092682396;393.60049549707037;4499.83004418851;5040.84060666047;5128.487151284874;5181.2901742425;5229.372475302965;4269.957300426995;4506.864794056175;4538.387317712108;4872.537108974641;5093.26147708582;3524.9471257931023;3795.3547896857463;3824.6366595173413;3944.605539446047;4035.919281614366;3397.8447327908507;3874.9225015499674;3975.483187185662;4078.6125318094882;4106.219818234541;3587.1390866192055;4060.309747342944;4067.776272305022;4090.9386359204636;4112.547619761824;3505.3164632896596;3555.8044307563073;3941.763494190329;3969.7816620085882;4015.9799201003807;3534.5581802274714;3539.2744487380023;3545.2554963457706;3547.7161827053774;3583.4445660922597;4267.082577245876;4316.784160791948;4902.583280421133;4957.429895562021;5024.19612861944;4065.9593404065877;4254.936175957363;4660.4174478190225;4678.69588476748;4746.52534746526;4852.369192005052;5305.7612407441375;5335.866603334909;5348.438413966555;5547.278853749027;3761.1725420407465;3786.848526058982;3938.6324692387884;3940.7241493095494;4048.7975601219823;4506.954930450686;4904.828331008398;5780.393058728815;5794.420557944214;5866.21354856444;4516.435445569304;4681.531846815291;4806.903861922742;4869.613889194269;4886.731229782325;4242;4983.953369792384;4998.300577803564;5028.522290382408;5040.294358789773;4416.895776055986;4580.519045500241;5080;5148.845534633967;5240.34495688039;4550.704204226715;4875.585575226146;5503.807366742145;5527.2538207342295;5540;1510.6676531163346;1571.8742500599924;1625.1711627070042;1672.8624535316103;1680.269082948921;1203.6870413692502;1298.461138627478;1307.8365204349457;1356.5658989123583;1411.5835828430638;4510.932336014962;4748;4762.689765761991;4783.115123702126;4889;4884.8290309838985;5441.252846470348;5705.971470142623;5714.828555143353;5721.052473793069;4646.79089440976;4793.448753393334;5005.974970125126;5009.321877171188;5116.590672746172;2532.5821239495276;2909.767218622505;2944.573036909636;2969.613950186462;3002.7597792176575;5193.558547523503;5266.578023933593;5569.718964638156;5889.8233053007625;5936.588484436884;4985.152524070917;5257.5005374489365;5310.2831117798605;5709.65742055478;5724.484796368347;4477;5371.489708477767;5908.20239267702;5964.791232306935;6028;5042.016806722654;5131.204663277198;5196.064708352533;5415.6479828811;5642.802501912413;4444.31113177458;4832.95167048325;5135.8444350020945;5222.545403660273;5727.455891690282;5104.591632669451;5771.365149833431;5825.70871456434;5879.970600147143;5975.790847320323;3882.8058597069466;4042.514898212233;4112.943528235882;4131.772752498641;4546.249868771748;4978.5270399312;5099.878026834091;5540.22436858832;5573.6098473106495;5646.971765141148;4815.927761083657;5142.897142057063;5216.321878155815;5371.462853714597;5485.314335708036;5034.496550344937;5169.81905633301;5386.929450213341;5544.22380866687;5568.415316391721;5113.974430127825;5418.729063546728;5435.782568697208;5437.619366644297;5454.972725136349;4803.735794531334;5067.6452648315735;5087.643864929568;5559.58303127259;5616.466435688603;4981.900361992667;5409.377921539073;5444.401115877329;5450.645708028966;5503.944960550343 02:39:31 INFO - PROCESS | 1642 | |5;yui.html;740.3373980287639;742.4134933402609;759.2066290726191;830.2569200565493;847.8812966184735;14718.632034199138;15367.154806485667;15636.921815390908;15659.921700391496;15717.528474145765;13672.794908076386;14185.858141418583;14380.49668261611;14395.64010899728;14406.639834004156;940.4921342475072;959.7456673981401;963.7831487915233;965.1940629574314;966.5119114847028;938.8075444533888;959.9952000239989;963.330485312708;979.6179489998906;980.882294124706;1008.334499230508;1012.9392236465799;1012.9696109116701;1013.3463915774358;1013.9188864890828;1007.7531004903772;1009.5709323537467;1011.6610935336635;1012.1649639047741;1012.6455740490843;749.7938067031555;752.3003606645817;753.5365750063726;755.5013690963938;755.9433042521778;15587.142707151103;15963.122028288439;15989;16045.117518536475;16341.754873676904;10617.469126543641;14468.927655361762;14473.131612103307;14487.78268325976;14529.273536323142;11677.697153337069;11746.060315174765;11890.940545297304;11937.582184623496;12065.698357541043;3581.6239294874185;3617.7829330240006;3683.28176005679;3758.229562939591;3853.3064048471265;110163;114676;115173;115306;116390.83609163885;10529.526171322308;10683.94658026705;10958.068564171976;11025.44872756359;11265.26775759573;22528.098876045104;22806.087756489556;22916.4270893229;23032.884835575715;23249;7612.200718924544;7622.5426474411715;7703.537787732754;7759.68961241544;7776.7278145264645;4229.915401691949;4289.1421715657;4390.319500477367;4404.779761012001;4463.352813841975;3499.4400895856543;3613.94579081314;3620.891373258754;3623.4564815277918;3627.5646922369483;540.5162379670173;625.3340192694766;626.708580510065;627.6641996531833;628.6510986402591;515.8942416804546;626.8558231606756;647.8024202618152;679.1714108787272;697.7941507255372;9550.522473876417;9655.758606034764;9801.215902727765;9858.99426156733;9884.272434073178;561.4357570641479;638.2309317272675;662.2450406536552;670.1957650819037;684.8287928017995;4576.244919588231;4767.284907263869;4834.734089625104;4872.909916072106;4882.340883980617;110939.44530277458;111024.44487777671;112462;113159;116639;96233.51883240679;99128.51307230398;99677;99713.50429743559;100696;85308.14691853002;88050.55974720213;88408;88643.67034494488;90006.54996725105;7213.422926165999;9182.494962776844;9298.674546390845;9351.625934962525;9425.84255145766;49008.0198396023;49607;50194.749026254634;50521.74739126281;51742;62989.05516417349;63301.68349158225;63346;64102.67948660227;64998.35001649923;11307.943460282646;11448.484818183368;11659.941700291443;11935;12072.879271207175;12341.75316493683;12506;12524.185927914656;12954.481820727065;13049;11232.817976497114;11628.709282268012;11818.940905295762;12086.576969806014;12250.938745306217;11616;11924.216575379518;11929.28424294545;12071.879281207075;12249.632511024327;11525;11676.766464670489;11677.06583473337;11717.06263498901;11736.119791015879;9484.383515071499;10405.167586593207;10422.73943151397;10641.521131548943;10680.519376627915;8647.481151130953;8703.43427677199;8939.150780675825;9534.52327383642;9723.854142188015 02:39:31 INFO - PROCESS | 1642 | __end_tp_report 02:39:31 INFO - PROCESS | 1642 | __start_cc_report 02:39:31 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1974 02:39:31 INFO - PROCESS | 1642 | __end_cc_report 02:39:31 INFO - PROCESS | 1642 | __startTimestamp1489484371511__endTimestamp 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | ------- Summary: start ------- 02:39:31 INFO - PROCESS | 1642 | Number of tests: 6 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5909.05 Median:6142.57 stddev:665.06 (10.8%) stddev-sans-first:627.14 02:39:31 INFO - PROCESS | 1642 | Values: 3014.4 3410.7 3415.5 3450.3 3454.3 5909.2 5953.5 5962.3 5963.8 5982.5 5976.0 6044.2 6055.0 6056.2 6080.9 5349.8 5355.9 5390.2 5425.7 5465.2 5239.5 5245.7 5463.1 5480.1 5535.9 5293.2 5357.1 5368.6 5382.4 5386.9 5352.2 5361.4 5373.2 5376.0 5377.5 5214.9 5306.1 5312.8 5343.5 5358.5 5961.3 5973.7 5976.4 5988.6 5992.6 6329.4 6357.9 6374.2 6377.3 6378.5 6295.0 6338.7 6341.7 6341.9 6351.6 5541.7 6025.0 6081.0 6091.3 6111.5 6218.5 6473.6 6542.1 6545.2 6552.9 6142.2 6258.0 6260.4 6274.4 6302.7 5255.3 6294.3 6307.6 6308.3 6332.3 6321.4 6325.2 6335.3 6342.1 6361.6 6271.7 6310.3 6319.6 6328.0 6338.4 5018.3 5020.1 5022.6 5149.5 5183.3 4538.3 4559.8 4567.3 4590.0 4609.4 6041.8 6056.2 6068.8 6070.2 6071.1 6244.4 6322.0 6379.9 6391.1 6397.4 5875.6 5983.9 6021.5 6050.2 6085.5 5659.1 5662.8 5665.6 5670.6 5689.4 6568.0 6576.9 6589.2 6592.2 6607.5 6192.7 6265.8 6331.7 6331.9 6333.1 6379.9 6453.8 6503.7 6641.2 6645.5 6341.9 6350.9 6356.3 6358.9 6367.5 6354.9 6363.4 6369.2 6376.3 6376.4 6124.8 6132.9 6134.1 6142.6 6281.5 6234.8 6241.5 6243.8 6252.1 6254.5 6062.9 6144.8 6170.6 6188.2 6194.0 6297.8 6338.5 6345.2 6355.1 6361.7 4802.4 6213.2 6258.0 6258.4 6269.8 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:54643.25 Median:33624.66 stddev:106713.93 (317.4%) stddev-sans-first:106936.55 02:39:31 INFO - PROCESS | 1642 | Values: 739.6 808.7 815.4 873.1 884.5 28094.6 42204.4 42492.9 43996.7 44505.8 42467.8 42576.8 42663.1 42755.8 42808.8 7496.6 9226.3 9384.6 9401.2 9405.8 7502.6 7575.1 7575.1 7579.4 7579.7 11109.6 11382.5 11461.6 11486.9 11529.9 11196.2 11255.7 11261.5 11268.2 11274.8 7466.1 10963.6 11021.7 11023.3 11023.4 28430.4 28567.0 28599.9 39773.4 39887.0 3805.2 3832.6 3885.6 3887.1 3931.7 28079.9 28092.4 28191.4 28375.4 29418.7 3120.8 3146.9 3153.4 3157.0 3185.3 354736.0 356496.0 357276.0 357278.0 357824.0 52690.0 52845.7 52899.2 52943.5 52954.7 55314.4 55384.6 55400.7 55448.2 55494.7 14575.3 14953.8 14976.9 14981.6 15004.6 12811.4 12819.9 12829.7 12836.0 12859.4 11227.5 11235.2 12426.6 12858.5 12971.9 4696.1 4839.2 5318.7 5365.2 5483.6 1088.6 1122.3 1129.5 1170.6 1204.5 26800.6 27169.6 27408.5 27611.6 27616.3 1245.6 1256.3 1266.4 1300.5 1300.6 11408.0 13975.9 14297.0 14392.9 14587.8 435314.0 435592.0 436149.8 436180.0 436805.0 57333.4 57351.1 57415.7 57614.0 57634.7 1415.9 1446.6 1453.9 1454.8 1458.2 25929.5 26391.0 26818.3 26985.0 27002.6 47501.8 47815.3 47816.8 47822.0 47883.8 411767.0 412170.0 412988.0 413408.0 413870.0 34572.3 35455.6 35484.6 35610.0 35653.0 38502.0 39862.8 44140.8 44512.3 44845.0 32504.7 33014.0 33160.0 33261.8 34123.8 32796.9 33653.7 33976.2 33998.3 34147.6 33122.8 33196.3 33595.7 33766.7 33785.8 28096.0 29922.4 29935.7 30034.7 30461.5 17044.3 22785.5 22911.6 23468.8 23523.0 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:42732.73 Median:22413.55 stddev:126574.27 (564.7%) stddev-sans-first:126889.37 02:39:31 INFO - PROCESS | 1642 | Values: 369.6 428.7 429.6 434.8 440.9 14910.5 20582.8 21859.8 22128.6 22399.6 22427.6 22786.2 22974.9 23233.4 23406.4 5534.9 5887.9 6550.7 6790.5 6794.2 4181.7 4396.8 4440.5 4454.4 4461.0 4399.4 4443.0 4454.7 4466.2 4556.8 7620.4 7700.0 7744.3 7753.8 7763.5 7209.9 7460.8 7523.5 7542.7 7566.8 27159.6 27984.0 27989.4 28301.9 28471.7 2951.7 2958.8 3115.9 3386.6 3403.7 15516.1 16519.7 17209.6 17589.8 17686.8 1815.7 1941.6 2100.8 2107.2 2166.0 127672.0 129562.0 133615.0 135674.0 136463.3 15322.5 21880.6 21999.2 22020.8 22259.7 34165.8 34448.8 34535.3 35610.3 36366.0 11043.1 11071.7 11139.6 11186.0 11339.4 9052.0 9066.2 9078.3 9233.8 9305.3 10317.5 10615.8 10724.8 10746.3 10782.7 3742.7 3968.2 4070.2 4169.2 4180.9 796.8 953.6 968.0 989.1 1012.3 21661.0 23303.9 23342.8 23415.9 23418.5 979.5 981.1 990.9 1002.1 1003.6 11770.4 11956.3 12060.0 12188.1 12254.4 745881.0 758364.0 760153.0 776240.0 778943.0 122977.0 128858.0 151963.0 153639.0 159896.0 1215.9 1231.7 1262.5 1317.8 1323.0 13794.7 19362.4 20441.0 20727.8 20775.4 63726.4 64314.7 64670.4 65739.0 66599.0 69184.7 78745.6 78997.6 89253.6 93096.1 8738.9 11300.2 11699.1 11995.5 11995.9 10622.0 12765.2 12911.2 13118.7 13153.9 9711.1 10957.8 11017.4 11256.1 11349.7 9632.8 10653.3 10752.4 11173.4 11184.3 11212.8 11422.4 11593.3 11644.0 11651.6 11476.9 11546.2 11569.7 11641.9 11782.2 10697.3 11074.0 11153.5 11182.0 11194.8 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6715.19 Median:2431.21 stddev:4212.25 (173.3%) stddev-sans-first:4205.48 02:39:31 INFO - PROCESS | 1642 | Values: 1448.3 1513.2 1562.0 1602.2 1606.0 10542.8 11109.8 11144.1 11149.9 11161.3 10710.1 10808.0 11097.8 11197.4 11259.2 2405.6 2428.2 2441.3 2444.1 2448.4 2383.0 2420.5 2427.9 2431.1 2431.4 2378.4 2401.7 2406.8 2408.0 2411.3 2352.5 2373.5 2379.4 2387.7 2389.3 1961.8 1992.8 2376.5 2405.2 2405.8 10966.2 11203.8 11210.8 11213.0 11248.4 4715.7 5932.5 5935.6 5946.7 5949.7 3561.9 3584.5 3672.1 3689.2 3717.6 1160.0 1160.1 1205.5 1212.7 1226.7 13746.0 14147.6 14512.7 15383.7 15685.0 4252.0 4375.2 4379.5 4380.5 4388.5 10354.1 11697.7 11700.1 11725.2 11754.2 5750.3 5766.5 5768.3 5776.5 5778.7 5013.6 5230.3 5234.3 5315.6 5322.1 3879.8 3915.5 3954.2 3988.5 3998.8 1043.8 1045.6 1051.2 1063.7 1067.8 895.5 919.9 921.1 926.5 957.8 6331.1 6432.4 6594.6 6636.2 6680.6 977.2 978.8 997.3 999.2 1010.4 3510.0 4006.6 4093.8 4159.1 4241.9 13362.0 13776.3 13832.3 14051.7 14089.8 13670.3 13717.7 13961.4 13963.2 13967.6 7272.5 10107.4 10281.6 10282.3 10285.2 6507.3 6548.4 6597.1 6721.5 6794.3 11813.5 12179.7 12254.6 12330.1 12333.4 12107.8 12445.6 12447.3 12492.5 12526.4 9189.4 9233.3 9426.4 9430.4 9445.1 10210.5 10240.8 10335.4 10341.9 10409.5 8939.9 9122.4 9161.8 9168.0 9179.5 8798.2 8831.0 8871.2 8882.5 8898.4 7704.2 7754.6 7826.4 7841.5 7847.8 5673.6 5680.8 5681.4 5829.9 5849.2 5772.2 5862.1 5911.2 6044.8 6184.2 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4502.09 Median:4887.87 stddev:1260.87 (25.8%) stddev-sans-first:1225.85 02:39:31 INFO - PROCESS | 1642 | Values: 379.6 384.9 385.4 393.5 393.6 4499.8 5040.8 5128.5 5181.3 5229.4 4270.0 4506.9 4538.4 4872.5 5093.3 3524.9 3795.4 3824.6 3944.6 4035.9 3397.8 3874.9 3975.5 4078.6 4106.2 3587.1 4060.3 4067.8 4090.9 4112.5 3505.3 3555.8 3941.8 3969.8 4016.0 3534.6 3539.3 3545.3 3547.7 3583.4 4267.1 4316.8 4902.6 4957.4 5024.2 4066.0 4254.9 4660.4 4678.7 4746.5 4852.4 5305.8 5335.9 5348.4 5547.3 3761.2 3786.8 3938.6 3940.7 4048.8 4507.0 4904.8 5780.4 5794.4 5866.2 4516.4 4681.5 4806.9 4869.6 4886.7 4242.0 4984.0 4998.3 5028.5 5040.3 4416.9 4580.5 5080.0 5148.8 5240.3 4550.7 4875.6 5503.8 5527.3 5540.0 1510.7 1571.9 1625.2 1672.9 1680.3 1203.7 1298.5 1307.8 1356.6 1411.6 4510.9 4748.0 4762.7 4783.1 4889.0 4884.8 5441.3 5706.0 5714.8 5721.1 4646.8 4793.4 5006.0 5009.3 5116.6 2532.6 2909.8 2944.6 2969.6 3002.8 5193.6 5266.6 5569.7 5889.8 5936.6 4985.2 5257.5 5310.3 5709.7 5724.5 4477.0 5371.5 5908.2 5964.8 6028.0 5042.0 5131.2 5196.1 5415.6 5642.8 4444.3 4833.0 5135.8 5222.5 5727.5 5104.6 5771.4 5825.7 5880.0 5975.8 3882.8 4042.5 4112.9 4131.8 4546.2 4978.5 5099.9 5540.2 5573.6 5647.0 4815.9 5142.9 5216.3 5371.5 5485.3 5034.5 5169.8 5386.9 5544.2 5568.4 5114.0 5418.7 5435.8 5437.6 5455.0 4803.7 5067.6 5087.6 5559.6 5616.5 4981.9 5409.4 5444.4 5450.6 5503.9 02:39:31 INFO - PROCESS | 1642 | 02:39:31 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:21185.73 Median:3625.51 stddev:32023.37 (883.3%) stddev-sans-first:32076.41 02:39:31 INFO - PROCESS | 1642 | Values: 740.3 742.4 759.2 830.3 847.9 14718.6 15367.2 15636.9 15659.9 15717.5 13672.8 14185.9 14380.5 14395.6 14406.6 940.5 959.7 963.8 965.2 966.5 938.8 960.0 963.3 979.6 980.9 1008.3 1012.9 1013.0 1013.3 1013.9 1007.8 1009.6 1011.7 1012.2 1012.6 749.8 752.3 753.5 755.5 755.9 15587.1 15963.1 15989.0 16045.1 16341.8 10617.5 14468.9 14473.1 14487.8 14529.3 11677.7 11746.1 11890.9 11937.6 12065.7 3581.6 3617.8 3683.3 3758.2 3853.3 110163.0 114676.0 115173.0 115306.0 116390.8 10529.5 10683.9 10958.1 11025.4 11265.3 22528.1 22806.1 22916.4 23032.9 23249.0 7612.2 7622.5 7703.5 7759.7 7776.7 4229.9 4289.1 4390.3 4404.8 4463.4 3499.4 3613.9 3620.9 3623.5 3627.6 540.5 625.3 626.7 627.7 628.7 515.9 626.9 647.8 679.2 697.8 9550.5 9655.8 9801.2 9859.0 9884.3 561.4 638.2 662.2 670.2 684.8 4576.2 4767.3 4834.7 4872.9 4882.3 110939.4 111024.4 112462.0 113159.0 116639.0 96233.5 99128.5 99677.0 99713.5 100696.0 85308.1 88050.6 88408.0 88643.7 90006.5 7213.4 9182.5 9298.7 9351.6 9425.8 49008.0 49607.0 50194.7 50521.7 51742.0 62989.1 63301.7 63346.0 64102.7 64998.4 11307.9 11448.5 11659.9 11935.0 12072.9 12341.8 12506.0 12524.2 12954.5 13049.0 11232.8 11628.7 11818.9 12086.6 12250.9 11616.0 11924.2 11929.3 12071.9 12249.6 11525.0 11676.8 11677.1 11717.1 11736.1 9484.4 10405.2 10422.7 10641.5 10680.5 8647.5 8703.4 8939.2 9534.5 9723.9 02:39:31 INFO - PROCESS | 1642 | -------- Summary: end -------- 02:39:31 INFO - PROCESS | 1642 | 02:39:32 INFO - TEST-INFO | 1642: exit 0 02:39:32 INFO - TEST-OK | dromaeo_css | took 1120122ms 02:39:32 INFO - TEST-START | kraken 02:39:32 INFO - operating with platform_type : mac_ 02:39:32 INFO - Initialising browser for kraken test... 02:39:32 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpT34fFA/profile http://localhost:49250/getInfo.html) 02:39:34 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 02:39:34 INFO - PROCESS | 1653 | colorDepth:24 02:39:34 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 02:39:34 INFO - PROCESS | 1653 | __metrics 02:39:34 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:39:34 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:35 INFO - TEST-INFO | 1653: exit 0 02:39:35 INFO - Browser initialized. 02:39:35 INFO - Running cycle 1/1 for kraken test... 02:39:35 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpT34fFA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:47 INFO - PROCESS | 1655 | RSS: Main: 214491136 02:39:47 INFO - PROCESS | 1655 | 02:39:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:51 INFO - PROCESS | 1655 | RSS: Main: 267501568 02:39:51 INFO - PROCESS | 1655 | 02:39:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 02:39:54 INFO - PROCESS | 1655 | RSS: Main: 277868544 02:39:54 INFO - PROCESS | 1655 | 02:39:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 02:39:58 INFO - PROCESS | 1655 | RSS: Main: 374685696 02:39:58 INFO - PROCESS | 1655 | 02:40:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 02:40:01 INFO - PROCESS | 1655 | RSS: Main: 277864448 02:40:01 INFO - PROCESS | 1655 | 02:40:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:03 INFO - PROCESS | 1655 | RSS: Main: 280477696 02:40:03 INFO - PROCESS | 1655 | 02:40:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:07 INFO - PROCESS | 1655 | RSS: Main: 320921600 02:40:07 INFO - PROCESS | 1655 | 02:40:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:11 INFO - PROCESS | 1655 | RSS: Main: 320774144 02:40:11 INFO - PROCESS | 1655 | 02:40:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 02:40:15 INFO - PROCESS | 1655 | RSS: Main: 320761856 02:40:15 INFO - PROCESS | 1655 | 02:40:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:17 INFO - PROCESS | 1655 | RSS: Main: 295940096 02:40:17 INFO - PROCESS | 1655 | 02:40:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:19 INFO - PROCESS | 1655 | RSS: Main: 299499520 02:40:19 INFO - PROCESS | 1655 | 02:40:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:22 INFO - PROCESS | 1655 | RSS: Main: 305217536 02:40:22 INFO - PROCESS | 1655 | 02:40:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:26 INFO - PROCESS | 1655 | RSS: Main: 319537152 02:40:26 INFO - PROCESS | 1655 | 02:40:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:30 INFO - PROCESS | 1655 | RSS: Main: 313495552 02:40:30 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 02:40:31 INFO - PROCESS | 1655 | RSS: Main: 358432768 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | __start_tp_report 02:40:31 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 02:40:31 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 02:40:31 INFO - PROCESS | 1655 | |i|pagename|runs| 02:40:31 INFO - PROCESS | 1655 | |0;ai-astar;118;115;113;115;115;115;115;114;115;115 02:40:31 INFO - PROCESS | 1655 | |1;audio-beat-detection;142;108;109;144;108;116;110;109;129;109 02:40:31 INFO - PROCESS | 1655 | |2;audio-dft;183;185;184;187;184;186;184;184;186;184 02:40:31 INFO - PROCESS | 1655 | |3;audio-fft;82;59;59;94;61;61;61;76;99;83 02:40:31 INFO - PROCESS | 1655 | |4;audio-oscillator;88;70;112;99;100;55;102;89;98;114 02:40:31 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;92;88;87;87;87;87;87;88;86 02:40:31 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;94;95;95;94;95;94;94;94;93 02:40:31 INFO - PROCESS | 1655 | |7;imaging-desaturate;126;131;87;86;82;87;86;84;87;86 02:40:31 INFO - PROCESS | 1655 | |8;json-parse-financial;61;58;59;60;64;65;63;63;63;64 02:40:31 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;59;59;53;65;61;57;57;57;58;58 02:40:31 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;87;86;82;84;84;86;82;84;84;92 02:40:31 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;137;139;141;140;139;147;140;143;181;139 02:40:31 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;173;167;165;164;166;166;175;216;149;203 02:40:31 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;64;65;65;64;65;64;64;65;64;63 02:40:31 INFO - PROCESS | 1655 | __end_tp_report 02:40:31 INFO - PROCESS | 1655 | __start_cc_report 02:40:31 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2119 02:40:31 INFO - PROCESS | 1655 | __end_cc_report 02:40:31 INFO - PROCESS | 1655 | __startTimestamp1489484431985__endTimestamp 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | ------- Summary: start ------- 02:40:31 INFO - PROCESS | 1655 | Number of tests: 14 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 02:40:31 INFO - PROCESS | 1655 | Values: 118.0 115.0 113.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:113.00 stddev:14.46 (12.8%) stddev-sans-first:12.57 02:40:31 INFO - PROCESS | 1655 | Values: 142.0 108.0 109.0 144.0 108.0 116.0 110.0 109.0 129.0 109.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:184.70 Median:184.50 stddev:1.25 (0.7%) stddev-sans-first:1.17 02:40:31 INFO - PROCESS | 1655 | Values: 183.0 185.0 184.0 187.0 184.0 186.0 184.0 184.0 186.0 184.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:73.50 Median:79.00 stddev:15.38 (19.5%) stddev-sans-first:16.00 02:40:31 INFO - PROCESS | 1655 | Values: 82.0 59.0 59.0 94.0 61.0 61.0 61.0 76.0 99.0 83.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:79.00 stddev:18.28 (23.1%) stddev-sans-first:19.31 02:40:31 INFO - PROCESS | 1655 | Values: 88.0 70.0 112.0 99.0 100.0 55.0 102.0 89.0 98.0 114.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:87.50 stddev:1.64 (1.9%) stddev-sans-first:1.73 02:40:31 INFO - PROCESS | 1655 | Values: 88.0 92.0 88.0 87.0 87.0 87.0 87.0 87.0 88.0 86.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 02:40:31 INFO - PROCESS | 1655 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 93.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:86.00 stddev:18.18 (21.1%) stddev-sans-first:15.22 02:40:31 INFO - PROCESS | 1655 | Values: 126.0 131.0 87.0 86.0 82.0 87.0 86.0 84.0 87.0 86.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:63.00 stddev:2.36 (3.7%) stddev-sans-first:2.47 02:40:31 INFO - PROCESS | 1655 | Values: 61.0 58.0 59.0 60.0 64.0 65.0 63.0 63.0 63.0 64.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:3.10 (5.3%) stddev-sans-first:3.28 02:40:31 INFO - PROCESS | 1655 | Values: 59.0 59.0 53.0 65.0 61.0 57.0 57.0 57.0 58.0 58.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.92 (3.4%) stddev-sans-first:3.02 02:40:31 INFO - PROCESS | 1655 | Values: 87.0 86.0 82.0 84.0 84.0 86.0 82.0 84.0 84.0 92.0 02:40:31 INFO - PROCESS | 1655 | 02:40:31 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:140.50 stddev:13.08 (9.3%) stddev-sans-first:13.58 02:40:31 INFO - PROCESS | 1655 | Values: 137.0 139.0 141.0 140.0 139.0 147.0 140.0 143.0 181.0 139.0 02:40:31 INFO - PROCESS | 1655 | 02:40:32 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:170.00 stddev:19.97 (11.7%) stddev-sans-first:21.17 02:40:32 INFO - PROCESS | 1655 | Values: 173.0 167.0 165.0 164.0 166.0 166.0 175.0 216.0 149.0 203.0 02:40:32 INFO - PROCESS | 1655 | 02:40:32 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:40:32 INFO - PROCESS | 1655 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 63.0 02:40:32 INFO - PROCESS | 1655 | -------- Summary: end -------- 02:40:32 INFO - PROCESS | 1655 | 02:40:32 INFO - TEST-INFO | 1655: exit 0 02:40:32 INFO - TEST-OK | kraken | took 60727ms 02:40:32 INFO - SUITE-END | took 1180s 02:40:33 INFO - Completed test suite (00:19:41) 02:40:33 INFO - javascript benchmark 02:40:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7657.446791134735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.366982933584, 3410.6589341065896, 3415.5047518109873, 3450.2581944881845, 3454.27460233351, 5909.2022576952095, 5953.523718102552, 5962.34414214436, 5963.791267305645, 5982.491488223501, 5975.970120149394, 6044.214252147226, 6054.969725151379, 6056.212692349999, 6080.908786368208, 5349.786008559653, 5355.9196612050655, 5390.164524498709, 5425.674459532421, 5465.234867118586, 5239.476052394749, 5245.711485868275, 5463.071277882769, 5480.106972644272, 5535.861603459925, 5293.206019097128, 5357.116075847481, 5368.62419630626, 5382.434844341346, 5386.946130538684, 5352.197170424448, 5361.356637203521, 5373.167159090347, 5375.973120134413, 5377.542908852753, 5214.930939157463, 5306.124489459235, 5312.76092575835, 5343.465653434664, 5358.517733404013, 5961.314448838396, 5973.701314934236, 5976.432238937294, 5988.550858685616, 5992.550558708114, 6329.430351268408, 6357.936420635827, 6374.171357723466, 6377.2666143393635, 6378.4578310843635, 6294.968525157391, 6338.714757835908, 6341.682915854235, 6341.936580634227, 6351.587146835441, 5541.725403157256, 6025.0, 6081.0, 6091.269047714302, 6111.480524155408, 6218.533609979269, 6473.579217350857, 6542.116814230066, 6545.214574251025, 6552.901706474407, 6142.191841058572, 6258.0, 6260.436560709467, 6274.435300822856, 6302.716377763011, 5255.3168088148295, 6294.339094395023, 6307.590006649553, 6308.3060863305, 6332.271788744353, 6321.367863213642, 6325.177726895474, 6335.334789847, 6342.112104305401, 6361.61830290184, 6271.6550589718, 6310.305866354697, 6319.58922670025, 6327.96836015817, 6338.397852204033, 5018.272350509155, 5020.096382651158, 5022.573081288058, 5149.536541711264, 5183.3261675981885, 4538.251188553918, 4559.772011399416, 4567.269236922077, 4590.0, 4609.423822022247, 6041.78853740117, 6056.152138700585, 6068.848278793065, 6070.150178974947, 6071.058985857199, 6244.438000579969, 6322.0, 6379.872402551923, 6391.1371964785085, 6397.392247736458, 5875.618084824473, 5983.910241346383, 6021.488173505301, 6050.183225264621, 6085.5435842312, 5659.094544872801, 5662.801801936913, 5665.575081868794, 5670.603057785998, 5689.374168841424, 6568.047633093271, 6576.934230657632, 6589.17635295588, 6592.208934927743, 6607.504437167136, 6192.690365481798, 6265.8120256392385, 6331.683415829098, 6331.9366806331345, 6333.145025421509, 6379.904301435389, 6453.806385808433, 6503.707333170113, 6641.236257830218, 6645.468362531083, 6341.90487142684, 6350.872982540416, 6356.3325850785, 6358.936410635834, 6367.458766004941, 6354.90467642995, 6363.395477429637, 6369.172007638977, 6376.330485298977, 6376.39424254695, 6124.777645458507, 6132.936844521141, 6134.1119512865025, 6142.57002009855, 6281.52888533371, 6234.844128896814, 6241.531885108544, 6243.843903902439, 6252.124702541739, 6254.468370188585, 6062.878367502026, 6144.832481828438, 6170.598911070766, 6188.195534580475, 6194.039923811636, 6297.842553936188, 6338.461230795434, 6345.17512723343, 6355.078513615592, 6361.650109244036, 4802.447718512416, 6213.1922850029205, 6257.9674353731125, 6258.43674069336, 6269.780557680459], "value": 5865.583842333001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.5895278120644, 808.6684459371658, 815.4088285992656, 873.1268731268731, 884.491417434975, 28094.578581321297, 42204.36693449601, 42492.93767655806, 43996.68009959698, 44505.77747111268, 42467.78766106165, 42576.78711606446, 42663.14673706524, 42755.786221068855, 42808.785956070176, 7496.587687677175, 9226.308026897976, 9384.577694003787, 9401.247900168004, 9405.764855878624, 7502.5873576953245, 7575.053118360205, 7575.09098908129, 7579.355754760852, 7579.696812127509, 11109.611163609276, 11382.487788049557, 11461.59884404046, 11486.942565287161, 11529.884701153007, 11196.160287978393, 11255.66233013011, 11261.493232804543, 11268.154888383404, 11274.774504509905, 7466.066741657293, 10963.56145754169, 11021.724456888562, 11023.338599684044, 11023.393713345762, 28430.431391372265, 28567.000154994475, 28599.85700071507, 39773.40339894904, 39887.0, 3805.162864169878, 3832.559255685576, 3885.630865067814, 3887.105965627893, 3931.7247792654525, 28079.859600701864, 28092.438151237064, 28191.43617127646, 28375.432491350264, 29418.705812942026, 3120.8127512349333, 3146.921326966821, 3153.353562519678, 3157.0213233897566, 3185.3470038642254, 354736.0, 356496.0, 357276.0, 357278.0, 357824.0, 52690.0, 52845.7357713209, 52899.206511902354, 52943.47056529386, 52954.735226323624, 55314.446855531736, 55384.6153846149, 55400.722996385564, 55448.168277475874, 55494.72252638711, 14575.271236438135, 14953.775693364609, 14976.850231497763, 14981.625459363386, 15004.62488437776, 12811.423485943154, 12819.935900320625, 12829.743405132032, 12836.0, 12859.357032148355, 11227.494762735696, 11235.15736319763, 12426.5650702225, 12858.532206179472, 12971.935140324238, 4696.131215725101, 4839.249916262985, 5318.73406329682, 5365.168398898177, 5483.643563168382, 1088.6353071720903, 1122.294112948314, 1129.5425352732157, 1170.607846371458, 1204.4700331853956, 26800.59799103015, 27169.592456113172, 27408.45183096327, 27611.585826212624, 27616.309592260353, 1245.5640525815893, 1256.3215863433643, 1266.3731452930674, 1300.518808041031, 1300.570811632178, 11408.0, 13975.930120349332, 14297.0, 14392.856071439151, 14587.781183282259, 435314.0, 435592.0, 436149.8192509017, 436180.0, 436805.0, 57333.42666573281, 57351.13973290404, 57415.71292143512, 57614.0, 57634.69461221588, 1415.8938079644067, 1446.6455718348861, 1453.8764205042478, 1454.810874586297, 1458.1688437590471, 25929.481410372064, 26391.0, 26818.329541761614, 26985.0, 27002.594961075993, 47501.76249118732, 47815.282770759164, 47816.7609161952, 47822.0, 47883.76058119687, 411767.0, 412170.0, 412988.0, 413408.0, 413870.0, 34572.30855382929, 35455.64544354523, 35484.64515354813, 35610.0, 35653.0, 38502.0, 39862.800685996386, 44140.77929610331, 44512.33231501465, 44845.0, 32504.674953250164, 33014.0, 33160.0, 33261.833690831394, 34123.829380852934, 32796.85211017603, 33653.653853846554, 33976.15059623529, 33998.32003359968, 34147.63409463693, 33122.84070057536, 33196.33607327792, 33595.664043359255, 33766.66233337635, 33785.831070845474, 28096.0, 29922.401551969273, 29935.70064299329, 30034.710982514887, 30461.54307685431, 17044.318227271266, 22785.544289114456, 22911.625302481905, 23468.76531234666, 23523.0], "value": 18765.181435134124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5731430198122, 428.6677824685869, 429.593812307959, 434.76522677754014, 440.92283850326186, 14910.478133265324, 20582.808931616695, 21859.781402185974, 22128.557428851454, 22399.55200895981, 22427.55144897101, 22786.2024829131, 22974.88512557435, 23233.419164520852, 23406.414839628975, 5534.916976245359, 5887.88224235515, 6550.705218265166, 6790.5246632735725, 6794.218664853531, 4181.665466762652, 4396.758178300192, 4440.511543730187, 4454.354118652794, 4461.040876211614, 4399.42807435033, 4443.044745379742, 4454.688171827974, 4466.196084704752, 4556.815228040717, 7620.390368770512, 7700.0, 7744.341730952876, 7753.844923101563, 7763.534187948741, 7209.927900720978, 7460.776176714708, 7523.548587084792, 7542.6605802739, 7566.810829729246, 27159.642017899027, 27984.02055928033, 27989.440211195662, 28301.858490707415, 28471.71528284732, 2951.74910132639, 2958.8224706517676, 3115.890943816978, 3386.593608766964, 3403.7277017838514, 15516.14661193634, 16519.66960660792, 17209.569760755956, 17589.824101758946, 17686.823131768648, 1815.664102141108, 1941.6019715958196, 2100.7689154193026, 2107.1571371451387, 2165.98917005414, 127672.0, 129561.99999999905, 133615.0, 135674.0, 136463.31768341095, 15322.467753224812, 21880.562388752136, 21999.2300269493, 22020.779792202193, 22259.664420134843, 34165.829170853984, 34448.82775586106, 34535.30929381398, 35610.28779424449, 36366.0, 11043.061339786047, 11071.72320691973, 11139.554417823358, 11186.0, 11339.433028348549, 9052.0, 9066.156158092432, 9078.319126065571, 9233.815323693489, 9305.348625596143, 10317.48412579368, 10615.84076238857, 10724.839127413095, 10746.301490403099, 10782.730431739112, 3742.719296052807, 3968.2460332536725, 4070.247004304213, 4169.1661667666585, 4180.916381672349, 796.77690246731, 953.580424613168, 967.9516024198762, 989.094978095035, 1012.3318609717699, 21661.0, 23303.883480582488, 23342.766572334058, 23415.88292058529, 23418.531629367317, 979.4524651051322, 981.1365997921783, 990.9405435673883, 1002.1210230817218, 1003.6236411345745, 11770.411479425995, 11956.34240116802, 12060.0, 12188.14682972201, 12254.38728063611, 745881.0, 758364.0, 760153.0, 776240.0, 778943.0, 122977.0, 128858.0, 151963.0, 153639.0, 159896.0, 1215.89961085218, 1231.6859200903712, 1262.5391732017747, 1317.7891537353978, 1322.9867701323055, 13794.65513362174, 19362.4191274262, 20441.0, 20727.811266363937, 20775.37673869786, 63726.362736372044, 64314.67842660757, 64670.35329646832, 65739.0, 66599.0, 69184.65407672929, 78745.60627196827, 78997.60501197458, 89253.55373223351, 93096.06903930874, 8738.91261087381, 11300.152488563555, 11699.122565807429, 11995.520179193083, 11995.940020299842, 10622.0, 12765.234085954873, 12911.22532648044, 13118.672033199246, 13153.934230328787, 9711.125998659872, 10957.794642589468, 11017.394043327373, 11256.099512039182, 11349.659510214708, 9632.795900512436, 10653.254272200871, 10752.354858708502, 11173.441327933733, 11184.273022253528, 11212.83180752273, 11422.371769552754, 11593.304401735923, 11644.0, 11651.59219427316, 11476.942615286871, 11546.249493782878, 11569.6529104127, 11641.88358116408, 11782.234154779911, 10697.304675196086, 11074.0, 11153.49809258569, 11182.049525790399, 11194.832077519006], "value": 11507.340928204796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.2758620689663, 1513.160196091169, 1561.984380156198, 1602.1828867277684, 1605.9678806423872, 10542.78914421712, 11109.83335249972, 11144.108471322295, 11149.888501114976, 11161.274517156378, 10710.089642380388, 10808.0, 11097.778044439106, 11197.440127993608, 11259.21185517014, 2405.56699794037, 2428.2229686500327, 2441.316431399211, 2444.1445494077107, 2448.3511869354547, 2382.9642555361684, 2420.5037967216767, 2427.927162185137, 2431.051889762985, 2431.3678443604613, 2378.4053986503372, 2401.651760494727, 2406.8074554035634, 2407.963880541793, 2411.252511721372, 2352.5059737455153, 2373.5134297468976, 2379.428937055103, 2387.6776635154206, 2389.330987323535, 1961.7842037375876, 1992.7907569705117, 2376.4534157143953, 2405.230326295586, 2405.8315917885757, 10966.232363734542, 11203.831942520868, 11210.831837522444, 11213.0, 11248.437578121062, 4715.717056976592, 5932.466078052953, 5935.584509084366, 5946.672932988684, 5949.6727679977585, 3561.893143205708, 3584.480250363709, 3672.100335417813, 3689.24370504046, 3717.5724791649036, 1159.9710007249803, 1160.1414952934851, 1205.4876677412065, 1212.7331986962854, 1226.7423840993401, 13745.969052321116, 14147.575572732732, 14512.709745805236, 15383.692326153527, 15685.0, 4252.0, 4375.212461756851, 4379.5182529921685, 4380.496242932104, 4388.514357053683, 10354.11989980845, 11697.707557311136, 11700.122490813223, 11725.179237453467, 11754.177207595387, 5750.281214848144, 5766.481016708516, 5768.336641286306, 5776.537876969916, 5778.739956701958, 5013.5989120870245, 5230.267762513251, 5234.2933703949475, 5315.574754019669, 5322.0952438085615, 3879.767213967171, 3915.4909861717792, 3954.209158168378, 3988.4615576897327, 3998.7800670962793, 1043.76515284062, 1045.6183493025144, 1051.1800795379615, 1063.7021633942509, 1067.80779459698, 895.5208963204784, 919.8528235482424, 921.0697195832124, 926.4672813132341, 957.7749228931195, 6331.145295385156, 6432.356764323624, 6594.604323740495, 6636.203655561363, 6680.565763225375, 977.1791694976254, 978.7797745507346, 997.2719914462483, 999.1856636840952, 1010.3887148275335, 3509.964900351015, 4006.559278479365, 4093.815778289984, 4159.1265834175165, 4241.85469923119, 13362.0, 13776.311184440738, 13832.30838458073, 14051.71896562063, 14089.788653170212, 13670.31648417595, 13717.725645487035, 13961.441542338396, 13963.232022238875, 13967.580972570637, 7272.527285726516, 10107.39355638664, 10281.588736450607, 10282.331648442827, 10285.177185825116, 6507.256364925724, 6548.410643042149, 6597.109390232449, 6721.462283017249, 6794.286599906938, 11813.527458901548, 12179.695507612027, 12254.571090011807, 12330.136890417585, 12333.444994975069, 12107.81838272409, 12445.62663120108, 12447.253164810141, 12492.500299987898, 12526.436310366238, 9189.356745027784, 9233.261339092722, 9426.434413935185, 9430.387024843363, 9445.0554944505, 10210.540525676213, 10240.846387304346, 10335.431551264752, 10341.896581034094, 10409.47952602382, 8939.865902011345, 9122.361434699507, 9161.77095572616, 9168.0, 9179.49512776777, 8798.208161265517, 8830.984436789851, 8871.157240062184, 8882.511461869659, 8898.42160259581, 7704.229577042251, 7754.612269386621, 7826.373890088666, 7841.529508229524, 7847.764567062997, 5673.631213971244, 5680.829575112753, 5681.431856814285, 5829.941700583109, 5849.239598852122, 5772.163036359789, 5862.149988251595, 5911.201987731602, 6044.848878778066, 6184.226971628546], "value": 5114.951619797386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.56350197273133, 384.85567912032985, 385.43918598439274, 393.52187092682396, 393.60049549707037, 4499.83004418851, 5040.84060666047, 5128.487151284874, 5181.2901742425, 5229.372475302965, 4269.957300426995, 4506.864794056175, 4538.387317712108, 4872.537108974641, 5093.26147708582, 3524.9471257931023, 3795.3547896857463, 3824.6366595173413, 3944.605539446047, 4035.919281614366, 3397.8447327908507, 3874.9225015499674, 3975.483187185662, 4078.6125318094882, 4106.219818234541, 3587.1390866192055, 4060.309747342944, 4067.776272305022, 4090.9386359204636, 4112.547619761824, 3505.3164632896596, 3555.8044307563073, 3941.763494190329, 3969.7816620085882, 4015.9799201003807, 3534.5581802274714, 3539.2744487380023, 3545.2554963457706, 3547.7161827053774, 3583.4445660922597, 4267.082577245876, 4316.784160791948, 4902.583280421133, 4957.429895562021, 5024.19612861944, 4065.9593404065877, 4254.936175957363, 4660.4174478190225, 4678.69588476748, 4746.52534746526, 4852.369192005052, 5305.7612407441375, 5335.866603334909, 5348.438413966555, 5547.278853749027, 3761.1725420407465, 3786.848526058982, 3938.6324692387884, 3940.7241493095494, 4048.7975601219823, 4506.954930450686, 4904.828331008398, 5780.393058728815, 5794.420557944214, 5866.21354856444, 4516.435445569304, 4681.531846815291, 4806.903861922742, 4869.613889194269, 4886.731229782325, 4242.0, 4983.953369792384, 4998.300577803564, 5028.522290382408, 5040.294358789773, 4416.895776055986, 4580.519045500241, 5080.0, 5148.845534633967, 5240.34495688039, 4550.704204226715, 4875.585575226146, 5503.807366742145, 5527.2538207342295, 5540.0, 1510.6676531163346, 1571.8742500599924, 1625.1711627070042, 1672.8624535316103, 1680.269082948921, 1203.6870413692502, 1298.461138627478, 1307.8365204349457, 1356.5658989123583, 1411.5835828430638, 4510.932336014962, 4748.0, 4762.689765761991, 4783.115123702126, 4889.0, 4884.8290309838985, 5441.252846470348, 5705.971470142623, 5714.828555143353, 5721.052473793069, 4646.79089440976, 4793.448753393334, 5005.974970125126, 5009.321877171188, 5116.590672746172, 2532.5821239495276, 2909.767218622505, 2944.573036909636, 2969.613950186462, 3002.7597792176575, 5193.558547523503, 5266.578023933593, 5569.718964638156, 5889.8233053007625, 5936.588484436884, 4985.152524070917, 5257.5005374489365, 5310.2831117798605, 5709.65742055478, 5724.484796368347, 4477.0, 5371.489708477767, 5908.20239267702, 5964.791232306935, 6028.0, 5042.016806722654, 5131.204663277198, 5196.064708352533, 5415.6479828811, 5642.802501912413, 4444.31113177458, 4832.95167048325, 5135.8444350020945, 5222.545403660273, 5727.455891690282, 5104.591632669451, 5771.365149833431, 5825.70871456434, 5879.970600147143, 5975.790847320323, 3882.8058597069466, 4042.514898212233, 4112.943528235882, 4131.772752498641, 4546.249868771748, 4978.5270399312, 5099.878026834091, 5540.22436858832, 5573.6098473106495, 5646.971765141148, 4815.927761083657, 5142.897142057063, 5216.321878155815, 5371.462853714597, 5485.314335708036, 5034.496550344937, 5169.81905633301, 5386.929450213341, 5544.22380866687, 5568.415316391721, 5113.974430127825, 5418.729063546728, 5435.782568697208, 5437.619366644297, 5454.972725136349, 4803.735794531334, 5067.6452648315735, 5087.643864929568, 5559.58303127259, 5616.466435688603, 4981.900361992667, 5409.377921539073, 5444.401115877329, 5450.645708028966, 5503.944960550343], "value": 4153.419425115685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.3373980287639, 742.4134933402609, 759.2066290726191, 830.2569200565493, 847.8812966184735, 14718.632034199138, 15367.154806485667, 15636.921815390908, 15659.921700391496, 15717.528474145765, 13672.794908076386, 14185.858141418583, 14380.49668261611, 14395.64010899728, 14406.639834004156, 940.4921342475072, 959.7456673981401, 963.7831487915233, 965.1940629574314, 966.5119114847028, 938.8075444533888, 959.9952000239989, 963.330485312708, 979.6179489998906, 980.882294124706, 1008.334499230508, 1012.9392236465799, 1012.9696109116701, 1013.3463915774358, 1013.9188864890828, 1007.7531004903772, 1009.5709323537467, 1011.6610935336635, 1012.1649639047741, 1012.6455740490843, 749.7938067031555, 752.3003606645817, 753.5365750063726, 755.5013690963938, 755.9433042521778, 15587.142707151103, 15963.122028288439, 15989.0, 16045.117518536475, 16341.754873676904, 10617.469126543641, 14468.927655361762, 14473.131612103307, 14487.78268325976, 14529.273536323142, 11677.697153337069, 11746.060315174765, 11890.940545297304, 11937.582184623496, 12065.698357541043, 3581.6239294874185, 3617.7829330240006, 3683.28176005679, 3758.229562939591, 3853.3064048471265, 110163.0, 114676.0, 115173.0, 115306.0, 116390.83609163885, 10529.526171322308, 10683.94658026705, 10958.068564171976, 11025.44872756359, 11265.26775759573, 22528.098876045104, 22806.087756489556, 22916.4270893229, 23032.884835575715, 23249.0, 7612.200718924544, 7622.5426474411715, 7703.537787732754, 7759.68961241544, 7776.7278145264645, 4229.915401691949, 4289.1421715657, 4390.319500477367, 4404.779761012001, 4463.352813841975, 3499.4400895856543, 3613.94579081314, 3620.891373258754, 3623.4564815277918, 3627.5646922369483, 540.5162379670173, 625.3340192694766, 626.708580510065, 627.6641996531833, 628.6510986402591, 515.8942416804546, 626.8558231606756, 647.8024202618152, 679.1714108787272, 697.7941507255372, 9550.522473876417, 9655.758606034764, 9801.215902727765, 9858.99426156733, 9884.272434073178, 561.4357570641479, 638.2309317272675, 662.2450406536552, 670.1957650819037, 684.8287928017995, 4576.244919588231, 4767.284907263869, 4834.734089625104, 4872.909916072106, 4882.340883980617, 110939.44530277458, 111024.44487777671, 112462.0, 113159.0, 116639.0, 96233.51883240679, 99128.51307230398, 99677.0, 99713.50429743559, 100696.0, 85308.14691853002, 88050.55974720213, 88408.0, 88643.67034494488, 90006.54996725105, 7213.422926165999, 9182.494962776844, 9298.674546390845, 9351.625934962525, 9425.84255145766, 49008.0198396023, 49607.0, 50194.749026254634, 50521.74739126281, 51742.0, 62989.05516417349, 63301.68349158225, 63346.0, 64102.67948660227, 64998.35001649923, 11307.943460282646, 11448.484818183368, 11659.941700291443, 11935.0, 12072.879271207175, 12341.75316493683, 12506.0, 12524.185927914656, 12954.481820727065, 13049.0, 11232.817976497114, 11628.709282268012, 11818.940905295762, 12086.576969806014, 12250.938745306217, 11616.0, 11924.216575379518, 11929.28424294545, 12071.879281207075, 12249.632511024327, 11525.0, 11676.766464670489, 11677.06583473337, 11717.06263498901, 11736.119791015879, 9484.383515071499, 10405.167586593207, 10422.73943151397, 10641.521131548943, 10680.519376627915, 8647.481151130953, 8703.43427677199, 8939.150780675825, 9534.52327383642, 9723.854142188015], "value": 7491.616687036326, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 113.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 109.0, 144.0, 108.0, 116.0, 110.0, 109.0, 129.0, 109.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 184.0, 187.0, 184.0, 186.0, 184.0, 184.0, 186.0, 184.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 94.0, 61.0, 61.0, 61.0, 76.0, 99.0, 83.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 112.0, 99.0, 100.0, 55.0, 102.0, 89.0, 98.0, 114.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 88.0, 87.0, 87.0, 87.0, 87.0, 87.0, 88.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 87.0, 86.0, 82.0, 87.0, 86.0, 84.0, 87.0, 86.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 59.0, 60.0, 64.0, 65.0, 63.0, 63.0, 63.0, 64.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 53.0, 65.0, 61.0, 57.0, 57.0, 57.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 82.0, 84.0, 84.0, 86.0, 82.0, 84.0, 84.0, 92.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 141.0, 140.0, 139.0, 147.0, 140.0, 143.0, 181.0, 139.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 165.0, 164.0, 166.0, 166.0, 175.0, 216.0, 149.0, 203.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 63.0], "value": 64.3, "unit": "score"}]}]} 02:40:33 INFO - Return code: 0 02:40:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:33 ERROR - # TBPL SUCCESS # 02:40:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:40:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:40:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:40:33 INFO - 2017-03-14 02:40:33.310 screenresolution[1659:10241] starting screenresolution argv=screenresolution get 02:40:33 INFO - 2017-03-14 02:40:33.313 screenresolution[1659:10241] Display 0: 1600x1200x32@60 02:40:33 INFO - 2017-03-14 02:40:33.320 screenresolution[1660:10244] starting screenresolution argv=screenresolution list 02:40:33 INFO - Available Modes on Display 0 02:40:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:40:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:40:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:40:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:40:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:40:33 INFO - Intel Iris: 02:40:33 INFO - Chipset Model: Intel Iris 02:40:33 INFO - Type: GPU 02:40:33 INFO - Bus: Built-In 02:40:33 INFO - VRAM (Dynamic, Max): 1536 MB 02:40:33 INFO - Vendor: Intel (0x8086) 02:40:33 INFO - Device ID: 0x0a2e 02:40:33 INFO - Revision ID: 0x0009 02:40:33 INFO - Displays: 02:40:33 INFO - Display: 02:40:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:40:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:40:33 INFO - Display Serial Number: 1600x1200 60 02:40:33 INFO - Main Display: Yes 02:40:33 INFO - Mirror: Off 02:40:33 INFO - Online: Yes 02:40:33 INFO - Rotation: Supported 02:40:33 INFO - Return code: 0 02:40:33 INFO - Running post-action listener: _resource_record_post_action 02:40:33 INFO - [mozharness: 2017-03-14 09:40:33.556740Z] Finished run-tests step (success) 02:40:33 INFO - Running post-run listener: _resource_record_post_run 02:40:33 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39113728; Write bytes: 509687808; Read time: 381; Write time: 2102 02:40:33 INFO - TinderboxPrint: CPU usage
54.0% 02:40:33 INFO - TinderboxPrint: I/O read bytes / time
39,113,728 / 381 02:40:33 INFO - TinderboxPrint: I/O write bytes / time
509,687,808 / 2,102 02:40:33 INFO - TinderboxPrint: CPU idle
2,211.7 (46.0%) 02:40:33 INFO - TinderboxPrint: CPU system
959.6 (20.0%) 02:40:33 INFO - TinderboxPrint: CPU user
1,634.4 (34.0%) 02:40:33 INFO - TinderboxPrint: Swap in / out
247,496,704 / 0 02:40:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206254592; Write bytes: 202037248; Read time: 15767; Write time: 413 02:40:33 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 36963328; Write bytes: 296615936; Read time: 353; Write time: 1650 02:40:34 INFO - Running post-run listener: _upload_blobber_files 02:40:34 INFO - Blob upload gear active. 02:40:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:34 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 02:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:35 INFO - (blobuploader) - INFO - Done attempting. 02:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:36 INFO - (blobuploader) - INFO - Done attempting. 02:40:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:40:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:40:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:37 INFO - (blobuploader) - INFO - Done attempting. 02:40:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:39 INFO - (blobuploader) - INFO - Done attempting. 02:40:39 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:39 INFO - Return code: 0 02:40:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c8eef32ee146423b77244347fed8343d75e28f3d4e782af11590f95640a73e4d5f1a531304a182e51c69bb7852a484207cb64a3e52019bda39894524d86c92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49cb67c8139977cd483d4788a8ff5eea070c280797d252dcf0d4a3128059f3ea9882aa7c2872eb01b7e4518f668092af45ea657984664ff026b3a3a5d0df8da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/158e65001f4070e4fb4f8275c055c9c839d4e1efbe4590156b091c9eaf8654450b4a3d52fd262c4d7761d0d807e615addc4c73b000c7470194ac14a7e976a980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2c8309e20df180c957c4dc94f3ef8abf84bf196426268fc52222f0c98350d53155d080b1db8b6880634d9f14aac0304019b83e84482bfae8d1daed6e6c02c43"} 02:40:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:39 INFO - Contents: 02:40:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c8eef32ee146423b77244347fed8343d75e28f3d4e782af11590f95640a73e4d5f1a531304a182e51c69bb7852a484207cb64a3e52019bda39894524d86c92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49cb67c8139977cd483d4788a8ff5eea070c280797d252dcf0d4a3128059f3ea9882aa7c2872eb01b7e4518f668092af45ea657984664ff026b3a3a5d0df8da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/158e65001f4070e4fb4f8275c055c9c839d4e1efbe4590156b091c9eaf8654450b4a3d52fd262c4d7761d0d807e615addc4c73b000c7470194ac14a7e976a980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2c8309e20df180c957c4dc94f3ef8abf84bf196426268fc52222f0c98350d53155d080b1db8b6880634d9f14aac0304019b83e84482bfae8d1daed6e6c02c43"} 02:40:39 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:39 INFO - Copying logs to upload dir... 02:40:39 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.593043 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-14 02:40:39.726859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 02:40:39.730765) ========= 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.93UNGwwOLw/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.DmyCApZrK2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c8eef32ee146423b77244347fed8343d75e28f3d4e782af11590f95640a73e4d5f1a531304a182e51c69bb7852a484207cb64a3e52019bda39894524d86c92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49cb67c8139977cd483d4788a8ff5eea070c280797d252dcf0d4a3128059f3ea9882aa7c2872eb01b7e4518f668092af45ea657984664ff026b3a3a5d0df8da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/158e65001f4070e4fb4f8275c055c9c839d4e1efbe4590156b091c9eaf8654450b4a3d52fd262c4d7761d0d807e615addc4c73b000c7470194ac14a7e976a980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2c8309e20df180c957c4dc94f3ef8abf84bf196426268fc52222f0c98350d53155d080b1db8b6880634d9f14aac0304019b83e84482bfae8d1daed6e6c02c43"} build_url:https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/JqBYx9MBRjikbsqLXwamhQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c8eef32ee146423b77244347fed8343d75e28f3d4e782af11590f95640a73e4d5f1a531304a182e51c69bb7852a484207cb64a3e52019bda39894524d86c92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49cb67c8139977cd483d4788a8ff5eea070c280797d252dcf0d4a3128059f3ea9882aa7c2872eb01b7e4518f668092af45ea657984664ff026b3a3a5d0df8da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/158e65001f4070e4fb4f8275c055c9c839d4e1efbe4590156b091c9eaf8654450b4a3d52fd262c4d7761d0d807e615addc4c73b000c7470194ac14a7e976a980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2c8309e20df180c957c4dc94f3ef8abf84bf196426268fc52222f0c98350d53155d080b1db8b6880634d9f14aac0304019b83e84482bfae8d1daed6e6c02c43"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 02:40:39.764654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:40:39.764938) ========= 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.93UNGwwOLw/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.DmyCApZrK2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005305 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:40:39.816079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 02:40:39.816355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 02:40:39.816663) ========= ========= Total master_lag: 0.18 =========