builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0125 starttime: 1494022210.55 results: success (0) buildid: 20170505132514 builduid: ab7b3c90aba04cce9e11f8687611e4b3 revision: e7bf9443be2c4a5187c37440e35f3526148d7fa8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:10.549851) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:10.550430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:10.550863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:10.584400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:10.584844) ========= 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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-05-05 15:10:10-- 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% 13.6M=0.001s 2017-05-05 15:10:10 (13.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122785 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:11.379094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:11.481735) ========= 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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.032376 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:11.538673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 15:10:11.539139) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e7bf9443be2c4a5187c37440e35f3526148d7fa8 --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 e7bf9443be2c4a5187c37440e35f3526148d7fa8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-05-05 15:10:11,615 truncating revision to first 12 chars 2017-05-05 15:10:11,615 Setting DEBUG logging. 2017-05-05 15:10:11,615 attempt 1/10 2017-05-05 15:10:11,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e7bf9443be2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 15:10:12,624 unpacking tar archive at: mozilla-central-e7bf9443be2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.383118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 15:10:12.946885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:12.947278) ========= script_repo_revision: e7bf9443be2c4a5187c37440e35f3526148d7fa8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:12.947723) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:12.948054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 15:10:12.968773) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-05-05 15:10:12.969151) ========= /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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:10:13 INFO - MultiFileLogger online at 20170505 15:10:13 in /builds/slave/test 15:10:13 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 15:10:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:13 INFO - {'append_to_log': False, 15:10:13 INFO - 'base_work_dir': '/builds/slave/test', 15:10:13 INFO - 'blob_upload_branch': 'Firefox', 15:10:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:13 INFO - 'branch': 'Firefox', 15:10:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:13 INFO - 'config_files': ('talos/mac_config.py',), 15:10:13 INFO - 'default_actions': ('clobber', 15:10:13 INFO - 'read-buildbot-config', 15:10:13 INFO - 'download-and-extract', 15:10:13 INFO - 'populate-webroot', 15:10:13 INFO - 'create-virtualenv', 15:10:13 INFO - 'install', 15:10:13 INFO - 'run-tests'), 15:10:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:13 INFO - 'download_minidump_stackwalk': True, 15:10:13 INFO - 'download_symbols': 'ondemand', 15:10:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:10:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:10:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:10:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:10:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:13 INFO - 'gecko_profile': False, 15:10:13 INFO - 'gecko_profile_interval': 0, 15:10:13 INFO - 'installer_path': 'installer.exe', 15:10:13 INFO - 'log_level': 'info', 15:10:13 INFO - 'log_name': 'talos', 15:10:13 INFO - 'log_to_console': True, 15:10:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:10:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:10:13 INFO - 'opt_config_files': (), 15:10:13 INFO - 'pip_index': False, 15:10:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:10:13 INFO - 'cmd': ('bash', 15:10:13 INFO - '-c', 15:10:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:10:13 INFO - 'enabled': True, 15:10:13 INFO - 'halt_on_failure': False, 15:10:13 INFO - 'name': 'check_screen_resolution'},), 15:10:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:10:13 INFO - 'cmd': ('bash', 15:10:13 INFO - '-c', 15:10:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:10:13 INFO - 'enabled': True, 15:10:13 INFO - 'halt_on_failure': False, 15:10:13 INFO - 'name': 'check_screen_resolution'},), 15:10:13 INFO - 'run_cmd_checks_enabled': True, 15:10:13 INFO - 'suite': 'dromaeojs', 15:10:13 INFO - 'system_bits': '32', 15:10:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:13 INFO - 'title': 't-yosemite-r7-0125', 15:10:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:13 INFO - 'use_talos_json': True, 15:10:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:13 INFO - 'work_dir': 'build'} 15:10:13 INFO - [mozharness: 2017-05-05 22:10:13.157327Z] Running clobber step. 15:10:13 INFO - Running pre-action listener: _resource_record_pre_action 15:10:13 INFO - Running main action method: clobber 15:10:13 INFO - rmtree: /builds/slave/test/build 15:10:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:15 INFO - Running post-action listener: _resource_record_post_action 15:10:15 INFO - [mozharness: 2017-05-05 22:10:15.812869Z] Finished clobber step (success) 15:10:15 INFO - [mozharness: 2017-05-05 22:10:15.813011Z] Running read-buildbot-config step. 15:10:15 INFO - Running pre-action listener: _resource_record_pre_action 15:10:15 INFO - Running main action method: read_buildbot_config 15:10:15 INFO - Using buildbot properties: 15:10:15 INFO - { 15:10:15 INFO - "project": "", 15:10:15 INFO - "product": "firefox", 15:10:15 INFO - "script_repo_revision": "production", 15:10:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:10:15 INFO - "repository": "", 15:10:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:10:15 INFO - "buildid": "20170505132514", 15:10:15 INFO - "pgo_build": "False", 15:10:15 INFO - "basedir": "/builds/slave/test", 15:10:15 INFO - "buildnumber": 22, 15:10:15 INFO - "slavename": "t-yosemite-r7-0125", 15:10:15 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 15:10:15 INFO - "platform": "yosemite_r7", 15:10:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:10:15 INFO - "branch": "mozilla-central", 15:10:15 INFO - "repo_path": "mozilla-central", 15:10:15 INFO - "revision": "e7bf9443be2c4a5187c37440e35f3526148d7fa8", 15:10:15 INFO - "stage_platform": "macosx64", 15:10:15 INFO - "builduid": "ab7b3c90aba04cce9e11f8687611e4b3", 15:10:15 INFO - "slavebuilddir": "test" 15:10:15 INFO - } 15:10:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:10:15 INFO - Running post-action listener: _resource_record_post_action 15:10:15 INFO - [mozharness: 2017-05-05 22:10:15.816407Z] Finished read-buildbot-config step (success) 15:10:15 INFO - [mozharness: 2017-05-05 22:10:15.816550Z] Running download-and-extract step. 15:10:15 INFO - Running pre-action listener: _resource_record_pre_action 15:10:15 INFO - Running main action method: download_and_extract 15:10:15 INFO - mkdir: /builds/slave/test/build/tests 15:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:15 INFO - trying https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:10:15 INFO - Downloading https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/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 15:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/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 15:10:16 INFO - Downloaded 1325 bytes. 15:10:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:10:16 INFO - Using the following test package requirements: 15:10:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:10:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:10:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:10:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:10:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'jsshell-mac.zip'], 15:10:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:10:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:10:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:10:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:10:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:10:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:10:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:10:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:10:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:10:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:10:16 INFO - Fetch https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:10:18 INFO - Content-Length response header: 52702890 15:10:18 INFO - Bytes received: 52702890 15:10:34 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 15:10:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:10:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:10:34 INFO - Fetch https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:10:36 INFO - Content-Length response header: 52702890 15:10:36 INFO - Bytes received: 52702890 15:10:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:10:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:10:52 INFO - Fetch https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:10:53 INFO - Content-Length response header: 14408697 15:10:53 INFO - Bytes received: 14408697 15:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:53 INFO - trying https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:10:53 INFO - Downloading https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/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 15:10:55 INFO - Downloaded 70885317 bytes. 15:10:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:10:55 INFO - mkdir: /builds/slave/test/properties 15:10:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:55 INFO - Contents: 15:10:55 INFO - build_url:https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:10:56 INFO - Running post-action listener: _resource_record_post_action 15:10:56 INFO - Running post-action listener: set_extra_try_arguments 15:10:56 INFO - [mozharness: 2017-05-05 22:10:56.484186Z] Finished download-and-extract step (success) 15:10:56 INFO - [mozharness: 2017-05-05 22:10:56.484317Z] Running populate-webroot step. 15:10:56 INFO - Running pre-action listener: _resource_record_pre_action 15:10:56 INFO - Running main action method: populate_webroot 15:10:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:56 INFO - '--tppagecycles', 15:10:56 INFO - '7'], 15:10:56 INFO - 'tests': ['tsvgm']}}, 15:10:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['damp', 'tps']}, 15:10:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'tests': ['damp', 'tps']}, 15:10:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['dromaeo_dom']}, 15:10:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:10:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:10:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['a11yr', 15:10:56 INFO - 'ts_paint', 15:10:56 INFO - 'tpaint', 15:10:56 INFO - 'sessionrestore', 15:10:56 INFO - 'sessionrestore_no_auto_restore', 15:10:56 INFO - 'tabpaint']}, 15:10:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:56 INFO - 'ts_paint', 15:10:56 INFO - 'tpaint', 15:10:56 INFO - 'sessionrestore', 15:10:56 INFO - 'sessionrestore_no_auto_restore', 15:10:56 INFO - 'tabpaint']}, 15:10:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:10:56 INFO - 'ts_paint', 15:10:56 INFO - 'tpaint', 15:10:56 INFO - 'sessionrestore', 15:10:56 INFO - 'sessionrestore_no_auto_restore', 15:10:56 INFO - 'tabpaint']}, 15:10:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:10:56 INFO - 'ts_paint', 15:10:56 INFO - 'tpaint', 15:10:56 INFO - 'sessionrestore', 15:10:56 INFO - 'sessionrestore_no_auto_restore', 15:10:56 INFO - 'tabpaint']}, 15:10:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['a11yr', 15:10:56 INFO - 'ts_paint', 15:10:56 INFO - 'tpaint', 15:10:56 INFO - 'sessionrestore', 15:10:56 INFO - 'sessionrestore_no_auto_restore', 15:10:56 INFO - 'tabpaint']}, 15:10:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['a11yr', 15:10:56 INFO - 'ts_paint', 15:10:56 INFO - 'tpaint', 15:10:56 INFO - 'sessionrestore', 15:10:56 INFO - 'sessionrestore_no_auto_restore', 15:10:56 INFO - 'tabpaint']}, 15:10:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:10:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:10:56 INFO - 'bloom_basic_ref']}, 15:10:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['tsvgx', 15:10:56 INFO - 'tsvgr_opacity', 15:10:56 INFO - 'tart', 15:10:56 INFO - 'tscrollx', 15:10:56 INFO - 'cart', 15:10:56 INFO - 'tsvg_static']}, 15:10:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:56 INFO - 'tsvgr_opacity', 15:10:56 INFO - 'tart', 15:10:56 INFO - 'tscrollx', 15:10:56 INFO - 'cart', 15:10:56 INFO - 'tsvg_static']}, 15:10:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'talos_options': ['--disable-e10s'], 15:10:56 INFO - 'tests': ['tp5o']}, 15:10:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:10:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'talos_options': ['--disable-e10s', 15:10:56 INFO - '--xperf_path', 15:10:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:56 INFO - 'tests': ['tp5n']}, 15:10:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:10:56 INFO - 'talos_options': ['--xperf_path', 15:10:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:56 INFO - 'tests': ['tp5n']}}, 15:10:56 INFO - 'talos.zip': {'path': '', 15:10:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:56 INFO - Running post-action listener: _resource_record_post_action 15:10:56 INFO - [mozharness: 2017-05-05 22:10:56.503680Z] Finished populate-webroot step (success) 15:10:56 INFO - [mozharness: 2017-05-05 22:10:56.503812Z] Running create-virtualenv step. 15:10:56 INFO - Running pre-action listener: _resource_record_pre_action 15:10:56 INFO - Running main action method: create_virtualenv 15:10:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:10:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:56 INFO - Using real prefix '/tools/python27' 15:10:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:11:00 INFO - Installing pip.................done. 15:11:00 INFO - Return code: 0 15:11:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:11:00 INFO - Reading from file tmpfile_stdout 15:11:00 INFO - Output received: 15:11:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:11:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:00 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 15:11:00 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 15:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:00 INFO - 'HOME': '/Users/cltbld', 15:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:00 INFO - 'LOGNAME': 'cltbld', 15:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:00 INFO - 'MOZ_NO_REMOTE': '1', 15:11:00 INFO - 'NO_EM_RESTART': '1', 15:11:00 INFO - 'PAGER': '/bin/cat', 15:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:00 INFO - 'PWD': '/builds/slave/test', 15:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:00 INFO - 'SHELL': '/bin/bash', 15:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:00 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:00 INFO - 'USER': 'cltbld', 15:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:00 INFO - 'XPC_FLAGS': '0x0', 15:11:00 INFO - 'XPC_SERVICE_NAME': '0', 15:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:00 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 15:11:00 INFO - Cleaning up... 15:11:00 INFO - Return code: 0 15:11:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:00 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:00 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 15:11:00 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 15:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:00 INFO - 'HOME': '/Users/cltbld', 15:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:00 INFO - 'LOGNAME': 'cltbld', 15:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:00 INFO - 'MOZ_NO_REMOTE': '1', 15:11:00 INFO - 'NO_EM_RESTART': '1', 15:11:00 INFO - 'PAGER': '/bin/cat', 15:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:00 INFO - 'PWD': '/builds/slave/test', 15:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:00 INFO - 'SHELL': '/bin/bash', 15:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:00 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:00 INFO - 'USER': 'cltbld', 15:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:00 INFO - 'XPC_FLAGS': '0x0', 15:11:00 INFO - 'XPC_SERVICE_NAME': '0', 15:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:01 INFO - Downloading/unpacking psutil>=3.1.1 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:11:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:03 INFO - Installing collected packages: psutil 15:11:03 INFO - Running setup.py install for psutil 15:11:03 INFO - building 'psutil._psutil_osx' extension 15:11:03 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 15:11:04 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 15:11:04 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 15:11:04 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 15:11:04 INFO - building 'psutil._psutil_posix' extension 15:11:04 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 15:11:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:11:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:11:04 INFO - ^ 15:11:04 INFO - 1 warning generated. 15:11:04 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 15:11:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:04 INFO - Successfully installed psutil 15:11:04 INFO - Cleaning up... 15:11:04 INFO - Return code: 0 15:11:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:05 INFO - 'HOME': '/Users/cltbld', 15:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:05 INFO - 'LOGNAME': 'cltbld', 15:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:05 INFO - 'MOZ_NO_REMOTE': '1', 15:11:05 INFO - 'NO_EM_RESTART': '1', 15:11:05 INFO - 'PAGER': '/bin/cat', 15:11:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:05 INFO - 'PWD': '/builds/slave/test', 15:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:05 INFO - 'SHELL': '/bin/bash', 15:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:05 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:05 INFO - 'USER': 'cltbld', 15:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:05 INFO - 'XPC_FLAGS': '0x0', 15:11:05 INFO - 'XPC_SERVICE_NAME': '0', 15:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:11:05 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 15:11:05 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 15:11:05 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 15:11:05 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 15:11:05 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 15:11:05 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 15:11:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:11:07 INFO - Installing collected packages: mozsystemmonitor 15:11:07 INFO - Running setup.py install for mozsystemmonitor 15:11:07 INFO - Successfully installed mozsystemmonitor 15:11:07 INFO - Cleaning up... 15:11:07 INFO - Return code: 0 15:11:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:07 INFO - 'HOME': '/Users/cltbld', 15:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:07 INFO - 'LOGNAME': 'cltbld', 15:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:07 INFO - 'MOZ_NO_REMOTE': '1', 15:11:07 INFO - 'NO_EM_RESTART': '1', 15:11:07 INFO - 'PAGER': '/bin/cat', 15:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:07 INFO - 'PWD': '/builds/slave/test', 15:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:07 INFO - 'SHELL': '/bin/bash', 15:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:07 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:07 INFO - 'USER': 'cltbld', 15:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:07 INFO - 'XPC_FLAGS': '0x0', 15:11:07 INFO - 'XPC_SERVICE_NAME': '0', 15:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:07 INFO - Downloading/unpacking jsonschema==2.5.1 15:11:07 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 15:11:07 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 15:11:07 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 15:11:07 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 15:11:07 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 15:11:07 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 15:11:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:11:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:11:09 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 15:11:09 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 15:11:09 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 15:11:09 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 15:11:09 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 15:11:09 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 15:11:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:11:09 INFO - warning: no files found matching '*.txt' 15:11:09 INFO - no previously-included directories found matching 'build' 15:11:09 INFO - no previously-included directories found matching 'dist' 15:11:09 INFO - no previously-included directories found matching '.git*' 15:11:09 INFO - Installing collected packages: jsonschema, functools32 15:11:09 INFO - Running setup.py install for functools32 15:11:09 INFO - warning: no files found matching '*.txt' 15:11:09 INFO - no previously-included directories found matching 'build' 15:11:09 INFO - no previously-included directories found matching 'dist' 15:11:09 INFO - no previously-included directories found matching '.git*' 15:11:09 INFO - Successfully installed jsonschema functools32 15:11:09 INFO - Cleaning up... 15:11:09 INFO - Return code: 0 15:11:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:09 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 15:11:09 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 15:11:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:09 INFO - 'HOME': '/Users/cltbld', 15:11:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:09 INFO - 'LOGNAME': 'cltbld', 15:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:09 INFO - 'MOZ_NO_REMOTE': '1', 15:11:09 INFO - 'NO_EM_RESTART': '1', 15:11:09 INFO - 'PAGER': '/bin/cat', 15:11:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:09 INFO - 'PWD': '/builds/slave/test', 15:11:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:09 INFO - 'SHELL': '/bin/bash', 15:11:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:09 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:09 INFO - 'USER': 'cltbld', 15:11:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:09 INFO - 'XPC_FLAGS': '0x0', 15:11:09 INFO - 'XPC_SERVICE_NAME': '0', 15:11:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:11:09 INFO - Cleaning up... 15:11:09 INFO - Return code: 0 15:11:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:09 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:09 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 15:11:09 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 15:11:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:09 INFO - 'HOME': '/Users/cltbld', 15:11:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:09 INFO - 'LOGNAME': 'cltbld', 15:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:09 INFO - 'MOZ_NO_REMOTE': '1', 15:11:09 INFO - 'NO_EM_RESTART': '1', 15:11:09 INFO - 'PAGER': '/bin/cat', 15:11:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:09 INFO - 'PWD': '/builds/slave/test', 15:11:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:09 INFO - 'SHELL': '/bin/bash', 15:11:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:09 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:09 INFO - 'USER': 'cltbld', 15:11:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:09 INFO - 'XPC_FLAGS': '0x0', 15:11:09 INFO - 'XPC_SERVICE_NAME': '0', 15:11:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:10 INFO - Downloading/unpacking blobuploader==1.2.4 15:11:10 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 15:11:10 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 15:11:10 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 15:11:10 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 15:11:10 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 15:11:10 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 15:11:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:11:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:11:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 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 15:11:12 INFO - Downloading docopt-0.6.1.tar.gz 15:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:11:12 INFO - Installing collected packages: blobuploader, requests, docopt 15:11:12 INFO - Running setup.py install for blobuploader 15:11:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:11:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:11:12 INFO - Running setup.py install for requests 15:11:13 INFO - Running setup.py install for docopt 15:11:13 INFO - Successfully installed blobuploader requests docopt 15:11:13 INFO - Cleaning up... 15:11:13 INFO - Return code: 0 15:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:13 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:13 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 15:11:13 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 15:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:13 INFO - 'HOME': '/Users/cltbld', 15:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:13 INFO - 'LOGNAME': 'cltbld', 15:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:13 INFO - 'MOZ_NO_REMOTE': '1', 15:11:13 INFO - 'NO_EM_RESTART': '1', 15:11:13 INFO - 'PAGER': '/bin/cat', 15:11:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:13 INFO - 'PWD': '/builds/slave/test', 15:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:13 INFO - 'SHELL': '/bin/bash', 15:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:13 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:13 INFO - 'USER': 'cltbld', 15:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:13 INFO - 'XPC_FLAGS': '0x0', 15:11:13 INFO - 'XPC_SERVICE_NAME': '0', 15:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:13 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-eG32qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:13 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-DX0pru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:13 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-rMwuXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:13 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-vlq9Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:13 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-zMVghk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Do3xPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-2_lUne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-a8e6U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-12EFkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Rfjomj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Z1HC0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-etxGky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-bsobv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-u32286-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:14 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-K31tiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:15 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-M1zRtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:15 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-s2BJp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:11:15 INFO - Running setup.py install for manifestparser 15:11:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:11:15 INFO - Running setup.py install for mozcrash 15:11:15 INFO - Running setup.py install for mozdebug 15:11:15 INFO - Running setup.py install for mozdevice 15:11:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:11:15 INFO - Running setup.py install for mozfile 15:11:16 INFO - Running setup.py install for mozhttpd 15:11:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Running setup.py install for mozinfo 15:11:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Running setup.py install for mozInstall 15:11:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Running setup.py install for mozleak 15:11:16 INFO - Running setup.py install for mozlog 15:11:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Running setup.py install for moznetwork 15:11:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:11:16 INFO - Running setup.py install for mozprocess 15:11:17 INFO - Running setup.py install for mozprofile 15:11:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:11:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:11:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:11:17 INFO - Running setup.py install for mozrunner 15:11:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:11:17 INFO - Running setup.py install for mozscreenshot 15:11:17 INFO - Running setup.py install for moztest 15:11:17 INFO - Running setup.py install for mozversion 15:11:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:11:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:11:17 INFO - Cleaning up... 15:11:17 INFO - Return code: 0 15:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:17 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:17 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 15:11:17 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 15:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:17 INFO - 'HOME': '/Users/cltbld', 15:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:17 INFO - 'LOGNAME': 'cltbld', 15:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:17 INFO - 'MOZ_NO_REMOTE': '1', 15:11:17 INFO - 'NO_EM_RESTART': '1', 15:11:17 INFO - 'PAGER': '/bin/cat', 15:11:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:17 INFO - 'PWD': '/builds/slave/test', 15:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:17 INFO - 'SHELL': '/bin/bash', 15:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:17 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:17 INFO - 'USER': 'cltbld', 15:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:17 INFO - 'XPC_FLAGS': '0x0', 15:11:17 INFO - 'XPC_SERVICE_NAME': '0', 15:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-koBB04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-zZ7dtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-mBWHwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-C7z22t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-KS3zkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-jQ9erW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-SpzWCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-a8XgDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:11:18 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)) 15:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:11:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-LUp3Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-JxZIur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ywx4PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-7aTIsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-r_Pl4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-NZt_Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-BjB6_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-WThDLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:11:19 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)) 15:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:11:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-wMu15e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:11:19 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)) 15:11:19 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)) 15:11:19 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)) 15:11:19 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)) 15:11:19 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:11:19 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:11:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:21 INFO - Downloading blessings-1.6.tar.gz 15:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:11:21 INFO - Installing collected packages: blessings 15:11:21 INFO - Running setup.py install for blessings 15:11:21 INFO - Successfully installed blessings 15:11:21 INFO - Cleaning up... 15:11:21 INFO - Return code: 0 15:11:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:21 INFO - Reading from file tmpfile_stdout 15:11:21 INFO - Current package versions: 15:11:21 INFO - blessings == 1.6 15:11:21 INFO - blobuploader == 1.2.4 15:11:21 INFO - docopt == 0.6.1 15:11:21 INFO - functools32 == 3.2.3-2 15:11:21 INFO - jsonschema == 2.5.1 15:11:21 INFO - manifestparser == 1.1 15:11:21 INFO - mozInstall == 1.12 15:11:21 INFO - mozcrash == 1.0 15:11:21 INFO - mozdebug == 0.1 15:11:21 INFO - mozdevice == 0.50 15:11:21 INFO - mozfile == 1.2 15:11:21 INFO - mozhttpd == 0.7 15:11:21 INFO - mozinfo == 0.9 15:11:21 INFO - mozleak == 0.1 15:11:21 INFO - mozlog == 3.4 15:11:21 INFO - moznetwork == 0.27 15:11:21 INFO - mozprocess == 0.25 15:11:21 INFO - mozprofile == 0.28 15:11:21 INFO - mozrunner == 6.13 15:11:21 INFO - mozscreenshot == 0.1 15:11:21 INFO - mozsystemmonitor == 0.3 15:11:21 INFO - moztest == 0.8 15:11:21 INFO - mozversion == 1.4 15:11:21 INFO - psutil == 3.1.1 15:11:21 INFO - requests == 1.2.3 15:11:21 INFO - wsgiref == 0.1.2 15:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:21 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:21 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 15:11:21 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 15:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:21 INFO - 'HOME': '/Users/cltbld', 15:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:21 INFO - 'LOGNAME': 'cltbld', 15:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:21 INFO - 'MOZ_NO_REMOTE': '1', 15:11:21 INFO - 'NO_EM_RESTART': '1', 15:11:21 INFO - 'PAGER': '/bin/cat', 15:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:21 INFO - 'PWD': '/builds/slave/test', 15:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:21 INFO - 'SHELL': '/bin/bash', 15:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:21 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:21 INFO - 'USER': 'cltbld', 15:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:21 INFO - 'XPC_FLAGS': '0x0', 15:11:21 INFO - 'XPC_SERVICE_NAME': '0', 15:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 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)) 15:11:22 INFO - Cleaning up... 15:11:22 INFO - Return code: 0 15:11:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:22 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 0x105bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b33d7d4d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, '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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 15:11:22 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 15:11:22 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 15:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:22 INFO - 'HOME': '/Users/cltbld', 15:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:22 INFO - 'LOGNAME': 'cltbld', 15:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:22 INFO - 'MOZ_NO_REMOTE': '1', 15:11:22 INFO - 'NO_EM_RESTART': '1', 15:11:22 INFO - 'PAGER': '/bin/cat', 15:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:22 INFO - 'PWD': '/builds/slave/test', 15:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:22 INFO - 'SHELL': '/bin/bash', 15:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:22 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:22 INFO - 'USER': 'cltbld', 15:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:22 INFO - 'XPC_FLAGS': '0x0', 15:11:22 INFO - 'XPC_SERVICE_NAME': '0', 15:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:11:22 INFO - Cleaning up... 15:11:22 INFO - Return code: 0 15:11:22 INFO - Running post-action listener: _resource_record_post_action 15:11:22 INFO - Running post-action listener: _start_resource_monitoring 15:11:22 INFO - Starting resource monitoring. 15:11:22 INFO - [mozharness: 2017-05-05 22:11:22.388241Z] Finished create-virtualenv step (success) 15:11:22 INFO - [mozharness: 2017-05-05 22:11:22.389187Z] Running install step. 15:11:22 INFO - Running pre-action listener: _resource_record_pre_action 15:11:22 INFO - Running main action method: install 15:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:11:22 INFO - Reading from file tmpfile_stdout 15:11:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:11:22 INFO - Reading from file tmpfile_stdout 15:11:22 INFO - Output received: 15:11:22 INFO - Usage: mozinstall [options] installer 15:11:22 INFO - Options: 15:11:22 INFO - -h, --help show this help message and exit 15:11:22 INFO - -d DEST, --destination=DEST 15:11:22 INFO - Directory to install application into. [default: 15:11:22 INFO - "/builds/slave/test"] 15:11:22 INFO - --app=APP Application being installed. [default: firefox] 15:11:22 INFO - mkdir: /builds/slave/test/build/application 15:11:22 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'] 15:11:22 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 15:11:42 INFO - Reading from file tmpfile_stdout 15:11:42 INFO - Output received: 15:11:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:11:42 INFO - Running post-action listener: _resource_record_post_action 15:11:42 INFO - [mozharness: 2017-05-05 22:11:42.570231Z] Finished install step (success) 15:11:42 INFO - [mozharness: 2017-05-05 22:11:42.570357Z] Running run-tests step. 15:11:42 INFO - Running pre-action listener: _resource_record_pre_action 15:11:42 INFO - Running main action method: run_tests 15:11:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:42 INFO - 2017-05-05 15:11:42.584 screenresolution[1630:7591] starting screenresolution argv=screenresolution get 15:11:42 INFO - 2017-05-05 15:11:42.586 screenresolution[1630:7591] Display 0: 1600x1200x32@60 15:11:42 INFO - 2017-05-05 15:11:42.592 screenresolution[1631:7593] starting screenresolution argv=screenresolution list 15:11:42 INFO - Available Modes on Display 0 15:11:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:42 INFO - Intel Iris: 15:11:42 INFO - Chipset Model: Intel Iris 15:11:42 INFO - Type: GPU 15:11:42 INFO - Bus: Built-In 15:11:42 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:42 INFO - Vendor: Intel (0x8086) 15:11:42 INFO - Device ID: 0x0a2e 15:11:42 INFO - Revision ID: 0x0009 15:11:42 INFO - Displays: 15:11:42 INFO - Display: 15:11:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:42 INFO - Display Serial Number: 1600x1200 60 15:11:42 INFO - Main Display: Yes 15:11:42 INFO - Mirror: Off 15:11:42 INFO - Online: Yes 15:11:42 INFO - Rotation: Supported 15:11:42 INFO - Return code: 0 15:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:42 INFO - Python 2.7.3 15:11:42 INFO - Return code: 0 15:11:42 INFO - grabbing minidump binary from tooltool 15:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:42 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 0x1059ced30>, '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 0x1058f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:11:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:11:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:11:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:42 INFO - Return code: 0 15:11:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:42 INFO - ENV: RUST_BACKTRACE is now 1 15:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:42 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/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:11:42 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/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B8jL6hcxQ8/Render', 15:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:42 INFO - 'HOME': '/Users/cltbld', 15:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:42 INFO - 'LOGNAME': 'cltbld', 15:11:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:42 INFO - 'MOZ_NO_REMOTE': '1', 15:11:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:42 INFO - 'NO_EM_RESTART': '1', 15:11:42 INFO - 'PAGER': '/bin/cat', 15:11:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:42 INFO - 'PWD': '/builds/slave/test', 15:11:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:42 INFO - 'RUST_BACKTRACE': '1', 15:11:42 INFO - 'SHELL': '/bin/bash', 15:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5KaqDDdVQ/Listeners', 15:11:42 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 15:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:42 INFO - 'USER': 'cltbld', 15:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:42 INFO - 'XPC_FLAGS': '0x0', 15:11:42 INFO - 'XPC_SERVICE_NAME': '0', 15:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:42 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/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:11:43 INFO - mozversion application_buildid: 20170505132514 15:11:43 INFO - mozversion application_changeset: e7bf9443be2c4a5187c37440e35f3526148d7fa8 15:11:43 INFO - mozversion application_display_name: Nightly 15:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:43 INFO - mozversion application_name: Firefox 15:11:43 INFO - mozversion application_remotingname: firefox 15:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:11:43 INFO - mozversion application_vendor: Mozilla 15:11:43 INFO - mozversion application_version: 55.0a1 15:11:43 INFO - mozversion platform_buildid: 20170505132514 15:11:43 INFO - mozversion platform_changeset: e7bf9443be2c4a5187c37440e35f3526148d7fa8 15:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:11:43 INFO - mozversion platform_version: 55.0a1 15:11:43 INFO - using testdate: 1494022303 15:11:43 INFO - actual date: 1494022303 15:11:43 INFO - starting webserver on 'localhost:49242' 15:11:43 INFO - SUITE-START | Running 2 tests 15:11:43 INFO - TEST-START | dromaeo_css 15:11:43 INFO - operating with platform_type : mac_ 15:11:43 INFO - Initialising browser for dromaeo_css test... 15:11:43 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmp7b0Llk/profile http://localhost:49242/getInfo.html) 15:11:45 INFO - PID 1641 | __metrics Screen width/height:1600/1200 15:11:45 INFO - PID 1641 | colorDepth:24 15:11:45 INFO - PID 1641 | Browser inner width/height: 1024/691 15:11:45 INFO - PID 1641 | __metrics 15:11:46 INFO - PID 1641 | 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" 15:11:46 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:11:46 INFO - TEST-INFO | 1641: exit 0 15:11:46 INFO - Browser initialized. 15:11:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:46 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmp7b0Llk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:59 INFO - PID 1643 | RSS: Main: 238837760 15:11:59 INFO - PID 1643 | 15:15:03 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 15:15:05 INFO - PID 1643 | RSS: Main: 375881728 15:15:05 INFO - PID 1643 | 15:18:08 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 15:18:08 INFO - PID 1643 | RSS: Main: 368017408 15:18:08 INFO - PID 1643 | 15:21:10 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 15:21:11 INFO - PID 1643 | RSS: Main: 332812288 15:21:11 INFO - PID 1643 | 15:24:13 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 15:24:14 INFO - PID 1643 | RSS: Main: 358146048 15:24:14 INFO - PID 1643 | 15:27:18 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 15:27:18 INFO - PID 1643 | RSS: Main: 329625600 15:27:18 INFO - PID 1643 | 15:30:20 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 15:30:21 INFO - PID 1643 | RSS: Main: 375586816 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | __start_tp_report 15:30:21 INFO - PID 1643 | _x_x_mozilla_page_load 15:30:21 INFO - PID 1643 | _x_x_mozilla_page_load_details 15:30:21 INFO - PID 1643 | |i|pagename|runs| 15:30:21 INFO - PID 1643 | |0;dojo.html;2923.6783953765084;3393.6436674149213;3521.242932769454;3539.2567560812245;3573.3925232710444;6163.352847950968;6212.409821067003;6249.375062493754;6256.499480041597;6286.214223222098;6124.724387402566;6245.000799872021;6274.780382686607;6296.874062518758;6305;4959.181735013718;5381.515663590276;5414.91877621836;5474.370447398541;5479.890402191973;5310.62825602208;5475;5509.063459211923;5552.555795536347;5582.134769110774;5378.220158077057;5380.461953804608;5389.83830485086;5404.081306177959;5408.648437851527;5379.811706590251;5395.757190926418;5396.677813935572;5405.243265942771;5409.729513524348;5313.282706834567;5345.465453454663;5346.759395827197;5362.195670649395;5375.731213439351;5283.392409872876;6156.199694039791;6197.473214776749;6256.499480041632;6262.749490020394;6529.085927970088;6542.858569217741;6576.112224849632;6580.407763301278;6597.373249541286;5560.638558493725;6705.597664140168;6721.327867213288;6723.260441351447;6727.360900714473;6138.817583427401;6220.098085777582;6227.439530442282;6261.092141639437;6371.299157092716;6774.729010839511;6779.62712050832;6794.252632210453;6800.829979250559;6809;6341.397567231105;6402.903956440658;6416.32628573993;6452.838679033061;6560.9343906560325;6667.799966001027;6672.7330906764155;6686.765963191265;6688.565243259172;6695.598264104169;6380.298167201604;6437.388448097423;6503.934960650333;6567.737290508422;6577.868442631217;6524.575902566318;6577.967110164514;6615.801525954229;6616.536842421081;6629.171353580802;5174.14626586609;5262.710550919736;5265.710385928811;5270.578353731692;5275.551578115903;4605.792739326738;4731.976340118277;4732.905341893212;4750.311204875274;4779.498152693986;6145.371476558716;6194.132821405007;6196.535259855529;6204.224471941007;6212.409821066992;6552.63960482178;6558.573692709959;6590.439812615981;6723.966380168068;6746.494012949049;6295.150154729053;6322.336154703782;6324;6340;6346.524010699124;5864.44287792659;5869.677167755729;5877.206577112121;5880.764769409261;5931.40685931412;5671.744771485211;6594.175728033996;6694.933050669431;6839;6910.274421185904;6730.899036514358;6747.527673063035;6762.391384775394;6767.35710107539;6770.356816102462;6898.482613803884;6907.620080895398;6908.654567271717;6910.481713871581;6914.377706006484;6389.2652344980925;6435.292117867125;6558.508111891722;6602.306757790363;6619.56972796786;6634.336566343327;6700.363465470772;6719.664016799238;6726.327367263235;6743.898841517479;6454.1609590752905;6457.61254324742;6462.450691691259;6483.708233129426;6490.643014634241;6420.1974753155855;6426.068220108152;6454.19322584677;6467.902981455188;6481.254655714653;5299.867503312448;6304.5586808922935;6334.746610135728;6350.301466838551;6376.681165941592;6500.609963402211;6510.869782604226;6514;6520.18497687789;6521.804345869631;5225.503577160163;6278.811635650938;6368.4586810121655;6383.6808159592765;6386.521010924106 15:30:21 INFO - PID 1643 | |1;ext.html;798.0184373220939;1097.2154909239891;1116.3078891087528;1118.9216754827166;1238.170425814704;34952.65047349529;35909.28181436373;36013.63986360139;36020;36063.81968090156;36104.458433123524;36359.72740954067;36388.726394576195;36451.453228201535;36493.452598210984;5892.587518873681;5999.8200053998235;7575.545467271968;7723.227677232288;7737.767866964;5947.702614869261;6031.155638210654;6038.818835434922;7463.104427468711;8320.251177394033;8357.414980951336;8367.456115352514;8378.581070946459;8400.957995210016;8443.535605541692;8308.792280193013;8368.707095251637;8374.958125209396;8375.706850260272;8378.8324233515;5850.122481627747;5947.37552556984;5948.137520059568;8200.302974247195;8236.011678598607;25258.494830103296;25571.872140639178;34676.653233467594;34777.65222347769;35320.11699707502;3526.3828829954655;3562.038249672574;3562.251927095313;3565.215652556459;3571.14292569784;29779.10662680123;29911.80352785886;29926.251843703863;29952.700472995428;29967.550486742715;3021.7280444760077;3093.860776265051;3101.3332133591384;3118.220444888778;3119.266972261517;279634;284318;285934;286014;286637;38479;38541.42187867184;38616.6138338613;48396.5160348392;48487.75756121197;49137.0172596546;49290.75354623204;49329.75335123301;49338.75330623396;49884.50115498871;13618.795718064237;13688.52090176839;13718;13726.931365343109;13731.588052358446;11205.495752691148;11224.494897729623;11224.989750922294;11236.66290011301;11237.662870113909;12191.817122743167;12493.437795299233;12517.874821251853;12525.498980040878;12575.559855405018;4105.495647654928;4884.3161957326;5240.711760853113;5249.921251181236;5254.371144945003;998.5955687946393;1006.7281833904951;1019.9490025498695;1032.1072272484248;1033.4367769565604;18212.453626390965;24053.278401647978;24239.878800606235;24340.26979190627;24349.39126521851;1098.906592939609;1100.2188446203124;1129.497373668726;1148.2134737704698;1158.1198289300023;12284.324362160167;12360.505579776887;12405.379731013414;12442.626721198378;12456.31490268044;312484;312799;313094;313339;313893;51783.48216517862;51818;51828.22257666063;51828.481715182366;52061.47938520642;1496.865282124614;1500.4748338081583;1533.7929379533844;1537.753959366496;1542.0362273579012;23583.646245306678;23766.405839854142;23802.40493987664;23908.88045559761;23965.520689586458;38319.808400957816;38388.80805595954;38432.2313553733;38439.807800960814;38583.2283354337;265343;265392;266417;266885;267174.66412667814;29411.70588294175;29590.260243493223;34074.14814629654;34096.31807363888;34138.31723365568;41329.96675083027;41626.58373416227;42869.57130428656;42909.356359654004;43106.353404698326;28942;29652.258693532833;29779.702202977693;29857.55213671753;30231.546526802555;23369.883150584137;29711.514424278266;29798.95703650362;29976.40047199;29990.550141747455;35976.74081407138;36020.919372418866;36086.27827443384;36090.63909360873;36150.8192459036;27605.171844844688;28276.86892524276;28682.426351472437;29421.411571768873;30305.848470757504;19466.707999379738;23223.606583605037;23348;23654.763452365256;23668.763312367344 15:30:21 INFO - PID 1643 | |2;jquery.html;424.48711826307584;429.8431072658479;430.4576233945232;439.66585395099725;453.5895015011414;18752.99999999998;20534.075966581502;21095.050722717475;21277.680834787472;21311.893440532815;20908.790912090873;22982.310530684066;23037.769622303815;23261;23362.299131026055;4809.663323567352;6209.441150296472;6209.87580248397;6212.596181248227;6214.720337584819;5735.885282294352;6138.386161383848;6169.3522180170885;6200.534959878005;6206.100115483252;5898.88202235955;6149.354317796634;6163.90754138686;6177.258728952532;6182.659953702545;5986.8802623947495;6126.663033533154;6130.448259656608;6135.938640613604;6141.201643786324;5197.830488140176;5313.335833020872;5375.9462405376225;5431.592630552685;5443.237946687467;27256.454870902668;27265.727342726517;27346.726532734618;27405.451890962267;27482.862585687144;2115.9788402115937;2133;2171.185805323004;2172.543765809182;2172.9565408691897;17896.46310610671;17982.460526184237;18074;18127.4561763146;18389;2074.66805311151;2121.6817477378363;2152.461884528868;2159.8920053997235;2160.2007257314735;146040;147893.25211573465;148129.25935370254;148705;150737.49262507455;11861.940690296493;12353;12369.690757731129;12400.875991239973;12415.44130514129;16559.17204139788;16573;16581.419650312422;16598.087105209088;16601.66796664084;8697;8904.94099854737;8938.1508756668;8942.329325300498;9109.954450227706;8385.161483851565;8419.95790021046;8436.029856566573;8612.09572994839;8614.78463038429;7705.6147192641265;7786.1824508426935;7832.412569057344;7846.176151504124;7855.567943763148;2131.0516820015255;2147.4309308033385;2147.4309308033385;2159.8596091254017;2168.5229249565073;971.7036303927229;976.1848856205006;976.8632391465201;1009.0867764672836;1031.0668844695563;21061;21508.78491215099;21522.461938451663;21547.461313467287;21578.784212157992;836.3267569606525;1016.9508440492414;1025.4411345816548;1026.5688410867303;1035.9378437293788;10459.372437653765;10961.561537538568;10975;11013.669589912315;11025.503852326665;536602;541478;546724;559966.2001690047;560123;89414.55292723495;111766;123137;124897;129338.70661293267;1122.9494672739584;1163.988360116405;1180.9586664466703;1183.0358258019687;1183.9348835813942;22623.208187714008;22952.4261893454;22979.425514361606;23352.532949341257;23358.416039599146;57991.4200857986;58224.70887645535;58531.41468585259;59064;59259.81480370282;66587;77000;78013;79333.60333198297;79691;7041.50709450354;8517.361197910057;8742.650293988168;8747.300215982834;8879.11208879107;13958.58124256274;13977.371018304404;14380.712385752435;14484.85515144835;14494.565163045125;11669.533218671158;11750.707422183725;11876.881231187923;11885.881141188478;12128.151029428209;10480.58077676915;10654.520546575577;10950.890491094988;11089.722756930818;11324;11296.887031129583;11913.642590722293;12134.696632584257;12135.968442682472;12384.195027323196;8556.74329770108;8705.651773928972;8767.693130740394;8767.912320876965;9008.41445306053;10649.680509584725;10919.39943303126;12042.75914481723;12277.938610306892;12390.442430090849 15:30:21 INFO - PID 1643 | |3;mootools.html;1259.7417529406475;1354.9390277437515;1420.3608376230693;1435.4545272796336;1437.784332350148;11006.889931100697;11533.769324613524;11540;11557.19099663024;11570.190086693925;11064.17018723597;11284.492197851096;11535.596254131107;11655.242409243414;11661.41692915355;2479.789217916479;2518.5970244760842;2519.7732204101626;2525.4191535946743;2527.949441011179;2432.0879670123704;2475.195561442529;2483.8261321707487;2484.2174714964817;2484.968737973739;2415.408224984881;2516.19481765835;2518.6347979542957;2519.407939134302;2521.10500772226;2476.863772492512;2479.0579579759756;2501.1496091329036;2501.949961000788;2511.2717311979595;2487.589547724623;2498.800095992316;2507.072383218221;2507.636392723045;2518.3704073981503;11375;11652;11658.475368608433;11658.825117623242;11675.299482031105;6421.743130274784;6642.136522252076;6651.86696266072;6651.966740166316;6655.101561289212;3794.7343685941996;4046.858359957387;4120.608542188487;4296.140771845612;4315.331123675835;1228.3980849383827;1248.8189212564128;1298.5000774701714;1299.9740005199842;1302.9413676384586;15062.397504099823;15450.76823847632;16119;16247.350105995745;16261.024338539726;4583.449986001635;5319.175527793198;5514.696691681916;5523.6685798852195;5563.693996830132;11731.47208375625;11738.354390508433;11751.177417580859;11760.529578816751;11768.705782355339;5474.890502189934;6476.902846457307;6487.61074335532;6498.187726534184;6502.707378167994;5874.412558744091;6213.565050446516;6265.342139075423;6272.2159730033745;6277.435030847246;4239.9788001060415;4360.585744354281;4367.082912588392;4386.254336762758;4427.092446048552;1094.950727217277;1188.3107797477442;1243.4839541590138;1253.254313683357;1263.444084602772;789.5499565247868;795.1412474527497;809.0372456776417;810.691937063912;826.1696994520588;6092.847678807977;6096.512279017668;6238.469730072995;6333.46165575922;6441;582.4059459351522;596.0731063196771;596.8537708261504;599.7091410665823;606.3088079589272;3783.24335132969;3869.8839034829;3870.7096967727534;4160.167966406731;4353.891152721144;14614.415423382945;14923.701525969636;15160.545183644508;15166.924165379103;15173.013754105948;14382.065165764192;14832.332545035499;15066.54800355991;15084.849151508564;15117.319720612599;8428.578571071423;8627.525486098199;8636.524991125423;8657.134286571292;8676.305895528343;5612.663240205601;6433.903491447726;6858.725650973905;7029.121359830021;7093.32613401726;13110.868891311346;13409.66475838112;13413.32933353348;13462.259575723428;13490.86509134896;12285;12286.81569776472;13861.792073119113;13864.445422183404;13922;9057;9252.95373523155;9362.391444556082;9373;9384.81230375375;10560.894391056298;10705;10715.946420268161;10720.678379648623;10733.195010374096;8963.731088067369;9090.59092340833;9150.908490915006;9223.262139028995;9279.67521136757;8800;8822.117788221127;8973;9020.278377729635;9067;8139.511629302261;8155.5514446706;8175.1416101308505;8189.754307370788;8265.256126948603;6068.302145253176;6106.1146133811235;6106.45041946227;6134.693265336805;6207.720652570735;6005.339412664691;6033.818985430444;6186.876262474635;6215.409536094064;6322.3045464997895 15:30:21 INFO - PID 1643 | |4;prototype.html;375.778290808423;386.85492940147446;395.8456202081188;398.2373754260591;400.94787677601926;5161.096808058584;5561.249231353766;5645.689487078209;6015.819525414234;6059.727312270948;4454.752669252614;4843.927341089887;5098.107831129556;5281.075811732941;5700.315962084545;3912.9804350978347;3922.84308627656;4364.476262848462;4560.749158796257;4561.817527298921;4131.153113611717;4424.734515929054;4527.615152712024;4578.733526904187;4595.195840727876;4492.125039974403;4511.684182107254;4515.871032241939;4517.683762136652;4553.863384098482;3684.5025921500524;3892;4511.097780443908;4525.0994582275525;4540.18276710192;3705.3886108792017;3768;3778.848846046155;3895.688344932427;4044.7573145611063;4213.705040647156;5349.839504814861;5388.892222155535;5617.820257745878;5850.853728656775;4520.728756274634;4537.342085397632;5401.621886467949;5405.621606487547;5421.620486565942;6127.908081378783;6212.968935155295;6351.237851457809;6360.618362898241;6386.904196437057;3944.73768394114;4442;4571.702839315434;4572.9314060289125;4599;5701.828945131611;6470.770553594802;6660.666966651648;6671.766488172891;6687.832804179837;3148.8110713357273;3476.9826150869085;3534.452159915217;4111.280525907954;4155.542890282067;4282.143571285756;4299.54854740254;4307.440032795716;4307.784610769449;4320.1143765527995;4393.912121757611;5036.489053284;5059.342285502861;5060.949390506122;5073.619478539124;5184.7407629618365;6007.2666936543765;6043.214382130295;6263.467605253604;6364.7135878885565;1369.3221855181748;1407.4651632379835;1419.8002687729058;1454.7963285140088;1458.2490017640923;847.499975014732;847.9533625650648;936.7049379445452;956.5408603870181;959.6641175588628;4960.404751429852;5509.752061157257;5961.406788047127;5965.105234214902;5965.7613695452565;5933.376995415506;5988.011978023665;6442.35576442352;6458.6770661466735;6512.479001679854;5806.767729290866;5865.266841644794;5868.911966320508;5929.347771745104;5955.374685657944;2823.0217120937195;3340.248444100058;3384.272381438003;3384.340053689507;3390.5422767926016;5762.942370576325;6385.297617262097;6659.800205993828;6660.6336651484635;6726.630035348005;5823.4467725566;5878.823635290948;6589.110470086477;6793.116894803644;6824.829379265459;5601.907628012498;6192.5974811638;6408.935910640834;6555.410013098844;6612.371824676744;5850.678212698343;6565.671716414256;6579.276279609144;6593.835154121185;6609.900851487136;5396.919046214389;6184.350643182401;6427.935720642734;6474.676266186766;6499.252585952676;6568.113304703804;6743.9325606743305;6747.426468750211;6792.524523283323;6794.52438329332;3665.3402387570495;4178.603032711888;4214.283571792741;4215.3770798242285;4217.523866646649;5379.811706590251;6484.239141297941;6492.318306577741;6579.967100164468;6609.801705948829;5036.384431359082;6335.239771227482;6380.393862583047;6380.766731643887;6389.329120442472;6119.908201376894;6336.936630633634;6362.363763623601;6368.299487056513;6382.521310901608;5107.897842043212;5344.919826202532;5454.699991500505;5701.743421545957;6273.874522509615;5240;5640.746166422603;6383.425491705769;6384.776532821329;6392.520560957853;5207.6875387476875;5983.760649574142;6133.601315914451;6195.81412557624;6213.2233470816145 15:30:21 INFO - PID 1643 | |5;yui.html;814.6863457568836;841.2680967558225;865.4071960706916;866.8179682266724;876.0451108291962;15891.682166356666;15958.601034974117;16233;16275.348986040544;18233.54416139597;17679.55801104973;17706.911465442656;17913.731294030567;18022.81977180228;18170.182341794618;981.249344251648;995.3182070281844;995.5719040812447;995.5768798260747;999.4702807512031;783.9725609603637;845.6067928413318;999.5951639585979;1000.1598657128011;1002.7844013537089;1017.2218253036433;1017.4810846468317;1019.1846522781782;1020.9948950255275;1054.5518154784186;1020.6529779874804;1022.4018948914819;1023.0843395161363;1023.738946568624;1069.9995504203555;707.8336590901134;751.5866273549526;753.2429907942537;754.0310700749566;763.9388848892131;16494.17529123551;16569.25438355265;16789;16815.91592042044;16908.323667053304;16745.246463909032;16791.66416671672;17084.572885677833;17265.13674316279;17293.740593891103;13144.934275328658;13801.654958626013;13813.033087683867;13923.025388222828;13939.372728227254;3498.4577390504514;3515.7187425006196;3520.099146460908;3555.3955827509126;3561.056320075182;131499;132659.34681306416;133104;134862;136614.31692841472;13330.933345333406;13347;13400.597982060553;13597.660058498617;13602.251876146907;25297;25651.230463086136;25833.48333033329;26011.9595216193;26178.73821261763;7458.962705186439;7648.38812894967;7688.730894418669;7690.692372305157;7697.23027697237;3870.4774855394726;4016.397540368968;4017.5178978522763;4018.0758425562285;4019.7789121598594;4247.936280955788;4273.594008569243;4320.157569273962;4322.762248076386;4328.394024836525;852.5225873510853;877.9648814047366;879.0945326313779;880.3837313880309;883.726044926075;627.733213384319;636.4303947966637;653.6698967021624;664.1830548425368;670.168990451846;10675.733106672395;11679.766404671858;11695.005924496512;11724.209867529007;11858.525658973544;648.3581254557954;650.9446697030805;660.211047797877;663.2439019517753;683.719674933275;4215.114825886537;4990.725510096907;5093.363329583802;5117.488251174853;5225.973870130625;110876.33685494724;112814.40705407757;115315;116241.41879290719;117901;82227.76658350129;96680.54979175318;98462;99156.50421747845;99441;75163;78376;78439.60780196062;81655;84181;12076.939615302219;12722.173058751152;12766.42551085222;12810.410518378909;12875.484980601046;37855;40410;40548.39177412282;40717;42008;73090;73182;74154.62922685352;74313.88529171959;75502.6224868894;15746.842531574537;16321.428749993693;16834.15829208559;17026;17045;18084.367047153286;18266.817331827042;18526.258949642404;18730.531736706693;19035.333763318216;16437.260323285722;16842.326306947583;17243.310267589157;17452.912735436243;17517;16672.833271667612;16862.156892155097;17193.484195474157;17359.3924212657;17455.38906138279;16228.756568651715;16836.663266734842;16940.237689303765;16984.74522882133;17119.14404279806;11533.192676512563;11765.88234117682;12073.335966521925;12191.573294934635;12491.625251242478;12425.19236249641;12988.285644289655;13303.334833258104;13307.93536517057;13336.799948000593 15:30:21 INFO - PID 1643 | __end_tp_report 15:30:21 INFO - PID 1643 | __start_cc_report 15:30:21 INFO - PID 1643 | _x_x_mozilla_cycle_collect,1897 15:30:21 INFO - PID 1643 | __end_cc_report 15:30:21 INFO - PID 1643 | __startTimestamp1494023421108__endTimestamp 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | ------- Summary: start ------- 15:30:21 INFO - PID 1643 | Number of tests: 6 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6099.81 Median:6350.30 stddev:740.33 (11.7%) stddev-sans-first:699.41 15:30:21 INFO - PID 1643 | Values: 2923.7 3393.6 3521.2 3539.3 3573.4 6163.4 6212.4 6249.4 6256.5 6286.2 6124.7 6245.0 6274.8 6296.9 6305.0 4959.2 5381.5 5414.9 5474.4 5479.9 5310.6 5475.0 5509.1 5552.6 5582.1 5378.2 5380.5 5389.8 5404.1 5408.6 5379.8 5395.8 5396.7 5405.2 5409.7 5313.3 5345.5 5346.8 5362.2 5375.7 5283.4 6156.2 6197.5 6256.5 6262.7 6529.1 6542.9 6576.1 6580.4 6597.4 5560.6 6705.6 6721.3 6723.3 6727.4 6138.8 6220.1 6227.4 6261.1 6371.3 6774.7 6779.6 6794.3 6800.8 6809.0 6341.4 6402.9 6416.3 6452.8 6560.9 6667.8 6672.7 6686.8 6688.6 6695.6 6380.3 6437.4 6503.9 6567.7 6577.9 6524.6 6578.0 6615.8 6616.5 6629.2 5174.1 5262.7 5265.7 5270.6 5275.6 4605.8 4732.0 4732.9 4750.3 4779.5 6145.4 6194.1 6196.5 6204.2 6212.4 6552.6 6558.6 6590.4 6724.0 6746.5 6295.2 6322.3 6324.0 6340.0 6346.5 5864.4 5869.7 5877.2 5880.8 5931.4 5671.7 6594.2 6694.9 6839.0 6910.3 6730.9 6747.5 6762.4 6767.4 6770.4 6898.5 6907.6 6908.7 6910.5 6914.4 6389.3 6435.3 6558.5 6602.3 6619.6 6634.3 6700.4 6719.7 6726.3 6743.9 6454.2 6457.6 6462.5 6483.7 6490.6 6420.2 6426.1 6454.2 6467.9 6481.3 5299.9 6304.6 6334.7 6350.3 6376.7 6500.6 6510.9 6514.0 6520.2 6521.8 5225.5 6278.8 6368.5 6383.7 6386.5 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:43056.23 Median:3118.74 stddev:75732.78 (2428.3%) stddev-sans-first:75878.77 15:30:21 INFO - PID 1643 | Values: 798.0 1097.2 1116.3 1118.9 1238.2 34952.7 35909.3 36013.6 36020.0 36063.8 36104.5 36359.7 36388.7 36451.5 36493.5 5892.6 5999.8 7575.5 7723.2 7737.8 5947.7 6031.2 6038.8 7463.1 8320.3 8357.4 8367.5 8378.6 8401.0 8443.5 8308.8 8368.7 8375.0 8375.7 8378.8 5850.1 5947.4 5948.1 8200.3 8236.0 25258.5 25571.9 34676.7 34777.7 35320.1 3526.4 3562.0 3562.3 3565.2 3571.1 29779.1 29911.8 29926.3 29952.7 29967.6 3021.7 3093.9 3101.3 3118.2 3119.3 279634.0 284318.0 285934.0 286014.0 286637.0 38479.0 38541.4 38616.6 48396.5 48487.8 49137.0 49290.8 49329.8 49338.8 49884.5 13618.8 13688.5 13718.0 13726.9 13731.6 11205.5 11224.5 11225.0 11236.7 11237.7 12191.8 12493.4 12517.9 12525.5 12575.6 4105.5 4884.3 5240.7 5249.9 5254.4 998.6 1006.7 1019.9 1032.1 1033.4 18212.5 24053.3 24239.9 24340.3 24349.4 1098.9 1100.2 1129.5 1148.2 1158.1 12284.3 12360.5 12405.4 12442.6 12456.3 312484.0 312799.0 313094.0 313339.0 313893.0 51783.5 51818.0 51828.2 51828.5 52061.5 1496.9 1500.5 1533.8 1537.8 1542.0 23583.6 23766.4 23802.4 23908.9 23965.5 38319.8 38388.8 38432.2 38439.8 38583.2 265343.0 265392.0 266417.0 266885.0 267174.7 29411.7 29590.3 34074.1 34096.3 34138.3 41330.0 41626.6 42869.6 42909.4 43106.4 28942.0 29652.3 29779.7 29857.6 30231.5 23369.9 29711.5 29799.0 29976.4 29990.6 35976.7 36020.9 36086.3 36090.6 36150.8 27605.2 28276.9 28682.4 29421.4 30305.8 19466.7 23223.6 23348.0 23654.8 23668.8 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:35093.19 Median:12398.08 stddev:92577.77 (746.7%) stddev-sans-first:92800.88 15:30:21 INFO - PID 1643 | Values: 424.5 429.8 430.5 439.7 453.6 18753.0 20534.1 21095.1 21277.7 21311.9 20908.8 22982.3 23037.8 23261.0 23362.3 4809.7 6209.4 6209.9 6212.6 6214.7 5735.9 6138.4 6169.4 6200.5 6206.1 5898.9 6149.4 6163.9 6177.3 6182.7 5986.9 6126.7 6130.4 6135.9 6141.2 5197.8 5313.3 5375.9 5431.6 5443.2 27256.5 27265.7 27346.7 27405.5 27482.9 2116.0 2133.0 2171.2 2172.5 2173.0 17896.5 17982.5 18074.0 18127.5 18389.0 2074.7 2121.7 2152.5 2159.9 2160.2 146040.0 147893.3 148129.3 148705.0 150737.5 11861.9 12353.0 12369.7 12400.9 12415.4 16559.2 16573.0 16581.4 16598.1 16601.7 8697.0 8904.9 8938.2 8942.3 9110.0 8385.2 8420.0 8436.0 8612.1 8614.8 7705.6 7786.2 7832.4 7846.2 7855.6 2131.1 2147.4 2147.4 2159.9 2168.5 971.7 976.2 976.9 1009.1 1031.1 21061.0 21508.8 21522.5 21547.5 21578.8 836.3 1017.0 1025.4 1026.6 1035.9 10459.4 10961.6 10975.0 11013.7 11025.5 536602.0 541478.0 546724.0 559966.2 560123.0 89414.6 111766.0 123137.0 124897.0 129338.7 1122.9 1164.0 1181.0 1183.0 1183.9 22623.2 22952.4 22979.4 23352.5 23358.4 57991.4 58224.7 58531.4 59064.0 59259.8 66587.0 77000.0 78013.0 79333.6 79691.0 7041.5 8517.4 8742.7 8747.3 8879.1 13958.6 13977.4 14380.7 14484.9 14494.6 11669.5 11750.7 11876.9 11885.9 12128.2 10480.6 10654.5 10950.9 11089.7 11324.0 11296.9 11913.6 12134.7 12136.0 12384.2 8556.7 8705.7 8767.7 8767.9 9008.4 10649.7 10919.4 12042.8 12277.9 12390.4 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7032.17 Median:3788.99 stddev:4452.30 (117.5%) stddev-sans-first:4443.66 15:30:21 INFO - PID 1643 | Values: 1259.7 1354.9 1420.4 1435.5 1437.8 11006.9 11533.8 11540.0 11557.2 11570.2 11064.2 11284.5 11535.6 11655.2 11661.4 2479.8 2518.6 2519.8 2525.4 2527.9 2432.1 2475.2 2483.8 2484.2 2485.0 2415.4 2516.2 2518.6 2519.4 2521.1 2476.9 2479.1 2501.1 2501.9 2511.3 2487.6 2498.8 2507.1 2507.6 2518.4 11375.0 11652.0 11658.5 11658.8 11675.3 6421.7 6642.1 6651.9 6652.0 6655.1 3794.7 4046.9 4120.6 4296.1 4315.3 1228.4 1248.8 1298.5 1300.0 1302.9 15062.4 15450.8 16119.0 16247.4 16261.0 4583.4 5319.2 5514.7 5523.7 5563.7 11731.5 11738.4 11751.2 11760.5 11768.7 5474.9 6476.9 6487.6 6498.2 6502.7 5874.4 6213.6 6265.3 6272.2 6277.4 4240.0 4360.6 4367.1 4386.3 4427.1 1095.0 1188.3 1243.5 1253.3 1263.4 789.5 795.1 809.0 810.7 826.2 6092.8 6096.5 6238.5 6333.5 6441.0 582.4 596.1 596.9 599.7 606.3 3783.2 3869.9 3870.7 4160.2 4353.9 14614.4 14923.7 15160.5 15166.9 15173.0 14382.1 14832.3 15066.5 15084.8 15117.3 8428.6 8627.5 8636.5 8657.1 8676.3 5612.7 6433.9 6858.7 7029.1 7093.3 13110.9 13409.7 13413.3 13462.3 13490.9 12285.0 12286.8 13861.8 13864.4 13922.0 9057.0 9253.0 9362.4 9373.0 9384.8 10560.9 10705.0 10715.9 10720.7 10733.2 8963.7 9090.6 9150.9 9223.3 9279.7 8800.0 8822.1 8973.0 9020.3 9067.0 8139.5 8155.6 8175.1 8189.8 8265.3 6068.3 6106.1 6106.5 6134.7 6207.7 6005.3 6033.8 6186.9 6215.4 6322.3 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5029.98 Median:5609.86 stddev:1594.03 (28.4%) stddev-sans-first:1559.75 15:30:21 INFO - PID 1643 | Values: 375.8 386.9 395.8 398.2 400.9 5161.1 5561.2 5645.7 6015.8 6059.7 4454.8 4843.9 5098.1 5281.1 5700.3 3913.0 3922.8 4364.5 4560.7 4561.8 4131.2 4424.7 4527.6 4578.7 4595.2 4492.1 4511.7 4515.9 4517.7 4553.9 3684.5 3892.0 4511.1 4525.1 4540.2 3705.4 3768.0 3778.8 3895.7 4044.8 4213.7 5349.8 5388.9 5617.8 5850.9 4520.7 4537.3 5401.6 5405.6 5421.6 6127.9 6213.0 6351.2 6360.6 6386.9 3944.7 4442.0 4571.7 4572.9 4599.0 5701.8 6470.8 6660.7 6671.8 6687.8 3148.8 3477.0 3534.5 4111.3 4155.5 4282.1 4299.5 4307.4 4307.8 4320.1 4393.9 5036.5 5059.3 5060.9 5073.6 5184.7 6007.3 6043.2 6263.5 6364.7 1369.3 1407.5 1419.8 1454.8 1458.2 847.5 848.0 936.7 956.5 959.7 4960.4 5509.8 5961.4 5965.1 5965.8 5933.4 5988.0 6442.4 6458.7 6512.5 5806.8 5865.3 5868.9 5929.3 5955.4 2823.0 3340.2 3384.3 3384.3 3390.5 5762.9 6385.3 6659.8 6660.6 6726.6 5823.4 5878.8 6589.1 6793.1 6824.8 5601.9 6192.6 6408.9 6555.4 6612.4 5850.7 6565.7 6579.3 6593.8 6609.9 5396.9 6184.4 6427.9 6474.7 6499.3 6568.1 6743.9 6747.4 6792.5 6794.5 3665.3 4178.6 4214.3 4215.4 4217.5 5379.8 6484.2 6492.3 6580.0 6609.8 5036.4 6335.2 6380.4 6380.8 6389.3 6119.9 6336.9 6362.4 6368.3 6382.5 5107.9 5344.9 5454.7 5701.7 6273.9 5240.0 5640.7 6383.4 6384.8 6392.5 5207.7 5983.8 6133.6 6195.8 6213.2 15:30:21 INFO - PID 1643 | 15:30:21 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:22949.77 Median:18127.27 stddev:33032.57 (182.2%) stddev-sans-first:33083.42 15:30:21 INFO - PID 1643 | Values: 814.7 841.3 865.4 866.8 876.0 15891.7 15958.6 16233.0 16275.3 18233.5 17679.6 17706.9 17913.7 18022.8 18170.2 981.2 995.3 995.6 995.6 999.5 784.0 845.6 999.6 1000.2 1002.8 1017.2 1017.5 1019.2 1021.0 1054.6 1020.7 1022.4 1023.1 1023.7 1070.0 707.8 751.6 753.2 754.0 763.9 16494.2 16569.3 16789.0 16815.9 16908.3 16745.2 16791.7 17084.6 17265.1 17293.7 13144.9 13801.7 13813.0 13923.0 13939.4 3498.5 3515.7 3520.1 3555.4 3561.1 131499.0 132659.3 133104.0 134862.0 136614.3 13330.9 13347.0 13400.6 13597.7 13602.3 25297.0 25651.2 25833.5 26012.0 26178.7 7459.0 7648.4 7688.7 7690.7 7697.2 3870.5 4016.4 4017.5 4018.1 4019.8 4247.9 4273.6 4320.2 4322.8 4328.4 852.5 878.0 879.1 880.4 883.7 627.7 636.4 653.7 664.2 670.2 10675.7 11679.8 11695.0 11724.2 11858.5 648.4 650.9 660.2 663.2 683.7 4215.1 4990.7 5093.4 5117.5 5226.0 110876.3 112814.4 115315.0 116241.4 117901.0 82227.8 96680.5 98462.0 99156.5 99441.0 75163.0 78376.0 78439.6 81655.0 84181.0 12076.9 12722.2 12766.4 12810.4 12875.5 37855.0 40410.0 40548.4 40717.0 42008.0 73090.0 73182.0 74154.6 74313.9 75502.6 15746.8 16321.4 16834.2 17026.0 17045.0 18084.4 18266.8 18526.3 18730.5 19035.3 16437.3 16842.3 17243.3 17452.9 17517.0 16672.8 16862.2 17193.5 17359.4 17455.4 16228.8 16836.7 16940.2 16984.7 17119.1 11533.2 11765.9 12073.3 12191.6 12491.6 12425.2 12988.3 13303.3 13307.9 13336.8 15:30:21 INFO - PID 1643 | -------- Summary: end -------- 15:30:21 INFO - PID 1643 | 15:30:21 INFO - TEST-INFO | 1643: exit 0 15:30:21 INFO - TEST-OK | dromaeo_css | took 1118595ms 15:30:21 INFO - TEST-START | kraken 15:30:21 INFO - operating with platform_type : mac_ 15:30:21 INFO - Initialising browser for kraken test... 15:30:21 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpCfUdXl/profile http://localhost:49242/getInfo.html) 15:30:24 INFO - PID 1654 | __metrics Screen width/height:1600/1200 15:30:24 INFO - PID 1654 | colorDepth:24 15:30:24 INFO - PID 1654 | Browser inner width/height: 1024/691 15:30:24 INFO - PID 1654 | __metrics 15:30:24 INFO - PID 1654 | 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" 15:30:24 INFO - PID 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:30:25 INFO - TEST-INFO | 1654: exit 0 15:30:25 INFO - Browser initialized. 15:30:25 INFO - Running cycle 1/1 for kraken test... 15:30:25 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpCfUdXl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:37 INFO - PID 1655 | RSS: Main: 239112192 15:30:37 INFO - PID 1655 | 15:30:39 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:40 INFO - PID 1655 | RSS: Main: 307904512 15:30:40 INFO - PID 1655 | 15:30:43 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 15:30:43 INFO - PID 1655 | RSS: Main: 289587200 15:30:43 INFO - PID 1655 | 15:30:47 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 15:30:47 INFO - PID 1655 | RSS: Main: 381816832 15:30:47 INFO - PID 1655 | 15:30:49 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 15:30:50 INFO - PID 1655 | RSS: Main: 284610560 15:30:50 INFO - PID 1655 | 15:30:52 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:53 INFO - PID 1655 | RSS: Main: 286629888 15:30:53 INFO - PID 1655 | 15:30:55 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:56 INFO - PID 1655 | RSS: Main: 351318016 15:30:56 INFO - PID 1655 | 15:30:59 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 15:31:00 INFO - PID 1655 | RSS: Main: 369582080 15:31:00 INFO - PID 1655 | 15:31:02 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 15:31:03 INFO - PID 1655 | RSS: Main: 374190080 15:31:03 INFO - PID 1655 | 15:31:04 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:31:05 INFO - PID 1655 | RSS: Main: 327098368 15:31:05 INFO - PID 1655 | 15:31:07 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:31:07 INFO - PID 1655 | RSS: Main: 330383360 15:31:07 INFO - PID 1655 | 15:31:09 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:31:10 INFO - PID 1655 | RSS: Main: 332050432 15:31:10 INFO - PID 1655 | 15:31:13 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:31:14 INFO - PID 1655 | RSS: Main: 349966336 15:31:14 INFO - PID 1655 | 15:31:17 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:31:17 INFO - PID 1655 | RSS: Main: 342847488 15:31:17 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 15:31:19 INFO - PID 1655 | RSS: Main: 386097152 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | __start_tp_report 15:31:19 INFO - PID 1655 | _x_x_mozilla_page_load 15:31:19 INFO - PID 1655 | _x_x_mozilla_page_load_details 15:31:19 INFO - PID 1655 | |i|pagename|runs| 15:31:19 INFO - PID 1655 | |0;ai-astar;112;109;111;112;111;111;111;112;110;110 15:31:19 INFO - PID 1655 | |1;audio-beat-detection;136;110;106;142;107;107;107;106;136;106 15:31:19 INFO - PID 1655 | |2;audio-dft;186;185;188;185;185;182;185;185;181;181 15:31:19 INFO - PID 1655 | |3;audio-fft;81;57;57;90;58;59;61;59;80;56 15:31:19 INFO - PID 1655 | |4;audio-oscillator;88;72;86;71;69;68;89;70;70;92 15:31:19 INFO - PID 1655 | |5;imaging-gaussian-blur;88;88;88;88;88;88;88;88;89;88 15:31:19 INFO - PID 1655 | |6;imaging-darkroom;94;94;94;94;94;94;96;95;94;94 15:31:19 INFO - PID 1655 | |7;imaging-desaturate;86;86;84;83;84;86;86;84;85;85 15:31:19 INFO - PID 1655 | |8;json-parse-financial;48;47;48;53;48;48;48;48;47;49 15:31:19 INFO - PID 1655 | |9;json-stringify-tinderbox;54;61;57;58;64;60;57;60;63;58 15:31:19 INFO - PID 1655 | |10;stanford-crypto-aes;83;82;82;83;81;81;81;83;80;83 15:31:19 INFO - PID 1655 | |11;stanford-crypto-ccm;136;134;129;144;143;146;129;134;182;136 15:31:19 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;183;178;224;231;179;183;182;186;183;180 15:31:19 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;68;70;67;67;69;68;69;67;68;69 15:31:19 INFO - PID 1655 | __end_tp_report 15:31:19 INFO - PID 1655 | __start_cc_report 15:31:19 INFO - PID 1655 | _x_x_mozilla_cycle_collect,2168 15:31:19 INFO - PID 1655 | __end_cc_report 15:31:19 INFO - PID 1655 | __startTimestamp1494023479969__endTimestamp 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | ------- Summary: start ------- 15:31:19 INFO - PID 1655 | Number of tests: 14 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 15:31:19 INFO - PID 1655 | Values: 112.0 109.0 111.0 112.0 111.0 111.0 111.0 112.0 110.0 110.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:108.50 stddev:15.11 (13.9%) stddev-sans-first:14.24 15:31:19 INFO - PID 1655 | Values: 136.0 110.0 106.0 142.0 107.0 107.0 107.0 106.0 136.0 106.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.26 (1.2%) stddev-sans-first:2.32 15:31:19 INFO - PID 1655 | Values: 186.0 185.0 188.0 185.0 185.0 182.0 185.0 185.0 181.0 181.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.00 stddev:12.67 (21.1%) stddev-sans-first:12.19 15:31:19 INFO - PID 1655 | Values: 81.0 57.0 57.0 90.0 58.0 59.0 61.0 59.0 80.0 56.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:9.85 (12.5%) stddev-sans-first:9.68 15:31:19 INFO - PID 1655 | Values: 88.0 72.0 86.0 71.0 69.0 68.0 89.0 70.0 70.0 92.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:88.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 15:31:19 INFO - PID 1655 | Values: 88.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 89.0 88.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:31:19 INFO - PID 1655 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 96.0 95.0 94.0 94.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 15:31:19 INFO - PID 1655 | Values: 86.0 86.0 84.0 83.0 84.0 86.0 86.0 84.0 85.0 85.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.00 stddev:1.71 (3.6%) stddev-sans-first:1.81 15:31:19 INFO - PID 1655 | Values: 48.0 47.0 48.0 53.0 48.0 48.0 48.0 48.0 47.0 49.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:60.00 stddev:3.01 (5.0%) stddev-sans-first:2.54 15:31:19 INFO - PID 1655 | Values: 54.0 61.0 57.0 58.0 64.0 60.0 57.0 60.0 63.0 58.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 15:31:19 INFO - PID 1655 | Values: 83.0 82.0 82.0 83.0 81.0 81.0 81.0 83.0 80.0 83.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:139.50 stddev:15.47 (11.1%) stddev-sans-first:16.29 15:31:19 INFO - PID 1655 | Values: 136.0 134.0 129.0 144.0 143.0 146.0 129.0 134.0 182.0 136.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:183.00 stddev:19.50 (10.7%) stddev-sans-first:20.47 15:31:19 INFO - PID 1655 | Values: 183.0 178.0 224.0 231.0 179.0 183.0 182.0 186.0 183.0 180.0 15:31:19 INFO - PID 1655 | 15:31:19 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 15:31:19 INFO - PID 1655 | Values: 68.0 70.0 67.0 67.0 69.0 68.0 69.0 67.0 68.0 69.0 15:31:19 INFO - PID 1655 | -------- Summary: end -------- 15:31:19 INFO - PID 1655 | 15:31:21 INFO - TEST-INFO | 1655: exit 0 15:31:21 INFO - TEST-OK | kraken | took 59410ms 15:31:21 INFO - SUITE-END | took 1178s 15:31:21 INFO - Completed test suite (00:19:38) 15:31:21 INFO - javascript benchmark 15:31:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7725.924451222078, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.6783953765084, 3393.6436674149213, 3521.242932769454, 3539.2567560812245, 3573.3925232710444, 6163.352847950968, 6212.409821067003, 6249.375062493754, 6256.499480041597, 6286.214223222098, 6124.724387402566, 6245.000799872021, 6274.780382686607, 6296.874062518758, 6305.0, 4959.181735013718, 5381.515663590276, 5414.91877621836, 5474.370447398541, 5479.890402191973, 5310.62825602208, 5475.0, 5509.063459211923, 5552.555795536347, 5582.134769110774, 5378.220158077057, 5380.461953804608, 5389.83830485086, 5404.081306177959, 5408.648437851527, 5379.811706590251, 5395.757190926418, 5396.677813935572, 5405.243265942771, 5409.729513524348, 5313.282706834567, 5345.465453454663, 5346.759395827197, 5362.195670649395, 5375.731213439351, 5283.392409872876, 6156.199694039791, 6197.473214776749, 6256.499480041632, 6262.749490020394, 6529.085927970088, 6542.858569217741, 6576.112224849632, 6580.407763301278, 6597.373249541286, 5560.638558493725, 6705.597664140168, 6721.327867213288, 6723.260441351447, 6727.360900714473, 6138.817583427401, 6220.098085777582, 6227.439530442282, 6261.092141639437, 6371.299157092716, 6774.729010839511, 6779.62712050832, 6794.252632210453, 6800.829979250559, 6809.0, 6341.397567231105, 6402.903956440658, 6416.32628573993, 6452.838679033061, 6560.9343906560325, 6667.799966001027, 6672.7330906764155, 6686.765963191265, 6688.565243259172, 6695.598264104169, 6380.298167201604, 6437.388448097423, 6503.934960650333, 6567.737290508422, 6577.868442631217, 6524.575902566318, 6577.967110164514, 6615.801525954229, 6616.536842421081, 6629.171353580802, 5174.14626586609, 5262.710550919736, 5265.710385928811, 5270.578353731692, 5275.551578115903, 4605.792739326738, 4731.976340118277, 4732.905341893212, 4750.311204875274, 4779.498152693986, 6145.371476558716, 6194.132821405007, 6196.535259855529, 6204.224471941007, 6212.409821066992, 6552.63960482178, 6558.573692709959, 6590.439812615981, 6723.966380168068, 6746.494012949049, 6295.150154729053, 6322.336154703782, 6324.0, 6340.0, 6346.524010699124, 5864.44287792659, 5869.677167755729, 5877.206577112121, 5880.764769409261, 5931.40685931412, 5671.744771485211, 6594.175728033996, 6694.933050669431, 6839.0, 6910.274421185904, 6730.899036514358, 6747.527673063035, 6762.391384775394, 6767.35710107539, 6770.356816102462, 6898.482613803884, 6907.620080895398, 6908.654567271717, 6910.481713871581, 6914.377706006484, 6389.2652344980925, 6435.292117867125, 6558.508111891722, 6602.306757790363, 6619.56972796786, 6634.336566343327, 6700.363465470772, 6719.664016799238, 6726.327367263235, 6743.898841517479, 6454.1609590752905, 6457.61254324742, 6462.450691691259, 6483.708233129426, 6490.643014634241, 6420.1974753155855, 6426.068220108152, 6454.19322584677, 6467.902981455188, 6481.254655714653, 5299.867503312448, 6304.5586808922935, 6334.746610135728, 6350.301466838551, 6376.681165941592, 6500.609963402211, 6510.869782604226, 6514.0, 6520.18497687789, 6521.804345869631, 5225.503577160163, 6278.811635650938, 6368.4586810121655, 6383.6808159592765, 6386.521010924106], "value": 6048.907291861639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.0184373220939, 1097.2154909239891, 1116.3078891087528, 1118.9216754827166, 1238.170425814704, 34952.65047349529, 35909.28181436373, 36013.63986360139, 36020.0, 36063.81968090156, 36104.458433123524, 36359.72740954067, 36388.726394576195, 36451.453228201535, 36493.452598210984, 5892.587518873681, 5999.8200053998235, 7575.545467271968, 7723.227677232288, 7737.767866964, 5947.702614869261, 6031.155638210654, 6038.818835434922, 7463.104427468711, 8320.251177394033, 8357.414980951336, 8367.456115352514, 8378.581070946459, 8400.957995210016, 8443.535605541692, 8308.792280193013, 8368.707095251637, 8374.958125209396, 8375.706850260272, 8378.8324233515, 5850.122481627747, 5947.37552556984, 5948.137520059568, 8200.302974247195, 8236.011678598607, 25258.494830103296, 25571.872140639178, 34676.653233467594, 34777.65222347769, 35320.11699707502, 3526.3828829954655, 3562.038249672574, 3562.251927095313, 3565.215652556459, 3571.14292569784, 29779.10662680123, 29911.80352785886, 29926.251843703863, 29952.700472995428, 29967.550486742715, 3021.7280444760077, 3093.860776265051, 3101.3332133591384, 3118.220444888778, 3119.266972261517, 279634.0, 284318.0, 285934.0, 286014.0, 286637.0, 38479.0, 38541.42187867184, 38616.6138338613, 48396.5160348392, 48487.75756121197, 49137.0172596546, 49290.75354623204, 49329.75335123301, 49338.75330623396, 49884.50115498871, 13618.795718064237, 13688.52090176839, 13718.0, 13726.931365343109, 13731.588052358446, 11205.495752691148, 11224.494897729623, 11224.989750922294, 11236.66290011301, 11237.662870113909, 12191.817122743167, 12493.437795299233, 12517.874821251853, 12525.498980040878, 12575.559855405018, 4105.495647654928, 4884.3161957326, 5240.711760853113, 5249.921251181236, 5254.371144945003, 998.5955687946393, 1006.7281833904951, 1019.9490025498695, 1032.1072272484248, 1033.4367769565604, 18212.453626390965, 24053.278401647978, 24239.878800606235, 24340.26979190627, 24349.39126521851, 1098.906592939609, 1100.2188446203124, 1129.497373668726, 1148.2134737704698, 1158.1198289300023, 12284.324362160167, 12360.505579776887, 12405.379731013414, 12442.626721198378, 12456.31490268044, 312484.0, 312799.0, 313094.0, 313339.0, 313893.0, 51783.48216517862, 51818.0, 51828.22257666063, 51828.481715182366, 52061.47938520642, 1496.865282124614, 1500.4748338081583, 1533.7929379533844, 1537.753959366496, 1542.0362273579012, 23583.646245306678, 23766.405839854142, 23802.40493987664, 23908.88045559761, 23965.520689586458, 38319.808400957816, 38388.80805595954, 38432.2313553733, 38439.807800960814, 38583.2283354337, 265343.0, 265392.0, 266417.0, 266885.0, 267174.66412667814, 29411.70588294175, 29590.260243493223, 34074.14814629654, 34096.31807363888, 34138.31723365568, 41329.96675083027, 41626.58373416227, 42869.57130428656, 42909.356359654004, 43106.353404698326, 28942.0, 29652.258693532833, 29779.702202977693, 29857.55213671753, 30231.546526802555, 23369.883150584137, 29711.514424278266, 29798.95703650362, 29976.40047199, 29990.550141747455, 35976.74081407138, 36020.919372418866, 36086.27827443384, 36090.63909360873, 36150.8192459036, 27605.171844844688, 28276.86892524276, 28682.426351472437, 29421.411571768873, 30305.848470757504, 19466.707999379738, 23223.606583605037, 23348.0, 23654.763452365256, 23668.763312367344], "value": 16677.80445325883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.48711826307584, 429.8431072658479, 430.4576233945232, 439.66585395099725, 453.5895015011414, 18752.99999999998, 20534.075966581502, 21095.050722717475, 21277.680834787472, 21311.893440532815, 20908.790912090873, 22982.310530684066, 23037.769622303815, 23261.0, 23362.299131026055, 4809.663323567352, 6209.441150296472, 6209.87580248397, 6212.596181248227, 6214.720337584819, 5735.885282294352, 6138.386161383848, 6169.3522180170885, 6200.534959878005, 6206.100115483252, 5898.88202235955, 6149.354317796634, 6163.90754138686, 6177.258728952532, 6182.659953702545, 5986.8802623947495, 6126.663033533154, 6130.448259656608, 6135.938640613604, 6141.201643786324, 5197.830488140176, 5313.335833020872, 5375.9462405376225, 5431.592630552685, 5443.237946687467, 27256.454870902668, 27265.727342726517, 27346.726532734618, 27405.451890962267, 27482.862585687144, 2115.9788402115937, 2133.0, 2171.185805323004, 2172.543765809182, 2172.9565408691897, 17896.46310610671, 17982.460526184237, 18074.0, 18127.4561763146, 18389.0, 2074.66805311151, 2121.6817477378363, 2152.461884528868, 2159.8920053997235, 2160.2007257314735, 146040.0, 147893.25211573465, 148129.25935370254, 148705.0, 150737.49262507455, 11861.940690296493, 12353.0, 12369.690757731129, 12400.875991239973, 12415.44130514129, 16559.17204139788, 16573.0, 16581.419650312422, 16598.087105209088, 16601.66796664084, 8697.0, 8904.94099854737, 8938.1508756668, 8942.329325300498, 9109.954450227706, 8385.161483851565, 8419.95790021046, 8436.029856566573, 8612.09572994839, 8614.78463038429, 7705.6147192641265, 7786.1824508426935, 7832.412569057344, 7846.176151504124, 7855.567943763148, 2131.0516820015255, 2147.4309308033385, 2147.4309308033385, 2159.8596091254017, 2168.5229249565073, 971.7036303927229, 976.1848856205006, 976.8632391465201, 1009.0867764672836, 1031.0668844695563, 21061.0, 21508.78491215099, 21522.461938451663, 21547.461313467287, 21578.784212157992, 836.3267569606525, 1016.9508440492414, 1025.4411345816548, 1026.5688410867303, 1035.9378437293788, 10459.372437653765, 10961.561537538568, 10975.0, 11013.669589912315, 11025.503852326665, 536602.0, 541478.0, 546724.0, 559966.2001690047, 560123.0, 89414.55292723495, 111766.0, 123137.0, 124897.0, 129338.70661293267, 1122.9494672739584, 1163.988360116405, 1180.9586664466703, 1183.0358258019687, 1183.9348835813942, 22623.208187714008, 22952.4261893454, 22979.425514361606, 23352.532949341257, 23358.416039599146, 57991.4200857986, 58224.70887645535, 58531.41468585259, 59064.0, 59259.81480370282, 66587.0, 77000.0, 78013.0, 79333.60333198297, 79691.0, 7041.50709450354, 8517.361197910057, 8742.650293988168, 8747.300215982834, 8879.11208879107, 13958.58124256274, 13977.371018304404, 14380.712385752435, 14484.85515144835, 14494.565163045125, 11669.533218671158, 11750.707422183725, 11876.881231187923, 11885.881141188478, 12128.151029428209, 10480.58077676915, 10654.520546575577, 10950.890491094988, 11089.722756930818, 11324.0, 11296.887031129583, 11913.642590722293, 12134.696632584257, 12135.968442682472, 12384.195027323196, 8556.74329770108, 8705.651773928972, 8767.693130740394, 8767.912320876965, 9008.41445306053, 10649.680509584725, 10919.39943303126, 12042.75914481723, 12277.938610306892, 12390.442430090849], "value": 10410.975286227924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.7417529406475, 1354.9390277437515, 1420.3608376230693, 1435.4545272796336, 1437.784332350148, 11006.889931100697, 11533.769324613524, 11540.0, 11557.19099663024, 11570.190086693925, 11064.17018723597, 11284.492197851096, 11535.596254131107, 11655.242409243414, 11661.41692915355, 2479.789217916479, 2518.5970244760842, 2519.7732204101626, 2525.4191535946743, 2527.949441011179, 2432.0879670123704, 2475.195561442529, 2483.8261321707487, 2484.2174714964817, 2484.968737973739, 2415.408224984881, 2516.19481765835, 2518.6347979542957, 2519.407939134302, 2521.10500772226, 2476.863772492512, 2479.0579579759756, 2501.1496091329036, 2501.949961000788, 2511.2717311979595, 2487.589547724623, 2498.800095992316, 2507.072383218221, 2507.636392723045, 2518.3704073981503, 11375.0, 11652.0, 11658.475368608433, 11658.825117623242, 11675.299482031105, 6421.743130274784, 6642.136522252076, 6651.86696266072, 6651.966740166316, 6655.101561289212, 3794.7343685941996, 4046.858359957387, 4120.608542188487, 4296.140771845612, 4315.331123675835, 1228.3980849383827, 1248.8189212564128, 1298.5000774701714, 1299.9740005199842, 1302.9413676384586, 15062.397504099823, 15450.76823847632, 16119.0, 16247.350105995745, 16261.024338539726, 4583.449986001635, 5319.175527793198, 5514.696691681916, 5523.6685798852195, 5563.693996830132, 11731.47208375625, 11738.354390508433, 11751.177417580859, 11760.529578816751, 11768.705782355339, 5474.890502189934, 6476.902846457307, 6487.61074335532, 6498.187726534184, 6502.707378167994, 5874.412558744091, 6213.565050446516, 6265.342139075423, 6272.2159730033745, 6277.435030847246, 4239.9788001060415, 4360.585744354281, 4367.082912588392, 4386.254336762758, 4427.092446048552, 1094.950727217277, 1188.3107797477442, 1243.4839541590138, 1253.254313683357, 1263.444084602772, 789.5499565247868, 795.1412474527497, 809.0372456776417, 810.691937063912, 826.1696994520588, 6092.847678807977, 6096.512279017668, 6238.469730072995, 6333.46165575922, 6441.0, 582.4059459351522, 596.0731063196771, 596.8537708261504, 599.7091410665823, 606.3088079589272, 3783.24335132969, 3869.8839034829, 3870.7096967727534, 4160.167966406731, 4353.891152721144, 14614.415423382945, 14923.701525969636, 15160.545183644508, 15166.924165379103, 15173.013754105948, 14382.065165764192, 14832.332545035499, 15066.54800355991, 15084.849151508564, 15117.319720612599, 8428.578571071423, 8627.525486098199, 8636.524991125423, 8657.134286571292, 8676.305895528343, 5612.663240205601, 6433.903491447726, 6858.725650973905, 7029.121359830021, 7093.32613401726, 13110.868891311346, 13409.66475838112, 13413.32933353348, 13462.259575723428, 13490.86509134896, 12285.0, 12286.81569776472, 13861.792073119113, 13864.445422183404, 13922.0, 9057.0, 9252.95373523155, 9362.391444556082, 9373.0, 9384.81230375375, 10560.894391056298, 10705.0, 10715.946420268161, 10720.678379648623, 10733.195010374096, 8963.731088067369, 9090.59092340833, 9150.908490915006, 9223.262139028995, 9279.67521136757, 8800.0, 8822.117788221127, 8973.0, 9020.278377729635, 9067.0, 8139.511629302261, 8155.5514446706, 8175.1416101308505, 8189.754307370788, 8265.256126948603, 6068.302145253176, 6106.1146133811235, 6106.45041946227, 6134.693265336805, 6207.720652570735, 6005.339412664691, 6033.818985430444, 6186.876262474635, 6215.409536094064, 6322.3045464997895], "value": 5270.067926584558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.778290808423, 386.85492940147446, 395.8456202081188, 398.2373754260591, 400.94787677601926, 5161.096808058584, 5561.249231353766, 5645.689487078209, 6015.819525414234, 6059.727312270948, 4454.752669252614, 4843.927341089887, 5098.107831129556, 5281.075811732941, 5700.315962084545, 3912.9804350978347, 3922.84308627656, 4364.476262848462, 4560.749158796257, 4561.817527298921, 4131.153113611717, 4424.734515929054, 4527.615152712024, 4578.733526904187, 4595.195840727876, 4492.125039974403, 4511.684182107254, 4515.871032241939, 4517.683762136652, 4553.863384098482, 3684.5025921500524, 3892.0, 4511.097780443908, 4525.0994582275525, 4540.18276710192, 3705.3886108792017, 3768.0, 3778.848846046155, 3895.688344932427, 4044.7573145611063, 4213.705040647156, 5349.839504814861, 5388.892222155535, 5617.820257745878, 5850.853728656775, 4520.728756274634, 4537.342085397632, 5401.621886467949, 5405.621606487547, 5421.620486565942, 6127.908081378783, 6212.968935155295, 6351.237851457809, 6360.618362898241, 6386.904196437057, 3944.73768394114, 4442.0, 4571.702839315434, 4572.9314060289125, 4599.0, 5701.828945131611, 6470.770553594802, 6660.666966651648, 6671.766488172891, 6687.832804179837, 3148.8110713357273, 3476.9826150869085, 3534.452159915217, 4111.280525907954, 4155.542890282067, 4282.143571285756, 4299.54854740254, 4307.440032795716, 4307.784610769449, 4320.1143765527995, 4393.912121757611, 5036.489053284, 5059.342285502861, 5060.949390506122, 5073.619478539124, 5184.7407629618365, 6007.2666936543765, 6043.214382130295, 6263.467605253604, 6364.7135878885565, 1369.3221855181748, 1407.4651632379835, 1419.8002687729058, 1454.7963285140088, 1458.2490017640923, 847.499975014732, 847.9533625650648, 936.7049379445452, 956.5408603870181, 959.6641175588628, 4960.404751429852, 5509.752061157257, 5961.406788047127, 5965.105234214902, 5965.7613695452565, 5933.376995415506, 5988.011978023665, 6442.35576442352, 6458.6770661466735, 6512.479001679854, 5806.767729290866, 5865.266841644794, 5868.911966320508, 5929.347771745104, 5955.374685657944, 2823.0217120937195, 3340.248444100058, 3384.272381438003, 3384.340053689507, 3390.5422767926016, 5762.942370576325, 6385.297617262097, 6659.800205993828, 6660.6336651484635, 6726.630035348005, 5823.4467725566, 5878.823635290948, 6589.110470086477, 6793.116894803644, 6824.829379265459, 5601.907628012498, 6192.5974811638, 6408.935910640834, 6555.410013098844, 6612.371824676744, 5850.678212698343, 6565.671716414256, 6579.276279609144, 6593.835154121185, 6609.900851487136, 5396.919046214389, 6184.350643182401, 6427.935720642734, 6474.676266186766, 6499.252585952676, 6568.113304703804, 6743.9325606743305, 6747.426468750211, 6792.524523283323, 6794.52438329332, 3665.3402387570495, 4178.603032711888, 4214.283571792741, 4215.3770798242285, 4217.523866646649, 5379.811706590251, 6484.239141297941, 6492.318306577741, 6579.967100164468, 6609.801705948829, 5036.384431359082, 6335.239771227482, 6380.393862583047, 6380.766731643887, 6389.329120442472, 6119.908201376894, 6336.936630633634, 6362.363763623601, 6368.299487056513, 6382.521310901608, 5107.897842043212, 5344.919826202532, 5454.699991500505, 5701.743421545957, 6273.874522509615, 5240.0, 5640.746166422603, 6383.425491705769, 6384.776532821329, 6392.520560957853, 5207.6875387476875, 5983.760649574142, 6133.601315914451, 6195.81412557624, 6213.2233470816145], "value": 4533.5831169455505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.6863457568836, 841.2680967558225, 865.4071960706916, 866.8179682266724, 876.0451108291962, 15891.682166356666, 15958.601034974117, 16233.0, 16275.348986040544, 18233.54416139597, 17679.55801104973, 17706.911465442656, 17913.731294030567, 18022.81977180228, 18170.182341794618, 981.249344251648, 995.3182070281844, 995.5719040812447, 995.5768798260747, 999.4702807512031, 783.9725609603637, 845.6067928413318, 999.5951639585979, 1000.1598657128011, 1002.7844013537089, 1017.2218253036433, 1017.4810846468317, 1019.1846522781782, 1020.9948950255275, 1054.5518154784186, 1020.6529779874804, 1022.4018948914819, 1023.0843395161363, 1023.738946568624, 1069.9995504203555, 707.8336590901134, 751.5866273549526, 753.2429907942537, 754.0310700749566, 763.9388848892131, 16494.17529123551, 16569.25438355265, 16789.0, 16815.91592042044, 16908.323667053304, 16745.246463909032, 16791.66416671672, 17084.572885677833, 17265.13674316279, 17293.740593891103, 13144.934275328658, 13801.654958626013, 13813.033087683867, 13923.025388222828, 13939.372728227254, 3498.4577390504514, 3515.7187425006196, 3520.099146460908, 3555.3955827509126, 3561.056320075182, 131499.0, 132659.34681306416, 133104.0, 134862.0, 136614.31692841472, 13330.933345333406, 13347.0, 13400.597982060553, 13597.660058498617, 13602.251876146907, 25297.0, 25651.230463086136, 25833.48333033329, 26011.9595216193, 26178.73821261763, 7458.962705186439, 7648.38812894967, 7688.730894418669, 7690.692372305157, 7697.23027697237, 3870.4774855394726, 4016.397540368968, 4017.5178978522763, 4018.0758425562285, 4019.7789121598594, 4247.936280955788, 4273.594008569243, 4320.157569273962, 4322.762248076386, 4328.394024836525, 852.5225873510853, 877.9648814047366, 879.0945326313779, 880.3837313880309, 883.726044926075, 627.733213384319, 636.4303947966637, 653.6698967021624, 664.1830548425368, 670.168990451846, 10675.733106672395, 11679.766404671858, 11695.005924496512, 11724.209867529007, 11858.525658973544, 648.3581254557954, 650.9446697030805, 660.211047797877, 663.2439019517753, 683.719674933275, 4215.114825886537, 4990.725510096907, 5093.363329583802, 5117.488251174853, 5225.973870130625, 110876.33685494724, 112814.40705407757, 115315.0, 116241.41879290719, 117901.0, 82227.76658350129, 96680.54979175318, 98462.0, 99156.50421747845, 99441.0, 75163.0, 78376.0, 78439.60780196062, 81655.0, 84181.0, 12076.939615302219, 12722.173058751152, 12766.42551085222, 12810.410518378909, 12875.484980601046, 37855.0, 40410.0, 40548.39177412282, 40717.0, 42008.0, 73090.0, 73182.0, 74154.62922685352, 74313.88529171959, 75502.6224868894, 15746.842531574537, 16321.428749993693, 16834.15829208559, 17026.0, 17045.0, 18084.367047153286, 18266.817331827042, 18526.258949642404, 18730.531736706693, 19035.333763318216, 16437.260323285722, 16842.326306947583, 17243.310267589157, 17452.912735436243, 17517.0, 16672.833271667612, 16862.156892155097, 17193.484195474157, 17359.3924212657, 17455.38906138279, 16228.756568651715, 16836.663266734842, 16940.237689303765, 16984.74522882133, 17119.14404279806, 11533.192676512563, 11765.88234117682, 12073.335966521925, 12191.573294934635, 12491.625251242478, 12425.19236249641, 12988.285644289655, 13303.334833258104, 13307.93536517057, 13336.799948000593], "value": 8474.342377361863, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1412.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 111.0, 112.0, 111.0, 111.0, 111.0, 112.0, 110.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 110.0, 106.0, 142.0, 107.0, 107.0, 107.0, 106.0, 136.0, 106.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 188.0, 185.0, 185.0, 182.0, 185.0, 185.0, 181.0, 181.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 57.0, 90.0, 58.0, 59.0, 61.0, 59.0, 80.0, 56.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 86.0, 71.0, 69.0, 68.0, 89.0, 70.0, 70.0, 92.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 89.0, 88.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 83.0, 84.0, 86.0, 86.0, 84.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 48.0, 53.0, 48.0, 48.0, 48.0, 48.0, 47.0, 49.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 57.0, 58.0, 64.0, 60.0, 57.0, 60.0, 63.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 81.0, 81.0, 81.0, 83.0, 80.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 129.0, 144.0, 143.0, 146.0, 129.0, 134.0, 182.0, 136.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 178.0, 224.0, 231.0, 179.0, 183.0, 182.0, 186.0, 183.0, 180.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 67.0, 69.0, 68.0, 69.0, 67.0, 68.0, 69.0], "value": 68.2, "unit": "score"}]}]} 15:31:21 INFO - Return code: 0 15:31:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:31:21 INFO - # TBPL SUCCESS # 15:31:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:31:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:31:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:31:21 INFO - 2017-05-05 15:31:21.809 screenresolution[1660:9901] starting screenresolution argv=screenresolution get 15:31:21 INFO - 2017-05-05 15:31:21.812 screenresolution[1660:9901] Display 0: 1600x1200x32@60 15:31:21 INFO - 2017-05-05 15:31:21.818 screenresolution[1661:9904] starting screenresolution argv=screenresolution list 15:31:21 INFO - Available Modes on Display 0 15:31:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:31:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:31:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:31:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:31:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:31:22 INFO - Intel Iris: 15:31:22 INFO - Chipset Model: Intel Iris 15:31:22 INFO - Type: GPU 15:31:22 INFO - Bus: Built-In 15:31:22 INFO - VRAM (Dynamic, Max): 1536 MB 15:31:22 INFO - Vendor: Intel (0x8086) 15:31:22 INFO - Device ID: 0x0a2e 15:31:22 INFO - Revision ID: 0x0009 15:31:22 INFO - Displays: 15:31:22 INFO - Display: 15:31:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:31:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:31:22 INFO - Display Serial Number: 1600x1200 60 15:31:22 INFO - Main Display: Yes 15:31:22 INFO - Mirror: Off 15:31:22 INFO - Online: Yes 15:31:22 INFO - Rotation: Supported 15:31:22 INFO - Return code: 0 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - [mozharness: 2017-05-05 22:31:22.053479Z] Finished run-tests step (success) 15:31:22 INFO - Running post-run listener: _resource_record_post_run 15:31:22 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 40318464; Write bytes: 508326400; Read time: 396; Write time: 1818 15:31:22 INFO - TinderboxPrint: CPU usage
53.4% 15:31:22 INFO - TinderboxPrint: I/O read bytes / time
40,318,464 / 396 15:31:22 INFO - TinderboxPrint: I/O write bytes / time
508,326,400 / 1,818 15:31:22 INFO - TinderboxPrint: CPU idle
2,236.9 (46.6%) 15:31:22 INFO - TinderboxPrint: CPU system
956.9 (19.9%) 15:31:22 INFO - TinderboxPrint: CPU user
1,603.7 (33.4%) 15:31:22 INFO - TinderboxPrint: Swap in / out
247,554,048 / 0 15:31:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207999488; Write bytes: 206387200; Read time: 16218; Write time: 519 15:31:22 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35280384; Write bytes: 294705664; Read time: 360; Write time: 1271 15:31:22 INFO - Running post-run listener: _upload_blobber_files 15:31:22 INFO - Blob upload gear active. 15:31:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:31:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:31:22 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'] 15:31:22 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 15:31:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:25 INFO - (blobuploader) - INFO - Done attempting. 15:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:26 INFO - (blobuploader) - INFO - Done attempting. 15:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:26 INFO - (blobuploader) - INFO - Done attempting. 15:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:31:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:29 INFO - (blobuploader) - INFO - Done attempting. 15:31:29 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:29 INFO - Return code: 0 15:31:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e71743eaaee22479945ee2acfcbefd99ea161e0c5416abf04780c456e83939d23322b266d9eb51a8266228d4b720d89d65141d9f174eb7910bf0971d183f6499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1645fa1f1cc5ecaf99b3110ff56ea443633faba3c2cc1772551445be4e2ab44f0d2da652ee4ebaffe73fe14bec85cf2b863ff400c74861974920bd9d1bfe94e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c3ae0eb974a7b1c7c81a3a9c1eb154aa457d3b0e5ec9bfd37ace6d1a13523b2922ceee9639f9ed43ec3ef26484998798843d4d2c3dd67daf7768e13d72ccac6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3558da3ee759a919a7ba5654b0870d81b6ef348d309628d7215da41d196e6d647b73a00ec916deaead8557c03fb5dfe207a7a0853de632556d0d01e3df1e21b"} 15:31:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:29 INFO - Contents: 15:31:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e71743eaaee22479945ee2acfcbefd99ea161e0c5416abf04780c456e83939d23322b266d9eb51a8266228d4b720d89d65141d9f174eb7910bf0971d183f6499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1645fa1f1cc5ecaf99b3110ff56ea443633faba3c2cc1772551445be4e2ab44f0d2da652ee4ebaffe73fe14bec85cf2b863ff400c74861974920bd9d1bfe94e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c3ae0eb974a7b1c7c81a3a9c1eb154aa457d3b0e5ec9bfd37ace6d1a13523b2922ceee9639f9ed43ec3ef26484998798843d4d2c3dd67daf7768e13d72ccac6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3558da3ee759a919a7ba5654b0870d81b6ef348d309628d7215da41d196e6d647b73a00ec916deaead8557c03fb5dfe207a7a0853de632556d0d01e3df1e21b"} 15:31:29 INFO - Running post-run listener: copy_logs_to_upload_dir 15:31:29 INFO - Copying logs to upload dir... 15:31:29 INFO - mkdir: /builds/slave/test/build/upload/logs 15:31:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.277388 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-05-05 15:31:29.286267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:31:29.290372) ========= 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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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/e71743eaaee22479945ee2acfcbefd99ea161e0c5416abf04780c456e83939d23322b266d9eb51a8266228d4b720d89d65141d9f174eb7910bf0971d183f6499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1645fa1f1cc5ecaf99b3110ff56ea443633faba3c2cc1772551445be4e2ab44f0d2da652ee4ebaffe73fe14bec85cf2b863ff400c74861974920bd9d1bfe94e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c3ae0eb974a7b1c7c81a3a9c1eb154aa457d3b0e5ec9bfd37ace6d1a13523b2922ceee9639f9ed43ec3ef26484998798843d4d2c3dd67daf7768e13d72ccac6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3558da3ee759a919a7ba5654b0870d81b6ef348d309628d7215da41d196e6d647b73a00ec916deaead8557c03fb5dfe207a7a0853de632556d0d01e3df1e21b"} build_url:https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/V6_FvUlOT2GkS8FQv7CHWA/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/e71743eaaee22479945ee2acfcbefd99ea161e0c5416abf04780c456e83939d23322b266d9eb51a8266228d4b720d89d65141d9f174eb7910bf0971d183f6499", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1645fa1f1cc5ecaf99b3110ff56ea443633faba3c2cc1772551445be4e2ab44f0d2da652ee4ebaffe73fe14bec85cf2b863ff400c74861974920bd9d1bfe94e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c3ae0eb974a7b1c7c81a3a9c1eb154aa457d3b0e5ec9bfd37ace6d1a13523b2922ceee9639f9ed43ec3ef26484998798843d4d2c3dd67daf7768e13d72ccac6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3558da3ee759a919a7ba5654b0870d81b6ef348d309628d7215da41d196e6d647b73a00ec916deaead8557c03fb5dfe207a7a0853de632556d0d01e3df1e21b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:31:29.326955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:31:29.327277) ========= 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.B8jL6hcxQ8/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.v5KaqDDdVQ/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.004458 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:31:29.376168) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:31:29.376490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:31:29.376852) ========= ========= Total master_lag: 0.83 =========