builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0220 starttime: 1493153018.43 results: success (0) buildid: 20170425121527 builduid: 02063c45b9d643b19f6cfac5abf7918c revision: 872f6a669f11224a26f0e71e81bec4e9d723b450 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.426845) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.427425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.427716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.453688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.454046) ========= 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.tvZmU520iA/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.sJQQRDGHxG/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-04-25 13:43:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-04-25 13:43:38 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.592100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.592464) ========= 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.tvZmU520iA/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.sJQQRDGHxG/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.025639 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:38.641366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 13:43:38.641701) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 872f6a669f11224a26f0e71e81bec4e9d723b450 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 872f6a669f11224a26f0e71e81bec4e9d723b450 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tvZmU520iA/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.sJQQRDGHxG/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-04-25 13:43:38,754 truncating revision to first 12 chars 2017-04-25 13:43:38,754 Setting DEBUG logging. 2017-04-25 13:43:38,754 attempt 1/10 2017-04-25 13:43:38,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/872f6a669f11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 13:43:39,925 unpacking tar archive at: mozilla-beta-872f6a669f11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.452006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 13:43:40.117696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:40.118019) ========= script_repo_revision: 872f6a669f11224a26f0e71e81bec4e9d723b450 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:40.118432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:40.118704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 13:43:40.139122) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-25 13:43:40.139448) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tvZmU520iA/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.sJQQRDGHxG/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:43:40 INFO - MultiFileLogger online at 20170425 13:43:40 in /builds/slave/test 13:43:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:43:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:40 INFO - {'append_to_log': False, 13:43:40 INFO - 'base_work_dir': '/builds/slave/test', 13:43:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:43:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:40 INFO - 'branch': 'Mozilla-Beta', 13:43:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:40 INFO - 'config_files': ('talos/mac_config.py',), 13:43:40 INFO - 'default_actions': ('clobber', 13:43:40 INFO - 'read-buildbot-config', 13:43:40 INFO - 'download-and-extract', 13:43:40 INFO - 'populate-webroot', 13:43:40 INFO - 'create-virtualenv', 13:43:40 INFO - 'install', 13:43:40 INFO - 'run-tests'), 13:43:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:40 INFO - 'download_minidump_stackwalk': True, 13:43:40 INFO - 'download_symbols': 'ondemand', 13:43:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:40 INFO - 'gecko_profile': False, 13:43:40 INFO - 'gecko_profile_interval': 0, 13:43:40 INFO - 'installer_path': 'installer.exe', 13:43:40 INFO - 'log_level': 'info', 13:43:40 INFO - 'log_name': 'talos', 13:43:40 INFO - 'log_to_console': True, 13:43:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:43:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:43:40 INFO - 'opt_config_files': (), 13:43:40 INFO - 'pip_index': False, 13:43:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:43:40 INFO - 'cmd': ('bash', 13:43:40 INFO - '-c', 13:43:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:43:40 INFO - 'enabled': True, 13:43:40 INFO - 'halt_on_failure': False, 13:43:40 INFO - 'name': 'check_screen_resolution'},), 13:43:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:43:40 INFO - 'cmd': ('bash', 13:43:40 INFO - '-c', 13:43:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:43:40 INFO - 'enabled': True, 13:43:40 INFO - 'halt_on_failure': False, 13:43:40 INFO - 'name': 'check_screen_resolution'},), 13:43:40 INFO - 'run_cmd_checks_enabled': True, 13:43:40 INFO - 'suite': 'dromaeojs', 13:43:40 INFO - 'system_bits': '32', 13:43:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:40 INFO - 'title': 't-yosemite-r7-0220', 13:43:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:40 INFO - 'use_talos_json': True, 13:43:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:40 INFO - 'work_dir': 'build'} 13:43:40 INFO - [mozharness: 2017-04-25 20:43:40.358076Z] Running clobber step. 13:43:40 INFO - Running pre-action listener: _resource_record_pre_action 13:43:40 INFO - Running main action method: clobber 13:43:40 INFO - rmtree: /builds/slave/test/build 13:43:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:42 INFO - Running post-action listener: _resource_record_post_action 13:43:42 INFO - [mozharness: 2017-04-25 20:43:42.556793Z] Finished clobber step (success) 13:43:42 INFO - [mozharness: 2017-04-25 20:43:42.557064Z] Running read-buildbot-config step. 13:43:42 INFO - Running pre-action listener: _resource_record_pre_action 13:43:42 INFO - Running main action method: read_buildbot_config 13:43:42 INFO - Using buildbot properties: 13:43:42 INFO - { 13:43:42 INFO - "project": "", 13:43:42 INFO - "product": "firefox", 13:43:42 INFO - "script_repo_revision": "production", 13:43:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:43:42 INFO - "repository": "", 13:43:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:43:42 INFO - "buildid": "20170425121527", 13:43:42 INFO - "pgo_build": "False", 13:43:42 INFO - "basedir": "/builds/slave/test", 13:43:42 INFO - "buildnumber": 10, 13:43:42 INFO - "slavename": "t-yosemite-r7-0220", 13:43:42 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:43:42 INFO - "platform": "yosemite_r7", 13:43:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:43:42 INFO - "branch": "mozilla-beta", 13:43:42 INFO - "repo_path": "releases/mozilla-beta", 13:43:42 INFO - "revision": "872f6a669f11224a26f0e71e81bec4e9d723b450", 13:43:42 INFO - "stage_platform": "macosx64", 13:43:42 INFO - "builduid": "02063c45b9d643b19f6cfac5abf7918c", 13:43:42 INFO - "slavebuilddir": "test" 13:43:42 INFO - } 13:43:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 13:43:42 INFO - Running post-action listener: _resource_record_post_action 13:43:42 INFO - [mozharness: 2017-04-25 20:43:42.562730Z] Finished read-buildbot-config step (success) 13:43:42 INFO - [mozharness: 2017-04-25 20:43:42.562963Z] Running download-and-extract step. 13:43:42 INFO - Running pre-action listener: _resource_record_pre_action 13:43:42 INFO - Running main action method: download_and_extract 13:43:42 INFO - mkdir: /builds/slave/test/build/tests 13:43:42 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')]} 13:43:42 INFO - trying https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 13:43:42 INFO - Downloading https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 13:43:43 INFO - Downloaded 1165 bytes. 13:43:43 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:43:43 INFO - Using the following test package requirements: 13:43:43 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:43:43 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 13:43:43 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 13:43:43 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:43:43 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 13:43:43 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:43:43 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 13:43:43 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 13:43:43 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 13:43:43 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:43:43 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 13:43:43 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 13:43:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:43:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:43:43 INFO - Fetch https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:43:44 INFO - Expected file size: 51224780 13:43:44 INFO - Obtained file size: 51224780 13:44:00 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:44:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:44:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:44:00 INFO - Fetch https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:44:02 INFO - Expected file size: 51224780 13:44:02 INFO - Obtained file size: 51224780 13:44:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 13:44:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 13:44:17 INFO - Fetch https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 13:44:18 INFO - Expected file size: 14404449 13:44:18 INFO - Obtained file size: 14404449 13:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:18 INFO - trying https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:44:18 INFO - Downloading https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 13:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 13:44:20 INFO - Downloaded 59533468 bytes. 13:44:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:44:20 INFO - mkdir: /builds/slave/test/properties 13:44:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:44:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:44:20 INFO - Contents: 13:44:20 INFO - build_url:https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:44:21 INFO - Running post-action listener: _resource_record_post_action 13:44:21 INFO - Running post-action listener: set_extra_try_arguments 13:44:21 INFO - [mozharness: 2017-04-25 20:44:21.223854Z] Finished download-and-extract step (success) 13:44:21 INFO - [mozharness: 2017-04-25 20:44:21.223992Z] Running populate-webroot step. 13:44:21 INFO - Running pre-action listener: _resource_record_pre_action 13:44:21 INFO - Running main action method: populate_webroot 13:44:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:44:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:44:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:44:21 INFO - '--tppagecycles', 13:44:21 INFO - '7'], 13:44:21 INFO - 'tests': ['tsvgm']}}, 13:44:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:44:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:44:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:44:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:44:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:44:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['damp', 'tps']}, 13:44:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'tests': ['damp', 'tps']}, 13:44:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['dromaeo_dom']}, 13:44:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:44:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['basic_compositor_video']}, 13:44:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:44:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['a11yr', 13:44:21 INFO - 'ts_paint', 13:44:21 INFO - 'tpaint', 13:44:21 INFO - 'sessionrestore', 13:44:21 INFO - 'sessionrestore_no_auto_restore', 13:44:21 INFO - 'tabpaint']}, 13:44:21 INFO - 'other-e10s': {'tests': ['a11yr', 13:44:21 INFO - 'ts_paint', 13:44:21 INFO - 'tpaint', 13:44:21 INFO - 'sessionrestore', 13:44:21 INFO - 'sessionrestore_no_auto_restore', 13:44:21 INFO - 'tabpaint']}, 13:44:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:44:21 INFO - 'ts_paint', 13:44:21 INFO - 'tpaint', 13:44:21 INFO - 'sessionrestore', 13:44:21 INFO - 'sessionrestore_no_auto_restore', 13:44:21 INFO - 'tabpaint']}, 13:44:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:44:21 INFO - 'ts_paint', 13:44:21 INFO - 'tpaint', 13:44:21 INFO - 'sessionrestore', 13:44:21 INFO - 'sessionrestore_no_auto_restore', 13:44:21 INFO - 'tabpaint']}, 13:44:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['a11yr', 13:44:21 INFO - 'ts_paint', 13:44:21 INFO - 'tpaint', 13:44:21 INFO - 'sessionrestore', 13:44:21 INFO - 'sessionrestore_no_auto_restore', 13:44:21 INFO - 'tabpaint']}, 13:44:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['a11yr', 13:44:21 INFO - 'ts_paint', 13:44:21 INFO - 'tpaint', 13:44:21 INFO - 'sessionrestore', 13:44:21 INFO - 'sessionrestore_no_auto_restore', 13:44:21 INFO - 'tabpaint']}, 13:44:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['tsvgx', 13:44:21 INFO - 'tsvgr_opacity', 13:44:21 INFO - 'tart', 13:44:21 INFO - 'tscrollx', 13:44:21 INFO - 'cart', 13:44:21 INFO - 'tsvg_static']}, 13:44:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:44:21 INFO - 'tsvgr_opacity', 13:44:21 INFO - 'tart', 13:44:21 INFO - 'tscrollx', 13:44:21 INFO - 'cart', 13:44:21 INFO - 'tsvg_static']}, 13:44:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'talos_options': ['--disable-e10s'], 13:44:21 INFO - 'tests': ['tp5o']}, 13:44:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:44:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'talos_options': ['--disable-e10s', 13:44:21 INFO - '--xperf_path', 13:44:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:21 INFO - 'tests': ['tp5n']}, 13:44:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:44:21 INFO - 'talos_options': ['--xperf_path', 13:44:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:44:21 INFO - 'tests': ['tp5n']}}, 13:44:21 INFO - 'talos.zip': {'path': '', 13:44:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:44:21 INFO - Running post-action listener: _resource_record_post_action 13:44:21 INFO - [mozharness: 2017-04-25 20:44:21.242205Z] Finished populate-webroot step (success) 13:44:21 INFO - [mozharness: 2017-04-25 20:44:21.242315Z] Running create-virtualenv step. 13:44:21 INFO - Running pre-action listener: _resource_record_pre_action 13:44:21 INFO - Running main action method: create_virtualenv 13:44:21 INFO - Creating virtualenv /builds/slave/test/build/venv 13:44:21 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 13:44:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:44:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:44:21 INFO - Using real prefix '/tools/python27' 13:44:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:44:22 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:25 INFO - Installing pip.................done. 13:44:25 INFO - Return code: 0 13:44:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:44:25 INFO - Reading from file tmpfile_stdout 13:44:25 INFO - Output received: 13:44:25 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) 13:44:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:25 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:25 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 13:44:25 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 13:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:25 INFO - 'HOME': '/Users/cltbld', 13:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:25 INFO - 'LOGNAME': 'cltbld', 13:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:25 INFO - 'MOZ_NO_REMOTE': '1', 13:44:25 INFO - 'NO_EM_RESTART': '1', 13:44:25 INFO - 'PAGER': '/bin/cat', 13:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:25 INFO - 'PWD': '/builds/slave/test', 13:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:25 INFO - 'SHELL': '/bin/bash', 13:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:25 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:25 INFO - 'USER': 'cltbld', 13:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:25 INFO - 'XPC_FLAGS': '0x0', 13:44:25 INFO - 'XPC_SERVICE_NAME': '0', 13:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:25 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 13:44:25 INFO - Cleaning up... 13:44:25 INFO - Return code: 0 13:44:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:25 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:25 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 13:44:25 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 13:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:25 INFO - 'HOME': '/Users/cltbld', 13:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:25 INFO - 'LOGNAME': 'cltbld', 13:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:25 INFO - 'MOZ_NO_REMOTE': '1', 13:44:25 INFO - 'NO_EM_RESTART': '1', 13:44:25 INFO - 'PAGER': '/bin/cat', 13:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:25 INFO - 'PWD': '/builds/slave/test', 13:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:25 INFO - 'SHELL': '/bin/bash', 13:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:25 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:25 INFO - 'USER': 'cltbld', 13:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:25 INFO - 'XPC_FLAGS': '0x0', 13:44:25 INFO - 'XPC_SERVICE_NAME': '0', 13:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:25 INFO - Downloading/unpacking psutil>=3.1.1 13:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:29 INFO - Installing collected packages: psutil 13:44:29 INFO - Running setup.py install for psutil 13:44:29 INFO - building 'psutil._psutil_osx' extension 13:44:29 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 13:44:29 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 13:44:29 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 13:44:29 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 13:44:29 INFO - building 'psutil._psutil_posix' extension 13:44:29 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 13:44:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:44:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:44:29 INFO - ^ 13:44:30 INFO - 1 warning generated. 13:44:30 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 13:44:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:30 INFO - Successfully installed psutil 13:44:30 INFO - Cleaning up... 13:44:30 INFO - Return code: 0 13:44:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:44: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 mozsystemmonitor==0.3 13:44:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:30 INFO - 'HOME': '/Users/cltbld', 13:44:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:30 INFO - 'LOGNAME': 'cltbld', 13:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:30 INFO - 'MOZ_NO_REMOTE': '1', 13:44:30 INFO - 'NO_EM_RESTART': '1', 13:44:30 INFO - 'PAGER': '/bin/cat', 13:44:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:30 INFO - 'PWD': '/builds/slave/test', 13:44:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:30 INFO - 'SHELL': '/bin/bash', 13:44:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:30 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:30 INFO - 'USER': 'cltbld', 13:44:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:30 INFO - 'XPC_FLAGS': '0x0', 13:44:30 INFO - 'XPC_SERVICE_NAME': '0', 13:44:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:44:30 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 13:44:30 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 13:44:30 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 13:44:30 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 13:44:30 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 13:44:30 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 13:44:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:44:33 INFO - Installing collected packages: mozsystemmonitor 13:44:33 INFO - Running setup.py install for mozsystemmonitor 13:44:33 INFO - Successfully installed mozsystemmonitor 13:44:33 INFO - Cleaning up... 13:44:33 INFO - Return code: 0 13:44:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:44:33 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')]} 13:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:34 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:34 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 13:44:34 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 13:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:34 INFO - 'HOME': '/Users/cltbld', 13:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:34 INFO - 'LOGNAME': 'cltbld', 13:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:34 INFO - 'MOZ_NO_REMOTE': '1', 13:44:34 INFO - 'NO_EM_RESTART': '1', 13:44:34 INFO - 'PAGER': '/bin/cat', 13:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:34 INFO - 'PWD': '/builds/slave/test', 13:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:34 INFO - 'SHELL': '/bin/bash', 13:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:34 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:34 INFO - 'USER': 'cltbld', 13:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:34 INFO - 'XPC_FLAGS': '0x0', 13:44:34 INFO - 'XPC_SERVICE_NAME': '0', 13:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:34 INFO - Downloading/unpacking jsonschema==2.5.1 13:44:34 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 13:44:34 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 13:44:34 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 13:44:34 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 13:44:34 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 13:44:34 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 13:44:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:44:37 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 13:44:37 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 13:44:37 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 13:44:37 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 13:44:37 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 13:44:37 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 13:44:37 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:38 INFO - warning: no files found matching '*.txt' 13:44:38 INFO - no previously-included directories found matching 'build' 13:44:38 INFO - no previously-included directories found matching 'dist' 13:44:38 INFO - no previously-included directories found matching '.git*' 13:44:38 INFO - Installing collected packages: jsonschema, functools32 13:44:38 INFO - Running setup.py install for functools32 13:44:38 INFO - warning: no files found matching '*.txt' 13:44:38 INFO - no previously-included directories found matching 'build' 13:44:38 INFO - no previously-included directories found matching 'dist' 13:44:38 INFO - no previously-included directories found matching '.git*' 13:44:38 INFO - Successfully installed jsonschema functools32 13:44:38 INFO - Cleaning up... 13:44:38 INFO - Return code: 0 13:44:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:38 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:38 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 13:44:38 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 13:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:38 INFO - 'HOME': '/Users/cltbld', 13:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:38 INFO - 'LOGNAME': 'cltbld', 13:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:38 INFO - 'MOZ_NO_REMOTE': '1', 13:44:38 INFO - 'NO_EM_RESTART': '1', 13:44:38 INFO - 'PAGER': '/bin/cat', 13:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:38 INFO - 'PWD': '/builds/slave/test', 13:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:38 INFO - 'SHELL': '/bin/bash', 13:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:38 INFO - 'USER': 'cltbld', 13:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:38 INFO - 'XPC_FLAGS': '0x0', 13:44:38 INFO - 'XPC_SERVICE_NAME': '0', 13:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:44:38 INFO - Cleaning up... 13:44:38 INFO - Return code: 0 13:44:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:38 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:38 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 13:44:38 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 13:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:38 INFO - 'HOME': '/Users/cltbld', 13:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:38 INFO - 'LOGNAME': 'cltbld', 13:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:38 INFO - 'MOZ_NO_REMOTE': '1', 13:44:38 INFO - 'NO_EM_RESTART': '1', 13:44:38 INFO - 'PAGER': '/bin/cat', 13:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:38 INFO - 'PWD': '/builds/slave/test', 13:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:38 INFO - 'SHELL': '/bin/bash', 13:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:38 INFO - 'USER': 'cltbld', 13:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:38 INFO - 'XPC_FLAGS': '0x0', 13:44:38 INFO - 'XPC_SERVICE_NAME': '0', 13:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:38 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:38 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 13:44:38 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 13:44:38 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 13:44:38 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 13:44:38 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 13:44:38 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 13:44:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:41 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 13:44:41 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 13:44:41 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 13:44:41 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 13:44:41 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 13:44:41 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 13:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:42 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 13:44:42 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 13:44:42 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 13:44:42 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 13:44:42 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 13:44:42 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 13:44:42 INFO - Downloading docopt-0.6.1.tar.gz 13:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:42 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:42 INFO - Running setup.py install for blobuploader 13:44:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:42 INFO - Running setup.py install for requests 13:44:43 INFO - Running setup.py install for docopt 13:44:43 INFO - Successfully installed blobuploader requests docopt 13:44:43 INFO - Cleaning up... 13:44:43 INFO - Return code: 0 13:44:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:43 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')]} 13:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:43 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')]} 13:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:43 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:43 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 13:44:43 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 13:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:43 INFO - 'HOME': '/Users/cltbld', 13:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:43 INFO - 'LOGNAME': 'cltbld', 13:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:43 INFO - 'MOZ_NO_REMOTE': '1', 13:44:43 INFO - 'NO_EM_RESTART': '1', 13:44:43 INFO - 'PAGER': '/bin/cat', 13:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:43 INFO - 'PWD': '/builds/slave/test', 13:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:43 INFO - 'SHELL': '/bin/bash', 13:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:43 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:43 INFO - 'USER': 'cltbld', 13:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:43 INFO - 'XPC_FLAGS': '0x0', 13:44:43 INFO - 'XPC_SERVICE_NAME': '0', 13:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VMb13m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-iJ0Xlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-T59tZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-78jHzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HnfLlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qQVtKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-I6NfGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TtwNRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VFiyXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-POfe0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-6PtbnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5uJf2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-AGm_qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-H2QQDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-psNdwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-nkdZ46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:45 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lyGN0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:45 INFO - Running setup.py install for manifestparser 13:44:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:45 INFO - Running setup.py install for mozcrash 13:44:46 INFO - Running setup.py install for mozdebug 13:44:46 INFO - Running setup.py install for mozdevice 13:44:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Running setup.py install for mozfile 13:44:46 INFO - Running setup.py install for mozhttpd 13:44:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Running setup.py install for mozinfo 13:44:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Running setup.py install for mozInstall 13:44:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:46 INFO - Running setup.py install for mozleak 13:44:47 INFO - Running setup.py install for mozlog 13:44:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:47 INFO - Running setup.py install for moznetwork 13:44:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:47 INFO - Running setup.py install for mozprocess 13:44:47 INFO - Running setup.py install for mozprofile 13:44:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:47 INFO - Running setup.py install for mozrunner 13:44:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:47 INFO - Running setup.py install for mozscreenshot 13:44:48 INFO - Running setup.py install for moztest 13:44:48 INFO - Running setup.py install for mozversion 13:44:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:48 INFO - Cleaning up... 13:44:48 INFO - Return code: 0 13:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:48 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:48 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 13:44:48 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 13:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:48 INFO - 'HOME': '/Users/cltbld', 13:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:48 INFO - 'LOGNAME': 'cltbld', 13:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:48 INFO - 'MOZ_NO_REMOTE': '1', 13:44:48 INFO - 'NO_EM_RESTART': '1', 13:44:48 INFO - 'PAGER': '/bin/cat', 13:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:48 INFO - 'PWD': '/builds/slave/test', 13:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:48 INFO - 'SHELL': '/bin/bash', 13:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:48 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:48 INFO - 'USER': 'cltbld', 13:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:48 INFO - 'XPC_FLAGS': '0x0', 13:44:48 INFO - 'XPC_SERVICE_NAME': '0', 13:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zQRX40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:48 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)) 13:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Choxoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:48 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)) 13:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-diqycx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:48 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)) 13:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SwvXTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZfVaJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-meMUNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ATFIm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-8ydIfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-NyU5Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-opuVIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pe4nXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-dcEpDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:49 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)) 13:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mQRg7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:50 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)) 13:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-KQ6MTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:50 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)) 13:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-sYrhFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:50 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)) 13:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-8xg3zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:50 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)) 13:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:50 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vc2e_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:50 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)) 13:44:50 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)) 13:44:50 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)) 13:44:50 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)) 13:44:50 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)) 13:44:50 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)) 13:44:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:44:50 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 13:44:50 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 13:44:50 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 13:44:50 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 13:44:50 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 13:44:50 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 13:44:53 INFO - Downloading blessings-1.6.tar.gz 13:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:53 INFO - Installing collected packages: blessings 13:44:53 INFO - Running setup.py install for blessings 13:44:53 INFO - Successfully installed blessings 13:44:53 INFO - Cleaning up... 13:44:53 INFO - Return code: 0 13:44:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:44:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:53 INFO - Reading from file tmpfile_stdout 13:44:53 INFO - Current package versions: 13:44:53 INFO - blessings == 1.6 13:44:53 INFO - blobuploader == 1.2.4 13:44:53 INFO - docopt == 0.6.1 13:44:53 INFO - functools32 == 3.2.3-2 13:44:53 INFO - jsonschema == 2.5.1 13:44:53 INFO - manifestparser == 1.1 13:44:53 INFO - mozInstall == 1.12 13:44:53 INFO - mozcrash == 1.0 13:44:53 INFO - mozdebug == 0.1 13:44:53 INFO - mozdevice == 0.49 13:44:53 INFO - mozfile == 1.2 13:44:53 INFO - mozhttpd == 0.7 13:44:53 INFO - mozinfo == 0.9 13:44:53 INFO - mozleak == 0.1 13:44:53 INFO - mozlog == 3.4 13:44:53 INFO - moznetwork == 0.27 13:44:53 INFO - mozprocess == 0.25 13:44:53 INFO - mozprofile == 0.28 13:44:53 INFO - mozrunner == 6.13 13:44:53 INFO - mozscreenshot == 0.1 13:44:53 INFO - mozsystemmonitor == 0.3 13:44:53 INFO - moztest == 0.8 13:44:53 INFO - mozversion == 1.4 13:44:53 INFO - psutil == 3.1.1 13:44:53 INFO - requests == 1.2.3 13:44:53 INFO - wsgiref == 0.1.2 13:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:53 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:53 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 13:44:53 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 13:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:53 INFO - 'HOME': '/Users/cltbld', 13:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:53 INFO - 'LOGNAME': 'cltbld', 13:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:53 INFO - 'MOZ_NO_REMOTE': '1', 13:44:53 INFO - 'NO_EM_RESTART': '1', 13:44:53 INFO - 'PAGER': '/bin/cat', 13:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:53 INFO - 'PWD': '/builds/slave/test', 13:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:53 INFO - 'SHELL': '/bin/bash', 13:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:53 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:53 INFO - 'USER': 'cltbld', 13:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:53 INFO - 'XPC_FLAGS': '0x0', 13:44:53 INFO - 'XPC_SERVICE_NAME': '0', 13:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 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)) 13:44:54 INFO - Cleaning up... 13:44:54 INFO - Return code: 0 13:44:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:44:54 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')]} 13:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:54 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')]} 13:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:54 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 0x110306b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110309768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85f2584a20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, '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.tvZmU520iA/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.sJQQRDGHxG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 13:44:54 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 13:44:54 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 13:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:44:54 INFO - 'HOME': '/Users/cltbld', 13:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:44:54 INFO - 'LOGNAME': 'cltbld', 13:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:54 INFO - 'MOZ_NO_REMOTE': '1', 13:44:54 INFO - 'NO_EM_RESTART': '1', 13:44:54 INFO - 'PAGER': '/bin/cat', 13:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:54 INFO - 'PWD': '/builds/slave/test', 13:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:44:54 INFO - 'SHELL': '/bin/bash', 13:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:44:54 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:44:54 INFO - 'USER': 'cltbld', 13:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:54 INFO - 'XPC_FLAGS': '0x0', 13:44:54 INFO - 'XPC_SERVICE_NAME': '0', 13:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:44:54 INFO - Cleaning up... 13:44:54 INFO - Return code: 0 13:44:54 INFO - Running post-action listener: _resource_record_post_action 13:44:54 INFO - Running post-action listener: _start_resource_monitoring 13:44:54 INFO - Starting resource monitoring. 13:44:54 INFO - [mozharness: 2017-04-25 20:44:54.337407Z] Finished create-virtualenv step (success) 13:44:54 INFO - [mozharness: 2017-04-25 20:44:54.338464Z] Running install step. 13:44:54 INFO - Running pre-action listener: _resource_record_pre_action 13:44:54 INFO - Running main action method: install 13:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:54 INFO - Reading from file tmpfile_stdout 13:44:54 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:44:54 INFO - Reading from file tmpfile_stdout 13:44:54 INFO - Output received: 13:44:54 INFO - Usage: mozinstall [options] installer 13:44:54 INFO - Options: 13:44:54 INFO - -h, --help show this help message and exit 13:44:54 INFO - -d DEST, --destination=DEST 13:44:54 INFO - Directory to install application into. [default: 13:44:54 INFO - "/builds/slave/test"] 13:44:54 INFO - --app=APP Application being installed. [default: firefox] 13:44:54 INFO - mkdir: /builds/slave/test/build/application 13:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:45:09 INFO - Reading from file tmpfile_stdout 13:45:09 INFO - Output received: 13:45:09 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:45:09 INFO - Running post-action listener: _resource_record_post_action 13:45:09 INFO - [mozharness: 2017-04-25 20:45:09.610755Z] Finished install step (success) 13:45:09 INFO - [mozharness: 2017-04-25 20:45:09.610891Z] Running run-tests step. 13:45:09 INFO - Running pre-action listener: _resource_record_pre_action 13:45:09 INFO - Running main action method: run_tests 13:45:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:45:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:45:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:45:09 INFO - 2017-04-25 13:45:09.625 screenresolution[4055:128101] starting screenresolution argv=screenresolution get 13:45:09 INFO - 2017-04-25 13:45:09.628 screenresolution[4055:128101] Display 0: 1600x1200x32@60 13:45:09 INFO - 2017-04-25 13:45:09.634 screenresolution[4056:128103] starting screenresolution argv=screenresolution list 13:45:09 INFO - Available Modes on Display 0 13:45:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:45:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:45:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:45:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:45:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:45:09 INFO - Intel Iris: 13:45:09 INFO - Chipset Model: Intel Iris 13:45:09 INFO - Type: GPU 13:45:09 INFO - Bus: Built-In 13:45:09 INFO - VRAM (Dynamic, Max): 1536 MB 13:45:09 INFO - Vendor: Intel (0x8086) 13:45:09 INFO - Device ID: 0x0a2e 13:45:09 INFO - Revision ID: 0x0009 13:45:09 INFO - Displays: 13:45:09 INFO - Display: 13:45:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:45:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:45:09 INFO - Display Serial Number: 1600x1200 60 13:45:09 INFO - Main Display: Yes 13:45:09 INFO - Mirror: Off 13:45:09 INFO - Online: Yes 13:45:09 INFO - Rotation: Supported 13:45:09 INFO - Return code: 0 13:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:45:09 INFO - Python 2.7.3 13:45:09 INFO - Return code: 0 13:45:09 INFO - grabbing minidump binary from tooltool 13:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:09 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 0x1100e4d30>, '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 0x11000bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100d9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:45:09 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 13:45:09 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 13:45:09 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 13:45:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:45:10 INFO - Return code: 0 13:45:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:45:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:45:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:45:10 INFO - ENV: RUST_BACKTRACE is now 1 13:45:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:45:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 13:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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 13:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvZmU520iA/Render', 13:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:10 INFO - 'HOME': '/Users/cltbld', 13:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:10 INFO - 'LOGNAME': 'cltbld', 13:45:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:45:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:10 INFO - 'MOZ_NO_REMOTE': '1', 13:45:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:45:10 INFO - 'NO_EM_RESTART': '1', 13:45:10 INFO - 'PAGER': '/bin/cat', 13:45:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:10 INFO - 'PWD': '/builds/slave/test', 13:45:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:10 INFO - 'RUST_BACKTRACE': '1', 13:45:10 INFO - 'SHELL': '/bin/bash', 13:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJQQRDGHxG/Listeners', 13:45:10 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 13:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:10 INFO - 'USER': 'cltbld', 13:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:10 INFO - 'XPC_FLAGS': '0x0', 13:45:10 INFO - 'XPC_SERVICE_NAME': '0', 13:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 13:45:10 INFO - mozversion application_buildid: 20170425121527 13:45:10 INFO - mozversion application_changeset: 872f6a669f11224a26f0e71e81bec4e9d723b450 13:45:10 INFO - mozversion application_display_name: Firefox 13:45:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:45:10 INFO - mozversion application_name: Firefox 13:45:10 INFO - mozversion application_remotingname: firefox 13:45:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:45:10 INFO - mozversion application_vendor: Mozilla 13:45:10 INFO - mozversion application_version: 54.0 13:45:10 INFO - mozversion platform_buildid: 20170425121527 13:45:10 INFO - mozversion platform_changeset: 872f6a669f11224a26f0e71e81bec4e9d723b450 13:45:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:45:10 INFO - mozversion platform_version: 54.0 13:45:10 INFO - using testdate: 1493153110 13:45:10 INFO - actual date: 1493153110 13:45:10 INFO - starting webserver on 'localhost:65387' 13:45:10 INFO - SUITE-START | Running 2 tests 13:45:10 INFO - TEST-START | dromaeo_css 13:45:10 INFO - operating with platform_type : mac_ 13:45:10 INFO - Initialising browser for dromaeo_css test... 13:45:10 INFO - TEST-INFO | started process 4066 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpGZ3ao4/profile http://localhost:65387/getInfo.html) 13:45:12 INFO - PROCESS | 4066 | __metrics Screen width/height:1600/1200 13:45:12 INFO - PROCESS | 4066 | colorDepth:24 13:45:12 INFO - PROCESS | 4066 | Browser inner width/height: 1024/689 13:45:12 INFO - PROCESS | 4066 | __metrics 13:45:12 INFO - PROCESS | 4066 | 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" 13:45:12 INFO - PROCESS | 4066 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:45:13 INFO - TEST-INFO | 4066: exit 0 13:45:13 INFO - Browser initialized. 13:45:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:45:13 INFO - TEST-INFO | started process 4069 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpGZ3ao4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:25 INFO - PROCESS | 4069 | RSS: Main: 164896768 13:45:25 INFO - PROCESS | 4069 | 13:48:28 INFO - PROCESS | 4069 | Cycle 1(1): loaded http://localhost:65387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:65387/tests/dromaeo/cssquery-ext.html) 13:48:31 INFO - PROCESS | 4069 | RSS: Main: 383877120 13:48:31 INFO - PROCESS | 4069 | 13:51:34 INFO - PROCESS | 4069 | Cycle 1(1): loaded http://localhost:65387/tests/dromaeo/cssquery-ext.html (next: http://localhost:65387/tests/dromaeo/cssquery-jquery.html) 13:51:35 INFO - PROCESS | 4069 | RSS: Main: 302477312 13:51:35 INFO - PROCESS | 4069 | 13:54:37 INFO - PROCESS | 4069 | Cycle 1(1): loaded http://localhost:65387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:65387/tests/dromaeo/cssquery-mootools.html) 13:54:38 INFO - PROCESS | 4069 | RSS: Main: 291246080 13:54:38 INFO - PROCESS | 4069 | 13:57:40 INFO - PROCESS | 4069 | Cycle 1(1): loaded http://localhost:65387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:65387/tests/dromaeo/cssquery-prototype.html) 13:57:41 INFO - PROCESS | 4069 | RSS: Main: 292634624 13:57:41 INFO - PROCESS | 4069 | 14:00:45 INFO - PROCESS | 4069 | Cycle 1(1): loaded http://localhost:65387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:65387/tests/dromaeo/cssquery-yui.html) 14:00:45 INFO - PROCESS | 4069 | RSS: Main: 265818112 14:00:45 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | Cycle 1(1): loaded http://localhost:65387/tests/dromaeo/cssquery-yui.html (next: http://localhost:65387/tests/dromaeo/cssquery-dojo.html) 14:03:49 INFO - PROCESS | 4069 | RSS: Main: 387837952 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | __start_tp_report 14:03:49 INFO - PROCESS | 4069 | _x_x_mozilla_page_load 14:03:49 INFO - PROCESS | 4069 | _x_x_mozilla_page_load_details 14:03:49 INFO - PROCESS | 4069 | |i|pagename|runs| 14:03:49 INFO - PROCESS | 4069 | |0;dojo.html;2948.2039849240705;3511.4908338290966;3538.91152721182;3547.8048707321104;3550.8224588770554;6141.477974372184;6149.538784591156;6173.166622505961;6174.320824709284;6189.566730328873;6119.847003824907;6147.907781383272;6199.597026193294;6202.81391558254;6208.317085120644;5524.696141712204;5557.305336832896;5583.302087239095;5643.68959707216;5721.885562288751;4465.933011004838;5404.945950540503;5418.078926582471;5719.113537401709;5726.656400615976;5485.890282194354;5551.306086739158;5564.666120032811;5571.888562228753;5574.944250557483;5609.775608975636;5614.017546929271;5618.550515958714;5639.2668953036045;5644.266245388073;5342.652727572734;5389.784408623689;5476.507114359727;5568.916466252969;5579.302587176603;6108.888502348208;6153.353897840751;6180.320164781915;6221.284552276501;6269.996800511896;6596.571222870498;6604.1084453599115;6607.867842643121;6608.0418339341;6608.867822643569;6628.5691430056895;6697.966510167466;6704.93295067048;6708;6717.193936727624;6099.237595300588;6152.169457123276;6159.23009623797;6241.032639940726;6255.74977000924;6759.966200168968;6770.898436523456;6776.390124888783;6811.182658081062;6823.69293381799;6377.266614339317;6437;6445.774397896051;6448.258450278185;6450.774222902176;6278.15244941927;6325.683715814191;6502.577332473469;6643.70103345341;6647.767328143492;6236.314005459396;6469.320721324288;6472.061551075068;6513.934860651428;6514.511411644051;6343.27052388972;6349.746010159542;6397.872042559123;6421.4541763949655;6442.903356449657;5215.478452154754;5253.711045892513;5261.4738526147075;5266.868328291824;5281.630285880028;4599.103174880933;4733.100710864925;4739.028499157665;4746.833860814855;4757.738324392191;5978.252718410199;5988.850278743066;6172.598781079216;6178.196834411498;6255.56211065221;6665.900011499832;6667.299933507009;6680.86638267232;6682.298358672367;6683.298253683391;6236.438720515084;6248.625082495065;6262.874742505215;6274.686265686697;6276.246850377984;4783.258594917794;5631.267935168402;5731.656100633975;5823.330317013598;5869.530437564985;6797.797952674861;6827.761028363983;6874.175098988154;6876.106106206161;6876.449884009267;6639.302873198245;6640.933590664032;6642.900356494753;6646.136002319861;6646.936490161551;6533.869322613426;6804.489663275175;6818;6866.725330986905;6869.347411995853;6356.682165891594;6363.490920726424;6376.713047912763;6381.553291269753;6386.521010924293;6422.036694495676;6475.579087359495;6534.673266336569;6560.639164845979;6649.667516624246;6359.872802544016;6423.839404014937;6428.035794630656;6431.646259455775;6437.227532696106;6387.457066149429;6405.327440618668;6419.325970773001;6422.743090276336;6441.967790161019;6194.659293738888;6220.720067596879;6247.937850565324;6271.96864015677;6326.398992095744;6209.627422354673;6227.813165605039;6240.906386404298;6279.874402511833;6429.292777794345;6264.31092579825;6275.96862015687;6282.937170628235;6283.057541368648;6291.402316779899 14:03:49 INFO - PROCESS | 4069 | |1;ext.html;816.3510009542413;824.8638974569194;912.9041450647682;921.6405601815293;991.8773824016611;39534.60465395345;40142.598574014286;40288.79855600721;41840.37239441403;41953.58046419535;40131.79604611867;40220.79889600548;40328.58849940245;40412;40557.797211013974;7925;8053.879191812128;8198.95900520498;8344.707935222268;11845.881541184606;10509.894901050968;11620.941895290513;11875.821862672066;12039.21745086571;12059.095567832404;11939;11980.580679676214;12038.217515861441;12054;12091.697707557294;11956.983656389217;11971.700707482383;11973.341466219354;11975.161738678296;11986.041116710643;11555.017823485014;11654.359010254433;11654.883451165464;11656.475458604384;11661.0088142508;41346;41599.58400416018;41627.167456651;41680.374794378105;41780;4035.152617950234;4063.410805433225;4070.206309769596;4084.305668036441;4085.7957102144774;28850.711492885013;29543.261418464495;30891.38217235665;31035.84482077575;31062.757489700383;3247.9512807307674;3258.6904244096772;3260.2990357073345;3299.670032996681;3409.556757621518;357334;357700;358032;358423;358932;41068.1786364271;43600.3459948101;44338.669839904855;47405.76297118561;47406.05187896292;47607.76196119066;47721.28418073732;47803.28295075577;55436;56434.43565564374;15640.921795391178;15767.211639417983;15843;15866.761998570031;15890.76163857543;13494.865051349558;13505.987050971216;13522.661933451742;13526.25605591702;13530.594082177551;12711;12751.744965100832;12769.425375858109;12813.679658008625;12878.80681789774;5642.605017648725;5665.263515742927;5683.516901063374;5688.345840228344;5696.857578560569;956.2827879090682;969.8205831921117;998.3161534348849;1001.3441196016475;1006.4917216805467;23126.99845859936;28694.713052869203;29115.7088429113;29344.706552934626;29347.972820951163;1092.983605245922;1098.8571485706807;1105.950232239551;1115.5816568786704;1128.9322640641587;14499.92750036243;14923.179225142505;14964.17697026674;15177.468788592347;15240.3903843845;448568;448818;448889;448967;449172.75413623377;58609.12086318708;58625;58681.70659146677;58931.70534147302;59342.406575934554;1466.0690461556776;1466.3987765016293;1506.374854435397;1510.765831296151;1512.750396184617;22349.888250558644;26671.33321666974;27813.582796257666;27948.72051279461;29087.83648654115;43232.91917702083;43311.783441083855;43425.56574434342;43426.56573434225;43510.34734479048;487708;487844;489099;490200;490524;25616.871915640302;25661;26203.73796262013;26578.734212657626;30438.086857394315;32532.67467325391;32707.836460817543;35590.466143008394;38710;40068.1986360277;26595.606395424504;29253;29362;29624.555631665113;29819.403611928075;29514.553404122424;29603.407931841673;29682.55476167816;29689.406211876074;29717;31578.36843263076;32707.836460817543;32761.34477310488;33209;33334.49998250077;28134.577981330705;28218.717812821607;28510.287242819097;28577.714222857507;29499.41001180007;22290.66564001509;23828.285151445485;24253.787310634045;24706.752932471165;25250.87374563189 14:03:49 INFO - PROCESS | 4069 | |2;jquery.html;394.2430533375918;415.756782282365;423.5404586024164;431.6352681983723;442.2857085806423;19726.309579164732;21928.45178870529;22377;22922.885385573092;23236;23474.413139671517;24381;24401.389965250877;24469.87765061177;24716.75283247167;6809.4892883033845;6851.623160726158;6945.097137372135;7171.067761191064;7188.137423509186;6936.618485983269;7050.365467107959;7052.224255331909;7060.152781666207;7097.574145551258;6682.097916781221;6916.23921368649;6993.965030174867;7009.369156775889;7052.153741551021;6952.513324067318;6969.860602787941;6979.720811167547;6988.860222795541;7061.823454413655;6796.218434880003;6841.62371069591;6854.931450685479;6858.794236172923;6866.8626627467675;28153.85923070392;28417;28567.57148642772;28623;28958.85520572405;3499.930001399983;3511.10466830959;3513.841877115536;3565.27256648664;3565.8038807865555;15802.972806767524;16383.672326553402;16614.501564953072;17643.647127057386;18092.90953545237;2047.1708957871938;2092.7697953225133;2094.1414020251623;2114.291712276374;2122.342073957063;118652.40673796662;127532.72467275395;135255.32372338074;159144;180673;20391.592168156552;20487.8975605121;20722.689159662317;20784;20871.269505567234;26037.73962260391;32799.01602951915;32871.3425731484;32883.50674739881;32885.342293154004;9323.627054917728;10699.6090508235;10801.729956751144;10921.672349829518;11116.388598627153;9040.321975851837;9063;9086.81826363469;9255.95372023149;9287.349885508085;8158.510489370538;9185.494797786052;9234.81530369389;9527.809443811086;9560.56977436017;3197.344544368399;3871.7483363581277;3887.378019516864;3894.8315505348282;3919.392494163409;1006.2402885821158;1015.8413371585381;1031.9380837149795;1046.1160319529986;1046.40877903984;20796.1681532737;21159.471013224793;21273.723576585144;21326.36020919375;21369.252076177258;1012.8379459286479;1018.3889666200221;1046.4140081554353;1060.4644654449453;1060.7295139739317;9994.700158995242;10882.945585272182;11165.609203677832;11188.832167517494;11205.271657342246;752549;755723;758024;764433;779805;153884;155674;156138.4386156124;156426;162358;1300.206873806977;1319.3139567425078;1349.5344106283317;1357.877790998795;1361.7821148616174;14745.557633271019;18554.81445185531;18743.65704286964;18808.52978675544;18875.716864246773;55428;57589.71205143948;59279;60374;60556;82868;83499.58250208953;84810.57594711987;88679.55660221657;90343.54828225817;11589.130815188726;12032.75934481323;12076.637700868989;12269.82825839219;12278.81581776292;13729.931350343184;13780.517681881087;14148.504802331869;14180.936429767602;14227.786583201467;11606.825897611712;11747.843873016447;11945.104117191418;12047.879521204675;12097.395130243629;11199.888001119885;11216.439178041228;11348.319100853974;11551.711207219887;11573.479193436147;11756.118291128028;12030.518779248732;12117.394130293274;12165;12248.142630015813;11932.463039163085;11971.324014637783;12230.571929982409;12347.876521234673;12367.876321236672;11524.769504610029;11645;11729.941350293195;11806.940965295118;12065.638030859089 14:03:49 INFO - PROCESS | 4069 | |3;mootools.html;1415.419677932048;1612.2426555054994;1637.1323198704683;1644.0628841560308;1661.235831517502;8875.24560412365;9262.490563019031;11293.435328233576;11449.82453333866;11620.825687614693;11456.083513318936;11564.132690048238;11591.130665200102;11594.130440216997;11622.476988535514;2447.1312683997194;2487.7139129000125;2490.5018996200743;2493.5137648158616;2493.7381574934643;2102.7161333219974;2181.7054697615777;2442.4992876460283;2511.234073607549;2521.319243804172;2417.6615273861676;2442.120836498859;2465.0386349323776;2467.494163696438;2468.5062987402503;2445.9877700611473;2450.228178123903;2452.1540068676277;2453.3130723397476;2457.2505385857216;2369.8104151667826;2381.666566680666;2393.198278576679;2403.3871362802547;2404.1345115758486;11552.6534203974;11646.8935451132;11677.532898684043;11677.941610291979;11694.356810375426;5814.418558144194;6006.039033754622;6006.948783962833;6008.459238668541;6013.128096425994;3447.517347571342;3519.8064106474135;3641.908952276188;3724.1062145085257;3736.8042226487537;1113.209621168971;1151.5681619392728;1221.1696046688248;1255.1276862580419;1273.045216087934;15923.283452244677;16089.758653620205;16100.597485062966;16120.032798032156;16127;4789.389782568509;4946.851594452172;4974.950250497449;5002.499750025041;5068.265101560253;13168.407421666048;13169.868301317056;13171.407286672124;13178.143420677625;13197.406116724578;5930.495907847881;6061.212042434456;6064.090386442069;6074.271087469532;6083.330833608299;4621.2837010263465;5108;5377.865553361197;5394.541463975527;5493;3681.9447708284397;4050.959490405058;4158.875233742992;4176.686748493875;4202;1103.685449646863;1120.1039168665036;1121.5233525751523;1131.179894576442;1137.2096393006946;847.4872702015315;919.9310051746146;962.841131213356;968.5205823117461;1012.2610494339174;6581.473482121419;6631.469482441393;6777.085093512412;6918.7232510699005;7027.297270273034;1017.5703137092397;1036.3729943384294;1050.4117694091333;1094.698957786615;1097.0620119797618;4406.2949928012;4439.622632076245;4480.977595112069;4613.746243956614;4630.282306242538;13639.795403068962;14159.575212743634;14198.361073751706;14219.64450888736;14224.786628200585;13372.866271337161;13831.239281839395;14121.576352709435;14177.432902683984;14215.50245741394;10318.896811031944;10596.364218146937;10624.840627390595;10635.52140153695;10636;6769.153855768029;7007.299270073156;7111.040009598638;7200.459965502713;7224.855502890018;10510;10565.577376904837;12680.492780288685;12941.805872912102;13001.15492492985;12991.155574887602;13097.41061652209;13122.60632181036;13237.80143297832;13242.337883105998;9038.774030649287;9138.406003609743;9266;9347.859782103409;9351.625934962798;9049.457032578066;9318.627254909728;9442;9466.432014079177;9857.753556161153;7784.571848548384;8536.615852286537;8698;8788.956055219684;9023.864642030243;8705.303575714055;8774.868376974478;8857;8865.51239681798;8949;7760.456768026184;7935.2064793520185;8140.145284745016;8273.544955027532;8280.544570048705;5788.392218817132;5965.850853728692;5990.490808281171;6017.759289628366;6074.757009719562;5720.971395142998;6036.939630603638;6126.172966649446;6179.598326108789;6361.395667411589 14:03:49 INFO - PROCESS | 4069 | |4;prototype.html;363.70721569136845;380.3552977702795;397.73948064018043;398.78465628560576;403.44526276369993;4464.910701785962;5097.031564002837;5250.65870718403;5377.300950876385;5409.051392483484;4429.468463784342;4707.482176960531;5021.59827213822;5171.276021357013;5284.39229488608;3430.0738800523845;3731.2537492501474;4326.490635431443;4431.49037860647;4527.4114365132655;4026.3960405939197;4188.874333769992;4407.80164892579;4568.70303430276;4573.405457290548;3570.7500474966632;4010.5989401059805;4252.553481884404;4266.722663026893;4299.054208074219;3737.7291720815056;3984.5019372578427;4132.152908653718;4214.325707886724;4319.308910574293;3765.585785563586;3940.5862384449506;3952.7233093683453;3982.900427489336;4008.2785098682225;4372.475302963633;4876.317315575822;5106.923396149061;5171.3535808024;5248.737563121828;4641.466231383401;4752.6910750801435;4851.708897466164;5004.924926126111;5013.974930125326;5309.4516230539175;5569.415211402785;5578.41426650204;5592.384837667853;5604.719764011783;3750.5311836020496;4032.8790136295956;4255.55316691746;4569.862904112882;4582.381378513925;5629.71851407432;5743.368229494752;5791.536677065867;5835.212246346774;5878.764849406019;3985.980070099631;4324.243257429937;4560.863174104782;4647.767611619405;4717.599004084623;4295.763732994653;4664.533546645308;4767.785449654774;4778.928316075262;4811.518848115161;4679.251319788817;4729.456112547101;4780.82472475023;4976.477469865685;5049.798008079709;4761.857144285677;4826.95173048265;5226.973865130726;5351.973240133774;5678.977783998837;1351.8175046368615;1502.684436268374;1508.7963124978207;1583.2900467495078;1585.5798213473438;1062.7077553672802;1135.5238190352509;1187.6615164678026;1188.3404710385646;1192.868784433729;4811.728024943072;5248.3701955765555;5275.736213189325;5279.52484276417;5337.866553336197;4862.586680132157;5184.715474757971;5719.4852463277675;5758.712064396764;5759.568032397587;4792.688475249098;5008.04686172393;5157.381114266237;5162.793488260428;5193;2684.503366877134;2696.463016080815;2884.624998750149;2972.2420782700706;3003.4593773121046;5374.044275648456;5440.537554307928;5975.820725378246;5985.982382994901;6015.969920150459;5710.885782284414;5820.462937229547;5846.356900740915;5883.235179426647;5914.6746928918465;5002.499750024968;5369.677819330853;5833.708314584339;5943.8288688840985;5947.345791962881;5156.61325400589;5200.45395233495;5468.851541176397;5670.731707317106;5757.884842303047;4787.760611969457;4888.388951381077;5585.045234168008;5597.6641401516035;5662.122371032497;5105.948940510547;5120.25756265332;5230.9799589081285;5641.26663533738;5752.827415177551;4383;4419.779011049499;4538.704984176018;4580.152671755736;4656.790444429941;4623.930641040454;4774.928376074292;5625.677965677981;5739.339975902658;5791.7683292667825;5453.64551304164;5474.726263686879;5600;5603.851210501756;5750.654960702372;5084.440711521804;5127.512886275797;5222.97388513055;5598.832035038955;5622.072358060874;4836.975815120902;4995.15082435994;5133.820316288912;5376.817100237941;5548.805791797429;4904.681195722266;5258.789648414021;5400.702961337164;5580.135079062752;5644.85887852807;5052.317937078595;5331.720991590067;5565.66424058215;5569.245687608391;5585.369509818651 14:03:49 INFO - PROCESS | 4069 | |5;yui.html;811.8213992921555;820.8481430935277;824.7855557555034;846.5809424334955;904.8101746203739;16276.837231627695;18142.818571814278;18154.63690726186;18163.909180454095;18264.995425251607;16346.937449065832;16380.508584742447;16477.752833707473;16503.917480412612;16602.916985415057;992.6376872441543;992.6724181020282;993.8459538771502;995.2088089968456;995.960161593539;979.9020097990215;987.0820137272334;988.5502096546054;1001.6794625719773;1039.080413833755;1059.4755595979962;1069.385103565449;1075.2688172043008;1076.4886678827572;1077.219016213247;1068.3056013591229;1070.7911957168355;1070.8929107089307;1071.7052810477103;1074.1299547366657;796.4385108498494;797.310326567515;798.0383637716595;798.2097723253995;799.4204201953595;17226.052567108803;17484.388046418313;17485.562860928578;17962.19170137347;18223.544411389823;12409;12485.75028499434;14244.92877535616;15145.394184232617;15501.147436890966;10683.893161068367;11664.35846028468;11972.58095966637;12007.3395963222;12124.151309408346;3726.2920045191327;3819.9618003819883;3885.572587015426;3933.0953880607335;3933.8623148189963;108085.45957270241;113353.43323283413;113739;114960;115402.42298788452;10597.84103238452;10720.46397680113;11166.497507612177;11254.212205145725;11271.887281127249;24494.02023919023;24503.142390016263;24518.774061296863;24558.01767929263;24578.016879324627;7946.880796788053;8045.597720113971;8063.435559510778;8066.83866322682;8255.628496717662;4260.914781704349;4400.22995975703;4632.374629424984;4650.581447669726;4863.635227357962;3379.4086034943784;3462.8095454749728;3472.6874581287807;3474.530938323294;3474.6872781449283;588.3263663105805;600.2916558460971;626.2047200055904;629.6473974574253;630.1083966187884;690.7962151165418;698.7449580903035;705.8976448415053;741.8775901976113;749.6439191384048;10553.419561924167;10583.94708026455;10736.550565673535;10893.128549716004;10980.725481862857;680.4454369688688;687.9036934829128;692.7921623512926;732.6666366803091;748.4835463530147;5073.797048118107;5174.223866419992;5196.220566914917;5196.220566914993;5244.396894357198;95752.52123739336;96022.51988740012;97064.05871882522;113827.50823184049;119008;63409.048864267075;82706.58646706727;83339.5833020831;102455.97544024464;105807;70742;73169;80374.598127009;80600;82771;11243.60647377338;11260.83108753353;11276.830847537458;11367.317960922372;11465;48037.31869384555;48924.2661360087;52937.67655808636;53933;55236;68666.31333686599;70556.29443705497;72615.27384726085;74001.25998739943;74478.62760686161;13309.600711978655;13535.323233838466;13622.591322260349;14094.647633809236;14395.28023598795;15519.767203492183;15598.844011560193;15855.841441585899;15940.583194501196;16004.119773412574;11471.770564588494;14469.782953255499;14495.565133046026;14647;15031.624209394853;14037.298135093;14548.41806327735;14683.706325873636;14748.705025899208;14841.109533428029;14100.576982690536;14306.213158275978;14331.211783351599;14373.353199105855;14708.852911470749;10036.297459177787;10234.232432567736;10692.89307106919;10819.15919848474;10913.447139862425;11369.829452558053;11436.284557316469;11651.766964660828;11674.533018679158;11679.941600291944 14:03:49 INFO - PROCESS | 4069 | __end_tp_report 14:03:49 INFO - PROCESS | 4069 | __start_cc_report 14:03:49 INFO - PROCESS | 4069 | _x_x_mozilla_cycle_collect,2764 14:03:49 INFO - PROCESS | 4069 | __end_cc_report 14:03:49 INFO - PROCESS | 4069 | __startTimestamp1493154229522__endTimestamp 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | ------- Summary: start ------- 14:03:49 INFO - PROCESS | 4069 | Number of tests: 6 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | [#0] dojo.html Cycles:165 Average:6089.72 Median:6274.69 stddev:701.68 (11.2%) stddev-sans-first:659.13 14:03:49 INFO - PROCESS | 4069 | Values: 2948.2 3511.5 3538.9 3547.8 3550.8 6141.5 6149.5 6173.2 6174.3 6189.6 6119.8 6147.9 6199.6 6202.8 6208.3 5524.7 5557.3 5583.3 5643.7 5721.9 4465.9 5404.9 5418.1 5719.1 5726.7 5485.9 5551.3 5564.7 5571.9 5574.9 5609.8 5614.0 5618.6 5639.3 5644.3 5342.7 5389.8 5476.5 5568.9 5579.3 6108.9 6153.4 6180.3 6221.3 6270.0 6596.6 6604.1 6607.9 6608.0 6608.9 6628.6 6698.0 6704.9 6708.0 6717.2 6099.2 6152.2 6159.2 6241.0 6255.7 6760.0 6770.9 6776.4 6811.2 6823.7 6377.3 6437.0 6445.8 6448.3 6450.8 6278.2 6325.7 6502.6 6643.7 6647.8 6236.3 6469.3 6472.1 6513.9 6514.5 6343.3 6349.7 6397.9 6421.5 6442.9 5215.5 5253.7 5261.5 5266.9 5281.6 4599.1 4733.1 4739.0 4746.8 4757.7 5978.3 5988.9 6172.6 6178.2 6255.6 6665.9 6667.3 6680.9 6682.3 6683.3 6236.4 6248.6 6262.9 6274.7 6276.2 4783.3 5631.3 5731.7 5823.3 5869.5 6797.8 6827.8 6874.2 6876.1 6876.4 6639.3 6640.9 6642.9 6646.1 6646.9 6533.9 6804.5 6818.0 6866.7 6869.3 6356.7 6363.5 6376.7 6381.6 6386.5 6422.0 6475.6 6534.7 6560.6 6649.7 6359.9 6423.8 6428.0 6431.6 6437.2 6387.5 6405.3 6419.3 6422.7 6442.0 6194.7 6220.7 6247.9 6272.0 6326.4 6209.6 6227.8 6240.9 6279.9 6429.3 6264.3 6276.0 6282.9 6283.1 6291.4 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | [#1] ext.html Cycles:180 Average:56643.48 Median:30963.61 stddev:115618.70 (373.4%) stddev-sans-first:115867.06 14:03:49 INFO - PROCESS | 4069 | Values: 816.4 824.9 912.9 921.6 991.9 39534.6 40142.6 40288.8 41840.4 41953.6 40131.8 40220.8 40328.6 40412.0 40557.8 7925.0 8053.9 8199.0 8344.7 11845.9 10509.9 11620.9 11875.8 12039.2 12059.1 11939.0 11980.6 12038.2 12054.0 12091.7 11957.0 11971.7 11973.3 11975.2 11986.0 11555.0 11654.4 11654.9 11656.5 11661.0 41346.0 41599.6 41627.2 41680.4 41780.0 4035.2 4063.4 4070.2 4084.3 4085.8 28850.7 29543.3 30891.4 31035.8 31062.8 3248.0 3258.7 3260.3 3299.7 3409.6 357334.0 357700.0 358032.0 358423.0 358932.0 41068.2 43600.3 44338.7 47405.8 47406.1 47607.8 47721.3 47803.3 55436.0 56434.4 15640.9 15767.2 15843.0 15866.8 15890.8 13494.9 13506.0 13522.7 13526.3 13530.6 12711.0 12751.7 12769.4 12813.7 12878.8 5642.6 5665.3 5683.5 5688.3 5696.9 956.3 969.8 998.3 1001.3 1006.5 23127.0 28694.7 29115.7 29344.7 29348.0 1093.0 1098.9 1106.0 1115.6 1128.9 14499.9 14923.2 14964.2 15177.5 15240.4 448568.0 448818.0 448889.0 448967.0 449172.8 58609.1 58625.0 58681.7 58931.7 59342.4 1466.1 1466.4 1506.4 1510.8 1512.8 22349.9 26671.3 27813.6 27948.7 29087.8 43232.9 43311.8 43425.6 43426.6 43510.3 487708.0 487844.0 489099.0 490200.0 490524.0 25616.9 25661.0 26203.7 26578.7 30438.1 32532.7 32707.8 35590.5 38710.0 40068.2 26595.6 29253.0 29362.0 29624.6 29819.4 29514.6 29603.4 29682.6 29689.4 29717.0 31578.4 32707.8 32761.3 33209.0 33334.5 28134.6 28218.7 28510.3 28577.7 29499.4 22290.7 23828.3 24253.8 24706.8 25250.9 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | [#2] jquery.html Cycles:180 Average:43446.09 Median:11698.03 stddev:126827.07 (1084.2%) stddev-sans-first:127141.65 14:03:49 INFO - PROCESS | 4069 | Values: 394.2 415.8 423.5 431.6 442.3 19726.3 21928.5 22377.0 22922.9 23236.0 23474.4 24381.0 24401.4 24469.9 24716.8 6809.5 6851.6 6945.1 7171.1 7188.1 6936.6 7050.4 7052.2 7060.2 7097.6 6682.1 6916.2 6994.0 7009.4 7052.2 6952.5 6969.9 6979.7 6988.9 7061.8 6796.2 6841.6 6854.9 6858.8 6866.9 28153.9 28417.0 28567.6 28623.0 28958.9 3499.9 3511.1 3513.8 3565.3 3565.8 15803.0 16383.7 16614.5 17643.6 18092.9 2047.2 2092.8 2094.1 2114.3 2122.3 118652.4 127532.7 135255.3 159144.0 180673.0 20391.6 20487.9 20722.7 20784.0 20871.3 26037.7 32799.0 32871.3 32883.5 32885.3 9323.6 10699.6 10801.7 10921.7 11116.4 9040.3 9063.0 9086.8 9256.0 9287.3 8158.5 9185.5 9234.8 9527.8 9560.6 3197.3 3871.7 3887.4 3894.8 3919.4 1006.2 1015.8 1031.9 1046.1 1046.4 20796.2 21159.5 21273.7 21326.4 21369.3 1012.8 1018.4 1046.4 1060.5 1060.7 9994.7 10882.9 11165.6 11188.8 11205.3 752549.0 755723.0 758024.0 764433.0 779805.0 153884.0 155674.0 156138.4 156426.0 162358.0 1300.2 1319.3 1349.5 1357.9 1361.8 14745.6 18554.8 18743.7 18808.5 18875.7 55428.0 57589.7 59279.0 60374.0 60556.0 82868.0 83499.6 84810.6 88679.6 90343.5 11589.1 12032.8 12076.6 12269.8 12278.8 13729.9 13780.5 14148.5 14180.9 14227.8 11606.8 11747.8 11945.1 12047.9 12097.4 11199.9 11216.4 11348.3 11551.7 11573.5 11756.1 12030.5 12117.4 12165.0 12248.1 11932.5 11971.3 12230.6 12347.9 12367.9 11524.8 11645.0 11729.9 11806.9 12065.6 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | [#3] mootools.html Cycles:180 Average:6918.61 Median:2493.63 stddev:4362.11 (174.9%) stddev-sans-first:4354.74 14:03:49 INFO - PROCESS | 4069 | Values: 1415.4 1612.2 1637.1 1644.1 1661.2 8875.2 9262.5 11293.4 11449.8 11620.8 11456.1 11564.1 11591.1 11594.1 11622.5 2447.1 2487.7 2490.5 2493.5 2493.7 2102.7 2181.7 2442.5 2511.2 2521.3 2417.7 2442.1 2465.0 2467.5 2468.5 2446.0 2450.2 2452.2 2453.3 2457.3 2369.8 2381.7 2393.2 2403.4 2404.1 11552.7 11646.9 11677.5 11677.9 11694.4 5814.4 6006.0 6006.9 6008.5 6013.1 3447.5 3519.8 3641.9 3724.1 3736.8 1113.2 1151.6 1221.2 1255.1 1273.0 15923.3 16089.8 16100.6 16120.0 16127.0 4789.4 4946.9 4975.0 5002.5 5068.3 13168.4 13169.9 13171.4 13178.1 13197.4 5930.5 6061.2 6064.1 6074.3 6083.3 4621.3 5108.0 5377.9 5394.5 5493.0 3681.9 4051.0 4158.9 4176.7 4202.0 1103.7 1120.1 1121.5 1131.2 1137.2 847.5 919.9 962.8 968.5 1012.3 6581.5 6631.5 6777.1 6918.7 7027.3 1017.6 1036.4 1050.4 1094.7 1097.1 4406.3 4439.6 4481.0 4613.7 4630.3 13639.8 14159.6 14198.4 14219.6 14224.8 13372.9 13831.2 14121.6 14177.4 14215.5 10318.9 10596.4 10624.8 10635.5 10636.0 6769.2 7007.3 7111.0 7200.5 7224.9 10510.0 10565.6 12680.5 12941.8 13001.2 12991.2 13097.4 13122.6 13237.8 13242.3 9038.8 9138.4 9266.0 9347.9 9351.6 9049.5 9318.6 9442.0 9466.4 9857.8 7784.6 8536.6 8698.0 8789.0 9023.9 8705.3 8774.9 8857.0 8865.5 8949.0 7760.5 7935.2 8140.1 8273.5 8280.5 5788.4 5965.9 5990.5 6017.8 6074.8 5721.0 6036.9 6126.2 6179.6 6361.4 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | [#4] prototype.html Cycles:180 Average:4630.18 Median:5006.49 stddev:1292.30 (25.8%) stddev-sans-first:1255.63 14:03:49 INFO - PROCESS | 4069 | Values: 363.7 380.4 397.7 398.8 403.4 4464.9 5097.0 5250.7 5377.3 5409.1 4429.5 4707.5 5021.6 5171.3 5284.4 3430.1 3731.3 4326.5 4431.5 4527.4 4026.4 4188.9 4407.8 4568.7 4573.4 3570.8 4010.6 4252.6 4266.7 4299.1 3737.7 3984.5 4132.2 4214.3 4319.3 3765.6 3940.6 3952.7 3982.9 4008.3 4372.5 4876.3 5106.9 5171.4 5248.7 4641.5 4752.7 4851.7 5004.9 5014.0 5309.5 5569.4 5578.4 5592.4 5604.7 3750.5 4032.9 4255.6 4569.9 4582.4 5629.7 5743.4 5791.5 5835.2 5878.8 3986.0 4324.2 4560.9 4647.8 4717.6 4295.8 4664.5 4767.8 4778.9 4811.5 4679.3 4729.5 4780.8 4976.5 5049.8 4761.9 4827.0 5227.0 5352.0 5679.0 1351.8 1502.7 1508.8 1583.3 1585.6 1062.7 1135.5 1187.7 1188.3 1192.9 4811.7 5248.4 5275.7 5279.5 5337.9 4862.6 5184.7 5719.5 5758.7 5759.6 4792.7 5008.0 5157.4 5162.8 5193.0 2684.5 2696.5 2884.6 2972.2 3003.5 5374.0 5440.5 5975.8 5986.0 6016.0 5710.9 5820.5 5846.4 5883.2 5914.7 5002.5 5369.7 5833.7 5943.8 5947.3 5156.6 5200.5 5468.9 5670.7 5757.9 4787.8 4888.4 5585.0 5597.7 5662.1 5105.9 5120.3 5231.0 5641.3 5752.8 4383.0 4419.8 4538.7 4580.2 4656.8 4623.9 4774.9 5625.7 5739.3 5791.8 5453.6 5474.7 5600.0 5603.9 5750.7 5084.4 5127.5 5223.0 5598.8 5622.1 4837.0 4995.2 5133.8 5376.8 5548.8 4904.7 5258.8 5400.7 5580.1 5644.9 5052.3 5331.7 5565.7 5569.2 5585.4 14:03:49 INFO - PROCESS | 4069 | 14:03:49 INFO - PROCESS | 4069 | [#5] yui.html Cycles:180 Average:21365.73 Median:18052.51 stddev:30280.52 (167.7%) stddev-sans-first:30326.13 14:03:49 INFO - PROCESS | 4069 | Values: 811.8 820.8 824.8 846.6 904.8 16276.8 18142.8 18154.6 18163.9 18265.0 16346.9 16380.5 16477.8 16503.9 16602.9 992.6 992.7 993.8 995.2 996.0 979.9 987.1 988.6 1001.7 1039.1 1059.5 1069.4 1075.3 1076.5 1077.2 1068.3 1070.8 1070.9 1071.7 1074.1 796.4 797.3 798.0 798.2 799.4 17226.1 17484.4 17485.6 17962.2 18223.5 12409.0 12485.8 14244.9 15145.4 15501.1 10683.9 11664.4 11972.6 12007.3 12124.2 3726.3 3820.0 3885.6 3933.1 3933.9 108085.5 113353.4 113739.0 114960.0 115402.4 10597.8 10720.5 11166.5 11254.2 11271.9 24494.0 24503.1 24518.8 24558.0 24578.0 7946.9 8045.6 8063.4 8066.8 8255.6 4260.9 4400.2 4632.4 4650.6 4863.6 3379.4 3462.8 3472.7 3474.5 3474.7 588.3 600.3 626.2 629.6 630.1 690.8 698.7 705.9 741.9 749.6 10553.4 10583.9 10736.6 10893.1 10980.7 680.4 687.9 692.8 732.7 748.5 5073.8 5174.2 5196.2 5196.2 5244.4 95752.5 96022.5 97064.1 113827.5 119008.0 63409.0 82706.6 83339.6 102456.0 105807.0 70742.0 73169.0 80374.6 80600.0 82771.0 11243.6 11260.8 11276.8 11367.3 11465.0 48037.3 48924.3 52937.7 53933.0 55236.0 68666.3 70556.3 72615.3 74001.3 74478.6 13309.6 13535.3 13622.6 14094.6 14395.3 15519.8 15598.8 15855.8 15940.6 16004.1 11471.8 14469.8 14495.6 14647.0 15031.6 14037.3 14548.4 14683.7 14748.7 14841.1 14100.6 14306.2 14331.2 14373.4 14708.9 10036.3 10234.2 10692.9 10819.2 10913.4 11369.8 11436.3 11651.8 11674.5 11679.9 14:03:49 INFO - PROCESS | 4069 | -------- Summary: end -------- 14:03:49 INFO - PROCESS | 4069 | 14:03:50 INFO - TEST-INFO | 4069: exit 0 14:03:50 INFO - TEST-OK | dromaeo_css | took 1119937ms 14:03:50 INFO - TEST-START | kraken 14:03:50 INFO - operating with platform_type : mac_ 14:03:50 INFO - Initialising browser for kraken test... 14:03:50 INFO - TEST-INFO | started process 4071 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmppC74X3/profile http://localhost:65387/getInfo.html) 14:03:52 INFO - PROCESS | 4071 | __metrics Screen width/height:1600/1200 14:03:52 INFO - PROCESS | 4071 | colorDepth:24 14:03:52 INFO - PROCESS | 4071 | Browser inner width/height: 1024/689 14:03:52 INFO - PROCESS | 4071 | __metrics 14:03:52 INFO - PROCESS | 4071 | 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" 14:03:52 INFO - PROCESS | 4071 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:53 INFO - TEST-INFO | 4071: exit 0 14:03:53 INFO - Browser initialized. 14:03:53 INFO - Running cycle 1/1 for kraken test... 14:03:53 INFO - TEST-INFO | started process 4073 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmppC74X3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:05 INFO - PROCESS | 4073 | RSS: Main: 165330944 14:04:05 INFO - PROCESS | 4073 | 14:04:08 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:65387/tests/kraken/driver.html?testName=audio-beat-detection) 14:04:08 INFO - PROCESS | 4073 | RSS: Main: 215945216 14:04:08 INFO - PROCESS | 4073 | 14:04:11 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:65387/tests/kraken/driver.html?testName=audio-dft) 14:04:12 INFO - PROCESS | 4073 | RSS: Main: 231223296 14:04:12 INFO - PROCESS | 4073 | 14:04:15 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:65387/tests/kraken/driver.html?testName=audio-fft) 14:04:15 INFO - PROCESS | 4073 | RSS: Main: 328683520 14:04:15 INFO - PROCESS | 4073 | 14:04:17 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:65387/tests/kraken/driver.html?testName=audio-oscillator) 14:04:18 INFO - PROCESS | 4073 | RSS: Main: 229445632 14:04:18 INFO - PROCESS | 4073 | 14:04:20 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:65387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:04:21 INFO - PROCESS | 4073 | RSS: Main: 231796736 14:04:21 INFO - PROCESS | 4073 | 14:04:24 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:65387/tests/kraken/driver.html?testName=imaging-darkroom) 14:04:24 INFO - PROCESS | 4073 | RSS: Main: 272314368 14:04:24 INFO - PROCESS | 4073 | 14:04:27 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:65387/tests/kraken/driver.html?testName=imaging-desaturate) 14:04:28 INFO - PROCESS | 4073 | RSS: Main: 273702912 14:04:28 INFO - PROCESS | 4073 | 14:04:31 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:65387/tests/kraken/driver.html?testName=json-parse-financial) 14:04:31 INFO - PROCESS | 4073 | RSS: Main: 270385152 14:04:31 INFO - PROCESS | 4073 | 14:04:33 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:65387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:04:34 INFO - PROCESS | 4073 | RSS: Main: 247230464 14:04:34 INFO - PROCESS | 4073 | 14:04:35 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:36 INFO - PROCESS | 4073 | RSS: Main: 251551744 14:04:36 INFO - PROCESS | 4073 | 14:04:38 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:39 INFO - PROCESS | 4073 | RSS: Main: 255115264 14:04:39 INFO - PROCESS | 4073 | 14:04:42 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:42 INFO - PROCESS | 4073 | RSS: Main: 269606912 14:04:42 INFO - PROCESS | 4073 | 14:04:45 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:46 INFO - PROCESS | 4073 | RSS: Main: 263196672 14:04:46 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | Cycle 1(1): loaded http://localhost:65387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:65387/tests/kraken/driver.html?testName=ai-astar) 14:04:48 INFO - PROCESS | 4073 | RSS: Main: 308174848 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | __start_tp_report 14:04:48 INFO - PROCESS | 4073 | _x_x_mozilla_page_load 14:04:48 INFO - PROCESS | 4073 | _x_x_mozilla_page_load_details 14:04:48 INFO - PROCESS | 4073 | |i|pagename|runs| 14:04:48 INFO - PROCESS | 4073 | |0;ai-astar;105;114;116;115;115;117;115;116;115;116 14:04:48 INFO - PROCESS | 4073 | |1;audio-beat-detection;147;108;110;147;107;107;108;107;131;131 14:04:48 INFO - PROCESS | 4073 | |2;audio-dft;184;185;184;186;182;186;184;183;184;185 14:04:48 INFO - PROCESS | 4073 | |3;audio-fft;83;59;58;91;59;58;61;78;96;81 14:04:48 INFO - PROCESS | 4073 | |4;audio-oscillator;86;68;87;68;70;67;81;67;67;81 14:04:48 INFO - PROCESS | 4073 | |5;imaging-gaussian-blur;88;88;88;87;88;88;88;88;88;91 14:04:48 INFO - PROCESS | 4073 | |6;imaging-darkroom;96;107;149;100;95;96;96;95;95;95 14:04:48 INFO - PROCESS | 4073 | |7;imaging-desaturate;86;85;85;86;86;85;82;86;83;83 14:04:48 INFO - PROCESS | 4073 | |8;json-parse-financial;63;61;60;60;61;64;64;66;63;62 14:04:48 INFO - PROCESS | 4073 | |9;json-stringify-tinderbox;55;63;58;66;60;60;60;59;59;60 14:04:48 INFO - PROCESS | 4073 | |10;stanford-crypto-aes;80;84;82;79;76;89;86;68;92;100 14:04:48 INFO - PROCESS | 4073 | |11;stanford-crypto-ccm;137;152;131;142;135;144;137;137;178;146 14:04:48 INFO - PROCESS | 4073 | |12;stanford-crypto-pbkdf2;160;160;160;161;166;156;156;160;164;162 14:04:48 INFO - PROCESS | 4073 | |13;stanford-crypto-sha256-iterative;64;63;65;62;64;63;62;65;62;62 14:04:48 INFO - PROCESS | 4073 | __end_tp_report 14:04:48 INFO - PROCESS | 4073 | __start_cc_report 14:04:48 INFO - PROCESS | 4073 | _x_x_mozilla_cycle_collect,2109 14:04:48 INFO - PROCESS | 4073 | __end_cc_report 14:04:48 INFO - PROCESS | 4073 | __startTimestamp1493154288255__endTimestamp 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | ------- Summary: start ------- 14:04:48 INFO - PROCESS | 4073 | Number of tests: 14 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.50 stddev:3.41 (2.9%) stddev-sans-first:0.88 14:04:48 INFO - PROCESS | 4073 | Values: 105.0 114.0 116.0 115.0 115.0 117.0 115.0 116.0 115.0 116.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:120.50 stddev:16.98 (14.1%) stddev-sans-first:15.01 14:04:48 INFO - PROCESS | 4073 | Values: 147.0 108.0 110.0 147.0 107.0 107.0 108.0 107.0 131.0 131.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.25 (0.7%) stddev-sans-first:1.32 14:04:48 INFO - PROCESS | 4073 | Values: 184.0 185.0 184.0 186.0 182.0 186.0 184.0 183.0 184.0 185.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#3] audio-fft Cycles:10 Average:72.40 Median:79.50 stddev:15.00 (18.9%) stddev-sans-first:15.41 14:04:48 INFO - PROCESS | 4073 | Values: 83.0 59.0 58.0 91.0 59.0 58.0 61.0 78.0 96.0 81.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:75.50 stddev:8.47 (11.2%) stddev-sans-first:7.83 14:04:48 INFO - PROCESS | 4073 | Values: 86.0 68.0 87.0 68.0 70.0 67.0 81.0 67.0 67.0 81.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 14:04:48 INFO - PROCESS | 4073 | Values: 88.0 88.0 88.0 87.0 88.0 88.0 88.0 88.0 88.0 91.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:95.00 stddev:16.80 (17.7%) stddev-sans-first:17.66 14:04:48 INFO - PROCESS | 4073 | Values: 96.0 107.0 149.0 100.0 95.0 96.0 96.0 95.0 95.0 95.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.51 14:04:48 INFO - PROCESS | 4073 | Values: 86.0 85.0 85.0 86.0 86.0 85.0 82.0 86.0 83.0 83.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.96 (3.1%) stddev-sans-first:2.06 14:04:48 INFO - PROCESS | 4073 | Values: 63.0 61.0 60.0 60.0 61.0 64.0 64.0 66.0 63.0 62.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:2.91 (4.8%) stddev-sans-first:2.46 14:04:48 INFO - PROCESS | 4073 | Values: 55.0 63.0 58.0 66.0 60.0 60.0 60.0 59.0 59.0 60.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:8.90 (10.7%) stddev-sans-first:9.34 14:04:48 INFO - PROCESS | 4073 | Values: 80.0 84.0 82.0 79.0 76.0 89.0 86.0 68.0 92.0 100.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:143.00 stddev:13.44 (9.4%) stddev-sans-first:14.02 14:04:48 INFO - PROCESS | 4073 | Values: 137.0 152.0 131.0 142.0 135.0 144.0 137.0 137.0 178.0 146.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:3.10 (1.9%) stddev-sans-first:3.28 14:04:48 INFO - PROCESS | 4073 | Values: 160.0 160.0 160.0 161.0 166.0 156.0 156.0 160.0 164.0 162.0 14:04:48 INFO - PROCESS | 4073 | 14:04:48 INFO - PROCESS | 4073 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.23 (1.9%) stddev-sans-first:1.27 14:04:48 INFO - PROCESS | 4073 | Values: 64.0 63.0 65.0 62.0 64.0 63.0 62.0 65.0 62.0 62.0 14:04:48 INFO - PROCESS | 4073 | -------- Summary: end -------- 14:04:48 INFO - PROCESS | 4073 | 14:04:49 INFO - TEST-INFO | 4073: exit 0 14:04:49 INFO - TEST-OK | kraken | took 58970ms 14:04:49 INFO - SUITE-END | took 1178s 14:04:49 INFO - Completed test suite (00:19:39) 14:04:49 INFO - javascript benchmark 14:04:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7921.224432417596, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2948.2039849240705, 3511.4908338290966, 3538.91152721182, 3547.8048707321104, 3550.8224588770554, 6141.477974372184, 6149.538784591156, 6173.166622505961, 6174.320824709284, 6189.566730328873, 6119.847003824907, 6147.907781383272, 6199.597026193294, 6202.81391558254, 6208.317085120644, 5524.696141712204, 5557.305336832896, 5583.302087239095, 5643.68959707216, 5721.885562288751, 4465.933011004838, 5404.945950540503, 5418.078926582471, 5719.113537401709, 5726.656400615976, 5485.890282194354, 5551.306086739158, 5564.666120032811, 5571.888562228753, 5574.944250557483, 5609.775608975636, 5614.017546929271, 5618.550515958714, 5639.2668953036045, 5644.266245388073, 5342.652727572734, 5389.784408623689, 5476.507114359727, 5568.916466252969, 5579.302587176603, 6108.888502348208, 6153.353897840751, 6180.320164781915, 6221.284552276501, 6269.996800511896, 6596.571222870498, 6604.1084453599115, 6607.867842643121, 6608.0418339341, 6608.867822643569, 6628.5691430056895, 6697.966510167466, 6704.93295067048, 6708.0, 6717.193936727624, 6099.237595300588, 6152.169457123276, 6159.23009623797, 6241.032639940726, 6255.74977000924, 6759.966200168968, 6770.898436523456, 6776.390124888783, 6811.182658081062, 6823.69293381799, 6377.266614339317, 6437.0, 6445.774397896051, 6448.258450278185, 6450.774222902176, 6278.15244941927, 6325.683715814191, 6502.577332473469, 6643.70103345341, 6647.767328143492, 6236.314005459396, 6469.320721324288, 6472.061551075068, 6513.934860651428, 6514.511411644051, 6343.27052388972, 6349.746010159542, 6397.872042559123, 6421.4541763949655, 6442.903356449657, 5215.478452154754, 5253.711045892513, 5261.4738526147075, 5266.868328291824, 5281.630285880028, 4599.103174880933, 4733.100710864925, 4739.028499157665, 4746.833860814855, 4757.738324392191, 5978.252718410199, 5988.850278743066, 6172.598781079216, 6178.196834411498, 6255.56211065221, 6665.900011499832, 6667.299933507009, 6680.86638267232, 6682.298358672367, 6683.298253683391, 6236.438720515084, 6248.625082495065, 6262.874742505215, 6274.686265686697, 6276.246850377984, 4783.258594917794, 5631.267935168402, 5731.656100633975, 5823.330317013598, 5869.530437564985, 6797.797952674861, 6827.761028363983, 6874.175098988154, 6876.106106206161, 6876.449884009267, 6639.302873198245, 6640.933590664032, 6642.900356494753, 6646.136002319861, 6646.936490161551, 6533.869322613426, 6804.489663275175, 6818.0, 6866.725330986905, 6869.347411995853, 6356.682165891594, 6363.490920726424, 6376.713047912763, 6381.553291269753, 6386.521010924293, 6422.036694495676, 6475.579087359495, 6534.673266336569, 6560.639164845979, 6649.667516624246, 6359.872802544016, 6423.839404014937, 6428.035794630656, 6431.646259455775, 6437.227532696106, 6387.457066149429, 6405.327440618668, 6419.325970773001, 6422.743090276336, 6441.967790161019, 6194.659293738888, 6220.720067596879, 6247.937850565324, 6271.96864015677, 6326.398992095744, 6209.627422354673, 6227.813165605039, 6240.906386404298, 6279.874402511833, 6429.292777794345, 6264.31092579825, 6275.96862015687, 6282.937170628235, 6283.057541368648, 6291.402316779899], "value": 6042.424514929278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.3510009542413, 824.8638974569194, 912.9041450647682, 921.6405601815293, 991.8773824016611, 39534.60465395345, 40142.598574014286, 40288.79855600721, 41840.37239441403, 41953.58046419535, 40131.79604611867, 40220.79889600548, 40328.58849940245, 40412.0, 40557.797211013974, 7925.0, 8053.879191812128, 8198.95900520498, 8344.707935222268, 11845.881541184606, 10509.894901050968, 11620.941895290513, 11875.821862672066, 12039.21745086571, 12059.095567832404, 11939.0, 11980.580679676214, 12038.217515861441, 12054.0, 12091.697707557294, 11956.983656389217, 11971.700707482383, 11973.341466219354, 11975.161738678296, 11986.041116710643, 11555.017823485014, 11654.359010254433, 11654.883451165464, 11656.475458604384, 11661.0088142508, 41346.0, 41599.58400416018, 41627.167456651, 41680.374794378105, 41780.0, 4035.152617950234, 4063.410805433225, 4070.206309769596, 4084.305668036441, 4085.7957102144774, 28850.711492885013, 29543.261418464495, 30891.38217235665, 31035.84482077575, 31062.757489700383, 3247.9512807307674, 3258.6904244096772, 3260.2990357073345, 3299.670032996681, 3409.556757621518, 357334.0, 357700.0, 358032.0, 358423.0, 358932.0, 41068.1786364271, 43600.3459948101, 44338.669839904855, 47405.76297118561, 47406.05187896292, 47607.76196119066, 47721.28418073732, 47803.28295075577, 55436.0, 56434.43565564374, 15640.921795391178, 15767.211639417983, 15843.0, 15866.761998570031, 15890.76163857543, 13494.865051349558, 13505.987050971216, 13522.661933451742, 13526.25605591702, 13530.594082177551, 12711.0, 12751.744965100832, 12769.425375858109, 12813.679658008625, 12878.80681789774, 5642.605017648725, 5665.263515742927, 5683.516901063374, 5688.345840228344, 5696.857578560569, 956.2827879090682, 969.8205831921117, 998.3161534348849, 1001.3441196016475, 1006.4917216805467, 23126.99845859936, 28694.713052869203, 29115.7088429113, 29344.706552934626, 29347.972820951163, 1092.983605245922, 1098.8571485706807, 1105.950232239551, 1115.5816568786704, 1128.9322640641587, 14499.92750036243, 14923.179225142505, 14964.17697026674, 15177.468788592347, 15240.3903843845, 448568.0, 448818.0, 448889.0, 448967.0, 449172.75413623377, 58609.12086318708, 58625.0, 58681.70659146677, 58931.70534147302, 59342.406575934554, 1466.0690461556776, 1466.3987765016293, 1506.374854435397, 1510.765831296151, 1512.750396184617, 22349.888250558644, 26671.33321666974, 27813.582796257666, 27948.72051279461, 29087.83648654115, 43232.91917702083, 43311.783441083855, 43425.56574434342, 43426.56573434225, 43510.34734479048, 487708.0, 487844.0, 489099.0, 490200.0, 490524.0, 25616.871915640302, 25661.0, 26203.73796262013, 26578.734212657626, 30438.086857394315, 32532.67467325391, 32707.836460817543, 35590.466143008394, 38710.0, 40068.1986360277, 26595.606395424504, 29253.0, 29362.0, 29624.555631665113, 29819.403611928075, 29514.553404122424, 29603.407931841673, 29682.55476167816, 29689.406211876074, 29717.0, 31578.36843263076, 32707.836460817543, 32761.34477310488, 33209.0, 33334.49998250077, 28134.577981330705, 28218.717812821607, 28510.287242819097, 28577.714222857507, 29499.41001180007, 22290.66564001509, 23828.285151445485, 24253.787310634045, 24706.752932471165, 25250.87374563189], "value": 18977.572806824857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.2430533375918, 415.756782282365, 423.5404586024164, 431.6352681983723, 442.2857085806423, 19726.309579164732, 21928.45178870529, 22377.0, 22922.885385573092, 23236.0, 23474.413139671517, 24381.0, 24401.389965250877, 24469.87765061177, 24716.75283247167, 6809.4892883033845, 6851.623160726158, 6945.097137372135, 7171.067761191064, 7188.137423509186, 6936.618485983269, 7050.365467107959, 7052.224255331909, 7060.152781666207, 7097.574145551258, 6682.097916781221, 6916.23921368649, 6993.965030174867, 7009.369156775889, 7052.153741551021, 6952.513324067318, 6969.860602787941, 6979.720811167547, 6988.860222795541, 7061.823454413655, 6796.218434880003, 6841.62371069591, 6854.931450685479, 6858.794236172923, 6866.8626627467675, 28153.85923070392, 28417.0, 28567.57148642772, 28623.0, 28958.85520572405, 3499.930001399983, 3511.10466830959, 3513.841877115536, 3565.27256648664, 3565.8038807865555, 15802.972806767524, 16383.672326553402, 16614.501564953072, 17643.647127057386, 18092.90953545237, 2047.1708957871938, 2092.7697953225133, 2094.1414020251623, 2114.291712276374, 2122.342073957063, 118652.40673796662, 127532.72467275395, 135255.32372338074, 159144.0, 180673.0, 20391.592168156552, 20487.8975605121, 20722.689159662317, 20784.0, 20871.269505567234, 26037.73962260391, 32799.01602951915, 32871.3425731484, 32883.50674739881, 32885.342293154004, 9323.627054917728, 10699.6090508235, 10801.729956751144, 10921.672349829518, 11116.388598627153, 9040.321975851837, 9063.0, 9086.81826363469, 9255.95372023149, 9287.349885508085, 8158.510489370538, 9185.494797786052, 9234.81530369389, 9527.809443811086, 9560.56977436017, 3197.344544368399, 3871.7483363581277, 3887.378019516864, 3894.8315505348282, 3919.392494163409, 1006.2402885821158, 1015.8413371585381, 1031.9380837149795, 1046.1160319529986, 1046.40877903984, 20796.1681532737, 21159.471013224793, 21273.723576585144, 21326.36020919375, 21369.252076177258, 1012.8379459286479, 1018.3889666200221, 1046.4140081554353, 1060.4644654449453, 1060.7295139739317, 9994.700158995242, 10882.945585272182, 11165.609203677832, 11188.832167517494, 11205.271657342246, 752549.0, 755723.0, 758024.0, 764433.0, 779805.0, 153884.0, 155674.0, 156138.4386156124, 156426.0, 162358.0, 1300.206873806977, 1319.3139567425078, 1349.5344106283317, 1357.877790998795, 1361.7821148616174, 14745.557633271019, 18554.81445185531, 18743.65704286964, 18808.52978675544, 18875.716864246773, 55428.0, 57589.71205143948, 59279.0, 60374.0, 60556.0, 82868.0, 83499.58250208953, 84810.57594711987, 88679.55660221657, 90343.54828225817, 11589.130815188726, 12032.75934481323, 12076.637700868989, 12269.82825839219, 12278.81581776292, 13729.931350343184, 13780.517681881087, 14148.504802331869, 14180.936429767602, 14227.786583201467, 11606.825897611712, 11747.843873016447, 11945.104117191418, 12047.879521204675, 12097.395130243629, 11199.888001119885, 11216.439178041228, 11348.319100853974, 11551.711207219887, 11573.479193436147, 11756.118291128028, 12030.518779248732, 12117.394130293274, 12165.0, 12248.142630015813, 11932.463039163085, 11971.324014637783, 12230.571929982409, 12347.876521234673, 12367.876321236672, 11524.769504610029, 11645.0, 11729.941350293195, 11806.940965295118, 12065.638030859089], "value": 11932.898251893672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.419677932048, 1612.2426555054994, 1637.1323198704683, 1644.0628841560308, 1661.235831517502, 8875.24560412365, 9262.490563019031, 11293.435328233576, 11449.82453333866, 11620.825687614693, 11456.083513318936, 11564.132690048238, 11591.130665200102, 11594.130440216997, 11622.476988535514, 2447.1312683997194, 2487.7139129000125, 2490.5018996200743, 2493.5137648158616, 2493.7381574934643, 2102.7161333219974, 2181.7054697615777, 2442.4992876460283, 2511.234073607549, 2521.319243804172, 2417.6615273861676, 2442.120836498859, 2465.0386349323776, 2467.494163696438, 2468.5062987402503, 2445.9877700611473, 2450.228178123903, 2452.1540068676277, 2453.3130723397476, 2457.2505385857216, 2369.8104151667826, 2381.666566680666, 2393.198278576679, 2403.3871362802547, 2404.1345115758486, 11552.6534203974, 11646.8935451132, 11677.532898684043, 11677.941610291979, 11694.356810375426, 5814.418558144194, 6006.039033754622, 6006.948783962833, 6008.459238668541, 6013.128096425994, 3447.517347571342, 3519.8064106474135, 3641.908952276188, 3724.1062145085257, 3736.8042226487537, 1113.209621168971, 1151.5681619392728, 1221.1696046688248, 1255.1276862580419, 1273.045216087934, 15923.283452244677, 16089.758653620205, 16100.597485062966, 16120.032798032156, 16127.0, 4789.389782568509, 4946.851594452172, 4974.950250497449, 5002.499750025041, 5068.265101560253, 13168.407421666048, 13169.868301317056, 13171.407286672124, 13178.143420677625, 13197.406116724578, 5930.495907847881, 6061.212042434456, 6064.090386442069, 6074.271087469532, 6083.330833608299, 4621.2837010263465, 5108.0, 5377.865553361197, 5394.541463975527, 5493.0, 3681.9447708284397, 4050.959490405058, 4158.875233742992, 4176.686748493875, 4202.0, 1103.685449646863, 1120.1039168665036, 1121.5233525751523, 1131.179894576442, 1137.2096393006946, 847.4872702015315, 919.9310051746146, 962.841131213356, 968.5205823117461, 1012.2610494339174, 6581.473482121419, 6631.469482441393, 6777.085093512412, 6918.7232510699005, 7027.297270273034, 1017.5703137092397, 1036.3729943384294, 1050.4117694091333, 1094.698957786615, 1097.0620119797618, 4406.2949928012, 4439.622632076245, 4480.977595112069, 4613.746243956614, 4630.282306242538, 13639.795403068962, 14159.575212743634, 14198.361073751706, 14219.64450888736, 14224.786628200585, 13372.866271337161, 13831.239281839395, 14121.576352709435, 14177.432902683984, 14215.50245741394, 10318.896811031944, 10596.364218146937, 10624.840627390595, 10635.52140153695, 10636.0, 6769.153855768029, 7007.299270073156, 7111.040009598638, 7200.459965502713, 7224.855502890018, 10510.0, 10565.577376904837, 12680.492780288685, 12941.805872912102, 13001.15492492985, 12991.155574887602, 13097.41061652209, 13122.60632181036, 13237.80143297832, 13242.337883105998, 9038.774030649287, 9138.406003609743, 9266.0, 9347.859782103409, 9351.625934962798, 9049.457032578066, 9318.627254909728, 9442.0, 9466.432014079177, 9857.753556161153, 7784.571848548384, 8536.615852286537, 8698.0, 8788.956055219684, 9023.864642030243, 8705.303575714055, 8774.868376974478, 8857.0, 8865.51239681798, 8949.0, 7760.456768026184, 7935.2064793520185, 8140.145284745016, 8273.544955027532, 8280.544570048705, 5788.392218817132, 5965.850853728692, 5990.490808281171, 6017.759289628366, 6074.757009719562, 5720.971395142998, 6036.939630603638, 6126.172966649446, 6179.598326108789, 6361.395667411589], "value": 5275.467373366713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.70721569136845, 380.3552977702795, 397.73948064018043, 398.78465628560576, 403.44526276369993, 4464.910701785962, 5097.031564002837, 5250.65870718403, 5377.300950876385, 5409.051392483484, 4429.468463784342, 4707.482176960531, 5021.59827213822, 5171.276021357013, 5284.39229488608, 3430.0738800523845, 3731.2537492501474, 4326.490635431443, 4431.49037860647, 4527.4114365132655, 4026.3960405939197, 4188.874333769992, 4407.80164892579, 4568.70303430276, 4573.405457290548, 3570.7500474966632, 4010.5989401059805, 4252.553481884404, 4266.722663026893, 4299.054208074219, 3737.7291720815056, 3984.5019372578427, 4132.152908653718, 4214.325707886724, 4319.308910574293, 3765.585785563586, 3940.5862384449506, 3952.7233093683453, 3982.900427489336, 4008.2785098682225, 4372.475302963633, 4876.317315575822, 5106.923396149061, 5171.3535808024, 5248.737563121828, 4641.466231383401, 4752.6910750801435, 4851.708897466164, 5004.924926126111, 5013.974930125326, 5309.4516230539175, 5569.415211402785, 5578.41426650204, 5592.384837667853, 5604.719764011783, 3750.5311836020496, 4032.8790136295956, 4255.55316691746, 4569.862904112882, 4582.381378513925, 5629.71851407432, 5743.368229494752, 5791.536677065867, 5835.212246346774, 5878.764849406019, 3985.980070099631, 4324.243257429937, 4560.863174104782, 4647.767611619405, 4717.599004084623, 4295.763732994653, 4664.533546645308, 4767.785449654774, 4778.928316075262, 4811.518848115161, 4679.251319788817, 4729.456112547101, 4780.82472475023, 4976.477469865685, 5049.798008079709, 4761.857144285677, 4826.95173048265, 5226.973865130726, 5351.973240133774, 5678.977783998837, 1351.8175046368615, 1502.684436268374, 1508.7963124978207, 1583.2900467495078, 1585.5798213473438, 1062.7077553672802, 1135.5238190352509, 1187.6615164678026, 1188.3404710385646, 1192.868784433729, 4811.728024943072, 5248.3701955765555, 5275.736213189325, 5279.52484276417, 5337.866553336197, 4862.586680132157, 5184.715474757971, 5719.4852463277675, 5758.712064396764, 5759.568032397587, 4792.688475249098, 5008.04686172393, 5157.381114266237, 5162.793488260428, 5193.0, 2684.503366877134, 2696.463016080815, 2884.624998750149, 2972.2420782700706, 3003.4593773121046, 5374.044275648456, 5440.537554307928, 5975.820725378246, 5985.982382994901, 6015.969920150459, 5710.885782284414, 5820.462937229547, 5846.356900740915, 5883.235179426647, 5914.6746928918465, 5002.499750024968, 5369.677819330853, 5833.708314584339, 5943.8288688840985, 5947.345791962881, 5156.61325400589, 5200.45395233495, 5468.851541176397, 5670.731707317106, 5757.884842303047, 4787.760611969457, 4888.388951381077, 5585.045234168008, 5597.6641401516035, 5662.122371032497, 5105.948940510547, 5120.25756265332, 5230.9799589081285, 5641.26663533738, 5752.827415177551, 4383.0, 4419.779011049499, 4538.704984176018, 4580.152671755736, 4656.790444429941, 4623.930641040454, 4774.928376074292, 5625.677965677981, 5739.339975902658, 5791.7683292667825, 5453.64551304164, 5474.726263686879, 5600.0, 5603.851210501756, 5750.654960702372, 5084.440711521804, 5127.512886275797, 5222.97388513055, 5598.832035038955, 5622.072358060874, 4836.975815120902, 4995.15082435994, 5133.820316288912, 5376.817100237941, 5548.805791797429, 4904.681195722266, 5258.789648414021, 5400.702961337164, 5580.135079062752, 5644.85887852807, 5052.317937078595, 5331.720991590067, 5565.66424058215, 5569.245687608391, 5585.369509818651], "value": 4253.469561708748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.8213992921555, 820.8481430935277, 824.7855557555034, 846.5809424334955, 904.8101746203739, 16276.837231627695, 18142.818571814278, 18154.63690726186, 18163.909180454095, 18264.995425251607, 16346.937449065832, 16380.508584742447, 16477.752833707473, 16503.917480412612, 16602.916985415057, 992.6376872441543, 992.6724181020282, 993.8459538771502, 995.2088089968456, 995.960161593539, 979.9020097990215, 987.0820137272334, 988.5502096546054, 1001.6794625719773, 1039.080413833755, 1059.4755595979962, 1069.385103565449, 1075.2688172043008, 1076.4886678827572, 1077.219016213247, 1068.3056013591229, 1070.7911957168355, 1070.8929107089307, 1071.7052810477103, 1074.1299547366657, 796.4385108498494, 797.310326567515, 798.0383637716595, 798.2097723253995, 799.4204201953595, 17226.052567108803, 17484.388046418313, 17485.562860928578, 17962.19170137347, 18223.544411389823, 12409.0, 12485.75028499434, 14244.92877535616, 15145.394184232617, 15501.147436890966, 10683.893161068367, 11664.35846028468, 11972.58095966637, 12007.3395963222, 12124.151309408346, 3726.2920045191327, 3819.9618003819883, 3885.572587015426, 3933.0953880607335, 3933.8623148189963, 108085.45957270241, 113353.43323283413, 113739.0, 114960.0, 115402.42298788452, 10597.84103238452, 10720.46397680113, 11166.497507612177, 11254.212205145725, 11271.887281127249, 24494.02023919023, 24503.142390016263, 24518.774061296863, 24558.01767929263, 24578.016879324627, 7946.880796788053, 8045.597720113971, 8063.435559510778, 8066.83866322682, 8255.628496717662, 4260.914781704349, 4400.22995975703, 4632.374629424984, 4650.581447669726, 4863.635227357962, 3379.4086034943784, 3462.8095454749728, 3472.6874581287807, 3474.530938323294, 3474.6872781449283, 588.3263663105805, 600.2916558460971, 626.2047200055904, 629.6473974574253, 630.1083966187884, 690.7962151165418, 698.7449580903035, 705.8976448415053, 741.8775901976113, 749.6439191384048, 10553.419561924167, 10583.94708026455, 10736.550565673535, 10893.128549716004, 10980.725481862857, 680.4454369688688, 687.9036934829128, 692.7921623512926, 732.6666366803091, 748.4835463530147, 5073.797048118107, 5174.223866419992, 5196.220566914917, 5196.220566914993, 5244.396894357198, 95752.52123739336, 96022.51988740012, 97064.05871882522, 113827.50823184049, 119008.0, 63409.048864267075, 82706.58646706727, 83339.5833020831, 102455.97544024464, 105807.0, 70742.0, 73169.0, 80374.598127009, 80600.0, 82771.0, 11243.60647377338, 11260.83108753353, 11276.830847537458, 11367.317960922372, 11465.0, 48037.31869384555, 48924.2661360087, 52937.67655808636, 53933.0, 55236.0, 68666.31333686599, 70556.29443705497, 72615.27384726085, 74001.25998739943, 74478.62760686161, 13309.600711978655, 13535.323233838466, 13622.591322260349, 14094.647633809236, 14395.28023598795, 15519.767203492183, 15598.844011560193, 15855.841441585899, 15940.583194501196, 16004.119773412574, 11471.770564588494, 14469.782953255499, 14495.565133046026, 14647.0, 15031.624209394853, 14037.298135093, 14548.41806327735, 14683.706325873636, 14748.705025899208, 14841.109533428029, 14100.576982690536, 14306.213158275978, 14331.211783351599, 14373.353199105855, 14708.852911470749, 10036.297459177787, 10234.232432567736, 10692.89307106919, 10819.15919848474, 10913.447139862425, 11369.829452558053, 11436.284557316469, 11651.766964660828, 11674.533018679158, 11679.941600291944], "value": 8044.72507596103, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1414.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 116.0, 115.0, 115.0, 117.0, 115.0, 116.0, 115.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 108.0, 110.0, 147.0, 107.0, 107.0, 108.0, 107.0, 131.0, 131.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 186.0, 182.0, 186.0, 184.0, 183.0, 184.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 91.0, 59.0, 58.0, 61.0, 78.0, 96.0, 81.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 87.0, 68.0, 70.0, 67.0, 81.0, 67.0, 67.0, 81.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 88.0, 88.0, 88.0, 88.0, 88.0, 91.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 149.0, 100.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 86.0, 85.0, 82.0, 86.0, 83.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 60.0, 61.0, 64.0, 64.0, 66.0, 63.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 58.0, 66.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 82.0, 79.0, 76.0, 89.0, 86.0, 68.0, 92.0, 100.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 152.0, 131.0, 142.0, 135.0, 144.0, 137.0, 137.0, 178.0, 146.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 166.0, 156.0, 156.0, 160.0, 164.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 62.0, 64.0, 63.0, 62.0, 65.0, 62.0, 62.0], "value": 63.2, "unit": "score"}]}]} 14:04:49 INFO - Return code: 0 14:04:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:04:49 INFO - # TBPL SUCCESS # 14:04:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:04:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:04:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:04:49 INFO - 2017-04-25 14:04:49.610 screenresolution[4077:130100] starting screenresolution argv=screenresolution get 14:04:49 INFO - 2017-04-25 14:04:49.613 screenresolution[4077:130100] Display 0: 1600x1200x32@60 14:04:49 INFO - 2017-04-25 14:04:49.619 screenresolution[4078:130103] starting screenresolution argv=screenresolution list 14:04:49 INFO - Available Modes on Display 0 14:04:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:04:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:04:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:04:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:04:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:04:49 INFO - Intel Iris: 14:04:49 INFO - Chipset Model: Intel Iris 14:04:49 INFO - Type: GPU 14:04:49 INFO - Bus: Built-In 14:04:49 INFO - VRAM (Dynamic, Max): 1536 MB 14:04:49 INFO - Vendor: Intel (0x8086) 14:04:49 INFO - Device ID: 0x0a2e 14:04:49 INFO - Revision ID: 0x0009 14:04:49 INFO - Displays: 14:04:49 INFO - Display: 14:04:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:04:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:04:49 INFO - Display Serial Number: 1600x1200 60 14:04:49 INFO - Main Display: Yes 14:04:49 INFO - Mirror: Off 14:04:49 INFO - Online: Yes 14:04:49 INFO - Rotation: Supported 14:04:49 INFO - Return code: 0 14:04:49 INFO - Running post-action listener: _resource_record_post_action 14:04:49 INFO - [mozharness: 2017-04-25 21:04:49.855023Z] Finished run-tests step (success) 14:04:49 INFO - Running post-run listener: _resource_record_post_run 14:04:49 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 94208; Write bytes: 421896704; Read time: 2; Write time: 1373 14:04:49 INFO - TinderboxPrint: CPU usage
53.9% 14:04:49 INFO - TinderboxPrint: I/O read bytes / time
94,208 / 2 14:04:49 INFO - TinderboxPrint: I/O write bytes / time
421,896,704 / 1,373 14:04:49 INFO - TinderboxPrint: CPU idle
2,203.3 (46.1%) 14:04:49 INFO - TinderboxPrint: CPU system
956.7 (20.0%) 14:04:49 INFO - TinderboxPrint: CPU user
1,621.7 (33.9%) 14:04:49 INFO - TinderboxPrint: Swap in / out
121,442,304 / 0 14:04:49 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119273984; Write bytes: 115717632; Read time: 10843; Write time: 260 14:04:49 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 81920; Write bytes: 295107584; Read time: 1; Write time: 1079 14:04:50 INFO - Running post-run listener: _upload_blobber_files 14:04:50 INFO - Blob upload gear active. 14:04:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:04:50 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 14:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:04:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:51 INFO - (blobuploader) - INFO - Done attempting. 14:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:52 INFO - (blobuploader) - INFO - Done attempting. 14:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:53 INFO - (blobuploader) - INFO - Done attempting. 14:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:56 INFO - (blobuploader) - INFO - Done attempting. 14:04:56 INFO - (blobuploader) - INFO - Iteration through files over. 14:04:56 INFO - Return code: 0 14:04:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:04:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:04:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c64d6c6690a231b2a4852a719ff07e2f6163b29af97dc06d17d16a72f0ca85c57117c57deb4e62339202c680089e6e99160c1278b69ff43e5222752a57d9ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ebb7a80ee42c77b860be933ae46846c282325645f0743c565904731c7c78266e0191144ab8de0218eacac6cb7ac492127facc639918921f4b8fb16e490220ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e673c834755548a5d1790a8b077947a7e896c07a8ade85c985ddf741373acf70ae0115d6dfc279868f23b5ef18d6b87c28c454eaf12e196e0ae496b33b48f186", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eccf57ee08cdfabf41d00e3b801ba2096a441ca12969d546e2b1961042295d28967be73410c336fb3ffc82f56272247c2375e50f14e7f1166cc2f17bbe9de970"} 14:04:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:04:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:04:56 INFO - Contents: 14:04:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c64d6c6690a231b2a4852a719ff07e2f6163b29af97dc06d17d16a72f0ca85c57117c57deb4e62339202c680089e6e99160c1278b69ff43e5222752a57d9ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ebb7a80ee42c77b860be933ae46846c282325645f0743c565904731c7c78266e0191144ab8de0218eacac6cb7ac492127facc639918921f4b8fb16e490220ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e673c834755548a5d1790a8b077947a7e896c07a8ade85c985ddf741373acf70ae0115d6dfc279868f23b5ef18d6b87c28c454eaf12e196e0ae496b33b48f186", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eccf57ee08cdfabf41d00e3b801ba2096a441ca12969d546e2b1961042295d28967be73410c336fb3ffc82f56272247c2375e50f14e7f1166cc2f17bbe9de970"} 14:04:56 INFO - Running post-run listener: copy_logs_to_upload_dir 14:04:56 INFO - Copying logs to upload dir... 14:04:56 INFO - mkdir: /builds/slave/test/build/upload/logs 14:04:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.331839 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-25 14:04:56.505668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:04:56.509633) ========= 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.tvZmU520iA/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.sJQQRDGHxG/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c64d6c6690a231b2a4852a719ff07e2f6163b29af97dc06d17d16a72f0ca85c57117c57deb4e62339202c680089e6e99160c1278b69ff43e5222752a57d9ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ebb7a80ee42c77b860be933ae46846c282325645f0743c565904731c7c78266e0191144ab8de0218eacac6cb7ac492127facc639918921f4b8fb16e490220ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e673c834755548a5d1790a8b077947a7e896c07a8ade85c985ddf741373acf70ae0115d6dfc279868f23b5ef18d6b87c28c454eaf12e196e0ae496b33b48f186", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eccf57ee08cdfabf41d00e3b801ba2096a441ca12969d546e2b1961042295d28967be73410c336fb3ffc82f56272247c2375e50f14e7f1166cc2f17bbe9de970"} build_url:https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011669 build_url: 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c64d6c6690a231b2a4852a719ff07e2f6163b29af97dc06d17d16a72f0ca85c57117c57deb4e62339202c680089e6e99160c1278b69ff43e5222752a57d9ba69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4ebb7a80ee42c77b860be933ae46846c282325645f0743c565904731c7c78266e0191144ab8de0218eacac6cb7ac492127facc639918921f4b8fb16e490220ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e673c834755548a5d1790a8b077947a7e896c07a8ade85c985ddf741373acf70ae0115d6dfc279868f23b5ef18d6b87c28c454eaf12e196e0ae496b33b48f186", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eccf57ee08cdfabf41d00e3b801ba2096a441ca12969d546e2b1961042295d28967be73410c336fb3ffc82f56272247c2375e50f14e7f1166cc2f17bbe9de970"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:04:56.545572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:04:56.545866) ========= 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.tvZmU520iA/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.sJQQRDGHxG/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005668 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:04:56.594178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:04:56.594509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:04:56.594833) ========= ========= Total master_lag: 0.17 =========