builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0108 starttime: 1491154004.14 results: success (0) buildid: 20170402095022 builduid: 79b7bcb5e62a483fb9341e5b20640234 revision: 8fcb1f73a45d2d1619622ef8f30c77dac70cf555 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:44.144706) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:44.145257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:44.145540) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:44.442808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:44.443178) ========= 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.rtoUxvXICU/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.G8e0IAWrqh/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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-02 10:26:44-- 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% 5.83M=0.002s 2017-04-02 10:26:45 (5.83 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.639909 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:45.114213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:45.114517) ========= 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.rtoUxvXICU/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.G8e0IAWrqh/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.020692 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:45.166270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:45.166590) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8fcb1f73a45d2d1619622ef8f30c77dac70cf555 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8fcb1f73a45d2d1619622ef8f30c77dac70cf555 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rtoUxvXICU/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.G8e0IAWrqh/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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-02 10:26:45,213 truncating revision to first 12 chars 2017-04-02 10:26:45,213 Setting DEBUG logging. 2017-04-02 10:26:45,213 attempt 1/10 2017-04-02 10:26:45,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8fcb1f73a45d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 10:26:45,838 unpacking tar archive at: mozilla-central-8fcb1f73a45d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885012 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:46.075200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:46.075519) ========= script_repo_revision: 8fcb1f73a45d2d1619622ef8f30c77dac70cf555 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:46.075915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:46.076190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 10:26:46.096630) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2017-04-02 10:26:46.097292) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rtoUxvXICU/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.G8e0IAWrqh/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:26:46 INFO - MultiFileLogger online at 20170402 10:26:46 in /builds/slave/test 10:26:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:26:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:26:46 INFO - {'append_to_log': False, 10:26:46 INFO - 'base_work_dir': '/builds/slave/test', 10:26:46 INFO - 'blob_upload_branch': 'Firefox', 10:26:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:26:46 INFO - 'branch': 'Firefox', 10:26:46 INFO - 'buildbot_json_path': 'buildprops.json', 10:26:46 INFO - 'config_files': ('talos/mac_config.py',), 10:26:46 INFO - 'default_actions': ('clobber', 10:26:46 INFO - 'read-buildbot-config', 10:26:46 INFO - 'download-and-extract', 10:26:46 INFO - 'populate-webroot', 10:26:46 INFO - 'create-virtualenv', 10:26:46 INFO - 'install', 10:26:46 INFO - 'run-tests'), 10:26:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:26:46 INFO - 'download_minidump_stackwalk': True, 10:26:46 INFO - 'download_symbols': 'ondemand', 10:26:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:26:46 INFO - 'tooltool.py': '/tools/tooltool.py', 10:26:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:26:46 INFO - '/tools/misc-python/virtualenv.py')}, 10:26:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:26:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:26:46 INFO - 'gecko_profile': False, 10:26:46 INFO - 'gecko_profile_interval': 0, 10:26:46 INFO - 'installer_path': 'installer.exe', 10:26:46 INFO - 'log_level': 'info', 10:26:46 INFO - 'log_name': 'talos', 10:26:46 INFO - 'log_to_console': True, 10:26:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:26:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:26:46 INFO - 'opt_config_files': (), 10:26:46 INFO - 'pip_index': False, 10:26:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:26:46 INFO - 'cmd': ('bash', 10:26:46 INFO - '-c', 10:26:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:26:46 INFO - 'enabled': True, 10:26:46 INFO - 'halt_on_failure': False, 10:26:46 INFO - 'name': 'check_screen_resolution'},), 10:26:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:26:46 INFO - 'cmd': ('bash', 10:26:46 INFO - '-c', 10:26:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:26:46 INFO - 'enabled': True, 10:26:46 INFO - 'halt_on_failure': False, 10:26:46 INFO - 'name': 'check_screen_resolution'},), 10:26:46 INFO - 'run_cmd_checks_enabled': True, 10:26:46 INFO - 'suite': 'dromaeojs', 10:26:46 INFO - 'system_bits': '32', 10:26:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:26:46 INFO - 'title': 't-yosemite-r7-0108', 10:26:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:26:46 INFO - 'use_talos_json': True, 10:26:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:26:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:26:46 INFO - 'work_dir': 'build'} 10:26:46 INFO - [mozharness: 2017-04-02 17:26:46.270496Z] Running clobber step. 10:26:46 INFO - Running pre-action listener: _resource_record_pre_action 10:26:46 INFO - Running main action method: clobber 10:26:46 INFO - rmtree: /builds/slave/test/build 10:26:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:26:49 INFO - Running post-action listener: _resource_record_post_action 10:26:49 INFO - [mozharness: 2017-04-02 17:26:49.479995Z] Finished clobber step (success) 10:26:49 INFO - [mozharness: 2017-04-02 17:26:49.480217Z] Running read-buildbot-config step. 10:26:49 INFO - Running pre-action listener: _resource_record_pre_action 10:26:49 INFO - Running main action method: read_buildbot_config 10:26:49 INFO - Using buildbot properties: 10:26:49 INFO - { 10:26:49 INFO - "project": "", 10:26:49 INFO - "product": "firefox", 10:26:49 INFO - "script_repo_revision": "production", 10:26:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:26:49 INFO - "repository": "", 10:26:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:26:49 INFO - "buildid": "20170402095022", 10:26:49 INFO - "pgo_build": "False", 10:26:49 INFO - "basedir": "/builds/slave/test", 10:26:49 INFO - "buildnumber": 66, 10:26:49 INFO - "slavename": "t-yosemite-r7-0108", 10:26:49 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:26:49 INFO - "platform": "yosemite_r7", 10:26:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:26:49 INFO - "branch": "mozilla-central", 10:26:49 INFO - "repo_path": "mozilla-central", 10:26:49 INFO - "revision": "8fcb1f73a45d2d1619622ef8f30c77dac70cf555", 10:26:49 INFO - "stage_platform": "macosx64", 10:26:49 INFO - "builduid": "79b7bcb5e62a483fb9341e5b20640234", 10:26:49 INFO - "slavebuilddir": "test" 10:26:49 INFO - } 10:26:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:26:49 INFO - Running post-action listener: _resource_record_post_action 10:26:49 INFO - [mozharness: 2017-04-02 17:26:49.485811Z] Finished read-buildbot-config step (success) 10:26:49 INFO - [mozharness: 2017-04-02 17:26:49.485988Z] Running download-and-extract step. 10:26:49 INFO - Running pre-action listener: _resource_record_pre_action 10:26:49 INFO - Running main action method: download_and_extract 10:26:49 INFO - mkdir: /builds/slave/test/build/tests 10:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:49 INFO - trying https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:26:51 INFO - Downloaded 1325 bytes. 10:26:51 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:26:51 INFO - Using the following test package requirements: 10:26:51 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:26:51 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:26:51 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:26:51 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:26:51 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'jsshell-mac.zip'], 10:26:51 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:26:51 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:26:51 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:26:51 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:26:51 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:26:51 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:26:51 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:26:51 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:26:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:26:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:26:51 INFO - Fetch https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:26:54 INFO - Expected file size: 52515533 10:26:54 INFO - Obtained file size: 52515533 10:27:11 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:27:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:27:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:27:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:27:13 INFO - Expected file size: 52515533 10:27:13 INFO - Obtained file size: 52515533 10:27:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:27:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:27:29 INFO - Fetch https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:27:30 INFO - Expected file size: 14404152 10:27:30 INFO - Obtained file size: 14404152 10:27: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')]} 10:27:30 INFO - trying https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:27:33 INFO - Downloaded 75566317 bytes. 10:27:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:27:33 INFO - mkdir: /builds/slave/test/properties 10:27:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:27:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:27:33 INFO - Contents: 10:27:33 INFO - build_url:https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:27:33 INFO - Running post-action listener: _resource_record_post_action 10:27:33 INFO - Running post-action listener: set_extra_try_arguments 10:27:33 INFO - [mozharness: 2017-04-02 17:27:33.651664Z] Finished download-and-extract step (success) 10:27:33 INFO - [mozharness: 2017-04-02 17:27:33.651824Z] Running populate-webroot step. 10:27:33 INFO - Running pre-action listener: _resource_record_pre_action 10:27:33 INFO - Running main action method: populate_webroot 10:27:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:27:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:27:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:27:33 INFO - '--tppagecycles', 10:27:33 INFO - '7'], 10:27:33 INFO - 'tests': ['tsvgm']}}, 10:27:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:27:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:27:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:27:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:27:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['damp', 'tps']}, 10:27:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'tests': ['damp', 'tps']}, 10:27:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['dromaeo_dom']}, 10:27:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:27:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['basic_compositor_video']}, 10:27:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:27:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['a11yr', 10:27:33 INFO - 'ts_paint', 10:27:33 INFO - 'tpaint', 10:27:33 INFO - 'sessionrestore', 10:27:33 INFO - 'sessionrestore_no_auto_restore', 10:27:33 INFO - 'tabpaint']}, 10:27:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:27:33 INFO - 'ts_paint', 10:27:33 INFO - 'tpaint', 10:27:33 INFO - 'sessionrestore', 10:27:33 INFO - 'sessionrestore_no_auto_restore', 10:27:33 INFO - 'tabpaint']}, 10:27:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:27:33 INFO - 'ts_paint', 10:27:33 INFO - 'tpaint', 10:27:33 INFO - 'sessionrestore', 10:27:33 INFO - 'sessionrestore_no_auto_restore', 10:27:33 INFO - 'tabpaint']}, 10:27:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:27:33 INFO - 'ts_paint', 10:27:33 INFO - 'tpaint', 10:27:33 INFO - 'sessionrestore', 10:27:33 INFO - 'sessionrestore_no_auto_restore', 10:27:33 INFO - 'tabpaint']}, 10:27:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['a11yr', 10:27:33 INFO - 'ts_paint', 10:27:33 INFO - 'tpaint', 10:27:33 INFO - 'sessionrestore', 10:27:33 INFO - 'sessionrestore_no_auto_restore', 10:27:33 INFO - 'tabpaint']}, 10:27:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['a11yr', 10:27:33 INFO - 'ts_paint', 10:27:33 INFO - 'tpaint', 10:27:33 INFO - 'sessionrestore', 10:27:33 INFO - 'sessionrestore_no_auto_restore', 10:27:33 INFO - 'tabpaint']}, 10:27:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['tsvgx', 10:27:33 INFO - 'tsvgr_opacity', 10:27:33 INFO - 'tart', 10:27:33 INFO - 'tscrollx', 10:27:33 INFO - 'cart', 10:27:33 INFO - 'tsvg_static']}, 10:27:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:27:33 INFO - 'tsvgr_opacity', 10:27:33 INFO - 'tart', 10:27:33 INFO - 'tscrollx', 10:27:33 INFO - 'cart', 10:27:33 INFO - 'tsvg_static']}, 10:27:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'talos_options': ['--disable-e10s'], 10:27:33 INFO - 'tests': ['tp5o']}, 10:27:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:27:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'talos_options': ['--disable-e10s', 10:27:33 INFO - '--xperf_path', 10:27:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:33 INFO - 'tests': ['tp5n']}, 10:27:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:27:33 INFO - 'talos_options': ['--xperf_path', 10:27:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:33 INFO - 'tests': ['tp5n']}}, 10:27:33 INFO - 'talos.zip': {'path': '', 10:27:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:27:33 INFO - Running post-action listener: _resource_record_post_action 10:27:33 INFO - [mozharness: 2017-04-02 17:27:33.669830Z] Finished populate-webroot step (success) 10:27:33 INFO - [mozharness: 2017-04-02 17:27:33.669922Z] Running create-virtualenv step. 10:27:33 INFO - Running pre-action listener: _resource_record_pre_action 10:27:33 INFO - Running main action method: create_virtualenv 10:27:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:27:33 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 10:27:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:27:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:27:33 INFO - Using real prefix '/tools/python27' 10:27:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:27:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:27:37 INFO - Installing pip.................done. 10:27:37 INFO - Return code: 0 10:27:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:27:37 INFO - Reading from file tmpfile_stdout 10:27:37 INFO - Output received: 10:27:37 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) 10:27:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:27:37 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')]} 10:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:37 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')]} 10:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:37 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:37 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 10:27:37 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 10:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:37 INFO - 'HOME': '/Users/cltbld', 10:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:37 INFO - 'LOGNAME': 'cltbld', 10:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:37 INFO - 'MOZ_NO_REMOTE': '1', 10:27:37 INFO - 'NO_EM_RESTART': '1', 10:27:37 INFO - 'PAGER': '/bin/cat', 10:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:37 INFO - 'PWD': '/builds/slave/test', 10:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:37 INFO - 'SHELL': '/bin/bash', 10:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:37 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:37 INFO - 'USER': 'cltbld', 10:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:37 INFO - 'XPC_FLAGS': '0x0', 10:27:37 INFO - 'XPC_SERVICE_NAME': '0', 10:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:37 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 10:27:37 INFO - Cleaning up... 10:27:37 INFO - Return code: 0 10:27:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:27:37 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')]} 10:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:37 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')]} 10:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:37 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:37 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 10:27:37 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 10:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:37 INFO - 'HOME': '/Users/cltbld', 10:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:37 INFO - 'LOGNAME': 'cltbld', 10:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:37 INFO - 'MOZ_NO_REMOTE': '1', 10:27:37 INFO - 'NO_EM_RESTART': '1', 10:27:37 INFO - 'PAGER': '/bin/cat', 10:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:37 INFO - 'PWD': '/builds/slave/test', 10:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:37 INFO - 'SHELL': '/bin/bash', 10:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:37 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:37 INFO - 'USER': 'cltbld', 10:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:37 INFO - 'XPC_FLAGS': '0x0', 10:27:37 INFO - 'XPC_SERVICE_NAME': '0', 10:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:38 INFO - Downloading/unpacking psutil>=3.1.1 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:42 INFO - Installing collected packages: psutil 10:27:42 INFO - Running setup.py install for psutil 10:27:42 INFO - building 'psutil._psutil_osx' extension 10:27:42 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 10:27:42 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 10:27:42 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 10:27:42 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 10:27:42 INFO - building 'psutil._psutil_posix' extension 10:27:42 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 10:27:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:27:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:27:42 INFO - ^ 10:27:42 INFO - 1 warning generated. 10:27:42 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 10:27:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:43 INFO - Successfully installed psutil 10:27:43 INFO - Cleaning up... 10:27:43 INFO - Return code: 0 10:27:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:43 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:43 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 10:27:43 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 10:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:43 INFO - 'HOME': '/Users/cltbld', 10:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:43 INFO - 'LOGNAME': 'cltbld', 10:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:43 INFO - 'MOZ_NO_REMOTE': '1', 10:27:43 INFO - 'NO_EM_RESTART': '1', 10:27:43 INFO - 'PAGER': '/bin/cat', 10:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:43 INFO - 'PWD': '/builds/slave/test', 10:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:43 INFO - 'SHELL': '/bin/bash', 10:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:43 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:43 INFO - 'USER': 'cltbld', 10:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:43 INFO - 'XPC_FLAGS': '0x0', 10:27:43 INFO - 'XPC_SERVICE_NAME': '0', 10:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:27:43 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 10:27:43 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 10:27:43 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 10:27:43 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 10:27:43 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 10:27:43 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 10:27:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:27:46 INFO - Installing collected packages: mozsystemmonitor 10:27:46 INFO - Running setup.py install for mozsystemmonitor 10:27:46 INFO - Successfully installed mozsystemmonitor 10:27:46 INFO - Cleaning up... 10:27:46 INFO - Return code: 0 10:27:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:27:46 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')]} 10:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:46 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')]} 10:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:46 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:46 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 10:27:46 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 10:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:46 INFO - 'HOME': '/Users/cltbld', 10:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:46 INFO - 'LOGNAME': 'cltbld', 10:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:46 INFO - 'MOZ_NO_REMOTE': '1', 10:27:46 INFO - 'NO_EM_RESTART': '1', 10:27:46 INFO - 'PAGER': '/bin/cat', 10:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:46 INFO - 'PWD': '/builds/slave/test', 10:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:46 INFO - 'SHELL': '/bin/bash', 10:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:46 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:46 INFO - 'USER': 'cltbld', 10:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:46 INFO - 'XPC_FLAGS': '0x0', 10:27:46 INFO - 'XPC_SERVICE_NAME': '0', 10:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:46 INFO - Downloading/unpacking jsonschema==2.5.1 10:27:46 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 10:27:46 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 10:27:46 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 10:27:46 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 10:27:46 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 10:27:46 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 10:27:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:27:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:27:49 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 10:27:49 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 10:27:49 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 10:27:49 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 10:27:49 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 10:27:49 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 10:27:49 INFO - Downloading functools32-3.2.3-2.tar.gz 10:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:27:49 INFO - warning: no files found matching '*.txt' 10:27:49 INFO - no previously-included directories found matching 'build' 10:27:49 INFO - no previously-included directories found matching 'dist' 10:27:49 INFO - no previously-included directories found matching '.git*' 10:27:49 INFO - Installing collected packages: jsonschema, functools32 10:27:49 INFO - Running setup.py install for functools32 10:27:49 INFO - warning: no files found matching '*.txt' 10:27:49 INFO - no previously-included directories found matching 'build' 10:27:49 INFO - no previously-included directories found matching 'dist' 10:27:49 INFO - no previously-included directories found matching '.git*' 10:27:50 INFO - Successfully installed jsonschema functools32 10:27:50 INFO - Cleaning up... 10:27:50 INFO - Return code: 0 10:27:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:27:50 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')]} 10:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:50 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')]} 10:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:50 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:50 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 10:27:50 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 10:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:50 INFO - 'HOME': '/Users/cltbld', 10:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:50 INFO - 'LOGNAME': 'cltbld', 10:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:50 INFO - 'MOZ_NO_REMOTE': '1', 10:27:50 INFO - 'NO_EM_RESTART': '1', 10:27:50 INFO - 'PAGER': '/bin/cat', 10:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:50 INFO - 'PWD': '/builds/slave/test', 10:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:50 INFO - 'SHELL': '/bin/bash', 10:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:50 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:50 INFO - 'USER': 'cltbld', 10:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:50 INFO - 'XPC_FLAGS': '0x0', 10:27:50 INFO - 'XPC_SERVICE_NAME': '0', 10:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:27:50 INFO - Cleaning up... 10:27:50 INFO - Return code: 0 10:27:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:27:50 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')]} 10:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:50 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')]} 10:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:50 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:50 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 10:27:50 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 10:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:50 INFO - 'HOME': '/Users/cltbld', 10:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:50 INFO - 'LOGNAME': 'cltbld', 10:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:50 INFO - 'MOZ_NO_REMOTE': '1', 10:27:50 INFO - 'NO_EM_RESTART': '1', 10:27:50 INFO - 'PAGER': '/bin/cat', 10:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:50 INFO - 'PWD': '/builds/slave/test', 10:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:50 INFO - 'SHELL': '/bin/bash', 10:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:50 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:50 INFO - 'USER': 'cltbld', 10:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:50 INFO - 'XPC_FLAGS': '0x0', 10:27:50 INFO - 'XPC_SERVICE_NAME': '0', 10:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:27:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:27:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 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 10:27:54 INFO - Downloading docopt-0.6.1.tar.gz 10:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:27:54 INFO - Running setup.py install for blobuploader 10:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:27:54 INFO - Running setup.py install for requests 10:27:55 INFO - Running setup.py install for docopt 10:27:55 INFO - Successfully installed blobuploader requests docopt 10:27:55 INFO - Cleaning up... 10:27:55 INFO - Return code: 0 10:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27:55 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')]} 10:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:55 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')]} 10:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:55 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:27:55 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 10:27:55 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 10:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:55 INFO - 'HOME': '/Users/cltbld', 10:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:55 INFO - 'LOGNAME': 'cltbld', 10:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:55 INFO - 'MOZ_NO_REMOTE': '1', 10:27:55 INFO - 'NO_EM_RESTART': '1', 10:27:55 INFO - 'PAGER': '/bin/cat', 10:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:55 INFO - 'PWD': '/builds/slave/test', 10:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:55 INFO - 'SHELL': '/bin/bash', 10:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:27:55 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:55 INFO - 'USER': 'cltbld', 10:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:55 INFO - 'XPC_FLAGS': '0x0', 10:27:55 INFO - 'XPC_SERVICE_NAME': '0', 10:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:27:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-eUzfCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:27:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-fzSmbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-KR2l9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Y54wBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-HAbLIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-HgEeRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-vysICa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-1gp8vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-GTYAWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-LD4zmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-dHFXnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:27:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-HiOCiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:27:57 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-jNjM1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:27:57 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-xUAdJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:57 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-r2vtAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:27:57 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-cfqeTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:27:57 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-PiezzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:27:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:27:57 INFO - Running setup.py install for manifestparser 10:27:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:27:57 INFO - Running setup.py install for mozcrash 10:27:57 INFO - Running setup.py install for mozdebug 10:27:57 INFO - Running setup.py install for mozdevice 10:27:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Running setup.py install for mozfile 10:27:58 INFO - Running setup.py install for mozhttpd 10:27:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Running setup.py install for mozinfo 10:27:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Running setup.py install for mozInstall 10:27:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:27:58 INFO - Running setup.py install for mozleak 10:27:58 INFO - Running setup.py install for mozlog 10:27:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:27:59 INFO - Running setup.py install for moznetwork 10:27:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:27:59 INFO - Running setup.py install for mozprocess 10:27:59 INFO - Running setup.py install for mozprofile 10:27:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:27:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:27:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:27:59 INFO - Running setup.py install for mozrunner 10:27:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:27:59 INFO - Running setup.py install for mozscreenshot 10:27:59 INFO - Running setup.py install for moztest 10:27:59 INFO - Running setup.py install for mozversion 10:28:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:00 INFO - Cleaning up... 10:28:00 INFO - Return code: 0 10:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:00 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:28:00 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 10:28:00 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 10:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:00 INFO - 'HOME': '/Users/cltbld', 10:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:00 INFO - 'LOGNAME': 'cltbld', 10:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:00 INFO - 'MOZ_NO_REMOTE': '1', 10:28:00 INFO - 'NO_EM_RESTART': '1', 10:28:00 INFO - 'PAGER': '/bin/cat', 10:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:00 INFO - 'PWD': '/builds/slave/test', 10:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:00 INFO - 'SHELL': '/bin/bash', 10:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:28:00 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:00 INFO - 'USER': 'cltbld', 10:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:00 INFO - 'XPC_FLAGS': '0x0', 10:28:00 INFO - 'XPC_SERVICE_NAME': '0', 10:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-yDle56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:00 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)) 10:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-yaDXSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:00 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)) 10:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-H7BwwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:00 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)) 10:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Dp_9BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:00 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)) 10:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-kwt1fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:00 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)) 10:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-jQTl8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-5UbXPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-SBkR56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-SszWF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-VaNsHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-GY0VcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-bnd90s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-1eYIF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-bppFqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:01 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)) 10:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-6umekc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:02 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)) 10:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:02 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-jALWQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:02 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)) 10:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:02 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-yNA2sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:02 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)) 10:28:02 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)) 10:28:02 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)) 10:28:02 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)) 10:28:02 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)) 10:28:02 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)) 10:28:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - Downloading blessings-1.6.tar.gz 10:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:05 INFO - Installing collected packages: blessings 10:28:05 INFO - Running setup.py install for blessings 10:28:05 INFO - Successfully installed blessings 10:28:05 INFO - Cleaning up... 10:28:05 INFO - Return code: 0 10:28:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:05 INFO - Reading from file tmpfile_stdout 10:28:05 INFO - Current package versions: 10:28:05 INFO - blessings == 1.6 10:28:05 INFO - blobuploader == 1.2.4 10:28:05 INFO - docopt == 0.6.1 10:28:05 INFO - functools32 == 3.2.3-2 10:28:05 INFO - jsonschema == 2.5.1 10:28:05 INFO - manifestparser == 1.1 10:28:05 INFO - mozInstall == 1.12 10:28:05 INFO - mozcrash == 1.0 10:28:05 INFO - mozdebug == 0.1 10:28:05 INFO - mozdevice == 0.49 10:28:05 INFO - mozfile == 1.2 10:28:05 INFO - mozhttpd == 0.7 10:28:05 INFO - mozinfo == 0.9 10:28:05 INFO - mozleak == 0.1 10:28:05 INFO - mozlog == 3.4 10:28:05 INFO - moznetwork == 0.27 10:28:05 INFO - mozprocess == 0.25 10:28:05 INFO - mozprofile == 0.28 10:28:05 INFO - mozrunner == 6.13 10:28:05 INFO - mozscreenshot == 0.1 10:28:05 INFO - mozsystemmonitor == 0.3 10:28:05 INFO - moztest == 0.8 10:28:05 INFO - mozversion == 1.4 10:28:05 INFO - psutil == 3.1.1 10:28:05 INFO - requests == 1.2.3 10:28:05 INFO - wsgiref == 0.1.2 10:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:28:05 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 10:28:05 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 10:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:05 INFO - 'HOME': '/Users/cltbld', 10:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:05 INFO - 'LOGNAME': 'cltbld', 10:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:05 INFO - 'MOZ_NO_REMOTE': '1', 10:28:05 INFO - 'NO_EM_RESTART': '1', 10:28:05 INFO - 'PAGER': '/bin/cat', 10:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:05 INFO - 'PWD': '/builds/slave/test', 10:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:05 INFO - 'SHELL': '/bin/bash', 10:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:28:05 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:05 INFO - 'USER': 'cltbld', 10:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:05 INFO - 'XPC_FLAGS': '0x0', 10:28:05 INFO - 'XPC_SERVICE_NAME': '0', 10:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 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)) 10:28:05 INFO - Cleaning up... 10:28:05 INFO - Return code: 0 10:28:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 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 0x1016b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a1490cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, '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.rtoUxvXICU/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.G8e0IAWrqh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 10:28:05 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 10:28:05 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 10:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:05 INFO - 'HOME': '/Users/cltbld', 10:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:05 INFO - 'LOGNAME': 'cltbld', 10:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:05 INFO - 'MOZ_NO_REMOTE': '1', 10:28:05 INFO - 'NO_EM_RESTART': '1', 10:28:05 INFO - 'PAGER': '/bin/cat', 10:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:05 INFO - 'PWD': '/builds/slave/test', 10:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:05 INFO - 'SHELL': '/bin/bash', 10:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:28:05 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:05 INFO - 'USER': 'cltbld', 10:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:05 INFO - 'XPC_FLAGS': '0x0', 10:28:05 INFO - 'XPC_SERVICE_NAME': '0', 10:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:06 INFO - Cleaning up... 10:28:06 INFO - Return code: 0 10:28:06 INFO - Running post-action listener: _resource_record_post_action 10:28:06 INFO - Running post-action listener: _start_resource_monitoring 10:28:06 INFO - Starting resource monitoring. 10:28:06 INFO - [mozharness: 2017-04-02 17:28:06.112959Z] Finished create-virtualenv step (success) 10:28:06 INFO - [mozharness: 2017-04-02 17:28:06.113971Z] Running install step. 10:28:06 INFO - Running pre-action listener: _resource_record_pre_action 10:28:06 INFO - Running main action method: install 10:28:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:06 INFO - Reading from file tmpfile_stdout 10:28:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:06 INFO - Reading from file tmpfile_stdout 10:28:06 INFO - Output received: 10:28:06 INFO - Usage: mozinstall [options] installer 10:28:06 INFO - Options: 10:28:06 INFO - -h, --help show this help message and exit 10:28:06 INFO - -d DEST, --destination=DEST 10:28:06 INFO - Directory to install application into. [default: 10:28:06 INFO - "/builds/slave/test"] 10:28:06 INFO - --app=APP Application being installed. [default: firefox] 10:28:06 INFO - mkdir: /builds/slave/test/build/application 10:28:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:28:27 INFO - Reading from file tmpfile_stdout 10:28:27 INFO - Output received: 10:28:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:28:27 INFO - Running post-action listener: _resource_record_post_action 10:28:27 INFO - [mozharness: 2017-04-02 17:28:27.280976Z] Finished install step (success) 10:28:27 INFO - [mozharness: 2017-04-02 17:28:27.281117Z] Running run-tests step. 10:28:27 INFO - Running pre-action listener: _resource_record_pre_action 10:28:27 INFO - Running main action method: run_tests 10:28:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:27 INFO - 2017-04-02 10:28:27.295 screenresolution[1916:23944] starting screenresolution argv=screenresolution get 10:28:27 INFO - 2017-04-02 10:28:27.298 screenresolution[1916:23944] Display 0: 1600x1200x32@60 10:28:27 INFO - 2017-04-02 10:28:27.304 screenresolution[1917:23947] starting screenresolution argv=screenresolution list 10:28:27 INFO - Available Modes on Display 0 10:28:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:27 INFO - Intel Iris: 10:28:27 INFO - Chipset Model: Intel Iris 10:28:27 INFO - Type: GPU 10:28:27 INFO - Bus: Built-In 10:28:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:27 INFO - Vendor: Intel (0x8086) 10:28:27 INFO - Device ID: 0x0a2e 10:28:27 INFO - Revision ID: 0x0009 10:28:27 INFO - Displays: 10:28:27 INFO - Display: 10:28:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:27 INFO - Display Serial Number: 1600x1200 60 10:28:27 INFO - Main Display: Yes 10:28:27 INFO - Mirror: Off 10:28:27 INFO - Online: Yes 10:28:27 INFO - Rotation: Supported 10:28:27 INFO - Return code: 0 10:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:27 INFO - Python 2.7.3 10:28:27 INFO - Return code: 0 10:28:27 INFO - grabbing minidump binary from tooltool 10:28:27 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')]} 10:28:27 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 0x101494d30>, '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 0x1013bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101489be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:27 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 10:28:27 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 10:28:27 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 10:28:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:27 INFO - Return code: 0 10:28:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:28:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:27 INFO - ENV: RUST_BACKTRACE is now 1 10:28:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:28:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--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 10:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0108 --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 10:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rtoUxvXICU/Render', 10:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:27 INFO - 'HOME': '/Users/cltbld', 10:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:27 INFO - 'LOGNAME': 'cltbld', 10:28:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:27 INFO - 'MOZ_NO_REMOTE': '1', 10:28:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:27 INFO - 'NO_EM_RESTART': '1', 10:28:27 INFO - 'PAGER': '/bin/cat', 10:28:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:27 INFO - 'PWD': '/builds/slave/test', 10:28:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:27 INFO - 'RUST_BACKTRACE': '1', 10:28:27 INFO - 'SHELL': '/bin/bash', 10:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8e0IAWrqh/Listeners', 10:28:27 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 10:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:27 INFO - 'USER': 'cltbld', 10:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:27 INFO - 'XPC_FLAGS': '0x0', 10:28:27 INFO - 'XPC_SERVICE_NAME': '0', 10:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--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 10:28:27 INFO - mozversion application_buildid: 20170402095022 10:28:27 INFO - mozversion application_changeset: 8fcb1f73a45d2d1619622ef8f30c77dac70cf555 10:28:27 INFO - mozversion application_display_name: Nightly 10:28:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:27 INFO - mozversion application_name: Firefox 10:28:27 INFO - mozversion application_remotingname: firefox 10:28:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:28:27 INFO - mozversion application_vendor: Mozilla 10:28:27 INFO - mozversion application_version: 55.0a1 10:28:27 INFO - mozversion platform_buildid: 20170402095022 10:28:27 INFO - mozversion platform_changeset: 8fcb1f73a45d2d1619622ef8f30c77dac70cf555 10:28:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:28:27 INFO - mozversion platform_version: 55.0a1 10:28:27 INFO - using testdate: 1491154107 10:28:27 INFO - actual date: 1491154107 10:28:27 INFO - starting webserver on 'localhost:56626' 10:28:27 INFO - SUITE-START | Running 2 tests 10:28:27 INFO - TEST-START | dromaeo_css 10:28:27 INFO - operating with platform_type : mac_ 10:28:27 INFO - Initialising browser for dromaeo_css test... 10:28:27 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpIxccHb/profile http://localhost:56626/getInfo.html) 10:28:30 INFO - PID 1927 | __metrics Screen width/height:1600/1200 10:28:30 INFO - PID 1927 | colorDepth:24 10:28:30 INFO - PID 1927 | Browser inner width/height: 1024/689 10:28:30 INFO - PID 1927 | __metrics 10:28:30 INFO - PID 1927 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:28:30 INFO - PID 1927 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:28:31 INFO - TEST-INFO | 1927: exit 0 10:28:31 INFO - Browser initialized. 10:28:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:28:31 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpIxccHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:43 INFO - PID 1929 | RSS: Main: 234196992 10:28:43 INFO - PID 1929 | 10:31:49 INFO - PID 1929 | Cycle 1(1): loaded http://localhost:56626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56626/tests/dromaeo/cssquery-ext.html) 10:31:51 INFO - PID 1929 | RSS: Main: 425775104 10:31:51 INFO - PID 1929 | 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | A coding exception was thrown and uncaught in a Task. 10:33:33 INFO - PID 1929 | 10:33:33 ERROR - PID 1929 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:33:33 INFO - PID 1929 | Full stack: 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | A coding exception was thrown and uncaught in a Task. 10:33:33 INFO - PID 1929 | 10:33:33 ERROR - PID 1929 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:33:33 INFO - PID 1929 | Full stack: 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | A coding exception was thrown and uncaught in a Task. 10:33:33 INFO - PID 1929 | 10:33:33 ERROR - PID 1929 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:33:33 INFO - PID 1929 | Full stack: 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | ************************* 10:33:33 INFO - PID 1929 | A coding exception was thrown and uncaught in a Task. 10:33:33 INFO - PID 1929 | 10:33:33 ERROR - PID 1929 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:33:33 INFO - PID 1929 | Full stack: 10:33:33 INFO - PID 1929 | ************************* 10:34:54 INFO - PID 1929 | Cycle 1(1): loaded http://localhost:56626/tests/dromaeo/cssquery-ext.html (next: http://localhost:56626/tests/dromaeo/cssquery-jquery.html) 10:34:55 INFO - PID 1929 | RSS: Main: 365645824 10:34:55 INFO - PID 1929 | 10:37:57 INFO - PID 1929 | Cycle 1(1): loaded http://localhost:56626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56626/tests/dromaeo/cssquery-mootools.html) 10:37:58 INFO - PID 1929 | RSS: Main: 335515648 10:37:58 INFO - PID 1929 | 10:41:00 INFO - PID 1929 | Cycle 1(1): loaded http://localhost:56626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56626/tests/dromaeo/cssquery-prototype.html) 10:41:00 INFO - PID 1929 | RSS: Main: 361832448 10:41:00 INFO - PID 1929 | 10:44:04 INFO - PID 1929 | Cycle 1(1): loaded http://localhost:56626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56626/tests/dromaeo/cssquery-yui.html) 10:44:05 INFO - PID 1929 | RSS: Main: 336912384 10:44:05 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | Cycle 1(1): loaded http://localhost:56626/tests/dromaeo/cssquery-yui.html (next: http://localhost:56626/tests/dromaeo/cssquery-dojo.html) 10:47:08 INFO - PID 1929 | RSS: Main: 587673600 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | __start_tp_report 10:47:08 INFO - PID 1929 | _x_x_mozilla_page_load 10:47:08 INFO - PID 1929 | _x_x_mozilla_page_load_details 10:47:08 INFO - PID 1929 | |i|pagename|runs| 10:47:08 INFO - PID 1929 | |0;dojo.html;3005.5341422079587;3497.5659979408438;3523.048776830254;3528.770629909054;3592.4431713084464;6068.059450785125;6141.209856312073;6202.844928876774;6206.565540412173;6224.253089629246;6134.773364742522;6157.969210153943;6189.164462797521;6196.473299769525;6206.6586337751405;5246.160614301693;5372.785088596452;5415.404305526379;5426.511613954744;5533.889322213553;5435;5506.981208476444;5511.696856672881;5514;5522.3649280332675;5282.286891269668;5367.355917289911;5377.865553361158;5393.649412788156;5452.91820622691;5272.340957380327;5340.572754179656;5343.732813359316;5357.785688572452;5365.651232669903;5280.155175171993;5342.679439233659;5352.090144675414;5359.5444387227135;5364.088105022156;6124.045297608081;6132.967444181115;6135.2143331386815;6142.099766648166;6144.293406258293;6456.128422662928;6456.7740129095255;6459.935400646027;6460.547761656686;6475.481961443121;6690.197176338822;6699.933000669979;6784.321567843225;6797.082393876813;6802.931970680279;6288.308286088527;6300.3384644612115;6304.968475157641;6309.116723658692;6314.747410103544;6568.6058836469965;6847.691853866588;6855.794326170223;6860.725570977205;6863.794086177422;6322.873542529123;6479.8056058318325;6545.443637290884;6570.277269500351;6573.244076931119;6722.193336799615;6730;6733.259341472434;6738.225104113089;6740.797776066725;6628.900566491507;6630.53586248958;6634;6647.5346725729705;6648.7340506379205;6354.110424540568;6409.198850143732;6424.743010279536;6587.80236592903;6657.833554161185;5326.600504962066;5369.865753356119;5372.409035006224;5397.8380648580605;5416.0792665247;4706.670533062721;4711.575958163782;4714.622830173578;4726.338312636233;4735.147673418817;5188.610854185951;6238.875222495615;6304.873902521924;6325.7785977491485;6330.335314791972;6525.184351956005;6659.300773418721;6691.59850408977;6706.094677218513;6749.595024298558;6295.37046295376;6309.652969086745;6311.968440157862;6316.021016742412;6320.988641817287;5937.70311484424;5953.613015154001;5964.194833697396;5972.223610930638;5977.342492325841;6581.012848072827;6663.666816659244;6665.433438157617;6824.863502730017;6833.384995350442;6452.9677351612945;6552.967235163794;6764.594124352555;6771.458283337222;6787.728490860311;6681.09805176295;6839.042534045338;6866.450683945172;6916.20463646687;6930.7227710891;6600.8349791255605;6649.700763465559;6660;6670.199576050905;6672.799816005528;6447.677616119082;6753.2233793112455;6766.323367663194;6768.796936091925;6774.525783195326;6308.211473565804;6350.650714210763;6440;6451.903221451776;6466.515011374072;6368.299487056327;6490.772822951174;6508.088867558451;6511.153550038654;6527.379898909596;6312.589681670676;6329.620222786648;6380.585261957958;6381.106645069601;6395.232572091379;6251.968740156452;6325.525585581007;6330.272018717907;6364.745410183726;6522.7717029905625;6268.091126786499;6271.717772700331;6274.560780745486;6281.466075383643;6296.842578935563 10:47:08 INFO - PID 1929 | |1;ext.html;741.514308128176;807.2049031703771;1125.9493322800474;1146.1804809561156;1148.1733152130473;36670.44994325084;37351.62648373519;37573;37631.435528467024;37656.24687506252;39122.21755564887;39494.81515554531;39531.40702889459;39538.40692389617;39575.80212098943;6138.508919286446;6294.874102517947;8641.697540586065;8813.38306318558;8833.911660883405;8597.140285971383;8781.56092195391;8787.64849406023;8792.208701216889;8812.030676625565;8790.824183516326;8871.334649901251;8873.378863479527;8873.645054197825;8880.822383552326;8766.079561646031;8844.911550884506;8877.73366798997;8878.200961913459;8879.689210877588;8644.870326945102;8704.173103555153;8723.869141962876;8726.956365218133;8731.825363492695;38674.41988370177;38798.41802372967;38856.61143388587;38870.41694374587;38874;2950.7196816302417;2952.8818847246084;2953.246922034889;2960.141558947924;2979.597754303163;22640;26847.463050739072;26935.865320673467;26979.745367502423;28146.577801333;2802.831830090201;2812.1704097291145;2827.5193217153133;2828.1091456191234;2830.6320178376886;309660;310520;311927.4403627967;312277;314146.85853141407;39772.60227397689;40040.59959400369;40074;47711.761441192575;47980.280295795594;41539.58460415417;41602.58397416048;41605.37591936063;41626.58373416288;51396.48603513992;14485.85514144845;14764.26178691061;14782.704345913022;14789.96470247094;14795.408183672747;10026.448545329931;10194.031567001271;10195.643152489627;10196.388216706873;11866.288022718665;11999.760004799855;12118.151729378858;13234.20594764298;13420.792128708463;13474.461021559224;5155.536001759785;5317.229001794795;5436;5641.26663533738;5868.706564671749;899.581694512055;941.4962994797887;968.8595153702673;969.680005598165;1002.6190047781796;22060.669089963663;22477.77522224757;22568.54862902733;23806.16678416247;23889.52220955571;1067.2849191042021;1074.8441475985937;1082.783443311341;1104.3042882983668;1121.9158563107799;10230.08708156906;10646.840297395545;11761.235519691192;12117.575884844164;12224.083193760503;405630;436303;437303;438213.80893095967;438657;48189.75905120452;55839.16241256303;55885.441145588025;55976.60058498489;56092;1412.6680230145907;1448.43511030696;1500.6398464368692;1507.366905899525;1517.9772303415457;21815.80013099295;23399.649005264593;23443.648345275175;23445.88277058604;23487.53024939526;31874;38108.61891381162;38123.618763813116;38124.809375952944;38155.42766858444;450924;451487;452149;452655;454194;27215.319617009733;32225.677743222266;32543.34913301768;32543.511847321835;32795.672043279264;32737.18157046093;32738.672613274513;40852.182956341305;41448.0986330954;41974.58025419707;27269.45461090807;28547.28631784222;28971.275718107216;29525;29658;28638;29215.561766573093;29299.56050659199;29458.410831783673;29590;34444.65555344414;34515.30969380548;34850.82574587111;34862.30275394529;34874.47688284729;24729;26696.733032669425;28339.43321133607;29229.7077029227;29318.7068129316;22135.55728885381;22938.885305573367;22986.42533936665;23265.18571850045;23732.525349492567 10:47:08 INFO - PID 1929 | |2;jquery.html;425.1347481687443;427.64078174333594;434.38751360581585;439.31247597509895;452.27635782747586;21593.67609485857;22504.437389065282;22782;23310;23601.5279694406;22014;22626.77373226267;22755.658665120038;22943.311700649007;23205.071797128137;5952.613080149798;6209.441150296472;6254.718537665816;6529.347065293457;6542.672866356663;6175.567710260261;6246.718897649616;6281.40326668968;6288.748450062015;6291.559590828644;6280.717367718441;6319.083732858733;6326.905096423534;6333.778317758879;6337;6104.511639068864;6227.377262273736;6303.117563541108;6314.589551679126;6337.588056776295;5636.633618814764;5637.3235211774845;5642.85892852682;5652.5195358394585;5673.716314184316;27253.86373068122;27394.315142121406;28008.859955700296;28322.29194270139;28735.56896646552;1853.6848735714962;2038.8063134002246;2048.7541495020546;2048.764392094913;2080.6358887194833;15407.845921540866;16535.958120185533;16554.668906621922;16630.002199868046;17279.96320220791;1874.7375367448567;1891.7067854482577;1909.1695112625914;1911.6176764647125;1979.6832506798987;151516;158996;160447.99999999884;161696.19151904166;162149;12247.530296364494;12455.377231138407;12466.75066498683;12534;12608.684782880318;16734.98770221372;16754.66490670204;16759.581010474834;16763.91618041902;16785.475050239587;7662.961685191538;8814.735557933273;9037.638494460149;9054.049324820931;9192.63229470827;8657.52383618907;8662.87005694915;8665.393422460367;8843.646254149762;8860.468371897707;7002.124734408199;7081.362677359062;7688.269614386736;7799.844003120019;7830.491018083806;1790.8806995627733;1846.658368201887;2079.9480012999798;2104.6948192512;2297.7587353327995;818.1286929420148;915.8855143107112;925.9166674999283;932.3147486597481;962.6919385796618;19581.51046223856;20888.791112088686;21121.9439028048;21153.67309595943;21237.46906327354;951.4624237306039;955.2739917662626;992.9851052234222;994.627014869424;997.3018886779283;8277.83444331122;8786.516741579147;9584;10577.471126443646;11151.052160566443;598045;638794;652428;697901;701098;107894;150754;158577;158760;164341;1112.2603468693228;1147.3345459633392;1156.6067537037616;1165.2251252916715;1169.6491052684162;21160.576788464452;22096.779032210114;22425;22528.774712253322;22542.098316067175;62400;62489.43776405626;64808;64953;65825.67087164533;64607.67696161489;88841;89804.5509772447;90672.5466372664;90823.54588227016;8793.692220772242;8808.471491710518;8825.293976481738;8965.596548155218;12994.675133121747;13836.792448113085;14038.859611403755;14441.711165776416;14657.48698795537;14659.340329685403;11452.484638191134;11808.99623531975;12160.695982600506;12198.878011219775;12321.137520373488;11313.71715707114;11419.02938250258;11440.771184576095;11817.936385725327;11832;12058.336791476202;12165.81751273714;12477.563285284972;12490.06324525646;12556.121071524905;13141.277229752455;13148.211107333591;13568.660783480493;13597.388117534536;13678.247696376397;11742.354170520703;11933.641990740292;12168.75662486763;12229.633111006684;12277.69305767363 10:47:08 INFO - PID 1929 | |3;mootools.html;1322.3388305847077;1376.3599926034392;1394.8605139486049;1397.5946975377142;1397.6170629077424;10320.329178603395;10757.569697212111;10774.838377424345;10778.407187604678;10781.245312828105;10512.369257844535;10669.146468282539;11045.28205666633;11081.612143574977;11102.6114086007;2093.079045220106;2411.963820542689;2445.425325048621;2459.385153711572;2460.6432067350224;2252.414372263207;2379.0721618568773;2389.2593296078185;2398.37642213025;2438.719547252071;2025.1696804310236;2121.045529511718;2344.749040920718;2441.7680320369536;2447.4248551590363;2422.39440139965;2446.5473887330813;2448.2165706973774;2449.669294645218;2451.044092803808;2413.1312727418117;2427.1019722702536;2427.186892391051;2473.2951108933867;2476.938076548083;10969.670909872717;11123.777524449466;11127.387993660346;11131.666050018512;11140.220184587082;6146.815595532141;6378.043293505965;6399;6403.519736019817;6414.583052101645;3426.8457919393436;3685;3729.216864458467;3980.223856348013;4025.798710064485;1156.9421528923604;1173.3312012153076;1201.0871737479579;1225.209739717886;1229.9508019679292;15071.698566028728;15086.698266034618;15202;15204.847951520454;15235.771463427947;4999.375078115236;5103.923441148386;5302.708351040653;5351.331083614548;5409.972950135224;11279.379634120201;11280.379579123228;11285.943570282096;11291.604793832177;11297.03975162104;6224.470919971853;6228.657423841732;6229.314775374705;6232.127502149703;6235.563510554218;5620.100783874561;5744.396838331999;5755.22304488897;5832.416758324133;5834.154047663065;3995.8507651995496;4105.67154627629;4128.318827393447;4147.792610369469;4150.8547200847825;1243.1360204657676;1246.3394400967502;1250.5998080614297;1262.2868079535033;1268.67014576209;726.9854602907913;737.4911311195366;760.7641631094378;764.5450956680766;791.189031242969;5704.629199102045;5767.769289228468;5957.731902064331;5984.521238300926;5997.610155339889;573.5383016671536;576.9740361683735;581.2792137749161;588.0356215806081;590.5600327755849;3377.273886114448;3646.5259516263245;4010.6991975601945;4048.2510735514024;4057.006033521806;13237.801432978513;13960.441582336796;13965.371558279901;13970.650733731738;14009.949253806006;13212.669683257804;13875.889928805671;13890.791638125436;14178.574642760734;14249.78625320621;9837.704868853945;10163.898361016296;10170.186385089175;10173.338732982333;10180.796384072277;6134.294556126102;6237.157983672146;6310.085037669604;6326.588771729823;6386.648734319471;12006.459709312927;12340.074494412775;12364.938175309066;12374.13381063317;12376.81434778497;12429.005679545433;12493.500259989498;12593.559225427067;12799.936000319938;12806.359682015676;7251.782446526613;7911.367090632851;8013;8093.0692970309165;8162.469439486415;7808.57052862098;9778.75553111178;9948.154406875497;9954.004599540278;9955.552000159865;8477.533735644352;8533.53065581399;8594.871076933976;8615.181557752003;8663.436876603;8301.211384918422;8330.333573314241;8379.120192379713;8379.790505237417;8439.831203376021;7310.707571697285;7504.962475187589;7514.436417268836;7514.47398682087;7525.285097915689;5681.204631351697;5780.797672081457;5893.675847828411;5946.226990491208;6010.579259451796;5606.579506536945;5676.120201368794;5874.853128671817;5903.970480147572;6083.69581520931 10:47:08 INFO - PID 1929 | |4;prototype.html;356.7591875484048;383.40572113224493;390.82412914188615;404.52266325735627;411.8970257435639;5967.612105213164;6069.453749162574;6073.817785466437;6080.996635555133;6108.877822443559;5873.412658734124;5882.058870580708;5914.319853216882;5986.161937328778;6141.938580614193;4058.5299568868636;4636.281376386665;4645.839684546702;4653.767311634421;4684.836030738925;3564.590072141698;3707.4438834174953;4348.282428440764;4458.464984201901;4652.069586082797;3700.8897330800787;3746.5504139503296;3882.7476214046137;4235.258829704805;4475.418195634579;3700.389435743099;4376.5623437656295;4380.868573942771;4465.642748580106;4495.123450927071;3256.267339848539;3863.768173909574;3868.207017561393;3873.5545412277665;3887.5140607424073;4735;4914.70511769295;5395.568354531628;5906.586538942276;6002.909956350658;4762.404699412574;4791.760411979387;5347.358317001946;5363.731813409314;5375.354957405137;5659.688717120557;5665.093585026376;6187.721552530102;6471.805845824632;6524.93475065248;3777.527809023872;4207.4109624652265;4356.649438674021;4381.3208952612395;4399.670024748157;6895.75864844728;6926.515143939926;6927.965360173268;6943.930560694379;6958.199807022206;4434.3348497724955;4451.5103338632725;4451.998300382453;4474.395956545824;4494.640428765691;4304.182205380967;4459.598636122764;4526.683132180781;4527.479339875957;4543.136804007294;5309.973450132725;5316.175992721134;5319.685936617584;5322.787088516493;5337.786488540492;5596.300462442195;6199.845003874849;6255.40573645503;6341.23905131378;6576.408123268929;1266.9556565520347;1308.5093090091216;1540.468538354266;1544.143000634636;1550.3798480607848;981.7153025622632;1015.791762688647;1019.4545917934018;1027.8098551767946;1029.9794004119876;5588.882223555305;6179.783707570304;6204.231793938706;6222.595531290543;6247.875042499125;6588.40704336612;6720.495962802809;6720.975560997571;6722.226943901416;6745.494087943423;5940.732667029994;5971.5222782177325;6173;6203.627782333075;6207.937920620826;3306.8511916963794;3413.753979797356;3544.4506101554302;3546.723179655322;3549.201429678302;5418.729063546807;5419.403865574784;6923.2038315594355;6972.860542789116;7029.4376449883885;6042.6978651067275;6997.965010174917;7034.2262351141335;7038.612876291853;7083.316675328801;6910.827229319207;6950.652467376611;6967.352406085655;6989.30106989297;7028.964855175692;6185.072478975972;6754.527183097136;6842.794716158523;6854.520183587101;6903.89644155328;5183.449337204027;5297.920531192112;5576.633724737465;6745.460363171032;6764.188297404343;5945.881082378415;6735.865282694221;6872.896906546306;6921.8961715575315;6973.779588571878;4141.482314710661;4394.264265615128;4425.468943726773;4436.955630443784;4463.620592249695;5558.201071188238;5639.8590035249445;6105.092740645901;6717.328267173243;6736.73053077891;4731.0064886372875;6548.639824809681;6553.837233712768;6581.3747693969;6613.834654133685;5693.5160511357;5930;6439.645819479973;6577.769778057745;6579;5680.971595142163;6388.680565971776;6389.744410223539;6404.839879003062;6405.93594064072;6541.34586541342;6545.836354091186;6546.247181573989;6549.148610680581;6562.9827376756675;4952.925706114339;5516.365617953987;5863.853403664943;5929.9110513341475;6401.807945761635 10:47:08 INFO - PID 1929 | |5;yui.html;661.9040239165321;668.7358493395109;675.5988149818734;691.899674547191;697.1808125452592;15679.686406271867;16699.332026718916;16925.91537042316;16930.49208523743;16944.98330100195;14730.926345368285;15271.541853744378;15395;15424.922875385608;15441;947.3226642950307;963.5134257200104;971.1939090554857;971.3103696375582;971.621067783565;970.257752819094;995.7460847483882;1008.2941940641543;1021.1014307409506;1022.6727447216894;1062.139666869834;1062.3731998121107;1062.3838173859144;1063.457636605333;1066.802641511319;1055.5619417941546;1058.7088550648557;1058.7247315697934;1058.978820423591;1059.385556377307;781.4451739265072;783.91768864269;784.0630446616295;784.356827401531;784.5645666655004;16614.75077873821;16842.242099105446;16885.915570422192;17321.480355589352;17632.294708211655;14549.563513094625;14696.26518674062;14723.263836808117;14728.55814325572;14819.036762610396;11481.48333324994;11529.942350288278;11591.478383472764;11741.178117531776;12066.879331206663;2937.2069541223964;2947.2189869684553;3017.9396412071637;3024.395120975814;3037.817730936129;117191;122141;122562;123472.76527234702;126846.36576817241;10429.322094063862;11220.943895280634;11282.943585282184;11446.94276528612;11489.368084755419;25194.622080668803;25277;25582.488350233263;25604.74395256061;25731.48537029249;7542.2834830691;7749.3413059890545;7759.883601745978;8109.65617886863;8109.75670729879;4106.219818234586;4195.475565554306;4204.495460544754;4249.171411574775;4257.914231870853;4192.979035104805;4296.914061718748;4303.655707543389;4307.612314891675;4312.525622181557;742.4357488308816;822.2640736540762;831.2560258568548;836.7322456813761;859.4928991894812;523.4922125538221;546.4644648244742;553.1343447504643;566.9603127781015;594.3907494817846;9089.272858171462;9410.717678469657;9587.041295870356;10009.009990198016;10178.694639160836;522.8588281164065;546.469924173551;553.6014069869688;567.7360027587109;569.7236840132532;4410.609330402877;4499;4638.698579056756;4727.527247275245;4792.2092854678585;103871;105147;105857;106004;109196;69598;76278;90979.81570644995;96070.03929960611;98616.50691746495;55963;67301.66349168222;78825;81204.18795811966;85580.57209713911;8774.341924355827;10044;10693.923929511217;10970.890291097307;11045.502952367324;31587.84206078955;39805.20389592134;41617.37573936333;41969.79015105027;42114.57885421107;67714;68625.65687171533;68642.65678671574;69519;71766;13316.667083322995;13711.548536786408;13735.931320343334;14014.789778153132;14633.487827926398;12592.811107833206;14255;14706.77939830882;14815.25923703832;14888.032277901902;13457;13533.593992180251;13548.729025419634;13601.387937542637;13666;13124.934375328063;13632.318384080954;13659.286010006179;13678.93160534191;14191.503297384543;13191.34043297812;13261.270630115436;13283.80074298867;13307.733845323233;13758.65603359924;9769.31614786958;9998.103773490846;10005.699829005142;10197;10443.791124177626;7155.633275043717;9362.391444556082;10166.644167454104;10182.796344073226;11253.324800511995 10:47:08 INFO - PID 1929 | __end_tp_report 10:47:08 INFO - PID 1929 | __start_cc_report 10:47:08 INFO - PID 1929 | _x_x_mozilla_cycle_collect,2164 10:47:08 INFO - PID 1929 | __end_cc_report 10:47:08 INFO - PID 1929 | __startTimestamp1491155228949__endTimestamp 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | ------- Summary: start ------- 10:47:08 INFO - PID 1929 | Number of tests: 6 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | [#0] dojo.html Cycles:165 Average:6124.43 Median:6325.53 stddev:725.67 (11.5%) stddev-sans-first:685.41 10:47:08 INFO - PID 1929 | Values: 3005.5 3497.6 3523.0 3528.8 3592.4 6068.1 6141.2 6202.8 6206.6 6224.3 6134.8 6158.0 6189.2 6196.5 6206.7 5246.2 5372.8 5415.4 5426.5 5533.9 5435.0 5507.0 5511.7 5514.0 5522.4 5282.3 5367.4 5377.9 5393.6 5452.9 5272.3 5340.6 5343.7 5357.8 5365.7 5280.2 5342.7 5352.1 5359.5 5364.1 6124.0 6133.0 6135.2 6142.1 6144.3 6456.1 6456.8 6459.9 6460.5 6475.5 6690.2 6699.9 6784.3 6797.1 6802.9 6288.3 6300.3 6305.0 6309.1 6314.7 6568.6 6847.7 6855.8 6860.7 6863.8 6322.9 6479.8 6545.4 6570.3 6573.2 6722.2 6730.0 6733.3 6738.2 6740.8 6628.9 6630.5 6634.0 6647.5 6648.7 6354.1 6409.2 6424.7 6587.8 6657.8 5326.6 5369.9 5372.4 5397.8 5416.1 4706.7 4711.6 4714.6 4726.3 4735.1 5188.6 6238.9 6304.9 6325.8 6330.3 6525.2 6659.3 6691.6 6706.1 6749.6 6295.4 6309.7 6312.0 6316.0 6321.0 5937.7 5953.6 5964.2 5972.2 5977.3 6581.0 6663.7 6665.4 6824.9 6833.4 6453.0 6553.0 6764.6 6771.5 6787.7 6681.1 6839.0 6866.5 6916.2 6930.7 6600.8 6649.7 6660.0 6670.2 6672.8 6447.7 6753.2 6766.3 6768.8 6774.5 6308.2 6350.7 6440.0 6451.9 6466.5 6368.3 6490.8 6508.1 6511.2 6527.4 6312.6 6329.6 6380.6 6381.1 6395.2 6252.0 6325.5 6330.3 6364.7 6522.8 6268.1 6271.7 6274.6 6281.5 6296.8 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | [#1] ext.html Cycles:180 Average:52282.71 Median:32767.17 stddev:107206.94 (327.2%) stddev-sans-first:107437.84 10:47:08 INFO - PID 1929 | Values: 741.5 807.2 1125.9 1146.2 1148.2 36670.4 37351.6 37573.0 37631.4 37656.2 39122.2 39494.8 39531.4 39538.4 39575.8 6138.5 6294.9 8641.7 8813.4 8833.9 8597.1 8781.6 8787.6 8792.2 8812.0 8790.8 8871.3 8873.4 8873.6 8880.8 8766.1 8844.9 8877.7 8878.2 8879.7 8644.9 8704.2 8723.9 8727.0 8731.8 38674.4 38798.4 38856.6 38870.4 38874.0 2950.7 2952.9 2953.2 2960.1 2979.6 22640.0 26847.5 26935.9 26979.7 28146.6 2802.8 2812.2 2827.5 2828.1 2830.6 309660.0 310520.0 311927.4 312277.0 314146.9 39772.6 40040.6 40074.0 47711.8 47980.3 41539.6 41602.6 41605.4 41626.6 51396.5 14485.9 14764.3 14782.7 14790.0 14795.4 10026.4 10194.0 10195.6 10196.4 11866.3 11999.8 12118.2 13234.2 13420.8 13474.5 5155.5 5317.2 5436.0 5641.3 5868.7 899.6 941.5 968.9 969.7 1002.6 22060.7 22477.8 22568.5 23806.2 23889.5 1067.3 1074.8 1082.8 1104.3 1121.9 10230.1 10646.8 11761.2 12117.6 12224.1 405630.0 436303.0 437303.0 438213.8 438657.0 48189.8 55839.2 55885.4 55976.6 56092.0 1412.7 1448.4 1500.6 1507.4 1518.0 21815.8 23399.6 23443.6 23445.9 23487.5 31874.0 38108.6 38123.6 38124.8 38155.4 450924.0 451487.0 452149.0 452655.0 454194.0 27215.3 32225.7 32543.3 32543.5 32795.7 32737.2 32738.7 40852.2 41448.1 41974.6 27269.5 28547.3 28971.3 29525.0 29658.0 28638.0 29215.6 29299.6 29458.4 29590.0 34444.7 34515.3 34850.8 34862.3 34874.5 24729.0 26696.7 28339.4 29229.7 29318.7 22135.6 22938.9 22986.4 23265.2 23732.5 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | [#2] jquery.html Cycles:180 Average:39890.09 Median:22691.22 stddev:110961.62 (489.0%) stddev-sans-first:111233.33 10:47:08 INFO - PID 1929 | Values: 425.1 427.6 434.4 439.3 452.3 21593.7 22504.4 22782.0 23310.0 23601.5 22014.0 22626.8 22755.7 22943.3 23205.1 5952.6 6209.4 6254.7 6529.3 6542.7 6175.6 6246.7 6281.4 6288.7 6291.6 6280.7 6319.1 6326.9 6333.8 6337.0 6104.5 6227.4 6303.1 6314.6 6337.6 5636.6 5637.3 5642.9 5652.5 5673.7 27253.9 27394.3 28008.9 28322.3 28735.6 1853.7 2038.8 2048.8 2048.8 2080.6 15407.8 16536.0 16554.7 16630.0 17280.0 1874.7 1891.7 1909.2 1911.6 1979.7 151516.0 158996.0 160448.0 161696.2 162149.0 12247.5 12455.4 12466.8 12534.0 12608.7 16735.0 16754.7 16759.6 16763.9 16785.5 7663.0 8814.7 9037.6 9054.0 9192.6 8657.5 8662.9 8665.4 8843.6 8860.5 7002.1 7081.4 7688.3 7799.8 7830.5 1790.9 1846.7 2079.9 2104.7 2297.8 818.1 915.9 925.9 932.3 962.7 19581.5 20888.8 21121.9 21153.7 21237.5 951.5 955.3 993.0 994.6 997.3 8277.8 8786.5 9584.0 10577.5 11151.1 598045.0 638794.0 652428.0 697901.0 701098.0 107894.0 150754.0 158577.0 158760.0 164341.0 1112.3 1147.3 1156.6 1165.2 1169.6 21160.6 22096.8 22425.0 22528.8 22542.1 62400.0 62489.4 64808.0 64953.0 65825.7 64607.7 88841.0 89804.6 90672.5 90823.5 8793.7 8808.5 8825.3 8965.6 12994.7 13836.8 14038.9 14441.7 14657.5 14659.3 11452.5 11809.0 12160.7 12198.9 12321.1 11313.7 11419.0 11440.8 11817.9 11832.0 12058.3 12165.8 12477.6 12490.1 12556.1 13141.3 13148.2 13568.7 13597.4 13678.2 11742.4 11933.6 12168.8 12229.6 12277.7 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | [#3] mootools.html Cycles:180 Average:6662.13 Median:3536.69 stddev:4184.12 (118.3%) stddev-sans-first:4176.62 10:47:08 INFO - PID 1929 | Values: 1322.3 1376.4 1394.9 1397.6 1397.6 10320.3 10757.6 10774.8 10778.4 10781.2 10512.4 10669.1 11045.3 11081.6 11102.6 2093.1 2412.0 2445.4 2459.4 2460.6 2252.4 2379.1 2389.3 2398.4 2438.7 2025.2 2121.0 2344.7 2441.8 2447.4 2422.4 2446.5 2448.2 2449.7 2451.0 2413.1 2427.1 2427.2 2473.3 2476.9 10969.7 11123.8 11127.4 11131.7 11140.2 6146.8 6378.0 6399.0 6403.5 6414.6 3426.8 3685.0 3729.2 3980.2 4025.8 1156.9 1173.3 1201.1 1225.2 1230.0 15071.7 15086.7 15202.0 15204.8 15235.8 4999.4 5103.9 5302.7 5351.3 5410.0 11279.4 11280.4 11285.9 11291.6 11297.0 6224.5 6228.7 6229.3 6232.1 6235.6 5620.1 5744.4 5755.2 5832.4 5834.2 3995.9 4105.7 4128.3 4147.8 4150.9 1243.1 1246.3 1250.6 1262.3 1268.7 727.0 737.5 760.8 764.5 791.2 5704.6 5767.8 5957.7 5984.5 5997.6 573.5 577.0 581.3 588.0 590.6 3377.3 3646.5 4010.7 4048.3 4057.0 13237.8 13960.4 13965.4 13970.7 14009.9 13212.7 13875.9 13890.8 14178.6 14249.8 9837.7 10163.9 10170.2 10173.3 10180.8 6134.3 6237.2 6310.1 6326.6 6386.6 12006.5 12340.1 12364.9 12374.1 12376.8 12429.0 12493.5 12593.6 12799.9 12806.4 7251.8 7911.4 8013.0 8093.1 8162.5 7808.6 9778.8 9948.2 9954.0 9955.6 8477.5 8533.5 8594.9 8615.2 8663.4 8301.2 8330.3 8379.1 8379.8 8439.8 7310.7 7505.0 7514.4 7514.5 7525.3 5681.2 5780.8 5893.7 5946.2 6010.6 5606.6 5676.1 5874.9 5904.0 6083.7 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | [#4] prototype.html Cycles:180 Average:5198.81 Median:5673.03 stddev:1660.73 (29.3%) stddev-sans-first:1625.13 10:47:08 INFO - PID 1929 | Values: 356.8 383.4 390.8 404.5 411.9 5967.6 6069.5 6073.8 6081.0 6108.9 5873.4 5882.1 5914.3 5986.2 6141.9 4058.5 4636.3 4645.8 4653.8 4684.8 3564.6 3707.4 4348.3 4458.5 4652.1 3700.9 3746.6 3882.7 4235.3 4475.4 3700.4 4376.6 4380.9 4465.6 4495.1 3256.3 3863.8 3868.2 3873.6 3887.5 4735.0 4914.7 5395.6 5906.6 6002.9 4762.4 4791.8 5347.4 5363.7 5375.4 5659.7 5665.1 6187.7 6471.8 6524.9 3777.5 4207.4 4356.6 4381.3 4399.7 6895.8 6926.5 6928.0 6943.9 6958.2 4434.3 4451.5 4452.0 4474.4 4494.6 4304.2 4459.6 4526.7 4527.5 4543.1 5310.0 5316.2 5319.7 5322.8 5337.8 5596.3 6199.8 6255.4 6341.2 6576.4 1267.0 1308.5 1540.5 1544.1 1550.4 981.7 1015.8 1019.5 1027.8 1030.0 5588.9 6179.8 6204.2 6222.6 6247.9 6588.4 6720.5 6721.0 6722.2 6745.5 5940.7 5971.5 6173.0 6203.6 6207.9 3306.9 3413.8 3544.5 3546.7 3549.2 5418.7 5419.4 6923.2 6972.9 7029.4 6042.7 6998.0 7034.2 7038.6 7083.3 6910.8 6950.7 6967.4 6989.3 7029.0 6185.1 6754.5 6842.8 6854.5 6903.9 5183.4 5297.9 5576.6 6745.5 6764.2 5945.9 6735.9 6872.9 6921.9 6973.8 4141.5 4394.3 4425.5 4437.0 4463.6 5558.2 5639.9 6105.1 6717.3 6736.7 4731.0 6548.6 6553.8 6581.4 6613.8 5693.5 5930.0 6439.6 6577.8 6579.0 5681.0 6388.7 6389.7 6404.8 6405.9 6541.3 6545.8 6546.2 6549.1 6563.0 4952.9 5516.4 5863.9 5929.9 6401.8 10:47:08 INFO - PID 1929 | 10:47:08 INFO - PID 1929 | [#5] yui.html Cycles:180 Average:20805.74 Median:25235.81 stddev:30622.23 (121.3%) stddev-sans-first:30670.78 10:47:08 INFO - PID 1929 | Values: 661.9 668.7 675.6 691.9 697.2 15679.7 16699.3 16925.9 16930.5 16945.0 14730.9 15271.5 15395.0 15424.9 15441.0 947.3 963.5 971.2 971.3 971.6 970.3 995.7 1008.3 1021.1 1022.7 1062.1 1062.4 1062.4 1063.5 1066.8 1055.6 1058.7 1058.7 1059.0 1059.4 781.4 783.9 784.1 784.4 784.6 16614.8 16842.2 16885.9 17321.5 17632.3 14549.6 14696.3 14723.3 14728.6 14819.0 11481.5 11529.9 11591.5 11741.2 12066.9 2937.2 2947.2 3017.9 3024.4 3037.8 117191.0 122141.0 122562.0 123472.8 126846.4 10429.3 11220.9 11282.9 11446.9 11489.4 25194.6 25277.0 25582.5 25604.7 25731.5 7542.3 7749.3 7759.9 8109.7 8109.8 4106.2 4195.5 4204.5 4249.2 4257.9 4193.0 4296.9 4303.7 4307.6 4312.5 742.4 822.3 831.3 836.7 859.5 523.5 546.5 553.1 567.0 594.4 9089.3 9410.7 9587.0 10009.0 10178.7 522.9 546.5 553.6 567.7 569.7 4410.6 4499.0 4638.7 4727.5 4792.2 103871.0 105147.0 105857.0 106004.0 109196.0 69598.0 76278.0 90979.8 96070.0 98616.5 55963.0 67301.7 78825.0 81204.2 85580.6 8774.3 10044.0 10693.9 10970.9 11045.5 31587.8 39805.2 41617.4 41969.8 42114.6 67714.0 68625.7 68642.7 69519.0 71766.0 13316.7 13711.5 13735.9 14014.8 14633.5 12592.8 14255.0 14706.8 14815.3 14888.0 13457.0 13533.6 13548.7 13601.4 13666.0 13124.9 13632.3 13659.3 13678.9 14191.5 13191.3 13261.3 13283.8 13307.7 13758.7 9769.3 9998.1 10005.7 10197.0 10443.8 7155.6 9362.4 10166.6 10182.8 11253.3 10:47:08 INFO - PID 1929 | -------- Summary: end -------- 10:47:08 INFO - PID 1929 | 10:47:09 INFO - TEST-INFO | 1929: exit 0 10:47:09 INFO - TEST-OK | dromaeo_css | took 1121798ms 10:47:09 INFO - TEST-START | kraken 10:47:09 INFO - operating with platform_type : mac_ 10:47:09 INFO - Initialising browser for kraken test... 10:47:09 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpB1wOKT/profile http://localhost:56626/getInfo.html) 10:47:12 INFO - PID 1935 | __metrics Screen width/height:1600/1200 10:47:12 INFO - PID 1935 | colorDepth:24 10:47:12 INFO - PID 1935 | Browser inner width/height: 1024/689 10:47:12 INFO - PID 1935 | __metrics 10:47:12 INFO - PID 1935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:47:12 INFO - PID 1935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:13 INFO - TEST-INFO | 1935: exit 0 10:47:13 INFO - Browser initialized. 10:47:13 INFO - Running cycle 1/1 for kraken test... 10:47:13 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpB1wOKT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:25 INFO - PID 1936 | RSS: Main: 233242624 10:47:25 INFO - PID 1936 | 10:47:28 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56626/tests/kraken/driver.html?testName=audio-beat-detection) 10:47:29 INFO - PID 1936 | RSS: Main: 287256576 10:47:29 INFO - PID 1936 | 10:47:31 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56626/tests/kraken/driver.html?testName=audio-dft) 10:47:32 INFO - PID 1936 | RSS: Main: 287170560 10:47:32 INFO - PID 1936 | 10:47:36 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56626/tests/kraken/driver.html?testName=audio-fft) 10:47:36 INFO - PID 1936 | RSS: Main: 380313600 10:47:36 INFO - PID 1936 | 10:47:38 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56626/tests/kraken/driver.html?testName=audio-oscillator) 10:47:39 INFO - PID 1936 | RSS: Main: 284483584 10:47:39 INFO - PID 1936 | 10:47:41 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:47:42 INFO - PID 1936 | RSS: Main: 285114368 10:47:42 INFO - PID 1936 | 10:47:45 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56626/tests/kraken/driver.html?testName=imaging-darkroom) 10:47:45 INFO - PID 1936 | RSS: Main: 324837376 10:47:45 INFO - PID 1936 | 10:47:49 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56626/tests/kraken/driver.html?testName=imaging-desaturate) 10:47:49 INFO - PID 1936 | RSS: Main: 345931776 10:47:49 INFO - PID 1936 | 10:47:52 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56626/tests/kraken/driver.html?testName=json-parse-financial) 10:47:53 INFO - PID 1936 | RSS: Main: 357670912 10:47:53 INFO - PID 1936 | 10:47:55 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:47:55 INFO - PID 1936 | RSS: Main: 304140288 10:47:55 INFO - PID 1936 | 10:47:57 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:47:58 INFO - PID 1936 | RSS: Main: 309649408 10:47:58 INFO - PID 1936 | 10:48:00 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:48:01 INFO - PID 1936 | RSS: Main: 311939072 10:48:01 INFO - PID 1936 | 10:48:04 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:48:05 INFO - PID 1936 | RSS: Main: 327720960 10:48:05 INFO - PID 1936 | 10:48:08 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:09 INFO - PID 1936 | RSS: Main: 310714368 10:48:09 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:56626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56626/tests/kraken/driver.html?testName=ai-astar) 10:48:11 INFO - PID 1936 | RSS: Main: 376393728 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | __start_tp_report 10:48:11 INFO - PID 1936 | _x_x_mozilla_page_load 10:48:11 INFO - PID 1936 | _x_x_mozilla_page_load_details 10:48:11 INFO - PID 1936 | |i|pagename|runs| 10:48:11 INFO - PID 1936 | |0;ai-astar;110;137;178;148;121;122;122;125;122;123 10:48:11 INFO - PID 1936 | |1;audio-beat-detection;159;118;119;164;120;117;119;117;143;125 10:48:11 INFO - PID 1936 | |2;audio-dft;211;209;215;215;214;209;218;210;221;220 10:48:11 INFO - PID 1936 | |3;audio-fft;86;62;63;100;64;63;61;60;82;63 10:48:11 INFO - PID 1936 | |4;audio-oscillator;92;74;98;78;76;73;89;72;73;91 10:48:11 INFO - PID 1936 | |5;imaging-gaussian-blur;92;89;93;94;91;91;92;92;93;92 10:48:11 INFO - PID 1936 | |6;imaging-darkroom;101;103;102;102;102;101;100;101;101;101 10:48:11 INFO - PID 1936 | |7;imaging-desaturate;157;109;103;102;101;101;101;101;101;100 10:48:11 INFO - PID 1936 | |8;json-parse-financial;53;50;51;52;51;52;52;52;53;52 10:48:11 INFO - PID 1936 | |9;json-stringify-tinderbox;58;67;64;71;70;68;67;64;63;65 10:48:11 INFO - PID 1936 | |10;stanford-crypto-aes;88;92;88;91;93;79;94;105;115;117 10:48:11 INFO - PID 1936 | |11;stanford-crypto-ccm;172;181;158;150;186;184;171;167;208;149 10:48:11 INFO - PID 1936 | |12;stanford-crypto-pbkdf2;202;206;205;203;205;207;190;257;250;201 10:48:11 INFO - PID 1936 | |13;stanford-crypto-sha256-iterative;78;92;106;71;72;75;72;72;74;75 10:48:11 INFO - PID 1936 | __end_tp_report 10:48:11 INFO - PID 1936 | __start_cc_report 10:48:11 INFO - PID 1936 | _x_x_mozilla_cycle_collect,2194 10:48:11 INFO - PID 1936 | __end_cc_report 10:48:11 INFO - PID 1936 | __startTimestamp1491155291644__endTimestamp 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | ------- Summary: start ------- 10:48:11 INFO - PID 1936 | Number of tests: 14 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#0] ai-astar Cycles:10 Average:130.80 Median:124.00 stddev:19.49 (15.7%) stddev-sans-first:19.16 10:48:11 INFO - PID 1936 | Values: 110.0 137.0 178.0 148.0 121.0 122.0 122.0 125.0 122.0 123.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:122.50 stddev:18.30 (14.9%) stddev-sans-first:16.15 10:48:11 INFO - PID 1936 | Values: 159.0 118.0 119.0 164.0 120.0 117.0 119.0 117.0 143.0 125.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#2] audio-dft Cycles:10 Average:214.20 Median:215.00 stddev:4.44 (2.1%) stddev-sans-first:4.56 10:48:11 INFO - PID 1936 | Values: 211.0 209.0 215.0 215.0 214.0 209.0 218.0 210.0 221.0 220.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#3] audio-fft Cycles:10 Average:70.40 Median:63.00 stddev:13.85 (22.0%) stddev-sans-first:13.49 10:48:11 INFO - PID 1936 | Values: 86.0 62.0 63.0 100.0 64.0 63.0 61.0 60.0 82.0 63.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:83.50 stddev:9.79 (11.7%) stddev-sans-first:9.63 10:48:11 INFO - PID 1936 | Values: 92.0 74.0 98.0 78.0 76.0 73.0 89.0 72.0 73.0 91.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:92.00 stddev:1.37 (1.5%) stddev-sans-first:1.45 10:48:11 INFO - PID 1936 | Values: 92.0 89.0 93.0 94.0 91.0 91.0 92.0 92.0 93.0 92.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:101.50 stddev:0.84 (0.8%) stddev-sans-first:0.88 10:48:11 INFO - PID 1936 | Values: 101.0 103.0 102.0 102.0 102.0 101.0 100.0 101.0 101.0 101.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#7] imaging-desaturate Cycles:10 Average:107.60 Median:101.50 stddev:17.54 (17.3%) stddev-sans-first:2.71 10:48:11 INFO - PID 1936 | Values: 157.0 109.0 103.0 102.0 101.0 101.0 101.0 101.0 101.0 100.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.87 10:48:11 INFO - PID 1936 | Values: 53.0 50.0 51.0 52.0 51.0 52.0 52.0 52.0 53.0 52.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:67.00 stddev:3.77 (5.6%) stddev-sans-first:2.79 10:48:11 INFO - PID 1936 | Values: 58.0 67.0 64.0 71.0 70.0 68.0 67.0 64.0 63.0 65.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:89.50 stddev:12.26 (13.7%) stddev-sans-first:12.64 10:48:11 INFO - PID 1936 | Values: 88.0 92.0 88.0 91.0 93.0 79.0 94.0 105.0 115.0 117.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:172.60 Median:176.50 stddev:18.10 (10.3%) stddev-sans-first:19.20 10:48:11 INFO - PID 1936 | Values: 172.0 181.0 158.0 150.0 186.0 184.0 171.0 167.0 208.0 149.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:212.60 Median:205.50 stddev:22.14 (10.8%) stddev-sans-first:23.15 10:48:11 INFO - PID 1936 | Values: 202.0 206.0 205.0 203.0 205.0 207.0 190.0 257.0 250.0 201.0 10:48:11 INFO - PID 1936 | 10:48:11 INFO - PID 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:74.50 stddev:11.38 (15.3%) stddev-sans-first:12.07 10:48:11 INFO - PID 1936 | Values: 78.0 92.0 106.0 71.0 72.0 75.0 72.0 72.0 74.0 75.0 10:48:11 INFO - PID 1936 | -------- Summary: end -------- 10:48:11 INFO - PID 1936 | 10:48:12 INFO - TEST-INFO | 1936: exit 0 10:48:12 INFO - TEST-OK | kraken | took 62929ms 10:48:12 INFO - SUITE-END | took 1184s 10:48:12 INFO - Completed test suite (00:19:44) 10:48:12 INFO - javascript benchmark 10:48:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7657.116427665565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.5341422079587, 3497.5659979408438, 3523.048776830254, 3528.770629909054, 3592.4431713084464, 6068.059450785125, 6141.209856312073, 6202.844928876774, 6206.565540412173, 6224.253089629246, 6134.773364742522, 6157.969210153943, 6189.164462797521, 6196.473299769525, 6206.6586337751405, 5246.160614301693, 5372.785088596452, 5415.404305526379, 5426.511613954744, 5533.889322213553, 5435.0, 5506.981208476444, 5511.696856672881, 5514.0, 5522.3649280332675, 5282.286891269668, 5367.355917289911, 5377.865553361158, 5393.649412788156, 5452.91820622691, 5272.340957380327, 5340.572754179656, 5343.732813359316, 5357.785688572452, 5365.651232669903, 5280.155175171993, 5342.679439233659, 5352.090144675414, 5359.5444387227135, 5364.088105022156, 6124.045297608081, 6132.967444181115, 6135.2143331386815, 6142.099766648166, 6144.293406258293, 6456.128422662928, 6456.7740129095255, 6459.935400646027, 6460.547761656686, 6475.481961443121, 6690.197176338822, 6699.933000669979, 6784.321567843225, 6797.082393876813, 6802.931970680279, 6288.308286088527, 6300.3384644612115, 6304.968475157641, 6309.116723658692, 6314.747410103544, 6568.6058836469965, 6847.691853866588, 6855.794326170223, 6860.725570977205, 6863.794086177422, 6322.873542529123, 6479.8056058318325, 6545.443637290884, 6570.277269500351, 6573.244076931119, 6722.193336799615, 6730.0, 6733.259341472434, 6738.225104113089, 6740.797776066725, 6628.900566491507, 6630.53586248958, 6634.0, 6647.5346725729705, 6648.7340506379205, 6354.110424540568, 6409.198850143732, 6424.743010279536, 6587.80236592903, 6657.833554161185, 5326.600504962066, 5369.865753356119, 5372.409035006224, 5397.8380648580605, 5416.0792665247, 4706.670533062721, 4711.575958163782, 4714.622830173578, 4726.338312636233, 4735.147673418817, 5188.610854185951, 6238.875222495615, 6304.873902521924, 6325.7785977491485, 6330.335314791972, 6525.184351956005, 6659.300773418721, 6691.59850408977, 6706.094677218513, 6749.595024298558, 6295.37046295376, 6309.652969086745, 6311.968440157862, 6316.021016742412, 6320.988641817287, 5937.70311484424, 5953.613015154001, 5964.194833697396, 5972.223610930638, 5977.342492325841, 6581.012848072827, 6663.666816659244, 6665.433438157617, 6824.863502730017, 6833.384995350442, 6452.9677351612945, 6552.967235163794, 6764.594124352555, 6771.458283337222, 6787.728490860311, 6681.09805176295, 6839.042534045338, 6866.450683945172, 6916.20463646687, 6930.7227710891, 6600.8349791255605, 6649.700763465559, 6660.0, 6670.199576050905, 6672.799816005528, 6447.677616119082, 6753.2233793112455, 6766.323367663194, 6768.796936091925, 6774.525783195326, 6308.211473565804, 6350.650714210763, 6440.0, 6451.903221451776, 6466.515011374072, 6368.299487056327, 6490.772822951174, 6508.088867558451, 6511.153550038654, 6527.379898909596, 6312.589681670676, 6329.620222786648, 6380.585261957958, 6381.106645069601, 6395.232572091379, 6251.968740156452, 6325.525585581007, 6330.272018717907, 6364.745410183726, 6522.7717029905625, 6268.091126786499, 6271.717772700331, 6274.560780745486, 6281.466075383643, 6296.842578935563], "value": 6073.841718045888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.514308128176, 807.2049031703771, 1125.9493322800474, 1146.1804809561156, 1148.1733152130473, 36670.44994325084, 37351.62648373519, 37573.0, 37631.435528467024, 37656.24687506252, 39122.21755564887, 39494.81515554531, 39531.40702889459, 39538.40692389617, 39575.80212098943, 6138.508919286446, 6294.874102517947, 8641.697540586065, 8813.38306318558, 8833.911660883405, 8597.140285971383, 8781.56092195391, 8787.64849406023, 8792.208701216889, 8812.030676625565, 8790.824183516326, 8871.334649901251, 8873.378863479527, 8873.645054197825, 8880.822383552326, 8766.079561646031, 8844.911550884506, 8877.73366798997, 8878.200961913459, 8879.689210877588, 8644.870326945102, 8704.173103555153, 8723.869141962876, 8726.956365218133, 8731.825363492695, 38674.41988370177, 38798.41802372967, 38856.61143388587, 38870.41694374587, 38874.0, 2950.7196816302417, 2952.8818847246084, 2953.246922034889, 2960.141558947924, 2979.597754303163, 22640.0, 26847.463050739072, 26935.865320673467, 26979.745367502423, 28146.577801333, 2802.831830090201, 2812.1704097291145, 2827.5193217153133, 2828.1091456191234, 2830.6320178376886, 309660.0, 310520.0, 311927.4403627967, 312277.0, 314146.85853141407, 39772.60227397689, 40040.59959400369, 40074.0, 47711.761441192575, 47980.280295795594, 41539.58460415417, 41602.58397416048, 41605.37591936063, 41626.58373416288, 51396.48603513992, 14485.85514144845, 14764.26178691061, 14782.704345913022, 14789.96470247094, 14795.408183672747, 10026.448545329931, 10194.031567001271, 10195.643152489627, 10196.388216706873, 11866.288022718665, 11999.760004799855, 12118.151729378858, 13234.20594764298, 13420.792128708463, 13474.461021559224, 5155.536001759785, 5317.229001794795, 5436.0, 5641.26663533738, 5868.706564671749, 899.581694512055, 941.4962994797887, 968.8595153702673, 969.680005598165, 1002.6190047781796, 22060.669089963663, 22477.77522224757, 22568.54862902733, 23806.16678416247, 23889.52220955571, 1067.2849191042021, 1074.8441475985937, 1082.783443311341, 1104.3042882983668, 1121.9158563107799, 10230.08708156906, 10646.840297395545, 11761.235519691192, 12117.575884844164, 12224.083193760503, 405630.0, 436303.0, 437303.0, 438213.80893095967, 438657.0, 48189.75905120452, 55839.16241256303, 55885.441145588025, 55976.60058498489, 56092.0, 1412.6680230145907, 1448.43511030696, 1500.6398464368692, 1507.366905899525, 1517.9772303415457, 21815.80013099295, 23399.649005264593, 23443.648345275175, 23445.88277058604, 23487.53024939526, 31874.0, 38108.61891381162, 38123.618763813116, 38124.809375952944, 38155.42766858444, 450924.0, 451487.0, 452149.0, 452655.0, 454194.0, 27215.319617009733, 32225.677743222266, 32543.34913301768, 32543.511847321835, 32795.672043279264, 32737.18157046093, 32738.672613274513, 40852.182956341305, 41448.0986330954, 41974.58025419707, 27269.45461090807, 28547.28631784222, 28971.275718107216, 29525.0, 29658.0, 28638.0, 29215.561766573093, 29299.56050659199, 29458.410831783673, 29590.0, 34444.65555344414, 34515.30969380548, 34850.82574587111, 34862.30275394529, 34874.47688284729, 24729.0, 26696.733032669425, 28339.43321133607, 29229.7077029227, 29318.7068129316, 22135.55728885381, 22938.885305573367, 22986.42533936665, 23265.18571850045, 23732.525349492567], "value": 17197.085207461667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.1347481687443, 427.64078174333594, 434.38751360581585, 439.31247597509895, 452.27635782747586, 21593.67609485857, 22504.437389065282, 22782.0, 23310.0, 23601.5279694406, 22014.0, 22626.77373226267, 22755.658665120038, 22943.311700649007, 23205.071797128137, 5952.613080149798, 6209.441150296472, 6254.718537665816, 6529.347065293457, 6542.672866356663, 6175.567710260261, 6246.718897649616, 6281.40326668968, 6288.748450062015, 6291.559590828644, 6280.717367718441, 6319.083732858733, 6326.905096423534, 6333.778317758879, 6337.0, 6104.511639068864, 6227.377262273736, 6303.117563541108, 6314.589551679126, 6337.588056776295, 5636.633618814764, 5637.3235211774845, 5642.85892852682, 5652.5195358394585, 5673.716314184316, 27253.86373068122, 27394.315142121406, 28008.859955700296, 28322.29194270139, 28735.56896646552, 1853.6848735714962, 2038.8063134002246, 2048.7541495020546, 2048.764392094913, 2080.6358887194833, 15407.845921540866, 16535.958120185533, 16554.668906621922, 16630.002199868046, 17279.96320220791, 1874.7375367448567, 1891.7067854482577, 1909.1695112625914, 1911.6176764647125, 1979.6832506798987, 151516.0, 158996.0, 160447.99999999884, 161696.19151904166, 162149.0, 12247.530296364494, 12455.377231138407, 12466.75066498683, 12534.0, 12608.684782880318, 16734.98770221372, 16754.66490670204, 16759.581010474834, 16763.91618041902, 16785.475050239587, 7662.961685191538, 8814.735557933273, 9037.638494460149, 9054.049324820931, 9192.63229470827, 8657.52383618907, 8662.87005694915, 8665.393422460367, 8843.646254149762, 8860.468371897707, 7002.124734408199, 7081.362677359062, 7688.269614386736, 7799.844003120019, 7830.491018083806, 1790.8806995627733, 1846.658368201887, 2079.9480012999798, 2104.6948192512, 2297.7587353327995, 818.1286929420148, 915.8855143107112, 925.9166674999283, 932.3147486597481, 962.6919385796618, 19581.51046223856, 20888.791112088686, 21121.9439028048, 21153.67309595943, 21237.46906327354, 951.4624237306039, 955.2739917662626, 992.9851052234222, 994.627014869424, 997.3018886779283, 8277.83444331122, 8786.516741579147, 9584.0, 10577.471126443646, 11151.052160566443, 598045.0, 638794.0, 652428.0, 697901.0, 701098.0, 107894.0, 150754.0, 158577.0, 158760.0, 164341.0, 1112.2603468693228, 1147.3345459633392, 1156.6067537037616, 1165.2251252916715, 1169.6491052684162, 21160.576788464452, 22096.779032210114, 22425.0, 22528.774712253322, 22542.098316067175, 62400.0, 62489.43776405626, 64808.0, 64953.0, 65825.67087164533, 64607.67696161489, 88841.0, 89804.5509772447, 90672.5466372664, 90823.54588227016, 8793.692220772242, 8808.471491710518, 8825.293976481738, 8965.596548155218, 12994.675133121747, 13836.792448113085, 14038.859611403755, 14441.711165776416, 14657.48698795537, 14659.340329685403, 11452.484638191134, 11808.99623531975, 12160.695982600506, 12198.878011219775, 12321.137520373488, 11313.71715707114, 11419.02938250258, 11440.771184576095, 11817.936385725327, 11832.0, 12058.336791476202, 12165.81751273714, 12477.563285284972, 12490.06324525646, 12556.121071524905, 13141.277229752455, 13148.211107333591, 13568.660783480493, 13597.388117534536, 13678.247696376397, 11742.354170520703, 11933.641990740292, 12168.75662486763, 12229.633111006684, 12277.69305767363], "value": 10731.004635956164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.3388305847077, 1376.3599926034392, 1394.8605139486049, 1397.5946975377142, 1397.6170629077424, 10320.329178603395, 10757.569697212111, 10774.838377424345, 10778.407187604678, 10781.245312828105, 10512.369257844535, 10669.146468282539, 11045.28205666633, 11081.612143574977, 11102.6114086007, 2093.079045220106, 2411.963820542689, 2445.425325048621, 2459.385153711572, 2460.6432067350224, 2252.414372263207, 2379.0721618568773, 2389.2593296078185, 2398.37642213025, 2438.719547252071, 2025.1696804310236, 2121.045529511718, 2344.749040920718, 2441.7680320369536, 2447.4248551590363, 2422.39440139965, 2446.5473887330813, 2448.2165706973774, 2449.669294645218, 2451.044092803808, 2413.1312727418117, 2427.1019722702536, 2427.186892391051, 2473.2951108933867, 2476.938076548083, 10969.670909872717, 11123.777524449466, 11127.387993660346, 11131.666050018512, 11140.220184587082, 6146.815595532141, 6378.043293505965, 6399.0, 6403.519736019817, 6414.583052101645, 3426.8457919393436, 3685.0, 3729.216864458467, 3980.223856348013, 4025.798710064485, 1156.9421528923604, 1173.3312012153076, 1201.0871737479579, 1225.209739717886, 1229.9508019679292, 15071.698566028728, 15086.698266034618, 15202.0, 15204.847951520454, 15235.771463427947, 4999.375078115236, 5103.923441148386, 5302.708351040653, 5351.331083614548, 5409.972950135224, 11279.379634120201, 11280.379579123228, 11285.943570282096, 11291.604793832177, 11297.03975162104, 6224.470919971853, 6228.657423841732, 6229.314775374705, 6232.127502149703, 6235.563510554218, 5620.100783874561, 5744.396838331999, 5755.22304488897, 5832.416758324133, 5834.154047663065, 3995.8507651995496, 4105.67154627629, 4128.318827393447, 4147.792610369469, 4150.8547200847825, 1243.1360204657676, 1246.3394400967502, 1250.5998080614297, 1262.2868079535033, 1268.67014576209, 726.9854602907913, 737.4911311195366, 760.7641631094378, 764.5450956680766, 791.189031242969, 5704.629199102045, 5767.769289228468, 5957.731902064331, 5984.521238300926, 5997.610155339889, 573.5383016671536, 576.9740361683735, 581.2792137749161, 588.0356215806081, 590.5600327755849, 3377.273886114448, 3646.5259516263245, 4010.6991975601945, 4048.2510735514024, 4057.006033521806, 13237.801432978513, 13960.441582336796, 13965.371558279901, 13970.650733731738, 14009.949253806006, 13212.669683257804, 13875.889928805671, 13890.791638125436, 14178.574642760734, 14249.78625320621, 9837.704868853945, 10163.898361016296, 10170.186385089175, 10173.338732982333, 10180.796384072277, 6134.294556126102, 6237.157983672146, 6310.085037669604, 6326.588771729823, 6386.648734319471, 12006.459709312927, 12340.074494412775, 12364.938175309066, 12374.13381063317, 12376.81434778497, 12429.005679545433, 12493.500259989498, 12593.559225427067, 12799.936000319938, 12806.359682015676, 7251.782446526613, 7911.367090632851, 8013.0, 8093.0692970309165, 8162.469439486415, 7808.57052862098, 9778.75553111178, 9948.154406875497, 9954.004599540278, 9955.552000159865, 8477.533735644352, 8533.53065581399, 8594.871076933976, 8615.181557752003, 8663.436876603, 8301.211384918422, 8330.333573314241, 8379.120192379713, 8379.790505237417, 8439.831203376021, 7310.707571697285, 7504.962475187589, 7514.436417268836, 7514.47398682087, 7525.285097915689, 5681.204631351697, 5780.797672081457, 5893.675847828411, 5946.226990491208, 6010.579259451796, 5606.579506536945, 5676.120201368794, 5874.853128671817, 5903.970480147572, 6083.69581520931], "value": 5018.534134595146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7591875484048, 383.40572113224493, 390.82412914188615, 404.52266325735627, 411.8970257435639, 5967.612105213164, 6069.453749162574, 6073.817785466437, 6080.996635555133, 6108.877822443559, 5873.412658734124, 5882.058870580708, 5914.319853216882, 5986.161937328778, 6141.938580614193, 4058.5299568868636, 4636.281376386665, 4645.839684546702, 4653.767311634421, 4684.836030738925, 3564.590072141698, 3707.4438834174953, 4348.282428440764, 4458.464984201901, 4652.069586082797, 3700.8897330800787, 3746.5504139503296, 3882.7476214046137, 4235.258829704805, 4475.418195634579, 3700.389435743099, 4376.5623437656295, 4380.868573942771, 4465.642748580106, 4495.123450927071, 3256.267339848539, 3863.768173909574, 3868.207017561393, 3873.5545412277665, 3887.5140607424073, 4735.0, 4914.70511769295, 5395.568354531628, 5906.586538942276, 6002.909956350658, 4762.404699412574, 4791.760411979387, 5347.358317001946, 5363.731813409314, 5375.354957405137, 5659.688717120557, 5665.093585026376, 6187.721552530102, 6471.805845824632, 6524.93475065248, 3777.527809023872, 4207.4109624652265, 4356.649438674021, 4381.3208952612395, 4399.670024748157, 6895.75864844728, 6926.515143939926, 6927.965360173268, 6943.930560694379, 6958.199807022206, 4434.3348497724955, 4451.5103338632725, 4451.998300382453, 4474.395956545824, 4494.640428765691, 4304.182205380967, 4459.598636122764, 4526.683132180781, 4527.479339875957, 4543.136804007294, 5309.973450132725, 5316.175992721134, 5319.685936617584, 5322.787088516493, 5337.786488540492, 5596.300462442195, 6199.845003874849, 6255.40573645503, 6341.23905131378, 6576.408123268929, 1266.9556565520347, 1308.5093090091216, 1540.468538354266, 1544.143000634636, 1550.3798480607848, 981.7153025622632, 1015.791762688647, 1019.4545917934018, 1027.8098551767946, 1029.9794004119876, 5588.882223555305, 6179.783707570304, 6204.231793938706, 6222.595531290543, 6247.875042499125, 6588.40704336612, 6720.495962802809, 6720.975560997571, 6722.226943901416, 6745.494087943423, 5940.732667029994, 5971.5222782177325, 6173.0, 6203.627782333075, 6207.937920620826, 3306.8511916963794, 3413.753979797356, 3544.4506101554302, 3546.723179655322, 3549.201429678302, 5418.729063546807, 5419.403865574784, 6923.2038315594355, 6972.860542789116, 7029.4376449883885, 6042.6978651067275, 6997.965010174917, 7034.2262351141335, 7038.612876291853, 7083.316675328801, 6910.827229319207, 6950.652467376611, 6967.352406085655, 6989.30106989297, 7028.964855175692, 6185.072478975972, 6754.527183097136, 6842.794716158523, 6854.520183587101, 6903.89644155328, 5183.449337204027, 5297.920531192112, 5576.633724737465, 6745.460363171032, 6764.188297404343, 5945.881082378415, 6735.865282694221, 6872.896906546306, 6921.8961715575315, 6973.779588571878, 4141.482314710661, 4394.264265615128, 4425.468943726773, 4436.955630443784, 4463.620592249695, 5558.201071188238, 5639.8590035249445, 6105.092740645901, 6717.328267173243, 6736.73053077891, 4731.0064886372875, 6548.639824809681, 6553.837233712768, 6581.3747693969, 6613.834654133685, 5693.5160511357, 5930.0, 6439.645819479973, 6577.769778057745, 6579.0, 5680.971595142163, 6388.680565971776, 6389.744410223539, 6404.839879003062, 6405.93594064072, 6541.34586541342, 6545.836354091186, 6546.247181573989, 6549.148610680581, 6562.9827376756675, 4952.925706114339, 5516.365617953987, 5863.853403664943, 5929.9110513341475, 6401.807945761635], "value": 4683.236014217333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.9040239165321, 668.7358493395109, 675.5988149818734, 691.899674547191, 697.1808125452592, 15679.686406271867, 16699.332026718916, 16925.91537042316, 16930.49208523743, 16944.98330100195, 14730.926345368285, 15271.541853744378, 15395.0, 15424.922875385608, 15441.0, 947.3226642950307, 963.5134257200104, 971.1939090554857, 971.3103696375582, 971.621067783565, 970.257752819094, 995.7460847483882, 1008.2941940641543, 1021.1014307409506, 1022.6727447216894, 1062.139666869834, 1062.3731998121107, 1062.3838173859144, 1063.457636605333, 1066.802641511319, 1055.5619417941546, 1058.7088550648557, 1058.7247315697934, 1058.978820423591, 1059.385556377307, 781.4451739265072, 783.91768864269, 784.0630446616295, 784.356827401531, 784.5645666655004, 16614.75077873821, 16842.242099105446, 16885.915570422192, 17321.480355589352, 17632.294708211655, 14549.563513094625, 14696.26518674062, 14723.263836808117, 14728.55814325572, 14819.036762610396, 11481.48333324994, 11529.942350288278, 11591.478383472764, 11741.178117531776, 12066.879331206663, 2937.2069541223964, 2947.2189869684553, 3017.9396412071637, 3024.395120975814, 3037.817730936129, 117191.0, 122141.0, 122562.0, 123472.76527234702, 126846.36576817241, 10429.322094063862, 11220.943895280634, 11282.943585282184, 11446.94276528612, 11489.368084755419, 25194.622080668803, 25277.0, 25582.488350233263, 25604.74395256061, 25731.48537029249, 7542.2834830691, 7749.3413059890545, 7759.883601745978, 8109.65617886863, 8109.75670729879, 4106.219818234586, 4195.475565554306, 4204.495460544754, 4249.171411574775, 4257.914231870853, 4192.979035104805, 4296.914061718748, 4303.655707543389, 4307.612314891675, 4312.525622181557, 742.4357488308816, 822.2640736540762, 831.2560258568548, 836.7322456813761, 859.4928991894812, 523.4922125538221, 546.4644648244742, 553.1343447504643, 566.9603127781015, 594.3907494817846, 9089.272858171462, 9410.717678469657, 9587.041295870356, 10009.009990198016, 10178.694639160836, 522.8588281164065, 546.469924173551, 553.6014069869688, 567.7360027587109, 569.7236840132532, 4410.609330402877, 4499.0, 4638.698579056756, 4727.527247275245, 4792.2092854678585, 103871.0, 105147.0, 105857.0, 106004.0, 109196.0, 69598.0, 76278.0, 90979.81570644995, 96070.03929960611, 98616.50691746495, 55963.0, 67301.66349168222, 78825.0, 81204.18795811966, 85580.57209713911, 8774.341924355827, 10044.0, 10693.923929511217, 10970.890291097307, 11045.502952367324, 31587.84206078955, 39805.20389592134, 41617.37573936333, 41969.79015105027, 42114.57885421107, 67714.0, 68625.65687171533, 68642.65678671574, 69519.0, 71766.0, 13316.667083322995, 13711.548536786408, 13735.931320343334, 14014.789778153132, 14633.487827926398, 12592.811107833206, 14255.0, 14706.77939830882, 14815.25923703832, 14888.032277901902, 13457.0, 13533.593992180251, 13548.729025419634, 13601.387937542637, 13666.0, 13124.934375328063, 13632.318384080954, 13659.286010006179, 13678.93160534191, 14191.503297384543, 13191.34043297812, 13261.270630115436, 13283.80074298867, 13307.733845323233, 13758.65603359924, 9769.31614786958, 9998.103773490846, 10005.699829005142, 10197.0, 10443.791124177626, 7155.633275043717, 9362.391444556082, 10166.644167454104, 10182.796344073226, 11253.324800511995], "value": 7650.272910222573, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 137.0, 178.0, 148.0, 121.0, 122.0, 122.0, 125.0, 122.0, 123.0], "value": 130.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 118.0, 119.0, 164.0, 120.0, 117.0, 119.0, 117.0, 143.0, 125.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 209.0, 215.0, 215.0, 214.0, 209.0, 218.0, 210.0, 221.0, 220.0], "value": 214.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 62.0, 63.0, 100.0, 64.0, 63.0, 61.0, 60.0, 82.0, 63.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 74.0, 98.0, 78.0, 76.0, 73.0, 89.0, 72.0, 73.0, 91.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 93.0, 94.0, 91.0, 91.0, 92.0, 92.0, 93.0, 92.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 102.0, 102.0, 102.0, 101.0, 100.0, 101.0, 101.0, 101.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 109.0, 103.0, 102.0, 101.0, 101.0, 101.0, 101.0, 101.0, 100.0], "value": 107.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 52.0, 51.0, 52.0, 52.0, 52.0, 53.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 67.0, 64.0, 71.0, 70.0, 68.0, 67.0, 64.0, 63.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 88.0, 91.0, 93.0, 79.0, 94.0, 105.0, 115.0, 117.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 181.0, 158.0, 150.0, 186.0, 184.0, 171.0, 167.0, 208.0, 149.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 206.0, 205.0, 203.0, 205.0, 207.0, 190.0, 257.0, 250.0, 201.0], "value": 212.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 92.0, 106.0, 71.0, 72.0, 75.0, 72.0, 72.0, 74.0, 75.0], "value": 78.7, "unit": "score"}]}]} 10:48:12 INFO - Return code: 0 10:48:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:12 ERROR - # TBPL SUCCESS # 10:48:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:48:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:48:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:48:12 INFO - 2017-04-02 10:48:12.969 screenresolution[1940:26212] starting screenresolution argv=screenresolution get 10:48:12 INFO - 2017-04-02 10:48:12.972 screenresolution[1940:26212] Display 0: 1600x1200x32@60 10:48:12 INFO - 2017-04-02 10:48:12.978 screenresolution[1941:26215] starting screenresolution argv=screenresolution list 10:48:12 INFO - Available Modes on Display 0 10:48:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:48:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:48:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:48:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:48:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:48:13 INFO - Intel Iris: 10:48:13 INFO - Chipset Model: Intel Iris 10:48:13 INFO - Type: GPU 10:48:13 INFO - Bus: Built-In 10:48:13 INFO - VRAM (Dynamic, Max): 1536 MB 10:48:13 INFO - Vendor: Intel (0x8086) 10:48:13 INFO - Device ID: 0x0a2e 10:48:13 INFO - Revision ID: 0x0009 10:48:13 INFO - Displays: 10:48:13 INFO - Display: 10:48:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:48:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:48:13 INFO - Display Serial Number: 1600x1200 60 10:48:13 INFO - Main Display: Yes 10:48:13 INFO - Mirror: Off 10:48:13 INFO - Online: Yes 10:48:13 INFO - Rotation: Supported 10:48:13 INFO - Return code: 0 10:48:13 INFO - Running post-action listener: _resource_record_post_action 10:48:13 INFO - [mozharness: 2017-04-02 17:48:13.216152Z] Finished run-tests step (success) 10:48:13 INFO - Running post-run listener: _resource_record_post_run 10:48:13 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 307200; Write bytes: 514692096; Read time: 5; Write time: 1803 10:48:13 INFO - TinderboxPrint: CPU usage
53.4% 10:48:13 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 5 10:48:13 INFO - TinderboxPrint: I/O write bytes / time
514,692,096 / 1,803 10:48:13 INFO - TinderboxPrint: CPU idle
2,246.9 (46.6%) 10:48:13 INFO - TinderboxPrint: CPU system
967.3 (20.0%) 10:48:13 INFO - TinderboxPrint: CPU user
1,611.5 (33.4%) 10:48:13 INFO - TinderboxPrint: Swap in / out
211,283,968 / 0 10:48:13 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 211192320; Write bytes: 206153728; Read time: 16726; Write time: 439 10:48:13 INFO - run-tests - Wall time: 1186s; CPU: 53.0%; Read bytes: 204800; Write bytes: 298392576; Read time: 4; Write time: 1327 10:48:13 INFO - Running post-run listener: _upload_blobber_files 10:48:13 INFO - Blob upload gear active. 10:48:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:13 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 10:48:13 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:13 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:14 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:14 INFO - (blobuploader) - INFO - Done attempting. 10:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:15 INFO - (blobuploader) - INFO - Done attempting. 10:48:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:48:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:16 INFO - (blobuploader) - INFO - Done attempting. 10:48:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:18 INFO - (blobuploader) - INFO - Done attempting. 10:48:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:48:18 INFO - Return code: 0 10:48:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:48:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:48:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b52d97130e2b1e7dd3b8a48a8d3ea547e12bdf4fb6fc91ecefd171c86f171f171f851e7514167577bc56d62a57212bf3e5a546a18b997cb0ce1761fbd959cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/715358438d3ecf87235af5c47268571cd62293cd0313926baac8449e88f7a8ac7ddb89654b3ec1579610714aedfc38c41dfb4f0f86b1b5e9d6abfdcd3ae94a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd395fad8a2a48a4b86a7380ad845f66a1ca6ba19fe7e1e24c5e2cd4b779e7d042830d7f9c489a60e4014de45c333b2962dffae4d1cea9610f16dc1e873bf43", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eca497bf3b61bcfdb56460aaa733cd8885264f65885d7014cbb4cea1f79793d0e02d3909743211fee4a79b45c6dc8383b7aa06f95e8d7a24a5315d977880102c"} 10:48:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:48:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:48:18 INFO - Contents: 10:48:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b52d97130e2b1e7dd3b8a48a8d3ea547e12bdf4fb6fc91ecefd171c86f171f171f851e7514167577bc56d62a57212bf3e5a546a18b997cb0ce1761fbd959cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/715358438d3ecf87235af5c47268571cd62293cd0313926baac8449e88f7a8ac7ddb89654b3ec1579610714aedfc38c41dfb4f0f86b1b5e9d6abfdcd3ae94a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd395fad8a2a48a4b86a7380ad845f66a1ca6ba19fe7e1e24c5e2cd4b779e7d042830d7f9c489a60e4014de45c333b2962dffae4d1cea9610f16dc1e873bf43", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eca497bf3b61bcfdb56460aaa733cd8885264f65885d7014cbb4cea1f79793d0e02d3909743211fee4a79b45c6dc8383b7aa06f95e8d7a24a5315d977880102c"} 10:48:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:48:18 INFO - Copying logs to upload dir... 10:48:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:48:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.610288 ========= master_lag: 2.89 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2017-04-02 10:48:21.594591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 10:48:21.598624) ========= 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.rtoUxvXICU/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.G8e0IAWrqh/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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/Firefox/sha512/9b52d97130e2b1e7dd3b8a48a8d3ea547e12bdf4fb6fc91ecefd171c86f171f171f851e7514167577bc56d62a57212bf3e5a546a18b997cb0ce1761fbd959cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/715358438d3ecf87235af5c47268571cd62293cd0313926baac8449e88f7a8ac7ddb89654b3ec1579610714aedfc38c41dfb4f0f86b1b5e9d6abfdcd3ae94a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd395fad8a2a48a4b86a7380ad845f66a1ca6ba19fe7e1e24c5e2cd4b779e7d042830d7f9c489a60e4014de45c333b2962dffae4d1cea9610f16dc1e873bf43", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eca497bf3b61bcfdb56460aaa733cd8885264f65885d7014cbb4cea1f79793d0e02d3909743211fee4a79b45c6dc8383b7aa06f95e8d7a24a5315d977880102c"} build_url:https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011559 build_url: 'https://queue.taskcluster.net/v1/task/VBBdONfETV6MiaLyV0FmRA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b52d97130e2b1e7dd3b8a48a8d3ea547e12bdf4fb6fc91ecefd171c86f171f171f851e7514167577bc56d62a57212bf3e5a546a18b997cb0ce1761fbd959cdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/715358438d3ecf87235af5c47268571cd62293cd0313926baac8449e88f7a8ac7ddb89654b3ec1579610714aedfc38c41dfb4f0f86b1b5e9d6abfdcd3ae94a1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd395fad8a2a48a4b86a7380ad845f66a1ca6ba19fe7e1e24c5e2cd4b779e7d042830d7f9c489a60e4014de45c333b2962dffae4d1cea9610f16dc1e873bf43", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eca497bf3b61bcfdb56460aaa733cd8885264f65885d7014cbb4cea1f79793d0e02d3909743211fee4a79b45c6dc8383b7aa06f95e8d7a24a5315d977880102c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 10:48:21.637845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:48:21.638208) ========= 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.rtoUxvXICU/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.G8e0IAWrqh/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.005404 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:48:21.686783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 10:48:21.689602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 10:48:21.689939) ========= ========= Total master_lag: 3.04 =========