builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0158 starttime: 1490832082.42 results: success (0) buildid: 20170329154223 builduid: 0b556ed4dffe42d9910b9a1205ce6fa2 revision: 60d7a0496a3673450ddbc37ec387525148c32604 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.418467) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.418899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.419190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.448564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.448947) ========= 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.9zOL0jBbiw/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.YZ281UB8zH/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-29 17:01:22-- 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% 52.1M=0s 2017-03-29 17:01:22 (52.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.340085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.813102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.813414) ========= 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.9zOL0jBbiw/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.YZ281UB8zH/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.027665 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:22.863166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 17:01:22.863514) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60d7a0496a3673450ddbc37ec387525148c32604 --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 60d7a0496a3673450ddbc37ec387525148c32604 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9zOL0jBbiw/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.YZ281UB8zH/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-29 17:01:22,965 truncating revision to first 12 chars 2017-03-29 17:01:22,966 Setting DEBUG logging. 2017-03-29 17:01:22,966 attempt 1/10 2017-03-29 17:01:22,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60d7a0496a36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 17:01:23,984 unpacking tar archive at: mozilla-central-60d7a0496a36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 17:01:24.205073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:24.205460) ========= script_repo_revision: 60d7a0496a3673450ddbc37ec387525148c32604 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:24.205956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:24.206309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 17:01:24.226160) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-03-29 17:01:24.226553) ========= /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.9zOL0jBbiw/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.YZ281UB8zH/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:01:24 INFO - MultiFileLogger online at 20170329 17:01:24 in /builds/slave/test 17:01:24 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 17:01:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:24 INFO - {'append_to_log': False, 17:01:24 INFO - 'base_work_dir': '/builds/slave/test', 17:01:24 INFO - 'blob_upload_branch': 'Firefox', 17:01:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:24 INFO - 'branch': 'Firefox', 17:01:24 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:24 INFO - 'config_files': ('talos/mac_config.py',), 17:01:24 INFO - 'default_actions': ('clobber', 17:01:24 INFO - 'read-buildbot-config', 17:01:24 INFO - 'download-and-extract', 17:01:24 INFO - 'populate-webroot', 17:01:24 INFO - 'create-virtualenv', 17:01:24 INFO - 'install', 17:01:24 INFO - 'run-tests'), 17:01:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:24 INFO - 'download_minidump_stackwalk': True, 17:01:24 INFO - 'download_symbols': 'ondemand', 17:01:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:01:24 INFO - 'tooltool.py': '/tools/tooltool.py', 17:01:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:01:24 INFO - '/tools/misc-python/virtualenv.py')}, 17:01:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:24 INFO - 'gecko_profile': False, 17:01:24 INFO - 'gecko_profile_interval': 0, 17:01:24 INFO - 'installer_path': 'installer.exe', 17:01:24 INFO - 'log_level': 'info', 17:01:24 INFO - 'log_name': 'talos', 17:01:24 INFO - 'log_to_console': True, 17:01:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:01:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:01:24 INFO - 'opt_config_files': (), 17:01:24 INFO - 'pip_index': False, 17:01:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:01:24 INFO - 'cmd': ('bash', 17:01:24 INFO - '-c', 17:01:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:01:24 INFO - 'enabled': True, 17:01:24 INFO - 'halt_on_failure': False, 17:01:24 INFO - 'name': 'check_screen_resolution'},), 17:01:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:01:24 INFO - 'cmd': ('bash', 17:01:24 INFO - '-c', 17:01:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:01:24 INFO - 'enabled': True, 17:01:24 INFO - 'halt_on_failure': False, 17:01:24 INFO - 'name': 'check_screen_resolution'},), 17:01:24 INFO - 'run_cmd_checks_enabled': True, 17:01:24 INFO - 'suite': 'dromaeojs', 17:01:24 INFO - 'system_bits': '32', 17:01:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:24 INFO - 'title': 't-yosemite-r7-0158', 17:01:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:24 INFO - 'use_talos_json': True, 17:01:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:24 INFO - 'work_dir': 'build'} 17:01:24 INFO - [mozharness: 2017-03-30 00:01:24.444046Z] Running clobber step. 17:01:24 INFO - Running pre-action listener: _resource_record_pre_action 17:01:24 INFO - Running main action method: clobber 17:01:24 INFO - rmtree: /builds/slave/test/build 17:01:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:01:27 INFO - Running post-action listener: _resource_record_post_action 17:01:27 INFO - [mozharness: 2017-03-30 00:01:27.029043Z] Finished clobber step (success) 17:01:27 INFO - [mozharness: 2017-03-30 00:01:27.029280Z] Running read-buildbot-config step. 17:01:27 INFO - Running pre-action listener: _resource_record_pre_action 17:01:27 INFO - Running main action method: read_buildbot_config 17:01:27 INFO - Using buildbot properties: 17:01:27 INFO - { 17:01:27 INFO - "project": "", 17:01:27 INFO - "product": "firefox", 17:01:27 INFO - "script_repo_revision": "production", 17:01:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:01:27 INFO - "repository": "", 17:01:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:01:27 INFO - "buildid": "20170329154223", 17:01:27 INFO - "pgo_build": "False", 17:01:27 INFO - "basedir": "/builds/slave/test", 17:01:27 INFO - "buildnumber": 63, 17:01:27 INFO - "slavename": "t-yosemite-r7-0158", 17:01:27 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:01:27 INFO - "platform": "yosemite_r7", 17:01:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:01:27 INFO - "branch": "mozilla-central", 17:01:27 INFO - "repo_path": "mozilla-central", 17:01:27 INFO - "revision": "60d7a0496a3673450ddbc37ec387525148c32604", 17:01:27 INFO - "stage_platform": "macosx64", 17:01:27 INFO - "builduid": "0b556ed4dffe42d9910b9a1205ce6fa2", 17:01:27 INFO - "slavebuilddir": "test" 17:01:27 INFO - } 17:01:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:01:27 INFO - Running post-action listener: _resource_record_post_action 17:01:27 INFO - [mozharness: 2017-03-30 00:01:27.035001Z] Finished read-buildbot-config step (success) 17:01:27 INFO - [mozharness: 2017-03-30 00:01:27.035211Z] Running download-and-extract step. 17:01:27 INFO - Running pre-action listener: _resource_record_pre_action 17:01:27 INFO - Running main action method: download_and_extract 17:01:27 INFO - mkdir: /builds/slave/test/build/tests 17:01: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')]} 17:01:27 INFO - trying https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:01:27 INFO - Downloading https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/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 17:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/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 17:01:28 INFO - Downloaded 1325 bytes. 17:01:28 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:01:28 INFO - Using the following test package requirements: 17:01:28 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:01:28 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:01:28 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:01:28 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:01:28 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'jsshell-mac.zip'], 17:01:28 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:01:28 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:01:28 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:01:28 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:01:28 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:01:28 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:01:28 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:01:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:01:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:01:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:01:28 INFO - Fetch https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:01:29 INFO - Expected file size: 52508144 17:01:29 INFO - Obtained file size: 52508144 17:01:45 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 17:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:01:47 INFO - Expected file size: 52508144 17:01:47 INFO - Obtained file size: 52508144 17:02:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:02:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:02:03 INFO - Fetch https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:02:04 INFO - Expected file size: 14404171 17:02:04 INFO - Obtained file size: 14404171 17:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:04 INFO - trying https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:02:04 INFO - Downloading https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/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 17:02:06 INFO - Downloaded 75559102 bytes. 17:02:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:02:06 INFO - mkdir: /builds/slave/test/properties 17:02:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:06 INFO - Contents: 17:02:06 INFO - build_url:https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:02:07 INFO - Running post-action listener: _resource_record_post_action 17:02:07 INFO - Running post-action listener: set_extra_try_arguments 17:02:07 INFO - [mozharness: 2017-03-30 00:02:07.276500Z] Finished download-and-extract step (success) 17:02:07 INFO - [mozharness: 2017-03-30 00:02:07.276645Z] Running populate-webroot step. 17:02:07 INFO - Running pre-action listener: _resource_record_pre_action 17:02:07 INFO - Running main action method: populate_webroot 17:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:07 INFO - '--tppagecycles', 17:02:07 INFO - '7'], 17:02:07 INFO - 'tests': ['tsvgm']}}, 17:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['damp', 'tps']}, 17:02:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'tests': ['damp', 'tps']}, 17:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['dromaeo_dom']}, 17:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['basic_compositor_video']}, 17:02:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['a11yr', 17:02:07 INFO - 'ts_paint', 17:02:07 INFO - 'tpaint', 17:02:07 INFO - 'sessionrestore', 17:02:07 INFO - 'sessionrestore_no_auto_restore', 17:02:07 INFO - 'tabpaint']}, 17:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:07 INFO - 'ts_paint', 17:02:07 INFO - 'tpaint', 17:02:07 INFO - 'sessionrestore', 17:02:07 INFO - 'sessionrestore_no_auto_restore', 17:02:07 INFO - 'tabpaint']}, 17:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:07 INFO - 'ts_paint', 17:02:07 INFO - 'tpaint', 17:02:07 INFO - 'sessionrestore', 17:02:07 INFO - 'sessionrestore_no_auto_restore', 17:02:07 INFO - 'tabpaint']}, 17:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:07 INFO - 'ts_paint', 17:02:07 INFO - 'tpaint', 17:02:07 INFO - 'sessionrestore', 17:02:07 INFO - 'sessionrestore_no_auto_restore', 17:02:07 INFO - 'tabpaint']}, 17:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['a11yr', 17:02:07 INFO - 'ts_paint', 17:02:07 INFO - 'tpaint', 17:02:07 INFO - 'sessionrestore', 17:02:07 INFO - 'sessionrestore_no_auto_restore', 17:02:07 INFO - 'tabpaint']}, 17:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['a11yr', 17:02:07 INFO - 'ts_paint', 17:02:07 INFO - 'tpaint', 17:02:07 INFO - 'sessionrestore', 17:02:07 INFO - 'sessionrestore_no_auto_restore', 17:02:07 INFO - 'tabpaint']}, 17:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['tsvgx', 17:02:07 INFO - 'tsvgr_opacity', 17:02:07 INFO - 'tart', 17:02:07 INFO - 'tscrollx', 17:02:07 INFO - 'cart', 17:02:07 INFO - 'tsvg_static']}, 17:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:07 INFO - 'tsvgr_opacity', 17:02:07 INFO - 'tart', 17:02:07 INFO - 'tscrollx', 17:02:07 INFO - 'cart', 17:02:07 INFO - 'tsvg_static']}, 17:02:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'talos_options': ['--disable-e10s'], 17:02:07 INFO - 'tests': ['tp5o']}, 17:02:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:02:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'talos_options': ['--disable-e10s', 17:02:07 INFO - '--xperf_path', 17:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:07 INFO - 'tests': ['tp5n']}, 17:02:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:02:07 INFO - 'talos_options': ['--xperf_path', 17:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:07 INFO - 'tests': ['tp5n']}}, 17:02:07 INFO - 'talos.zip': {'path': '', 17:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:07 INFO - Running post-action listener: _resource_record_post_action 17:02:07 INFO - [mozharness: 2017-03-30 00:02:07.295022Z] Finished populate-webroot step (success) 17:02:07 INFO - [mozharness: 2017-03-30 00:02:07.295157Z] Running create-virtualenv step. 17:02:07 INFO - Running pre-action listener: _resource_record_pre_action 17:02:07 INFO - Running main action method: create_virtualenv 17:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:07 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 17:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:07 INFO - Using real prefix '/tools/python27' 17:02:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:10 INFO - Installing pip.................done. 17:02:10 INFO - Return code: 0 17:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:02:11 INFO - Reading from file tmpfile_stdout 17:02:11 INFO - Output received: 17:02:11 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) 17:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:11 INFO - 'HOME': '/Users/cltbld', 17:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:11 INFO - 'LOGNAME': 'cltbld', 17:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:11 INFO - 'MOZ_NO_REMOTE': '1', 17:02:11 INFO - 'NO_EM_RESTART': '1', 17:02:11 INFO - 'PAGER': '/bin/cat', 17:02:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:11 INFO - 'PWD': '/builds/slave/test', 17:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:11 INFO - 'SHELL': '/bin/bash', 17:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:11 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:11 INFO - 'USER': 'cltbld', 17:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:11 INFO - 'XPC_FLAGS': '0x0', 17:02:11 INFO - 'XPC_SERVICE_NAME': '0', 17:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:11 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 17:02:11 INFO - Cleaning up... 17:02:11 INFO - Return code: 0 17:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:11 INFO - 'HOME': '/Users/cltbld', 17:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:11 INFO - 'LOGNAME': 'cltbld', 17:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:11 INFO - 'MOZ_NO_REMOTE': '1', 17:02:11 INFO - 'NO_EM_RESTART': '1', 17:02:11 INFO - 'PAGER': '/bin/cat', 17:02:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:11 INFO - 'PWD': '/builds/slave/test', 17:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:11 INFO - 'SHELL': '/bin/bash', 17:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:11 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:11 INFO - 'USER': 'cltbld', 17:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:11 INFO - 'XPC_FLAGS': '0x0', 17:02:11 INFO - 'XPC_SERVICE_NAME': '0', 17:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:11 INFO - Downloading/unpacking psutil>=3.1.1 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:15 INFO - Installing collected packages: psutil 17:02:15 INFO - Running setup.py install for psutil 17:02:15 INFO - building 'psutil._psutil_osx' extension 17:02:15 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 17:02:16 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 17:02:16 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 17:02:16 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 17:02:16 INFO - building 'psutil._psutil_posix' extension 17:02:16 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 17:02:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:02:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:02:16 INFO - ^ 17:02:16 INFO - 1 warning generated. 17:02:16 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 17:02:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:16 INFO - Successfully installed psutil 17:02:16 INFO - Cleaning up... 17:02:16 INFO - Return code: 0 17:02:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:02:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:17 INFO - 'HOME': '/Users/cltbld', 17:02:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:17 INFO - 'LOGNAME': 'cltbld', 17:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:17 INFO - 'MOZ_NO_REMOTE': '1', 17:02:17 INFO - 'NO_EM_RESTART': '1', 17:02:17 INFO - 'PAGER': '/bin/cat', 17:02:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:17 INFO - 'PWD': '/builds/slave/test', 17:02:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:17 INFO - 'SHELL': '/bin/bash', 17:02:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:17 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:17 INFO - 'USER': 'cltbld', 17:02:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:17 INFO - 'XPC_FLAGS': '0x0', 17:02:17 INFO - 'XPC_SERVICE_NAME': '0', 17:02:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:02:20 INFO - Installing collected packages: mozsystemmonitor 17:02:20 INFO - Running setup.py install for mozsystemmonitor 17:02:20 INFO - Successfully installed mozsystemmonitor 17:02:20 INFO - Cleaning up... 17:02:21 INFO - Return code: 0 17:02:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:02:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:21 INFO - 'HOME': '/Users/cltbld', 17:02:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:21 INFO - 'LOGNAME': 'cltbld', 17:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:21 INFO - 'MOZ_NO_REMOTE': '1', 17:02:21 INFO - 'NO_EM_RESTART': '1', 17:02:21 INFO - 'PAGER': '/bin/cat', 17:02:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:21 INFO - 'PWD': '/builds/slave/test', 17:02:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:21 INFO - 'SHELL': '/bin/bash', 17:02:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:21 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:21 INFO - 'USER': 'cltbld', 17:02:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:21 INFO - 'XPC_FLAGS': '0x0', 17:02:21 INFO - 'XPC_SERVICE_NAME': '0', 17:02:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:21 INFO - Downloading/unpacking jsonschema==2.5.1 17:02:21 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 17:02:21 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 17:02:21 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 17:02:21 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 17:02:21 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 17:02:21 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 17:02:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:02:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:02:23 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 17:02:23 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 17:02:23 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 17:02:23 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 17:02:23 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 17:02:23 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 17:02:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:02:24 INFO - warning: no files found matching '*.txt' 17:02:24 INFO - no previously-included directories found matching 'build' 17:02:24 INFO - no previously-included directories found matching 'dist' 17:02:24 INFO - no previously-included directories found matching '.git*' 17:02:24 INFO - Installing collected packages: jsonschema, functools32 17:02:24 INFO - Running setup.py install for functools32 17:02:24 INFO - warning: no files found matching '*.txt' 17:02:24 INFO - no previously-included directories found matching 'build' 17:02:24 INFO - no previously-included directories found matching 'dist' 17:02:24 INFO - no previously-included directories found matching '.git*' 17:02:24 INFO - Successfully installed jsonschema functools32 17:02:24 INFO - Cleaning up... 17:02:24 INFO - Return code: 0 17:02:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:24 INFO - 'HOME': '/Users/cltbld', 17:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:24 INFO - 'LOGNAME': 'cltbld', 17:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:24 INFO - 'MOZ_NO_REMOTE': '1', 17:02:24 INFO - 'NO_EM_RESTART': '1', 17:02:24 INFO - 'PAGER': '/bin/cat', 17:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:24 INFO - 'PWD': '/builds/slave/test', 17:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:24 INFO - 'SHELL': '/bin/bash', 17:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:24 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:24 INFO - 'USER': 'cltbld', 17:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:24 INFO - 'XPC_FLAGS': '0x0', 17:02:24 INFO - 'XPC_SERVICE_NAME': '0', 17:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:02:24 INFO - Cleaning up... 17:02:24 INFO - Return code: 0 17:02:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:24 INFO - 'HOME': '/Users/cltbld', 17:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:24 INFO - 'LOGNAME': 'cltbld', 17:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:24 INFO - 'MOZ_NO_REMOTE': '1', 17:02:24 INFO - 'NO_EM_RESTART': '1', 17:02:24 INFO - 'PAGER': '/bin/cat', 17:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:24 INFO - 'PWD': '/builds/slave/test', 17:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:24 INFO - 'SHELL': '/bin/bash', 17:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:24 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:24 INFO - 'USER': 'cltbld', 17:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:24 INFO - 'XPC_FLAGS': '0x0', 17:02:24 INFO - 'XPC_SERVICE_NAME': '0', 17:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:02:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:02:28 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 17:02:28 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 17:02:28 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 17:02:28 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 17:02:28 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 17:02:28 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 17:02:28 INFO - Downloading docopt-0.6.1.tar.gz 17:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:29 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:29 INFO - Running setup.py install for blobuploader 17:02:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:29 INFO - Running setup.py install for requests 17:02:29 INFO - Running setup.py install for docopt 17:02:29 INFO - Successfully installed blobuploader requests docopt 17:02:29 INFO - Cleaning up... 17:02:29 INFO - Return code: 0 17:02:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:29 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')]} 17:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:29 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')]} 17:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:29 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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:29 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 17:02:29 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 17:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:29 INFO - 'HOME': '/Users/cltbld', 17:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:29 INFO - 'LOGNAME': 'cltbld', 17:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:29 INFO - 'MOZ_NO_REMOTE': '1', 17:02:29 INFO - 'NO_EM_RESTART': '1', 17:02:29 INFO - 'PAGER': '/bin/cat', 17:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:29 INFO - 'PWD': '/builds/slave/test', 17:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:29 INFO - 'SHELL': '/bin/bash', 17:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:29 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:29 INFO - 'USER': 'cltbld', 17:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:29 INFO - 'XPC_FLAGS': '0x0', 17:02:29 INFO - 'XPC_SERVICE_NAME': '0', 17:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-nA_ntQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-jA05_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-gXewRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-fpP6Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-hgY0sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-IqI_kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-oDyFpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:30 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-27VQUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-_vSC3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-QmacVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pkpiSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-aOtdor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-uHqcZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-cvmN8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XvByiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-EdRjg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:31 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-kdL30g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:31 INFO - Running setup.py install for manifestparser 17:02:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:32 INFO - Running setup.py install for mozcrash 17:02:32 INFO - Running setup.py install for mozdebug 17:02:32 INFO - Running setup.py install for mozdevice 17:02:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:32 INFO - Running setup.py install for mozfile 17:02:32 INFO - Running setup.py install for mozhttpd 17:02:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:32 INFO - Running setup.py install for mozinfo 17:02:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:32 INFO - Running setup.py install for mozInstall 17:02:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Running setup.py install for mozleak 17:02:33 INFO - Running setup.py install for mozlog 17:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Running setup.py install for moznetwork 17:02:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Running setup.py install for mozprocess 17:02:33 INFO - Running setup.py install for mozprofile 17:02:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Running setup.py install for mozrunner 17:02:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:34 INFO - Running setup.py install for mozscreenshot 17:02:34 INFO - Running setup.py install for moztest 17:02:34 INFO - Running setup.py install for mozversion 17:02:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:34 INFO - Cleaning up... 17:02:34 INFO - Return code: 0 17:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:34 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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:34 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 17:02:34 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 17:02:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:34 INFO - 'HOME': '/Users/cltbld', 17:02:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:34 INFO - 'LOGNAME': 'cltbld', 17:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:34 INFO - 'MOZ_NO_REMOTE': '1', 17:02:34 INFO - 'NO_EM_RESTART': '1', 17:02:34 INFO - 'PAGER': '/bin/cat', 17:02:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:34 INFO - 'PWD': '/builds/slave/test', 17:02:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:34 INFO - 'SHELL': '/bin/bash', 17:02:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:34 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:34 INFO - 'USER': 'cltbld', 17:02:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:34 INFO - 'XPC_FLAGS': '0x0', 17:02:34 INFO - 'XPC_SERVICE_NAME': '0', 17:02:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:34 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Da2SvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:34 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)) 17:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:34 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-6LsGMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-IK7OVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-GGl0n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-o_Skuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-19srBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-xR8FiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-CtGrEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-RT7OLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-hGsDya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:35 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)) 17:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:35 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-iQwtm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:36 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)) 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:36 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-UDYMTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:36 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)) 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:36 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Z0TvDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:36 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)) 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:36 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ZpIbik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:36 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)) 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:36 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-TmsV3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:36 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)) 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:36 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-99go3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:36 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)) 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:36 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-jzMez3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:36 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)) 17:02:36 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)) 17:02:36 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)) 17:02:36 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)) 17:02:36 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)) 17:02:36 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)) 17:02:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:36 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 17:02:36 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 17:02:36 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 17:02:36 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 17:02:36 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 17:02:36 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 17:02:39 INFO - Downloading blessings-1.6.tar.gz 17:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:39 INFO - Installing collected packages: blessings 17:02:39 INFO - Running setup.py install for blessings 17:02:39 INFO - Successfully installed blessings 17:02:39 INFO - Cleaning up... 17:02:39 INFO - Return code: 0 17:02:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:39 INFO - Reading from file tmpfile_stdout 17:02:39 INFO - Current package versions: 17:02:39 INFO - blessings == 1.6 17:02:39 INFO - blobuploader == 1.2.4 17:02:39 INFO - docopt == 0.6.1 17:02:39 INFO - functools32 == 3.2.3-2 17:02:39 INFO - jsonschema == 2.5.1 17:02:39 INFO - manifestparser == 1.1 17:02:39 INFO - mozInstall == 1.12 17:02:39 INFO - mozcrash == 1.0 17:02:39 INFO - mozdebug == 0.1 17:02:39 INFO - mozdevice == 0.49 17:02:39 INFO - mozfile == 1.2 17:02:39 INFO - mozhttpd == 0.7 17:02:39 INFO - mozinfo == 0.9 17:02:39 INFO - mozleak == 0.1 17:02:39 INFO - mozlog == 3.4 17:02:39 INFO - moznetwork == 0.27 17:02:39 INFO - mozprocess == 0.25 17:02:39 INFO - mozprofile == 0.28 17:02:39 INFO - mozrunner == 6.13 17:02:39 INFO - mozscreenshot == 0.1 17:02:39 INFO - mozsystemmonitor == 0.3 17:02:39 INFO - moztest == 0.8 17:02:39 INFO - mozversion == 1.4 17:02:39 INFO - psutil == 3.1.1 17:02:39 INFO - requests == 1.2.3 17:02:39 INFO - wsgiref == 0.1.2 17:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:39 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')]} 17:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:39 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')]} 17:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:39 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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:39 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 17:02:39 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 17:02:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:39 INFO - 'HOME': '/Users/cltbld', 17:02:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:39 INFO - 'LOGNAME': 'cltbld', 17:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:39 INFO - 'MOZ_NO_REMOTE': '1', 17:02:39 INFO - 'NO_EM_RESTART': '1', 17:02:39 INFO - 'PAGER': '/bin/cat', 17:02:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:39 INFO - 'PWD': '/builds/slave/test', 17:02:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:39 INFO - 'SHELL': '/bin/bash', 17:02:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:39 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:39 INFO - 'USER': 'cltbld', 17:02:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:39 INFO - 'XPC_FLAGS': '0x0', 17:02:39 INFO - 'XPC_SERVICE_NAME': '0', 17:02:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 INFO - Cleaning up... 17:02:40 INFO - Return code: 0 17:02:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02:40 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')]} 17:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:40 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')]} 17:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:40 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 0x10258cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10258f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa880d71060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, '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.9zOL0jBbiw/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.YZ281UB8zH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 17:02:40 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 17:02:40 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 17:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:02:40 INFO - 'HOME': '/Users/cltbld', 17:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:02:40 INFO - 'LOGNAME': 'cltbld', 17:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:40 INFO - 'MOZ_NO_REMOTE': '1', 17:02:40 INFO - 'NO_EM_RESTART': '1', 17:02:40 INFO - 'PAGER': '/bin/cat', 17:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:40 INFO - 'PWD': '/builds/slave/test', 17:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:02:40 INFO - 'SHELL': '/bin/bash', 17:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:02:40 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:02:40 INFO - 'USER': 'cltbld', 17:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:40 INFO - 'XPC_FLAGS': '0x0', 17:02:40 INFO - 'XPC_SERVICE_NAME': '0', 17:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:02:40 INFO - Cleaning up... 17:02:40 INFO - Return code: 0 17:02:40 INFO - Running post-action listener: _resource_record_post_action 17:02:40 INFO - Running post-action listener: _start_resource_monitoring 17:02:40 INFO - Starting resource monitoring. 17:02:40 INFO - [mozharness: 2017-03-30 00:02:40.440184Z] Finished create-virtualenv step (success) 17:02:40 INFO - [mozharness: 2017-03-30 00:02:40.441237Z] Running install step. 17:02:40 INFO - Running pre-action listener: _resource_record_pre_action 17:02:40 INFO - Running main action method: install 17:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:40 INFO - Reading from file tmpfile_stdout 17:02:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:02:40 INFO - Reading from file tmpfile_stdout 17:02:40 INFO - Output received: 17:02:40 INFO - Usage: mozinstall [options] installer 17:02:40 INFO - Options: 17:02:40 INFO - -h, --help show this help message and exit 17:02:40 INFO - -d DEST, --destination=DEST 17:02:40 INFO - Directory to install application into. [default: 17:02:40 INFO - "/builds/slave/test"] 17:02:40 INFO - --app=APP Application being installed. [default: firefox] 17:02:40 INFO - mkdir: /builds/slave/test/build/application 17:02:40 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'] 17:02:40 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 17:03:00 INFO - Reading from file tmpfile_stdout 17:03:00 INFO - Output received: 17:03:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:03:00 INFO - Running post-action listener: _resource_record_post_action 17:03:00 INFO - [mozharness: 2017-03-30 00:03:00.989680Z] Finished install step (success) 17:03:00 INFO - [mozharness: 2017-03-30 00:03:00.989823Z] Running run-tests step. 17:03:00 INFO - Running pre-action listener: _resource_record_pre_action 17:03:00 INFO - Running main action method: run_tests 17:03:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:03:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:03:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:03:01 INFO - 2017-03-29 17:03:01.004 screenresolution[1629:7774] starting screenresolution argv=screenresolution get 17:03:01 INFO - 2017-03-29 17:03:01.007 screenresolution[1629:7774] Display 0: 1600x1200x32@60 17:03:01 INFO - 2017-03-29 17:03:01.012 screenresolution[1630:7777] starting screenresolution argv=screenresolution list 17:03:01 INFO - Available Modes on Display 0 17:03:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:03:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:03:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:03:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:03:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:03:01 INFO - Intel Iris: 17:03:01 INFO - Chipset Model: Intel Iris 17:03:01 INFO - Type: GPU 17:03:01 INFO - Bus: Built-In 17:03:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:03:01 INFO - Vendor: Intel (0x8086) 17:03:01 INFO - Device ID: 0x0a2e 17:03:01 INFO - Revision ID: 0x0009 17:03:01 INFO - Displays: 17:03:01 INFO - Display: 17:03:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:03:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:03:01 INFO - Display Serial Number: 1600x1200 60 17:03:01 INFO - Main Display: Yes 17:03:01 INFO - Mirror: Off 17:03:01 INFO - Online: Yes 17:03:01 INFO - Rotation: Supported 17:03:01 INFO - Return code: 0 17:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:01 INFO - Python 2.7.3 17:03:01 INFO - Return code: 0 17:03:01 INFO - grabbing minidump binary from tooltool 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:01 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 0x10236ad30>, '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 0x102291db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10235fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:01 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 17:03:01 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 17:03:01 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 17:03:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:03:01 INFO - Return code: 0 17:03:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:03:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:03:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:03:01 INFO - ENV: RUST_BACKTRACE is now 1 17:03:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:03:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:03:01 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/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 17:03:01 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/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --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 17:03:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9zOL0jBbiw/Render', 17:03:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:01 INFO - 'HOME': '/Users/cltbld', 17:03:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PAGER': '/bin/cat', 17:03:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:01 INFO - 'RUST_BACKTRACE': '1', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YZ281UB8zH/Listeners', 17:03:01 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 17:03:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - 'XPC_FLAGS': '0x0', 17:03:01 INFO - 'XPC_SERVICE_NAME': '0', 17:03:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:01 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/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 17:03:01 INFO - mozversion application_buildid: 20170329154223 17:03:01 INFO - mozversion application_changeset: 60d7a0496a3673450ddbc37ec387525148c32604 17:03:01 INFO - mozversion application_display_name: Nightly 17:03:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:01 INFO - mozversion application_name: Firefox 17:03:01 INFO - mozversion application_remotingname: firefox 17:03:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:03:01 INFO - mozversion application_vendor: Mozilla 17:03:01 INFO - mozversion application_version: 55.0a1 17:03:01 INFO - mozversion platform_buildid: 20170329154223 17:03:01 INFO - mozversion platform_changeset: 60d7a0496a3673450ddbc37ec387525148c32604 17:03:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:03:01 INFO - mozversion platform_version: 55.0a1 17:03:01 INFO - using testdate: 1490832181 17:03:01 INFO - actual date: 1490832181 17:03:01 INFO - starting webserver on 'localhost:49243' 17:03:01 INFO - SUITE-START | Running 2 tests 17:03:01 INFO - TEST-START | dromaeo_css 17:03:01 INFO - operating with platform_type : mac_ 17:03:01 INFO - Initialising browser for dromaeo_css test... 17:03:01 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpKdboha/profile http://localhost:49243/getInfo.html) 17:03:04 INFO - PID 1640 | __metrics Screen width/height:1600/1200 17:03:04 INFO - PID 1640 | colorDepth:24 17:03:04 INFO - PID 1640 | Browser inner width/height: 1024/689 17:03:04 INFO - PID 1640 | __metrics 17:03:04 ERROR - PID 1640 | 1490832184335 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:03:04 INFO - PID 1640 | 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" 17:03:04 INFO - PID 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:05 INFO - TEST-INFO | 1640: exit 0 17:03:05 INFO - Browser initialized. 17:03:05 INFO - Running cycle 1/1 for dromaeo_css test... 17:03:05 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpKdboha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:17 INFO - PID 1642 | RSS: Main: 226426880 17:03:17 INFO - PID 1642 | 17:06:24 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 17:06:26 INFO - PID 1642 | RSS: Main: 384331776 17:06:26 INFO - PID 1642 | 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 17:08:07 INFO - PID 1642 | 17:08:07 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:08:07 INFO - PID 1642 | Full stack: 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 17:08:07 INFO - PID 1642 | 17:08:07 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:08:07 INFO - PID 1642 | Full stack: 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 17:08:07 INFO - PID 1642 | 17:08:07 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:08:07 INFO - PID 1642 | Full stack: 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | ************************* 17:08:07 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 17:08:07 INFO - PID 1642 | 17:08:07 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:08:07 INFO - PID 1642 | Full stack: 17:08:07 INFO - PID 1642 | ************************* 17:09:28 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 17:09:29 INFO - PID 1642 | RSS: Main: 368713728 17:09:29 INFO - PID 1642 | 17:12:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 17:12:32 INFO - PID 1642 | RSS: Main: 356790272 17:12:32 INFO - PID 1642 | 17:15:35 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 17:15:35 INFO - PID 1642 | RSS: Main: 339505152 17:15:35 INFO - PID 1642 | 17:18:39 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 17:18:40 INFO - PID 1642 | RSS: Main: 333971456 17:18:40 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 17:21:43 INFO - PID 1642 | RSS: Main: 497479680 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | __start_tp_report 17:21:43 INFO - PID 1642 | _x_x_mozilla_page_load 17:21:43 INFO - PID 1642 | _x_x_mozilla_page_load_details 17:21:43 INFO - PID 1642 | |i|pagename|runs| 17:21:43 INFO - PID 1642 | |0;dojo.html;3461.4461686130207;3465.3069386122775;3495.580530336359;3511;3513.2973405318926;6003.369646187142;6126.303932855867;6174.04302333138;6185.288691800444;6188.071789231618;6111.986793494201;6128.969355153218;6134.069235337271;6197.659128747917;6200.81397558074;5514.365847927479;5575.0522411189995;5606.355269144039;5620.100783874561;5708.971455142719;5516.586256030793;5599.608027438081;5691.8577035574235;5700.287464066992;5718.170865224561;5417.052015897202;5627.521660658849;5639.6334238274385;5688.943110568904;5689.4879460848515;5477.890442191174;5552.500274975271;5570.637908535973;5598.832035038955;5616.410276920946;4501.572350626685;5489.752961116759;5506.421825708283;5606.074997625427;5632.464915832989;6130.693465326716;6147.72335244915;6147.846303842395;6155.230596175478;6156.4766994805495;6349.555531112824;6424.518161137887;6454.774082907075;6617.338266173392;6619.834504137387;6585.242697089848;6631.966840165816;6700.597964122119;6703.664816759143;6704.93295067048;6090.847728806727;6206.844828879314;6211.7204725787;6228.532860035515;6229.470495007975;6564.277929427759;6785.1518560179975;6804.795856124324;6809.216940051859;6825.1809782825385;6336.968315158395;6344.524160687967;6359.07793369968;6441.0982462455295;6476.35236476358;6687.097241872382;6695.163104611924;6695.899561506581;6700.329967003261;6707.631080290534;6548.639824809681;6550.803475895731;6602.537822352485;6607.900881486781;6618.768343107968;6367.42693157618;6487.772927947499;6501.707423165969;6533.803985880431;6618;5311.044012077786;5323.30796996388;5333.546648534918;5361.276227709287;5363.0614642438195;4739.312799644033;4742.264948932921;4757.5718185363485;4759.333693282943;4798.568128868349;6126.754929802847;6155.322914479404;6185.474234690102;6226.533010024266;6227.346128656516;6560;6644.800655980328;6704.463642908556;6706.698198581075;6747.325267473311;6201.224846894138;6214.533909956771;6221.844453888689;6224;6231.127642130105;5777.162311464898;5882.382349853204;5899.970500147472;5923.585349025527;5973.253343332083;6608.603483790988;6709.7316107355155;6726.327367263235;6746.156730408699;6905.102336696398;6439.774607888889;6713.227978782307;6731.091302674076;6760.526763126534;6765.797026089225;6690.966545167243;6722.05891175226;6734.3602357775935;6749.0888730020815;6751.763688270887;6462.870742585216;6469.094326794347;6472.676366181766;6481.0926470295135;6537.150170477998;6647.534672572873;6677.666116694243;6697.3302669734585;6707.966460167668;6708.060871477899;5364.4099149094345;6462.450691691259;6474.320196379501;6486.124373209556;6493.837654058498;4910.3125562422;6058.151858739692;6244.65654389013;6324.3991820776955;6473.870522589427;5702.802411493467;6292.968535157295;6357.364263573606;6372.330905254881;6373.490120790419;6029.065494848305;6429.903551446826;6473.158489396348;6497.642629655415;6517.902231466437;6144.910730351702;6229.190205273286;6324.146240257506;6326.841828954313;6344.524160687874 17:21:43 INFO - PID 1642 | |1;ext.html;695.6382681005877;758.1508710244527;816.9387295952803;1132.0094916947676;1152.1071169843376;28575.71424285759;29071.12786616402;29155;38414.65548705796;38927.61072389275;41128.79435602818;41554.58445415545;41556.37665435013;41577.58422415783;41587;8625.353098517606;8803.73588792334;8811.251043661265;8811.339149563777;8814.867776983318;6154.815355539318;6295.779647712331;8557.572121393936;8647.95676021619;8762.25520830727;8870.11298870111;8888.955555222246;8890.288776897865;8895.332850036273;8900.73297801067;8767.868481972775;8842.5136617486;8844.159804818531;8845.646174153026;8864.468131912074;8617.95691021541;8657.783555411102;8675.826483470295;8678.956605216996;8679.132086791333;31695;38907.8054609728;39096;39114.608853911384;39182.21635567301;2943.8528073596235;2985.3125809601793;2996.5954596129463;3010.2216092686685;3074.571088839814;21358.893205534026;26948.865255673598;27140.592891106648;27587.586186207223;28132;2816.887324507017;2821.774258059371;2824.3362809739697;2831.702671219513;2839.1482555233556;260819.3918060814;263019;264153;264397.9999999981;264470;39432.605673943464;44601.33098003532;46710.59868203959;46800.7659961698;47037.76481117572;50061.998760024595;50139.49860501421;50166;50256.24615630769;50288.99422011539;14305.928470357581;14722.779158312635;14734;14747.829216718457;14750.557483275305;11911;11952.402379881145;11963.983061439874;11974.820377694341;11993.460294286779;9421.858672119924;11868.584599538975;11893;13564.253966031765;13807.378667959965;4945.802167913315;5707.771689132388;5871.471567558855;5879.764809407661;5899.380565040695;961.8990006049404;971.640493017588;982.8157070729753;985.8964808694984;995.5022488755623;24812.00751969937;24884.5023099537;24890.128845490322;24942.750572494042;25063.248102556954;1015.4262841494532;1087.1683162380784;1112.1269803204445;1123.8590485125849;1138.2544433396138;11159.665210043711;12282;12677.492900284069;12697.365131743376;12737.299448530235;412686;415749;416056;416359;416535.9173204115;56257.71871140618;56527.71736141293;56538.71730641321;56595.43404565984;56626;1334.4795529743408;1408.8377088901698;1491.3512622009462;1498.7377208988382;1507.3217052326497;22685.249617273344;24114.84684594843;24301.635475467527;24393;24426.51146977086;38370.0407489815;38447.03882402962;38447.80776096102;38615;38689.6131038686;392746;393133;393337;393850;394377;27211;33305.50041749327;34086;34113.658863411045;34149.146271343416;43675.56324436715;44451.11097778091;44601.66195014155;44665.77667111644;44689.88275293144;28874.27814304659;30265.092047238617;30352.571794255964;30419.84790076124;30534.541981870734;29260.56109158407;29458;30328.696713032587;30591.54112688356;30665.386692266475;35388.11529711778;35919;35923.82038089793;36063;36243.81878090592;26627.934882604477;29415.26461838471;30751.384972300875;31022.0693379199;31097.68902310948;23523.70619615869;23769.52460950806;23905.192769410824;23963.16128935479;24086.87956560276 17:21:43 INFO - PID 1642 | |2;jquery.html;383.113093189267;420.1129053433111;430.2986132603856;430.53932292447087;450.8331917190638;17374.47876563702;21434.03546840392;22251.888740556275;22952.852357382108;23340.883295583542;21969.780302197014;22154.892255387247;22817.885910570465;22891.77108228917;23364.883175584142;3962.544307404642;6111.449969502743;6278.30938596754;6336.017917222838;6343.207099112611;6176.320604733476;6303.432691057804;6306.747730090791;6309.053641953721;6323.272823625273;6001.48987336077;6088.1476593276975;6157.599756015867;6171.814845554641;6188.257409110913;5985.281766188042;6031.939680603182;6032.698365081728;6104.08438734189;6120.806442743667;5413.702246376448;5470.015397228497;5481.972590137064;5483;5486.506214440719;26184.86907565469;26716.332091697863;26758.19725408241;26836.73163268362;27035.324116897038;2002.549426379053;2015.3349394699715;2024.372444542182;2052.0663098290242;2099.233779670409;15893.364265429369;16188.595285117966;16356.591085222846;16462.506124816275;16968.3212671493;1478.526871401152;1617.7411614141681;1659.9031805726895;1718.3384397007242;1785.8660600455019;120208;157203.21398392934;162252.18873905673;166163;166708;11278.379689117177;11588.76822463546;12112.15214934946;12239.510419583117;12585.748285034431;14548.927255363868;16347.34610615562;16483.258253378626;16526.504204873872;16539;8928.642854285756;8938.597763100546;8995.55022248885;9160.175584197454;9217.170454658979;8642.913570864337;8648.78378040554;8650.610722517502;8833.293336533063;8847.46915185091;7119.75080872167;7156.320149585781;7664.934026389489;7816.960915195387;7854;2107.841911856586;2119.3430036688674;2121.7772133926023;2127.3086246969797;2282.281081459335;926.7405126564573;928.4846909964899;930.1210356213448;966.2028826218258;976.1800087926176;17143.485695429157;20918.267860624805;20976.47558811042;21016.054277557545;21599;941.2564074381299;952.8094381123803;990.8166989107038;991.1030517381781;993.1310103659298;8666.95666521676;8972.955135224282;9136.451812891248;10738.94630526858;10783;671589;672890;673049;682324;701711;134982;135843;139218.98981617042;140225;144614.27692861468;1126.2848091461817;1155.329908652996;1172.4489489939715;1174.6769638349522;1175.6002958993984;17787.822121778616;18275.26898924028;18358;18377.540561485534;18474.63050738951;63309.596981734765;63469.52736935078;63763.985961543265;63980.68009659922;64161;90158.54920725354;92578.07421925695;93923.53038234766;94081;94834;8842.734717958472;8863.202311791969;8933;9024.278057755233;9050.321225908216;13745.931270343985;13840.861591383957;13853.722925541231;14378.784318235445;14417.351219194952;10700.946495267473;11104.500297486795;11756.94121529387;11905.345206013752;12110.697232569257;11096.500657470595;11191.44042797873;11390.943045285052;11405.429728513374;11507.597234096766;9894;10254.333468324536;11689.88310116888;11885.5840045598;12069.215500992408;8591.484510929364;8593.914060859312;8975.102489750972;9023.774405639911;9071.455712657262;10852.67441976742;11698.824517632072;11917;11961.64115076549;12023.63929082129 17:21:43 INFO - PID 1642 | |3;mootools.html;1378.379729121895;1422.9217393043384;1444.5016469318089;1453.7964684944104;1462.6050966239115;10525.947370263148;10977.506012229449;10989.560417583287;10991.285566438177;11011.724706882333;9688.854667179998;10672.733181670463;10740.194485413605;10894.782104357908;11031.448427578629;2325.453518423169;2465.753424657538;2466.5436894174545;2467.0131947221075;2471.715752688437;2346.389938615955;2442.5237078769646;2443.3402981195068;2446.1438496526252;2448.400141965221;2352.8353015288935;2449;2453.7668921452523;2454.5459090068307;2462.101333013455;2423.918370984277;2437.4515733959806;2456.4841383309526;2457.557639624858;2465.0755966512556;2406.5066661334386;2413;2420.673209116782;2421.576224160765;2423.018677435641;10687.732806679895;10937.671869843918;10972.122230221643;10976.396298203596;10977.83533247002;6142.293636231801;6366.045093236005;6373.107764912916;6389;6390.520710946697;3604.189057462076;3699.426588878728;3745.2883952049024;4052.817623206933;4053.088055187589;1110.3892858927638;1161.7328014556615;1166.3993043582561;1192.2846292224683;1193.2780667696093;13975.860241397557;14438.350274237684;14438.855611443962;15296.923515382352;15302.08187508753;4130.607592278729;4834.468208497063;4963.081829861487;4967.627427942919;4972.776225069881;11273.379964101889;11570.132240082028;11609.129315301387;11621.24461909973;11631.360275184947;6043.395660434009;6125.387461253928;6185.659788711664;6189.009758438719;6197.81406557804;5859.736311865976;5865.88268234633;5983.9401605983385;5987.191729116601;6020.518358531307;3609.801460919675;3650.302609286641;3830.578636349999;4172.186423647359;4264.424302719155;1262.5833474953242;1265.2977597433512;1268.8858002779793;1287.7102651903247;1289.471316760124;750.598429840033;773.4817672159667;784.3999340504519;785.0932173339802;796.3151689546985;4791.832285870048;5200.63595548308;5814.517298089045;6182.350853160443;6595.340465953366;867.144311174088;869.452245085592;882.7925437522177;894.4722613657973;904.8506996345529;4087.7751723654887;4097.713160078825;4124.649404800625;4167.708260421741;4216.198922204771;11868.347240901834;13546.187228766306;13821.032527722962;14122;14172.716545669029;13555.457781688621;14013.579592612237;14103.435862565588;14117.858821411655;14120.43518259258;10090.293679442515;10292.536835842406;10302.639407620698;10315;10322.380657160595;5426.806102657409;6474;6819.283975182534;6873.106496155668;6895.724171033303;12479.56321528742;12789.93605031969;12806.295653739135;12868.742625147257;12891.097623166288;9547.474888881177;11924.344161071225;13065.477380904656;13068.477260909458;13232.735345293233;8781.297496200417;9079.273658107204;9198.95400522993;9301.395409298373;9324.067593240621;10130.645427410005;10169.186465082923;10233;10271.537780800032;10352.223583231438;8736.213740763362;8815.911840881508;8825.073367296598;8838.513881736566;8863.734087977371;6718.865622687421;8441.240288374076;8518.78703032429;8576.142385761374;8661.480311181349;7717.459777815724;7836.412269079956;7847;7894.447388682966;7906.486078404885;5881.268712108717;5894.587378883437;6004.459598636144;6058.666773327509;6117.265928088658;5792.304923409218;5896.380880007538;6089;6122.510199183966;6264.937350626436 17:21:43 INFO - PID 1642 | |4;prototype.html;307.7845508144299;380.19398874386303;389.4178203585638;401.7208040411915;404.5954045954046;4922.70463772173;6037.788677396286;6073.514118870491;6088.143116349523;6131.662758548278;4762.333273341726;5755.338136114348;5949.5537834662355;5967.283925928884;6019.849503762397;4619.861404157872;4663.880668639536;4703.129920964615;4704.364910737058;4729.101470720552;4338.305871060631;4649.907271791127;4680.765961701918;4712.340272361872;4714.104320179172;4375.234333991539;4607.447106347243;4644.233701439259;4680.315086568849;4687.250039993602;3896.8246428910766;4447.621952134073;4613.284940834143;4665.860024199263;4685.484596694361;4077.7757223352705;4104.486939132608;4105.91788164235;4126.236646220459;4136.172765446922;4786.401699787527;5428.891422171574;5787.50806181475;5849.473547380756;5868.625540314336;5336.706481143536;5386;5393.570703763467;5419.376771671229;5422.40353561108;6401.711922963478;6417.523969487044;6418.474975142513;6437.388448097423;6462.90305645411;3676.5771936227407;3681.7606855554304;3769.378052621314;4525.275955847049;4564.727739460928;5480.698561579112;6395.488360931115;6621.834454138685;6628.138342015555;6656.8668626627195;4609.677322587454;4709.033309015367;4730.266808644666;4731.739754313546;4733.621310295168;4778.426588809365;4803.735794531264;4810.542998415145;4816.903661926812;4818.975905120452;5028.918782461788;5164.870878227999;5287.312649355559;5349.518543331119;5359.356877174764;5874.970625146847;6060.33336333003;6407.295197528269;6411.6153030818305;6430.135260774323;1415.5257988573737;1484.792129101905;1621.7972753405825;1640.1881068870985;1646.3167785368937;880.9911900881037;975.0006243600225;988.2785566536469;997.6558087459815;1002.5037606384886;5903.675297858659;5927.466528012414;5933.228680271537;5945.435183657545;5985.012472941916;5499.50504454601;6544.672766361663;6567.573107748077;6595.901061484082;6610.338966103352;5723.227364305849;5732.283464566929;5838.38696936824;5896.498797602252;5937.2578427696535;3165.4302225599154;3438.607364017577;3445.3109378124477;3451.3960056990427;3455.3780319542725;5045.823396181116;6528.477721782246;6670.232923213893;6726.428253598499;6764.898526522106;6221.889055472264;6274.435300822948;6661.633610151392;6677.833054173588;6723.0923825283935;6319.178506794087;6747.257801641816;6753.716793809161;6790.151231096113;6790.966045169743;5355.625106242525;6194.783182588588;6354.23749150105;6500.3174666659315;6515.54391192612;5629.579280909248;6192.3807619239515;6345.270293916259;6462.4183823456115;6498.350164983463;6306.0587133041845;6673.699683514351;6777.695003724745;6811.8978215325815;6815.352541508549;4056.7565946043333;4311.827526898889;4337.371081193146;4339;4344.804483798173;4873.707577545359;5733.741981610754;6484.773032943825;6530.510211734234;6554.344565543408;5445.992491389105;6348.492120630431;6351.285153008569;6366.681665916593;6385.425311721968;6030.396960303934;6310.5898116622275;6343.619382837044;6382.425581697669;6387.233531976192;5841.824745257649;6260.154879091265;6266.749330026748;6273.404026617464;6277.654728989949;5413.458654134555;6086.360932102242;6307.936920630735;6412.807615771534;6426;6107.511399088151;6173.41352571505;6181.84545386351;6203.193584834124;6203.720832562455 17:21:43 INFO - PID 1642 | |5;yui.html;731.5135434935768;732.721565804994;739.3789217057672;744.285485933504;777.6656037903699;14717.116972981628;15228.771568426482;15463.613409664764;15464.845351546466;15512.991655542395;15070.588705807073;15225.923870380633;15368;15385.38458461663;15409.69180616387;965.5992763003345;977.0913050862695;1009.157353609733;1026.9743256418612;1027.7379268286577;949.1599934058339;995.6166875752851;1023.4626820919003;1026.3328836256455;1028.049054624473;1074.0601973273385;1075.9939456608058;1076.924615276931;1078.7842431513689;1082.4804094034869;1065.845452409404;1066.3388699006628;1066.5680399438163;1068.396356058832;1072.587053984214;796.044746304437;797.4696826610298;800.5836964778283;801.3589128697078;801.4309840013598;16132;16368.427105051385;16542.42101526453;16973;17016.744748828776;14418.711625767426;14766.48317308889;14771.630709232248;14775.70448591033;15504.379824806994;11348.43257837113;11763.294202347886;11813.350265735382;11854.170208085352;12287.815682764765;3026.969730302691;3061;3069.9232519186976;3084.0901933929545;3182.9522557161663;99236;102030;103694;105159.4742026285;105358.47320763348;10009.299349045643;11621.883781162249;11637.359945202927;11737.295762254293;12014.339211343286;24927.750722492907;25212.62181067249;25225.87387063053;25263.242102736946;25264.74735252624;7777.455578109591;7830.960845195737;7904.446688731734;8017.118117007125;8087.83824323522;4072.2466343726505;4136.855210067633;4141.275276826544;4170.22850772608;4193.643540299047;4140.979295103505;4172.311568591209;4248.745075295492;4267.637250833652;4267.722598031118;799.3245707377257;827.8178800663844;853.1724227499316;870.3559366069063;892.8794612727329;535.8821059366933;570.5065118672319;598.964062156272;604.4559896093463;621.4903778901257;8851.46891186518;9477.478738669439;10268.640597579199;10310.32982856112;10699.572017119384;549.8075673514238;585.8681796595732;590.893639144958;591.5031373646158;609.8627808742997;3881.5536213335827;4592.173408786383;4793.065352256276;4811.133995880775;4814.074051961745;100472.49763751135;100720;103192;104312;104791.42812857813;56708.149377759364;84869;86457.13542864617;88648.5567572158;89957;77042.22957770462;77770;78415.60792196002;78926.6053669728;79136.60431697805;9511.66709165176;9513.809723805623;9591.136797687963;9600.75998100053;9610.95194524023;37686;37837.86486405412;38073;38868.222635547696;39149.021274467224;48885.75557122192;49190.52428427153;49688.75155624199;49821.256256030865;50375;11534.653960381202;11864.466099025392;11899.04807615406;11968.700782480508;12223.511059557519;11661.475233614678;12523.749525009267;12709.17390369623;13238.602841914759;13298.468061277828;11596.014338781299;11803;11933.701657458632;11947.462364193805;12220.694482638006;11609.593664221711;11808.645740627795;11863.406829658656;12032.75934481323;12059.249558505438;11366.659000230007;11641.6507504775;11653.184277100521;12035.699107522032;12336.876631233572;8563.357748169037;8565;8673.436226645248;9118.133777291147;9202.861957070516;6048.818535443944;8714.869276960724;9922.801543969224;10119.494025298853;10149.49252537385 17:21:43 INFO - PID 1642 | __end_tp_report 17:21:43 INFO - PID 1642 | __start_cc_report 17:21:43 INFO - PID 1642 | _x_x_mozilla_cycle_collect,1652 17:21:43 INFO - PID 1642 | __end_cc_report 17:21:43 INFO - PID 1642 | __startTimestamp1490833303879__endTimestamp 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | ------- Summary: start ------- 17:21:43 INFO - PID 1642 | Number of tests: 6 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6106.54 Median:6244.66 stddev:689.54 (11.0%) stddev-sans-first:659.70 17:21:43 INFO - PID 1642 | Values: 3461.4 3465.3 3495.6 3511.0 3513.3 6003.4 6126.3 6174.0 6185.3 6188.1 6112.0 6129.0 6134.1 6197.7 6200.8 5514.4 5575.1 5606.4 5620.1 5709.0 5516.6 5599.6 5691.9 5700.3 5718.2 5417.1 5627.5 5639.6 5688.9 5689.5 5477.9 5552.5 5570.6 5598.8 5616.4 4501.6 5489.8 5506.4 5606.1 5632.5 6130.7 6147.7 6147.8 6155.2 6156.5 6349.6 6424.5 6454.8 6617.3 6619.8 6585.2 6632.0 6700.6 6703.7 6704.9 6090.8 6206.8 6211.7 6228.5 6229.5 6564.3 6785.2 6804.8 6809.2 6825.2 6337.0 6344.5 6359.1 6441.1 6476.4 6687.1 6695.2 6695.9 6700.3 6707.6 6548.6 6550.8 6602.5 6607.9 6618.8 6367.4 6487.8 6501.7 6533.8 6618.0 5311.0 5323.3 5333.5 5361.3 5363.1 4739.3 4742.3 4757.6 4759.3 4798.6 6126.8 6155.3 6185.5 6226.5 6227.3 6560.0 6644.8 6704.5 6706.7 6747.3 6201.2 6214.5 6221.8 6224.0 6231.1 5777.2 5882.4 5900.0 5923.6 5973.3 6608.6 6709.7 6726.3 6746.2 6905.1 6439.8 6713.2 6731.1 6760.5 6765.8 6691.0 6722.1 6734.4 6749.1 6751.8 6462.9 6469.1 6472.7 6481.1 6537.2 6647.5 6677.7 6697.3 6708.0 6708.1 5364.4 6462.5 6474.3 6486.1 6493.8 4910.3 6058.2 6244.7 6324.4 6473.9 5702.8 6293.0 6357.4 6372.3 6373.5 6029.1 6429.9 6473.2 6497.6 6517.9 6144.9 6229.2 6324.1 6326.8 6344.5 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:49610.64 Median:35653.56 stddev:96337.53 (270.2%) stddev-sans-first:96537.78 17:21:43 INFO - PID 1642 | Values: 695.6 758.2 816.9 1132.0 1152.1 28575.7 29071.1 29155.0 38414.7 38927.6 41128.8 41554.6 41556.4 41577.6 41587.0 8625.4 8803.7 8811.3 8811.3 8814.9 6154.8 6295.8 8557.6 8648.0 8762.3 8870.1 8889.0 8890.3 8895.3 8900.7 8767.9 8842.5 8844.2 8845.6 8864.5 8618.0 8657.8 8675.8 8679.0 8679.1 31695.0 38907.8 39096.0 39114.6 39182.2 2943.9 2985.3 2996.6 3010.2 3074.6 21358.9 26948.9 27140.6 27587.6 28132.0 2816.9 2821.8 2824.3 2831.7 2839.1 260819.4 263019.0 264153.0 264398.0 264470.0 39432.6 44601.3 46710.6 46800.8 47037.8 50062.0 50139.5 50166.0 50256.2 50289.0 14305.9 14722.8 14734.0 14747.8 14750.6 11911.0 11952.4 11964.0 11974.8 11993.5 9421.9 11868.6 11893.0 13564.3 13807.4 4945.8 5707.8 5871.5 5879.8 5899.4 961.9 971.6 982.8 985.9 995.5 24812.0 24884.5 24890.1 24942.8 25063.2 1015.4 1087.2 1112.1 1123.9 1138.3 11159.7 12282.0 12677.5 12697.4 12737.3 412686.0 415749.0 416056.0 416359.0 416535.9 56257.7 56527.7 56538.7 56595.4 56626.0 1334.5 1408.8 1491.4 1498.7 1507.3 22685.2 24114.8 24301.6 24393.0 24426.5 38370.0 38447.0 38447.8 38615.0 38689.6 392746.0 393133.0 393337.0 393850.0 394377.0 27211.0 33305.5 34086.0 34113.7 34149.1 43675.6 44451.1 44601.7 44665.8 44689.9 28874.3 30265.1 30352.6 30419.8 30534.5 29260.6 29458.0 30328.7 30591.5 30665.4 35388.1 35919.0 35923.8 36063.0 36243.8 26627.9 29415.3 30751.4 31022.1 31097.7 23523.7 23769.5 23905.2 23963.2 24086.9 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:39889.80 Median:24774.88 stddev:114140.48 (460.7%) stddev-sans-first:114422.12 17:21:43 INFO - PID 1642 | Values: 383.1 420.1 430.3 430.5 450.8 17374.5 21434.0 22251.9 22952.9 23340.9 21969.8 22154.9 22817.9 22891.8 23364.9 3962.5 6111.4 6278.3 6336.0 6343.2 6176.3 6303.4 6306.7 6309.1 6323.3 6001.5 6088.1 6157.6 6171.8 6188.3 5985.3 6031.9 6032.7 6104.1 6120.8 5413.7 5470.0 5482.0 5483.0 5486.5 26184.9 26716.3 26758.2 26836.7 27035.3 2002.5 2015.3 2024.4 2052.1 2099.2 15893.4 16188.6 16356.6 16462.5 16968.3 1478.5 1617.7 1659.9 1718.3 1785.9 120208.0 157203.2 162252.2 166163.0 166708.0 11278.4 11588.8 12112.2 12239.5 12585.7 14548.9 16347.3 16483.3 16526.5 16539.0 8928.6 8938.6 8995.6 9160.2 9217.2 8642.9 8648.8 8650.6 8833.3 8847.5 7119.8 7156.3 7664.9 7817.0 7854.0 2107.8 2119.3 2121.8 2127.3 2282.3 926.7 928.5 930.1 966.2 976.2 17143.5 20918.3 20976.5 21016.1 21599.0 941.3 952.8 990.8 991.1 993.1 8667.0 8973.0 9136.5 10738.9 10783.0 671589.0 672890.0 673049.0 682324.0 701711.0 134982.0 135843.0 139219.0 140225.0 144614.3 1126.3 1155.3 1172.4 1174.7 1175.6 17787.8 18275.3 18358.0 18377.5 18474.6 63309.6 63469.5 63764.0 63980.7 64161.0 90158.5 92578.1 93923.5 94081.0 94834.0 8842.7 8863.2 8933.0 9024.3 9050.3 13745.9 13840.9 13853.7 14378.8 14417.4 10700.9 11104.5 11756.9 11905.3 12110.7 11096.5 11191.4 11390.9 11405.4 11507.6 9894.0 10254.3 11689.9 11885.6 12069.2 8591.5 8593.9 8975.1 9023.8 9071.5 10852.7 11698.8 11917.0 11961.6 12023.6 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:6737.55 Median:2466.78 stddev:4178.09 (169.4%) stddev-sans-first:4170.41 17:21:43 INFO - PID 1642 | Values: 1378.4 1422.9 1444.5 1453.8 1462.6 10525.9 10977.5 10989.6 10991.3 11011.7 9688.9 10672.7 10740.2 10894.8 11031.4 2325.5 2465.8 2466.5 2467.0 2471.7 2346.4 2442.5 2443.3 2446.1 2448.4 2352.8 2449.0 2453.8 2454.5 2462.1 2423.9 2437.5 2456.5 2457.6 2465.1 2406.5 2413.0 2420.7 2421.6 2423.0 10687.7 10937.7 10972.1 10976.4 10977.8 6142.3 6366.0 6373.1 6389.0 6390.5 3604.2 3699.4 3745.3 4052.8 4053.1 1110.4 1161.7 1166.4 1192.3 1193.3 13975.9 14438.4 14438.9 15296.9 15302.1 4130.6 4834.5 4963.1 4967.6 4972.8 11273.4 11570.1 11609.1 11621.2 11631.4 6043.4 6125.4 6185.7 6189.0 6197.8 5859.7 5865.9 5983.9 5987.2 6020.5 3609.8 3650.3 3830.6 4172.2 4264.4 1262.6 1265.3 1268.9 1287.7 1289.5 750.6 773.5 784.4 785.1 796.3 4791.8 5200.6 5814.5 6182.4 6595.3 867.1 869.5 882.8 894.5 904.9 4087.8 4097.7 4124.6 4167.7 4216.2 11868.3 13546.2 13821.0 14122.0 14172.7 13555.5 14013.6 14103.4 14117.9 14120.4 10090.3 10292.5 10302.6 10315.0 10322.4 5426.8 6474.0 6819.3 6873.1 6895.7 12479.6 12789.9 12806.3 12868.7 12891.1 9547.5 11924.3 13065.5 13068.5 13232.7 8781.3 9079.3 9199.0 9301.4 9324.1 10130.6 10169.2 10233.0 10271.5 10352.2 8736.2 8815.9 8825.1 8838.5 8863.7 6718.9 8441.2 8518.8 8576.1 8661.5 7717.5 7836.4 7847.0 7894.4 7906.5 5881.3 5894.6 6004.5 6058.7 6117.3 5792.3 5896.4 6089.0 6122.5 6264.9 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5196.84 Median:5859.05 stddev:1568.24 (26.8%) stddev-sans-first:1529.10 17:21:43 INFO - PID 1642 | Values: 307.8 380.2 389.4 401.7 404.6 4922.7 6037.8 6073.5 6088.1 6131.7 4762.3 5755.3 5949.6 5967.3 6019.8 4619.9 4663.9 4703.1 4704.4 4729.1 4338.3 4649.9 4680.8 4712.3 4714.1 4375.2 4607.4 4644.2 4680.3 4687.3 3896.8 4447.6 4613.3 4665.9 4685.5 4077.8 4104.5 4105.9 4126.2 4136.2 4786.4 5428.9 5787.5 5849.5 5868.6 5336.7 5386.0 5393.6 5419.4 5422.4 6401.7 6417.5 6418.5 6437.4 6462.9 3676.6 3681.8 3769.4 4525.3 4564.7 5480.7 6395.5 6621.8 6628.1 6656.9 4609.7 4709.0 4730.3 4731.7 4733.6 4778.4 4803.7 4810.5 4816.9 4819.0 5028.9 5164.9 5287.3 5349.5 5359.4 5875.0 6060.3 6407.3 6411.6 6430.1 1415.5 1484.8 1621.8 1640.2 1646.3 881.0 975.0 988.3 997.7 1002.5 5903.7 5927.5 5933.2 5945.4 5985.0 5499.5 6544.7 6567.6 6595.9 6610.3 5723.2 5732.3 5838.4 5896.5 5937.3 3165.4 3438.6 3445.3 3451.4 3455.4 5045.8 6528.5 6670.2 6726.4 6764.9 6221.9 6274.4 6661.6 6677.8 6723.1 6319.2 6747.3 6753.7 6790.2 6791.0 5355.6 6194.8 6354.2 6500.3 6515.5 5629.6 6192.4 6345.3 6462.4 6498.4 6306.1 6673.7 6777.7 6811.9 6815.4 4056.8 4311.8 4337.4 4339.0 4344.8 4873.7 5733.7 6484.8 6530.5 6554.3 5446.0 6348.5 6351.3 6366.7 6385.4 6030.4 6310.6 6343.6 6382.4 6387.2 5841.8 6260.2 6266.7 6273.4 6277.7 5413.5 6086.4 6307.9 6412.8 6426.0 6107.5 6173.4 6181.8 6203.2 6203.7 17:21:43 INFO - PID 1642 | 17:21:43 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:19245.80 Median:3043.98 stddev:27842.28 (914.7%) stddev-sans-first:27885.68 17:21:43 INFO - PID 1642 | Values: 731.5 732.7 739.4 744.3 777.7 14717.1 15228.8 15463.6 15464.8 15513.0 15070.6 15225.9 15368.0 15385.4 15409.7 965.6 977.1 1009.2 1027.0 1027.7 949.2 995.6 1023.5 1026.3 1028.0 1074.1 1076.0 1076.9 1078.8 1082.5 1065.8 1066.3 1066.6 1068.4 1072.6 796.0 797.5 800.6 801.4 801.4 16132.0 16368.4 16542.4 16973.0 17016.7 14418.7 14766.5 14771.6 14775.7 15504.4 11348.4 11763.3 11813.4 11854.2 12287.8 3027.0 3061.0 3069.9 3084.1 3183.0 99236.0 102030.0 103694.0 105159.5 105358.5 10009.3 11621.9 11637.4 11737.3 12014.3 24927.8 25212.6 25225.9 25263.2 25264.7 7777.5 7831.0 7904.4 8017.1 8087.8 4072.2 4136.9 4141.3 4170.2 4193.6 4141.0 4172.3 4248.7 4267.6 4267.7 799.3 827.8 853.2 870.4 892.9 535.9 570.5 599.0 604.5 621.5 8851.5 9477.5 10268.6 10310.3 10699.6 549.8 585.9 590.9 591.5 609.9 3881.6 4592.2 4793.1 4811.1 4814.1 100472.5 100720.0 103192.0 104312.0 104791.4 56708.1 84869.0 86457.1 88648.6 89957.0 77042.2 77770.0 78415.6 78926.6 79136.6 9511.7 9513.8 9591.1 9600.8 9611.0 37686.0 37837.9 38073.0 38868.2 39149.0 48885.8 49190.5 49688.8 49821.3 50375.0 11534.7 11864.5 11899.0 11968.7 12223.5 11661.5 12523.7 12709.2 13238.6 13298.5 11596.0 11803.0 11933.7 11947.5 12220.7 11609.6 11808.6 11863.4 12032.8 12059.2 11366.7 11641.7 11653.2 12035.7 12336.9 8563.4 8565.0 8673.4 9118.1 9202.9 6048.8 8714.9 9922.8 10119.5 10149.5 17:21:43 INFO - PID 1642 | -------- Summary: end -------- 17:21:43 INFO - PID 1642 | 17:21:44 INFO - TEST-INFO | 1642: exit 0 17:21:44 INFO - TEST-OK | dromaeo_css | took 1123078ms 17:21:44 INFO - TEST-START | kraken 17:21:44 INFO - operating with platform_type : mac_ 17:21:44 INFO - Initialising browser for kraken test... 17:21:44 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpyFO8rG/profile http://localhost:49243/getInfo.html) 17:21:47 INFO - PID 1652 | __metrics Screen width/height:1600/1200 17:21:47 INFO - PID 1652 | colorDepth:24 17:21:47 INFO - PID 1652 | Browser inner width/height: 1024/689 17:21:47 INFO - PID 1652 | __metrics 17:21:47 ERROR - PID 1652 | 1490833307284 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:21:47 INFO - PID 1652 | 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" 17:21:47 INFO - PID 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:21:48 INFO - TEST-INFO | 1652: exit 0 17:21:48 INFO - Browser initialized. 17:21:48 INFO - Running cycle 1/1 for kraken test... 17:21:48 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpyFO8rG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:00 INFO - PID 1653 | RSS: Main: 234340352 17:22:00 INFO - PID 1653 | 17:22:03 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:04 INFO - PID 1653 | RSS: Main: 286928896 17:22:04 INFO - PID 1653 | 17:22:06 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 17:22:07 INFO - PID 1653 | RSS: Main: 288333824 17:22:07 INFO - PID 1653 | 17:22:11 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 17:22:11 INFO - PID 1653 | RSS: Main: 379654144 17:22:11 INFO - PID 1653 | 17:22:14 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 17:22:14 INFO - PID 1653 | RSS: Main: 284098560 17:22:14 INFO - PID 1653 | 17:22:16 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:17 INFO - PID 1653 | RSS: Main: 286941184 17:22:17 INFO - PID 1653 | 17:22:20 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:21 INFO - PID 1653 | RSS: Main: 329007104 17:22:21 INFO - PID 1653 | 17:22:24 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:25 INFO - PID 1653 | RSS: Main: 335704064 17:22:25 INFO - PID 1653 | 17:22:28 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 17:22:29 INFO - PID 1653 | RSS: Main: 342581248 17:22:29 INFO - PID 1653 | 17:22:30 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:31 INFO - PID 1653 | RSS: Main: 305541120 17:22:31 INFO - PID 1653 | 17:22:33 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:33 INFO - PID 1653 | RSS: Main: 308359168 17:22:33 INFO - PID 1653 | 17:22:36 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:36 INFO - PID 1653 | RSS: Main: 310194176 17:22:36 INFO - PID 1653 | 17:22:39 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:40 INFO - PID 1653 | RSS: Main: 328540160 17:22:40 INFO - PID 1653 | 17:22:44 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:44 INFO - PID 1653 | RSS: Main: 311443456 17:22:44 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 17:22:46 INFO - PID 1653 | RSS: Main: 377987072 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | __start_tp_report 17:22:46 INFO - PID 1653 | _x_x_mozilla_page_load 17:22:46 INFO - PID 1653 | _x_x_mozilla_page_load_details 17:22:46 INFO - PID 1653 | |i|pagename|runs| 17:22:46 INFO - PID 1653 | |0;ai-astar;111;123;130;152;122;122;122;123;144;180 17:22:46 INFO - PID 1653 | |1;audio-beat-detection;157;116;118;162;118;119;117;116;141;117 17:22:46 INFO - PID 1653 | |2;audio-dft;215;212;216;221;212;210;209;208;212;215 17:22:46 INFO - PID 1653 | |3;audio-fft;85;64;85;129;95;60;64;80;111;87 17:22:46 INFO - PID 1653 | |4;audio-oscillator;96;78;94;74;74;74;91;75;73;91 17:22:46 INFO - PID 1653 | |5;imaging-gaussian-blur;119;83;143;120;95;96;95;94;95;90 17:22:46 INFO - PID 1653 | |6;imaging-darkroom;100;100;99;99;99;99;137;100;101;101 17:22:46 INFO - PID 1653 | |7;imaging-desaturate;100;102;99;100;98;101;100;102;102;98 17:22:46 INFO - PID 1653 | |8;json-parse-financial;66;64;64;63;64;64;65;65;65;65 17:22:46 INFO - PID 1653 | |9;json-stringify-tinderbox;62;71;63;71;65;64;66;65;66;65 17:22:46 INFO - PID 1653 | |10;stanford-crypto-aes;89;92;91;94;93;90;93;89;88;89 17:22:46 INFO - PID 1653 | |11;stanford-crypto-ccm;151;148;168;167;168;155;151;150;192;160 17:22:46 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;199;205;197;202;205;200;202;252;237;201 17:22:46 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;73;74;74;71;75;72;72;73;75;74 17:22:46 INFO - PID 1653 | __end_tp_report 17:22:46 INFO - PID 1653 | __start_cc_report 17:22:46 INFO - PID 1653 | _x_x_mozilla_cycle_collect,2152 17:22:46 INFO - PID 1653 | __end_cc_report 17:22:46 INFO - PID 1653 | __startTimestamp1490833366876__endTimestamp 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | ------- Summary: start ------- 17:22:46 INFO - PID 1653 | Number of tests: 14 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:132.90 Median:126.50 stddev:20.40 (16.1%) stddev-sans-first:20.04 17:22:46 INFO - PID 1653 | Values: 111.0 123.0 130.0 152.0 122.0 122.0 122.0 123.0 144.0 180.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:118.50 stddev:18.19 (15.3%) stddev-sans-first:16.00 17:22:46 INFO - PID 1653 | Values: 157.0 116.0 118.0 162.0 118.0 119.0 117.0 116.0 141.0 117.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:213.00 Median:213.50 stddev:3.86 (1.8%) stddev-sans-first:4.02 17:22:46 INFO - PID 1653 | Values: 215.0 212.0 216.0 221.0 212.0 210.0 209.0 208.0 212.0 215.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:86.00 Median:82.50 stddev:21.70 (26.3%) stddev-sans-first:23.01 17:22:46 INFO - PID 1653 | Values: 85.0 64.0 85.0 129.0 95.0 60.0 64.0 80.0 111.0 87.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:84.50 stddev:9.66 (11.4%) stddev-sans-first:8.82 17:22:46 INFO - PID 1653 | Values: 96.0 78.0 94.0 74.0 74.0 74.0 91.0 75.0 73.0 91.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:94.50 stddev:18.37 (19.4%) stddev-sans-first:18.55 17:22:46 INFO - PID 1653 | Values: 119.0 83.0 143.0 120.0 95.0 96.0 95.0 94.0 95.0 90.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:118.00 stddev:11.80 (10.0%) stddev-sans-first:12.44 17:22:46 INFO - PID 1653 | Values: 100.0 100.0 99.0 99.0 99.0 99.0 137.0 100.0 101.0 101.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:100.20 Median:102.00 stddev:1.55 (1.5%) stddev-sans-first:1.64 17:22:46 INFO - PID 1653 | Values: 100.0 102.0 99.0 100.0 98.0 101.0 100.0 102.0 102.0 98.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 17:22:46 INFO - PID 1653 | Values: 66.0 64.0 64.0 63.0 64.0 64.0 65.0 65.0 65.0 65.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.50 stddev:3.01 (4.6%) stddev-sans-first:2.86 17:22:46 INFO - PID 1653 | Values: 62.0 71.0 63.0 71.0 65.0 64.0 66.0 65.0 66.0 65.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:91.50 stddev:2.10 (2.3%) stddev-sans-first:2.12 17:22:46 INFO - PID 1653 | Values: 89.0 92.0 91.0 94.0 93.0 90.0 93.0 89.0 88.0 89.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:161.00 Median:163.50 stddev:13.42 (8.2%) stddev-sans-first:13.74 17:22:46 INFO - PID 1653 | Values: 151.0 148.0 168.0 167.0 168.0 155.0 151.0 150.0 192.0 160.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:210.00 Median:203.50 stddev:18.68 (9.2%) stddev-sans-first:19.39 17:22:46 INFO - PID 1653 | Values: 199.0 205.0 197.0 202.0 205.0 200.0 202.0 252.0 237.0 201.0 17:22:46 INFO - PID 1653 | 17:22:46 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:1.34 (1.8%) stddev-sans-first:1.41 17:22:46 INFO - PID 1653 | Values: 73.0 74.0 74.0 71.0 75.0 72.0 72.0 73.0 75.0 74.0 17:22:46 INFO - PID 1653 | -------- Summary: end -------- 17:22:46 INFO - PID 1653 | 17:22:47 INFO - TEST-INFO | 1653: exit 0 17:22:47 INFO - TEST-OK | kraken | took 63095ms 17:22:47 INFO - SUITE-END | took 1186s 17:22:48 INFO - Completed test suite (00:19:46) 17:22:48 INFO - javascript benchmark 17:22:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7615.519155215155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3461.4461686130207, 3465.3069386122775, 3495.580530336359, 3511.0, 3513.2973405318926, 6003.369646187142, 6126.303932855867, 6174.04302333138, 6185.288691800444, 6188.071789231618, 6111.986793494201, 6128.969355153218, 6134.069235337271, 6197.659128747917, 6200.81397558074, 5514.365847927479, 5575.0522411189995, 5606.355269144039, 5620.100783874561, 5708.971455142719, 5516.586256030793, 5599.608027438081, 5691.8577035574235, 5700.287464066992, 5718.170865224561, 5417.052015897202, 5627.521660658849, 5639.6334238274385, 5688.943110568904, 5689.4879460848515, 5477.890442191174, 5552.500274975271, 5570.637908535973, 5598.832035038955, 5616.410276920946, 4501.572350626685, 5489.752961116759, 5506.421825708283, 5606.074997625427, 5632.464915832989, 6130.693465326716, 6147.72335244915, 6147.846303842395, 6155.230596175478, 6156.4766994805495, 6349.555531112824, 6424.518161137887, 6454.774082907075, 6617.338266173392, 6619.834504137387, 6585.242697089848, 6631.966840165816, 6700.597964122119, 6703.664816759143, 6704.93295067048, 6090.847728806727, 6206.844828879314, 6211.7204725787, 6228.532860035515, 6229.470495007975, 6564.277929427759, 6785.1518560179975, 6804.795856124324, 6809.216940051859, 6825.1809782825385, 6336.968315158395, 6344.524160687967, 6359.07793369968, 6441.0982462455295, 6476.35236476358, 6687.097241872382, 6695.163104611924, 6695.899561506581, 6700.329967003261, 6707.631080290534, 6548.639824809681, 6550.803475895731, 6602.537822352485, 6607.900881486781, 6618.768343107968, 6367.42693157618, 6487.772927947499, 6501.707423165969, 6533.803985880431, 6618.0, 5311.044012077786, 5323.30796996388, 5333.546648534918, 5361.276227709287, 5363.0614642438195, 4739.312799644033, 4742.264948932921, 4757.5718185363485, 4759.333693282943, 4798.568128868349, 6126.754929802847, 6155.322914479404, 6185.474234690102, 6226.533010024266, 6227.346128656516, 6560.0, 6644.800655980328, 6704.463642908556, 6706.698198581075, 6747.325267473311, 6201.224846894138, 6214.533909956771, 6221.844453888689, 6224.0, 6231.127642130105, 5777.162311464898, 5882.382349853204, 5899.970500147472, 5923.585349025527, 5973.253343332083, 6608.603483790988, 6709.7316107355155, 6726.327367263235, 6746.156730408699, 6905.102336696398, 6439.774607888889, 6713.227978782307, 6731.091302674076, 6760.526763126534, 6765.797026089225, 6690.966545167243, 6722.05891175226, 6734.3602357775935, 6749.0888730020815, 6751.763688270887, 6462.870742585216, 6469.094326794347, 6472.676366181766, 6481.0926470295135, 6537.150170477998, 6647.534672572873, 6677.666116694243, 6697.3302669734585, 6707.966460167668, 6708.060871477899, 5364.4099149094345, 6462.450691691259, 6474.320196379501, 6486.124373209556, 6493.837654058498, 4910.3125562422, 6058.151858739692, 6244.65654389013, 6324.3991820776955, 6473.870522589427, 5702.802411493467, 6292.968535157295, 6357.364263573606, 6372.330905254881, 6373.490120790419, 6029.065494848305, 6429.903551446826, 6473.158489396348, 6497.642629655415, 6517.902231466437, 6144.910730351702, 6229.190205273286, 6324.146240257506, 6326.841828954313, 6344.524160687874], "value": 6062.322189695399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.6382681005877, 758.1508710244527, 816.9387295952803, 1132.0094916947676, 1152.1071169843376, 28575.71424285759, 29071.12786616402, 29155.0, 38414.65548705796, 38927.61072389275, 41128.79435602818, 41554.58445415545, 41556.37665435013, 41577.58422415783, 41587.0, 8625.353098517606, 8803.73588792334, 8811.251043661265, 8811.339149563777, 8814.867776983318, 6154.815355539318, 6295.779647712331, 8557.572121393936, 8647.95676021619, 8762.25520830727, 8870.11298870111, 8888.955555222246, 8890.288776897865, 8895.332850036273, 8900.73297801067, 8767.868481972775, 8842.5136617486, 8844.159804818531, 8845.646174153026, 8864.468131912074, 8617.95691021541, 8657.783555411102, 8675.826483470295, 8678.956605216996, 8679.132086791333, 31695.0, 38907.8054609728, 39096.0, 39114.608853911384, 39182.21635567301, 2943.8528073596235, 2985.3125809601793, 2996.5954596129463, 3010.2216092686685, 3074.571088839814, 21358.893205534026, 26948.865255673598, 27140.592891106648, 27587.586186207223, 28132.0, 2816.887324507017, 2821.774258059371, 2824.3362809739697, 2831.702671219513, 2839.1482555233556, 260819.3918060814, 263019.0, 264153.0, 264397.9999999981, 264470.0, 39432.605673943464, 44601.33098003532, 46710.59868203959, 46800.7659961698, 47037.76481117572, 50061.998760024595, 50139.49860501421, 50166.0, 50256.24615630769, 50288.99422011539, 14305.928470357581, 14722.779158312635, 14734.0, 14747.829216718457, 14750.557483275305, 11911.0, 11952.402379881145, 11963.983061439874, 11974.820377694341, 11993.460294286779, 9421.858672119924, 11868.584599538975, 11893.0, 13564.253966031765, 13807.378667959965, 4945.802167913315, 5707.771689132388, 5871.471567558855, 5879.764809407661, 5899.380565040695, 961.8990006049404, 971.640493017588, 982.8157070729753, 985.8964808694984, 995.5022488755623, 24812.00751969937, 24884.5023099537, 24890.128845490322, 24942.750572494042, 25063.248102556954, 1015.4262841494532, 1087.1683162380784, 1112.1269803204445, 1123.8590485125849, 1138.2544433396138, 11159.665210043711, 12282.0, 12677.492900284069, 12697.365131743376, 12737.299448530235, 412686.0, 415749.0, 416056.0, 416359.0, 416535.9173204115, 56257.71871140618, 56527.71736141293, 56538.71730641321, 56595.43404565984, 56626.0, 1334.4795529743408, 1408.8377088901698, 1491.3512622009462, 1498.7377208988382, 1507.3217052326497, 22685.249617273344, 24114.84684594843, 24301.635475467527, 24393.0, 24426.51146977086, 38370.0407489815, 38447.03882402962, 38447.80776096102, 38615.0, 38689.6131038686, 392746.0, 393133.0, 393337.0, 393850.0, 394377.0, 27211.0, 33305.50041749327, 34086.0, 34113.658863411045, 34149.146271343416, 43675.56324436715, 44451.11097778091, 44601.66195014155, 44665.77667111644, 44689.88275293144, 28874.27814304659, 30265.092047238617, 30352.571794255964, 30419.84790076124, 30534.541981870734, 29260.56109158407, 29458.0, 30328.696713032587, 30591.54112688356, 30665.386692266475, 35388.11529711778, 35919.0, 35923.82038089793, 36063.0, 36243.81878090592, 26627.934882604477, 29415.26461838471, 30751.384972300875, 31022.0693379199, 31097.68902310948, 23523.70619615869, 23769.52460950806, 23905.192769410824, 23963.16128935479, 24086.87956560276], "value": 17406.23262432209, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.113093189267, 420.1129053433111, 430.2986132603856, 430.53932292447087, 450.8331917190638, 17374.47876563702, 21434.03546840392, 22251.888740556275, 22952.852357382108, 23340.883295583542, 21969.780302197014, 22154.892255387247, 22817.885910570465, 22891.77108228917, 23364.883175584142, 3962.544307404642, 6111.449969502743, 6278.30938596754, 6336.017917222838, 6343.207099112611, 6176.320604733476, 6303.432691057804, 6306.747730090791, 6309.053641953721, 6323.272823625273, 6001.48987336077, 6088.1476593276975, 6157.599756015867, 6171.814845554641, 6188.257409110913, 5985.281766188042, 6031.939680603182, 6032.698365081728, 6104.08438734189, 6120.806442743667, 5413.702246376448, 5470.015397228497, 5481.972590137064, 5483.0, 5486.506214440719, 26184.86907565469, 26716.332091697863, 26758.19725408241, 26836.73163268362, 27035.324116897038, 2002.549426379053, 2015.3349394699715, 2024.372444542182, 2052.0663098290242, 2099.233779670409, 15893.364265429369, 16188.595285117966, 16356.591085222846, 16462.506124816275, 16968.3212671493, 1478.526871401152, 1617.7411614141681, 1659.9031805726895, 1718.3384397007242, 1785.8660600455019, 120208.0, 157203.21398392934, 162252.18873905673, 166163.0, 166708.0, 11278.379689117177, 11588.76822463546, 12112.15214934946, 12239.510419583117, 12585.748285034431, 14548.927255363868, 16347.34610615562, 16483.258253378626, 16526.504204873872, 16539.0, 8928.642854285756, 8938.597763100546, 8995.55022248885, 9160.175584197454, 9217.170454658979, 8642.913570864337, 8648.78378040554, 8650.610722517502, 8833.293336533063, 8847.46915185091, 7119.75080872167, 7156.320149585781, 7664.934026389489, 7816.960915195387, 7854.0, 2107.841911856586, 2119.3430036688674, 2121.7772133926023, 2127.3086246969797, 2282.281081459335, 926.7405126564573, 928.4846909964899, 930.1210356213448, 966.2028826218258, 976.1800087926176, 17143.485695429157, 20918.267860624805, 20976.47558811042, 21016.054277557545, 21599.0, 941.2564074381299, 952.8094381123803, 990.8166989107038, 991.1030517381781, 993.1310103659298, 8666.95666521676, 8972.955135224282, 9136.451812891248, 10738.94630526858, 10783.0, 671589.0, 672890.0, 673049.0, 682324.0, 701711.0, 134982.0, 135843.0, 139218.98981617042, 140225.0, 144614.27692861468, 1126.2848091461817, 1155.329908652996, 1172.4489489939715, 1174.6769638349522, 1175.6002958993984, 17787.822121778616, 18275.26898924028, 18358.0, 18377.540561485534, 18474.63050738951, 63309.596981734765, 63469.52736935078, 63763.985961543265, 63980.68009659922, 64161.0, 90158.54920725354, 92578.07421925695, 93923.53038234766, 94081.0, 94834.0, 8842.734717958472, 8863.202311791969, 8933.0, 9024.278057755233, 9050.321225908216, 13745.931270343985, 13840.861591383957, 13853.722925541231, 14378.784318235445, 14417.351219194952, 10700.946495267473, 11104.500297486795, 11756.94121529387, 11905.345206013752, 12110.697232569257, 11096.500657470595, 11191.44042797873, 11390.943045285052, 11405.429728513374, 11507.597234096766, 9894.0, 10254.333468324536, 11689.88310116888, 11885.5840045598, 12069.215500992408, 8591.484510929364, 8593.914060859312, 8975.102489750972, 9023.774405639911, 9071.455712657262, 10852.67441976742, 11698.824517632072, 11917.0, 11961.64115076549, 12023.63929082129], "value": 10352.297307642042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.379729121895, 1422.9217393043384, 1444.5016469318089, 1453.7964684944104, 1462.6050966239115, 10525.947370263148, 10977.506012229449, 10989.560417583287, 10991.285566438177, 11011.724706882333, 9688.854667179998, 10672.733181670463, 10740.194485413605, 10894.782104357908, 11031.448427578629, 2325.453518423169, 2465.753424657538, 2466.5436894174545, 2467.0131947221075, 2471.715752688437, 2346.389938615955, 2442.5237078769646, 2443.3402981195068, 2446.1438496526252, 2448.400141965221, 2352.8353015288935, 2449.0, 2453.7668921452523, 2454.5459090068307, 2462.101333013455, 2423.918370984277, 2437.4515733959806, 2456.4841383309526, 2457.557639624858, 2465.0755966512556, 2406.5066661334386, 2413.0, 2420.673209116782, 2421.576224160765, 2423.018677435641, 10687.732806679895, 10937.671869843918, 10972.122230221643, 10976.396298203596, 10977.83533247002, 6142.293636231801, 6366.045093236005, 6373.107764912916, 6389.0, 6390.520710946697, 3604.189057462076, 3699.426588878728, 3745.2883952049024, 4052.817623206933, 4053.088055187589, 1110.3892858927638, 1161.7328014556615, 1166.3993043582561, 1192.2846292224683, 1193.2780667696093, 13975.860241397557, 14438.350274237684, 14438.855611443962, 15296.923515382352, 15302.08187508753, 4130.607592278729, 4834.468208497063, 4963.081829861487, 4967.627427942919, 4972.776225069881, 11273.379964101889, 11570.132240082028, 11609.129315301387, 11621.24461909973, 11631.360275184947, 6043.395660434009, 6125.387461253928, 6185.659788711664, 6189.009758438719, 6197.81406557804, 5859.736311865976, 5865.88268234633, 5983.9401605983385, 5987.191729116601, 6020.518358531307, 3609.801460919675, 3650.302609286641, 3830.578636349999, 4172.186423647359, 4264.424302719155, 1262.5833474953242, 1265.2977597433512, 1268.8858002779793, 1287.7102651903247, 1289.471316760124, 750.598429840033, 773.4817672159667, 784.3999340504519, 785.0932173339802, 796.3151689546985, 4791.832285870048, 5200.63595548308, 5814.517298089045, 6182.350853160443, 6595.340465953366, 867.144311174088, 869.452245085592, 882.7925437522177, 894.4722613657973, 904.8506996345529, 4087.7751723654887, 4097.713160078825, 4124.649404800625, 4167.708260421741, 4216.198922204771, 11868.347240901834, 13546.187228766306, 13821.032527722962, 14122.0, 14172.716545669029, 13555.457781688621, 14013.579592612237, 14103.435862565588, 14117.858821411655, 14120.43518259258, 10090.293679442515, 10292.536835842406, 10302.639407620698, 10315.0, 10322.380657160595, 5426.806102657409, 6474.0, 6819.283975182534, 6873.106496155668, 6895.724171033303, 12479.56321528742, 12789.93605031969, 12806.295653739135, 12868.742625147257, 12891.097623166288, 9547.474888881177, 11924.344161071225, 13065.477380904656, 13068.477260909458, 13232.735345293233, 8781.297496200417, 9079.273658107204, 9198.95400522993, 9301.395409298373, 9324.067593240621, 10130.645427410005, 10169.186465082923, 10233.0, 10271.537780800032, 10352.223583231438, 8736.213740763362, 8815.911840881508, 8825.073367296598, 8838.513881736566, 8863.734087977371, 6718.865622687421, 8441.240288374076, 8518.78703032429, 8576.142385761374, 8661.480311181349, 7717.459777815724, 7836.412269079956, 7847.0, 7894.447388682966, 7906.486078404885, 5881.268712108717, 5894.587378883437, 6004.459598636144, 6058.666773327509, 6117.265928088658, 5792.304923409218, 5896.380880007538, 6089.0, 6122.510199183966, 6264.937350626436], "value": 5139.1701329336265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.7845508144299, 380.19398874386303, 389.4178203585638, 401.7208040411915, 404.5954045954046, 4922.70463772173, 6037.788677396286, 6073.514118870491, 6088.143116349523, 6131.662758548278, 4762.333273341726, 5755.338136114348, 5949.5537834662355, 5967.283925928884, 6019.849503762397, 4619.861404157872, 4663.880668639536, 4703.129920964615, 4704.364910737058, 4729.101470720552, 4338.305871060631, 4649.907271791127, 4680.765961701918, 4712.340272361872, 4714.104320179172, 4375.234333991539, 4607.447106347243, 4644.233701439259, 4680.315086568849, 4687.250039993602, 3896.8246428910766, 4447.621952134073, 4613.284940834143, 4665.860024199263, 4685.484596694361, 4077.7757223352705, 4104.486939132608, 4105.91788164235, 4126.236646220459, 4136.172765446922, 4786.401699787527, 5428.891422171574, 5787.50806181475, 5849.473547380756, 5868.625540314336, 5336.706481143536, 5386.0, 5393.570703763467, 5419.376771671229, 5422.40353561108, 6401.711922963478, 6417.523969487044, 6418.474975142513, 6437.388448097423, 6462.90305645411, 3676.5771936227407, 3681.7606855554304, 3769.378052621314, 4525.275955847049, 4564.727739460928, 5480.698561579112, 6395.488360931115, 6621.834454138685, 6628.138342015555, 6656.8668626627195, 4609.677322587454, 4709.033309015367, 4730.266808644666, 4731.739754313546, 4733.621310295168, 4778.426588809365, 4803.735794531264, 4810.542998415145, 4816.903661926812, 4818.975905120452, 5028.918782461788, 5164.870878227999, 5287.312649355559, 5349.518543331119, 5359.356877174764, 5874.970625146847, 6060.33336333003, 6407.295197528269, 6411.6153030818305, 6430.135260774323, 1415.5257988573737, 1484.792129101905, 1621.7972753405825, 1640.1881068870985, 1646.3167785368937, 880.9911900881037, 975.0006243600225, 988.2785566536469, 997.6558087459815, 1002.5037606384886, 5903.675297858659, 5927.466528012414, 5933.228680271537, 5945.435183657545, 5985.012472941916, 5499.50504454601, 6544.672766361663, 6567.573107748077, 6595.901061484082, 6610.338966103352, 5723.227364305849, 5732.283464566929, 5838.38696936824, 5896.498797602252, 5937.2578427696535, 3165.4302225599154, 3438.607364017577, 3445.3109378124477, 3451.3960056990427, 3455.3780319542725, 5045.823396181116, 6528.477721782246, 6670.232923213893, 6726.428253598499, 6764.898526522106, 6221.889055472264, 6274.435300822948, 6661.633610151392, 6677.833054173588, 6723.0923825283935, 6319.178506794087, 6747.257801641816, 6753.716793809161, 6790.151231096113, 6790.966045169743, 5355.625106242525, 6194.783182588588, 6354.23749150105, 6500.3174666659315, 6515.54391192612, 5629.579280909248, 6192.3807619239515, 6345.270293916259, 6462.4183823456115, 6498.350164983463, 6306.0587133041845, 6673.699683514351, 6777.695003724745, 6811.8978215325815, 6815.352541508549, 4056.7565946043333, 4311.827526898889, 4337.371081193146, 4339.0, 4344.804483798173, 4873.707577545359, 5733.741981610754, 6484.773032943825, 6530.510211734234, 6554.344565543408, 5445.992491389105, 6348.492120630431, 6351.285153008569, 6366.681665916593, 6385.425311721968, 6030.396960303934, 6310.5898116622275, 6343.619382837044, 6382.425581697669, 6387.233531976192, 5841.824745257649, 6260.154879091265, 6266.749330026748, 6273.404026617464, 6277.654728989949, 5413.458654134555, 6086.360932102242, 6307.936920630735, 6412.807615771534, 6426.0, 6107.511399088151, 6173.41352571505, 6181.84545386351, 6203.193584834124, 6203.720832562455], "value": 4700.630007509804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.5135434935768, 732.721565804994, 739.3789217057672, 744.285485933504, 777.6656037903699, 14717.116972981628, 15228.771568426482, 15463.613409664764, 15464.845351546466, 15512.991655542395, 15070.588705807073, 15225.923870380633, 15368.0, 15385.38458461663, 15409.69180616387, 965.5992763003345, 977.0913050862695, 1009.157353609733, 1026.9743256418612, 1027.7379268286577, 949.1599934058339, 995.6166875752851, 1023.4626820919003, 1026.3328836256455, 1028.049054624473, 1074.0601973273385, 1075.9939456608058, 1076.924615276931, 1078.7842431513689, 1082.4804094034869, 1065.845452409404, 1066.3388699006628, 1066.5680399438163, 1068.396356058832, 1072.587053984214, 796.044746304437, 797.4696826610298, 800.5836964778283, 801.3589128697078, 801.4309840013598, 16132.0, 16368.427105051385, 16542.42101526453, 16973.0, 17016.744748828776, 14418.711625767426, 14766.48317308889, 14771.630709232248, 14775.70448591033, 15504.379824806994, 11348.43257837113, 11763.294202347886, 11813.350265735382, 11854.170208085352, 12287.815682764765, 3026.969730302691, 3061.0, 3069.9232519186976, 3084.0901933929545, 3182.9522557161663, 99236.0, 102030.0, 103694.0, 105159.4742026285, 105358.47320763348, 10009.299349045643, 11621.883781162249, 11637.359945202927, 11737.295762254293, 12014.339211343286, 24927.750722492907, 25212.62181067249, 25225.87387063053, 25263.242102736946, 25264.74735252624, 7777.455578109591, 7830.960845195737, 7904.446688731734, 8017.118117007125, 8087.83824323522, 4072.2466343726505, 4136.855210067633, 4141.275276826544, 4170.22850772608, 4193.643540299047, 4140.979295103505, 4172.311568591209, 4248.745075295492, 4267.637250833652, 4267.722598031118, 799.3245707377257, 827.8178800663844, 853.1724227499316, 870.3559366069063, 892.8794612727329, 535.8821059366933, 570.5065118672319, 598.964062156272, 604.4559896093463, 621.4903778901257, 8851.46891186518, 9477.478738669439, 10268.640597579199, 10310.32982856112, 10699.572017119384, 549.8075673514238, 585.8681796595732, 590.893639144958, 591.5031373646158, 609.8627808742997, 3881.5536213335827, 4592.173408786383, 4793.065352256276, 4811.133995880775, 4814.074051961745, 100472.49763751135, 100720.0, 103192.0, 104312.0, 104791.42812857813, 56708.149377759364, 84869.0, 86457.13542864617, 88648.5567572158, 89957.0, 77042.22957770462, 77770.0, 78415.60792196002, 78926.6053669728, 79136.60431697805, 9511.66709165176, 9513.809723805623, 9591.136797687963, 9600.75998100053, 9610.95194524023, 37686.0, 37837.86486405412, 38073.0, 38868.222635547696, 39149.021274467224, 48885.75557122192, 49190.52428427153, 49688.75155624199, 49821.256256030865, 50375.0, 11534.653960381202, 11864.466099025392, 11899.04807615406, 11968.700782480508, 12223.511059557519, 11661.475233614678, 12523.749525009267, 12709.17390369623, 13238.602841914759, 13298.468061277828, 11596.014338781299, 11803.0, 11933.701657458632, 11947.462364193805, 12220.694482638006, 11609.593664221711, 11808.645740627795, 11863.406829658656, 12032.75934481323, 12059.249558505438, 11366.659000230007, 11641.6507504775, 11653.184277100521, 12035.699107522032, 12336.876631233572, 8563.357748169037, 8565.0, 8673.436226645248, 9118.133777291147, 9202.861957070516, 6048.818535443944, 8714.869276960724, 9922.801543969224, 10119.494025298853, 10149.49252537385], "value": 7391.549203463699, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 123.0, 130.0, 152.0, 122.0, 122.0, 122.0, 123.0, 144.0, 180.0], "value": 132.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 116.0, 118.0, 162.0, 118.0, 119.0, 117.0, 116.0, 141.0, 117.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 212.0, 216.0, 221.0, 212.0, 210.0, 209.0, 208.0, 212.0, 215.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 64.0, 85.0, 129.0, 95.0, 60.0, 64.0, 80.0, 111.0, 87.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 78.0, 94.0, 74.0, 74.0, 74.0, 91.0, 75.0, 73.0, 91.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 83.0, 143.0, 120.0, 95.0, 96.0, 95.0, 94.0, 95.0, 90.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 99.0, 99.0, 99.0, 99.0, 137.0, 100.0, 101.0, 101.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 99.0, 100.0, 98.0, 101.0, 100.0, 102.0, 102.0, 98.0], "value": 100.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 63.0, 71.0, 65.0, 64.0, 66.0, 65.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 91.0, 94.0, 93.0, 90.0, 93.0, 89.0, 88.0, 89.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 168.0, 167.0, 168.0, 155.0, 151.0, 150.0, 192.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 205.0, 197.0, 202.0, 205.0, 200.0, 202.0, 252.0, 237.0, 201.0], "value": 210.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 71.0, 75.0, 72.0, 72.0, 73.0, 75.0, 74.0], "value": 73.3, "unit": "score"}]}]} 17:22:48 INFO - Return code: 0 17:22:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:22:48 ERROR - # TBPL SUCCESS # 17:22:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:22:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:22:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:22:48 INFO - 2017-03-29 17:22:48.181 screenresolution[1657:10138] starting screenresolution argv=screenresolution get 17:22:48 INFO - 2017-03-29 17:22:48.184 screenresolution[1657:10138] Display 0: 1600x1200x32@60 17:22:48 INFO - 2017-03-29 17:22:48.190 screenresolution[1658:10141] starting screenresolution argv=screenresolution list 17:22:48 INFO - Available Modes on Display 0 17:22:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:22:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:22:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:22:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:22:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:22:48 INFO - Intel Iris: 17:22:48 INFO - Chipset Model: Intel Iris 17:22:48 INFO - Type: GPU 17:22:48 INFO - Bus: Built-In 17:22:48 INFO - VRAM (Dynamic, Max): 1536 MB 17:22:48 INFO - Vendor: Intel (0x8086) 17:22:48 INFO - Device ID: 0x0a2e 17:22:48 INFO - Revision ID: 0x0009 17:22:48 INFO - Displays: 17:22:48 INFO - Display: 17:22:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:22:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:22:48 INFO - Display Serial Number: 1600x1200 60 17:22:48 INFO - Main Display: Yes 17:22:48 INFO - Mirror: Off 17:22:48 INFO - Online: Yes 17:22:48 INFO - Rotation: Supported 17:22:48 INFO - Return code: 0 17:22:48 INFO - Running post-action listener: _resource_record_post_action 17:22:48 INFO - [mozharness: 2017-03-30 00:22:48.429976Z] Finished run-tests step (success) 17:22:48 INFO - Running post-run listener: _resource_record_post_run 17:22:48 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39040000; Write bytes: 516282880; Read time: 377; Write time: 1741 17:22:48 INFO - TinderboxPrint: CPU usage
53.4% 17:22:48 INFO - TinderboxPrint: I/O read bytes / time
39,040,000 / 377 17:22:48 INFO - TinderboxPrint: I/O write bytes / time
516,282,880 / 1,741 17:22:48 INFO - TinderboxPrint: CPU idle
2,248.8 (46.6%) 17:22:48 INFO - TinderboxPrint: CPU system
962.5 (19.9%) 17:22:48 INFO - TinderboxPrint: CPU user
1,618.5 (33.5%) 17:22:48 INFO - TinderboxPrint: Swap in / out
250,408,960 / 0 17:22:48 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 207172096; Write bytes: 205174784; Read time: 15774; Write time: 475 17:22:48 INFO - run-tests - Wall time: 1187s; CPU: 53.0%; Read bytes: 37102592; Write bytes: 300278272; Read time: 356; Write time: 1235 17:22:48 INFO - Running post-run listener: _upload_blobber_files 17:22:48 INFO - Blob upload gear active. 17:22:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:48 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 17:22:48 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'] 17:22:48 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 17:22:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:50 INFO - (blobuploader) - INFO - Done attempting. 17:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:51 INFO - (blobuploader) - INFO - Done attempting. 17:22:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:22:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:52 INFO - (blobuploader) - INFO - Done attempting. 17:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:22:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:54 INFO - (blobuploader) - INFO - Done attempting. 17:22:54 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:54 INFO - Return code: 0 17:22:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8dc4e5e188af97297d6d991c66d6441d29bec6d2f17f6db31ccddeb1e11513ad06c4390cea508269219329ed095a44eda941005da57479c4cdf6f8bffe6ba44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aceb2783d8a030a6621abf1707ea85a36a507a5d6c3fff60d837491241673b35c66df4742a9964a26831e38c8054cf5a36dc2e581fa094652691cab73c8a8df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddf11ef97ae70bbe83a96e5c1c41c2d23abf1d9d31c82bdb7ae63d37a79c2ee0b66432dea7e7f21233ea6e5f80aad1b7acc73e553100f2bee30b10fd362be438", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3770aac8abb82561fdfa5de003ea5acd50b2da4a3a4003fde68cc36146a4f15b4267cf66807e809def7bd0bfe7e82df982a5d739809d0857c64765cf5d7b85b1"} 17:22:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:54 INFO - Contents: 17:22:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8dc4e5e188af97297d6d991c66d6441d29bec6d2f17f6db31ccddeb1e11513ad06c4390cea508269219329ed095a44eda941005da57479c4cdf6f8bffe6ba44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aceb2783d8a030a6621abf1707ea85a36a507a5d6c3fff60d837491241673b35c66df4742a9964a26831e38c8054cf5a36dc2e581fa094652691cab73c8a8df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddf11ef97ae70bbe83a96e5c1c41c2d23abf1d9d31c82bdb7ae63d37a79c2ee0b66432dea7e7f21233ea6e5f80aad1b7acc73e553100f2bee30b10fd362be438", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3770aac8abb82561fdfa5de003ea5acd50b2da4a3a4003fde68cc36146a4f15b4267cf66807e809def7bd0bfe7e82df982a5d739809d0857c64765cf5d7b85b1"} 17:22:54 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:54 INFO - Copying logs to upload dir... 17:22:54 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.202582 ========= master_lag: 2.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-03-29 17:22:56.500588) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 17:22:56.504452) ========= 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.9zOL0jBbiw/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.YZ281UB8zH/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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/a8dc4e5e188af97297d6d991c66d6441d29bec6d2f17f6db31ccddeb1e11513ad06c4390cea508269219329ed095a44eda941005da57479c4cdf6f8bffe6ba44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aceb2783d8a030a6621abf1707ea85a36a507a5d6c3fff60d837491241673b35c66df4742a9964a26831e38c8054cf5a36dc2e581fa094652691cab73c8a8df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddf11ef97ae70bbe83a96e5c1c41c2d23abf1d9d31c82bdb7ae63d37a79c2ee0b66432dea7e7f21233ea6e5f80aad1b7acc73e553100f2bee30b10fd362be438", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3770aac8abb82561fdfa5de003ea5acd50b2da4a3a4003fde68cc36146a4f15b4267cf66807e809def7bd0bfe7e82df982a5d739809d0857c64765cf5d7b85b1"} build_url:https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010972 build_url: 'https://queue.taskcluster.net/v1/task/f9sFoMfcScCPDg0qz-Jj2A/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/a8dc4e5e188af97297d6d991c66d6441d29bec6d2f17f6db31ccddeb1e11513ad06c4390cea508269219329ed095a44eda941005da57479c4cdf6f8bffe6ba44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aceb2783d8a030a6621abf1707ea85a36a507a5d6c3fff60d837491241673b35c66df4742a9964a26831e38c8054cf5a36dc2e581fa094652691cab73c8a8df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddf11ef97ae70bbe83a96e5c1c41c2d23abf1d9d31c82bdb7ae63d37a79c2ee0b66432dea7e7f21233ea6e5f80aad1b7acc73e553100f2bee30b10fd362be438", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3770aac8abb82561fdfa5de003ea5acd50b2da4a3a4003fde68cc36146a4f15b4267cf66807e809def7bd0bfe7e82df982a5d739809d0857c64765cf5d7b85b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 17:22:56.538098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:22:56.538398) ========= 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.9zOL0jBbiw/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.YZ281UB8zH/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005089 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 17:22:56.586691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 17:22:56.587007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 17:22:56.587325) ========= ========= Total master_lag: 2.21 =========