builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0346 starttime: 1493253776.33 results: success (0) buildid: 20170426153825 builduid: 67deccb195684117bff89b2f7dd13e98 revision: 745f2d85212d7c4bc82240c5a43730d9ecd32125 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.334974) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.335413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.335690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.363338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.363725) ========= 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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-26 17:42:56-- 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% 19.6M=0.001s 2017-04-26 17:42:56 (19.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101558 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.487654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.488004) ========= 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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.027169 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:56.537593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 17:42:56.538015) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 745f2d85212d7c4bc82240c5a43730d9ecd32125 --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 745f2d85212d7c4bc82240c5a43730d9ecd32125 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-26 17:42:56,645 truncating revision to first 12 chars 2017-04-26 17:42:56,645 Setting DEBUG logging. 2017-04-26 17:42:56,645 attempt 1/10 2017-04-26 17:42:56,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/745f2d85212d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 17:42:58,327 unpacking tar archive at: mozilla-central-745f2d85212d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.963892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 17:42:58.526271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:58.526620) ========= script_repo_revision: 745f2d85212d7c4bc82240c5a43730d9ecd32125 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:58.527018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:58.527281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:58.548083) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-26 17:42:58.548495) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:42:58 INFO - MultiFileLogger online at 20170426 17:42:58 in /builds/slave/test 17:42:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:42:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:58 INFO - {'append_to_log': False, 17:42:58 INFO - 'base_work_dir': '/builds/slave/test', 17:42:58 INFO - 'blob_upload_branch': 'Firefox', 17:42:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:58 INFO - 'branch': 'Firefox', 17:42:58 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:58 INFO - 'config_files': ('talos/mac_config.py',), 17:42:58 INFO - 'default_actions': ('clobber', 17:42:58 INFO - 'read-buildbot-config', 17:42:58 INFO - 'download-and-extract', 17:42:58 INFO - 'populate-webroot', 17:42:58 INFO - 'create-virtualenv', 17:42:58 INFO - 'install', 17:42:58 INFO - 'run-tests'), 17:42:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:58 INFO - 'download_minidump_stackwalk': True, 17:42:58 INFO - 'download_symbols': 'ondemand', 17:42:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:58 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:58 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:58 INFO - 'gecko_profile': False, 17:42:58 INFO - 'gecko_profile_interval': 0, 17:42:58 INFO - 'installer_path': 'installer.exe', 17:42:58 INFO - 'log_level': 'info', 17:42:58 INFO - 'log_name': 'talos', 17:42:58 INFO - 'log_to_console': True, 17:42:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:42:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:42:58 INFO - 'opt_config_files': (), 17:42:58 INFO - 'pip_index': False, 17:42:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:58 INFO - 'cmd': ('bash', 17:42:58 INFO - '-c', 17:42:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:58 INFO - 'enabled': True, 17:42:58 INFO - 'halt_on_failure': False, 17:42:58 INFO - 'name': 'check_screen_resolution'},), 17:42:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:58 INFO - 'cmd': ('bash', 17:42:58 INFO - '-c', 17:42:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:58 INFO - 'enabled': True, 17:42:58 INFO - 'halt_on_failure': False, 17:42:58 INFO - 'name': 'check_screen_resolution'},), 17:42:58 INFO - 'run_cmd_checks_enabled': True, 17:42:58 INFO - 'suite': 'dromaeojs-e10s', 17:42:58 INFO - 'system_bits': '32', 17:42:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:58 INFO - 'title': 't-yosemite-r7-0346', 17:42:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:58 INFO - 'use_talos_json': True, 17:42:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:58 INFO - 'work_dir': 'build'} 17:42:58 INFO - [mozharness: 2017-04-27 00:42:58.763511Z] Running clobber step. 17:42:58 INFO - Running pre-action listener: _resource_record_pre_action 17:42:58 INFO - Running main action method: clobber 17:42:58 INFO - rmtree: /builds/slave/test/build 17:42:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:01 INFO - Running post-action listener: _resource_record_post_action 17:43:01 INFO - [mozharness: 2017-04-27 00:43:01.248016Z] Finished clobber step (success) 17:43:01 INFO - [mozharness: 2017-04-27 00:43:01.248140Z] Running read-buildbot-config step. 17:43:01 INFO - Running pre-action listener: _resource_record_pre_action 17:43:01 INFO - Running main action method: read_buildbot_config 17:43:01 INFO - Using buildbot properties: 17:43:01 INFO - { 17:43:01 INFO - "project": "", 17:43:01 INFO - "product": "firefox", 17:43:01 INFO - "script_repo_revision": "production", 17:43:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:43:01 INFO - "repository": "", 17:43:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:43:01 INFO - "buildid": "20170426153825", 17:43:01 INFO - "pgo_build": "False", 17:43:01 INFO - "basedir": "/builds/slave/test", 17:43:01 INFO - "buildnumber": 49, 17:43:01 INFO - "slavename": "t-yosemite-r7-0346", 17:43:01 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:43:01 INFO - "platform": "yosemite_r7", 17:43:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:43:01 INFO - "branch": "mozilla-central", 17:43:01 INFO - "repo_path": "mozilla-central", 17:43:01 INFO - "revision": "745f2d85212d7c4bc82240c5a43730d9ecd32125", 17:43:01 INFO - "stage_platform": "macosx64", 17:43:01 INFO - "builduid": "67deccb195684117bff89b2f7dd13e98", 17:43:01 INFO - "slavebuilddir": "test" 17:43:01 INFO - } 17:43:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:43:01 INFO - Running post-action listener: _resource_record_post_action 17:43:01 INFO - [mozharness: 2017-04-27 00:43:01.251582Z] Finished read-buildbot-config step (success) 17:43:01 INFO - [mozharness: 2017-04-27 00:43:01.251716Z] Running download-and-extract step. 17:43:01 INFO - Running pre-action listener: _resource_record_pre_action 17:43:01 INFO - Running main action method: download_and_extract 17:43:01 INFO - mkdir: /builds/slave/test/build/tests 17:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:01 INFO - trying https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:43:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:43:02 INFO - Downloaded 1325 bytes. 17:43:02 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:43:02 INFO - Using the following test package requirements: 17:43:02 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:43:02 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:43:02 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:43:02 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:43:02 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'jsshell-mac.zip'], 17:43:02 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:43:02 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:43:02 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:43:02 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:43:02 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:43:02 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:43:02 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:43:02 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:43:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:43:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:43:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:43:04 INFO - Content-Length response header: 52527127 17:43:04 INFO - Bytes received: 52527127 17:43:20 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:43:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:43:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:43:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:43:22 INFO - Content-Length response header: 52527127 17:43:22 INFO - Bytes received: 52527127 17:43:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:43:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:43:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:43:38 INFO - Content-Length response header: 14408809 17:43:38 INFO - Bytes received: 14408809 17:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:38 INFO - trying https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:43:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:43:40 INFO - Downloaded 71193027 bytes. 17:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:43:40 INFO - mkdir: /builds/slave/test/properties 17:43:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:40 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:40 INFO - Contents: 17:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:43:41 INFO - Running post-action listener: _resource_record_post_action 17:43:41 INFO - Running post-action listener: set_extra_try_arguments 17:43:41 INFO - [mozharness: 2017-04-27 00:43:41.653023Z] Finished download-and-extract step (success) 17:43:41 INFO - [mozharness: 2017-04-27 00:43:41.653145Z] Running populate-webroot step. 17:43:41 INFO - Running pre-action listener: _resource_record_pre_action 17:43:41 INFO - Running main action method: populate_webroot 17:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:41 INFO - '--tppagecycles', 17:43:41 INFO - '7'], 17:43:41 INFO - 'tests': ['tsvgm']}}, 17:43:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['damp', 'tps']}, 17:43:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'tests': ['damp', 'tps']}, 17:43:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['dromaeo_dom']}, 17:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:43:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:43:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['a11yr', 17:43:41 INFO - 'ts_paint', 17:43:41 INFO - 'tpaint', 17:43:41 INFO - 'sessionrestore', 17:43:41 INFO - 'sessionrestore_no_auto_restore', 17:43:41 INFO - 'tabpaint']}, 17:43:41 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:41 INFO - 'ts_paint', 17:43:41 INFO - 'tpaint', 17:43:41 INFO - 'sessionrestore', 17:43:41 INFO - 'sessionrestore_no_auto_restore', 17:43:41 INFO - 'tabpaint']}, 17:43:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:41 INFO - 'ts_paint', 17:43:41 INFO - 'tpaint', 17:43:41 INFO - 'sessionrestore', 17:43:41 INFO - 'sessionrestore_no_auto_restore', 17:43:41 INFO - 'tabpaint']}, 17:43:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:41 INFO - 'ts_paint', 17:43:41 INFO - 'tpaint', 17:43:41 INFO - 'sessionrestore', 17:43:41 INFO - 'sessionrestore_no_auto_restore', 17:43:41 INFO - 'tabpaint']}, 17:43:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['a11yr', 17:43:41 INFO - 'ts_paint', 17:43:41 INFO - 'tpaint', 17:43:41 INFO - 'sessionrestore', 17:43:41 INFO - 'sessionrestore_no_auto_restore', 17:43:41 INFO - 'tabpaint']}, 17:43:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['a11yr', 17:43:41 INFO - 'ts_paint', 17:43:41 INFO - 'tpaint', 17:43:41 INFO - 'sessionrestore', 17:43:41 INFO - 'sessionrestore_no_auto_restore', 17:43:41 INFO - 'tabpaint']}, 17:43:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:43:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:43:41 INFO - 'bloom_basic_ref']}, 17:43:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['tsvgx', 17:43:41 INFO - 'tsvgr_opacity', 17:43:41 INFO - 'tart', 17:43:41 INFO - 'tscrollx', 17:43:41 INFO - 'cart', 17:43:41 INFO - 'tsvg_static']}, 17:43:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:41 INFO - 'tsvgr_opacity', 17:43:41 INFO - 'tart', 17:43:41 INFO - 'tscrollx', 17:43:41 INFO - 'cart', 17:43:41 INFO - 'tsvg_static']}, 17:43:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'talos_options': ['--disable-e10s'], 17:43:41 INFO - 'tests': ['tp5o']}, 17:43:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:43:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'talos_options': ['--disable-e10s', 17:43:41 INFO - '--xperf_path', 17:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:41 INFO - 'tests': ['tp5n']}, 17:43:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:43:41 INFO - 'talos_options': ['--xperf_path', 17:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:41 INFO - 'tests': ['tp5n']}}, 17:43:41 INFO - 'talos.zip': {'path': '', 17:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:41 INFO - Running post-action listener: _resource_record_post_action 17:43:41 INFO - [mozharness: 2017-04-27 00:43:41.672374Z] Finished populate-webroot step (success) 17:43:41 INFO - [mozharness: 2017-04-27 00:43:41.672476Z] Running create-virtualenv step. 17:43:41 INFO - Running pre-action listener: _resource_record_pre_action 17:43:41 INFO - Running main action method: create_virtualenv 17:43:41 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:41 INFO - Using real prefix '/tools/python27' 17:43:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:42 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:45 INFO - Installing pip.................done. 17:43:45 INFO - Return code: 0 17:43:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:43:45 INFO - Reading from file tmpfile_stdout 17:43:45 INFO - Output received: 17:43:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:43:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:45 INFO - 'HOME': '/Users/cltbld', 17:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:45 INFO - 'LOGNAME': 'cltbld', 17:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:45 INFO - 'MOZ_NO_REMOTE': '1', 17:43:45 INFO - 'NO_EM_RESTART': '1', 17:43:45 INFO - 'PAGER': '/bin/cat', 17:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:45 INFO - 'PWD': '/builds/slave/test', 17:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:45 INFO - 'SHELL': '/bin/bash', 17:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:43:45 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:45 INFO - 'USER': 'cltbld', 17:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:45 INFO - 'XPC_FLAGS': '0x0', 17:43:45 INFO - 'XPC_SERVICE_NAME': '0', 17:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:43:45 INFO - Cleaning up... 17:43:45 INFO - Return code: 0 17:43:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:45 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:45 INFO - 'HOME': '/Users/cltbld', 17:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:45 INFO - 'LOGNAME': 'cltbld', 17:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:45 INFO - 'MOZ_NO_REMOTE': '1', 17:43:45 INFO - 'NO_EM_RESTART': '1', 17:43:45 INFO - 'PAGER': '/bin/cat', 17:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:45 INFO - 'PWD': '/builds/slave/test', 17:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:45 INFO - 'SHELL': '/bin/bash', 17:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:43:45 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:45 INFO - 'USER': 'cltbld', 17:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:45 INFO - 'XPC_FLAGS': '0x0', 17:43:45 INFO - 'XPC_SERVICE_NAME': '0', 17:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:46 INFO - Downloading/unpacking psutil>=3.1.1 17:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:49 INFO - Installing collected packages: psutil 17:43:49 INFO - Running setup.py install for psutil 17:43:49 INFO - building 'psutil._psutil_osx' extension 17:43:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:43:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:43:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:43:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:43:50 INFO - building 'psutil._psutil_posix' extension 17:43:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:43:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:43:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:43:50 INFO - ^ 17:43:50 INFO - 1 warning generated. 17:43:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:50 INFO - Successfully installed psutil 17:43:50 INFO - Cleaning up... 17:43:50 INFO - Return code: 0 17:43:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:43:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:43:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:50 INFO - 'HOME': '/Users/cltbld', 17:43:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:50 INFO - 'LOGNAME': 'cltbld', 17:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:50 INFO - 'MOZ_NO_REMOTE': '1', 17:43:50 INFO - 'NO_EM_RESTART': '1', 17:43:50 INFO - 'PAGER': '/bin/cat', 17:43:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:50 INFO - 'PWD': '/builds/slave/test', 17:43:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:50 INFO - 'SHELL': '/bin/bash', 17:43:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:43:50 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:43:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:50 INFO - 'USER': 'cltbld', 17:43:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:50 INFO - 'XPC_FLAGS': '0x0', 17:43:50 INFO - 'XPC_SERVICE_NAME': '0', 17:43:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:43:53 INFO - Installing collected packages: mozsystemmonitor 17:43:53 INFO - Running setup.py install for mozsystemmonitor 17:43:54 INFO - Successfully installed mozsystemmonitor 17:43:54 INFO - Cleaning up... 17:43:54 INFO - Return code: 0 17:43:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:43:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:43:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:54 INFO - 'HOME': '/Users/cltbld', 17:43:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:54 INFO - 'LOGNAME': 'cltbld', 17:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:54 INFO - 'MOZ_NO_REMOTE': '1', 17:43:54 INFO - 'NO_EM_RESTART': '1', 17:43:54 INFO - 'PAGER': '/bin/cat', 17:43:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:54 INFO - 'PWD': '/builds/slave/test', 17:43:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:54 INFO - 'SHELL': '/bin/bash', 17:43:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:43:54 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:43:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:54 INFO - 'USER': 'cltbld', 17:43:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:54 INFO - 'XPC_FLAGS': '0x0', 17:43:54 INFO - 'XPC_SERVICE_NAME': '0', 17:43:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:58 INFO - warning: no files found matching '*.txt' 17:43:58 INFO - no previously-included directories found matching 'build' 17:43:58 INFO - no previously-included directories found matching 'dist' 17:43:58 INFO - no previously-included directories found matching '.git*' 17:43:58 INFO - Installing collected packages: jsonschema, functools32 17:43:58 INFO - Running setup.py install for functools32 17:43:58 INFO - warning: no files found matching '*.txt' 17:43:58 INFO - no previously-included directories found matching 'build' 17:43:58 INFO - no previously-included directories found matching 'dist' 17:43:58 INFO - no previously-included directories found matching '.git*' 17:43:58 INFO - Successfully installed jsonschema functools32 17:43:58 INFO - Cleaning up... 17:43:58 INFO - Return code: 0 17:43:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:58 INFO - 'HOME': '/Users/cltbld', 17:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:58 INFO - 'LOGNAME': 'cltbld', 17:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:58 INFO - 'MOZ_NO_REMOTE': '1', 17:43:58 INFO - 'NO_EM_RESTART': '1', 17:43:58 INFO - 'PAGER': '/bin/cat', 17:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:58 INFO - 'PWD': '/builds/slave/test', 17:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:58 INFO - 'SHELL': '/bin/bash', 17:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:43:58 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:58 INFO - 'USER': 'cltbld', 17:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:58 INFO - 'XPC_FLAGS': '0x0', 17:43:58 INFO - 'XPC_SERVICE_NAME': '0', 17:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:43:59 INFO - Cleaning up... 17:43:59 INFO - Return code: 0 17:43:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:59 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:43:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:59 INFO - 'HOME': '/Users/cltbld', 17:43:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:59 INFO - 'LOGNAME': 'cltbld', 17:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:59 INFO - 'MOZ_NO_REMOTE': '1', 17:43:59 INFO - 'NO_EM_RESTART': '1', 17:43:59 INFO - 'PAGER': '/bin/cat', 17:43:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:59 INFO - 'PWD': '/builds/slave/test', 17:43:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:59 INFO - 'SHELL': '/bin/bash', 17:43:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:43:59 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:43:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:59 INFO - 'USER': 'cltbld', 17:43:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:59 INFO - 'XPC_FLAGS': '0x0', 17:43:59 INFO - 'XPC_SERVICE_NAME': '0', 17:43:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:03 INFO - Downloading docopt-0.6.1.tar.gz 17:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:03 INFO - Running setup.py install for blobuploader 17:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:03 INFO - Running setup.py install for requests 17:44:04 INFO - Running setup.py install for docopt 17:44:04 INFO - Successfully installed blobuploader requests docopt 17:44:04 INFO - Cleaning up... 17:44:04 INFO - Return code: 0 17:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:04 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:04 INFO - 'HOME': '/Users/cltbld', 17:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:04 INFO - 'LOGNAME': 'cltbld', 17:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:04 INFO - 'MOZ_NO_REMOTE': '1', 17:44:04 INFO - 'NO_EM_RESTART': '1', 17:44:04 INFO - 'PAGER': '/bin/cat', 17:44:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:04 INFO - 'PWD': '/builds/slave/test', 17:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:04 INFO - 'SHELL': '/bin/bash', 17:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:44:04 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:04 INFO - 'USER': 'cltbld', 17:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:04 INFO - 'XPC_FLAGS': '0x0', 17:44:04 INFO - 'XPC_SERVICE_NAME': '0', 17:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:04 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-JTcLYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:04 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-PjH_wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:04 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-U8louB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:04 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-eoywF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:04 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Bz6mPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0i2FtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0CrU9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-Yl_WyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-ex19vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-PodO_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-sBmLqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-zFFkmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-kSqaxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-gUO_xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:05 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-VMyQJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-H6A3u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:06 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-BDv155-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:06 INFO - Running setup.py install for manifestparser 17:44:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Running setup.py install for mozcrash 17:44:06 INFO - Running setup.py install for mozdebug 17:44:06 INFO - Running setup.py install for mozdevice 17:44:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Running setup.py install for mozfile 17:44:06 INFO - Running setup.py install for mozhttpd 17:44:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozinfo 17:44:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozInstall 17:44:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozleak 17:44:07 INFO - Running setup.py install for mozlog 17:44:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for moznetwork 17:44:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozprocess 17:44:08 INFO - Running setup.py install for mozprofile 17:44:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Running setup.py install for mozrunner 17:44:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Running setup.py install for mozscreenshot 17:44:08 INFO - Running setup.py install for moztest 17:44:08 INFO - Running setup.py install for mozversion 17:44:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:08 INFO - Cleaning up... 17:44:08 INFO - Return code: 0 17:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:08 INFO - 'HOME': '/Users/cltbld', 17:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:08 INFO - 'LOGNAME': 'cltbld', 17:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:08 INFO - 'MOZ_NO_REMOTE': '1', 17:44:08 INFO - 'NO_EM_RESTART': '1', 17:44:08 INFO - 'PAGER': '/bin/cat', 17:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:08 INFO - 'PWD': '/builds/slave/test', 17:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:08 INFO - 'SHELL': '/bin/bash', 17:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:44:08 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:08 INFO - 'USER': 'cltbld', 17:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:08 INFO - 'XPC_FLAGS': '0x0', 17:44:08 INFO - 'XPC_SERVICE_NAME': '0', 17:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0gkV4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-y5ytWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-urGEbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-BebkBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-CdAl6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-XuvZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-qXkTWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-iYugLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:09 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-YeZBS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-UisBSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-P6snmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-0ZpfUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-P1AuGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-M1N2j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-3ZOtsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-5NUTh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:10 INFO - Running setup.py (path:/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/pip-XXvk38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:44:10 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)) 17:44:10 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)) 17:44:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:13 INFO - Downloading blessings-1.6.tar.gz 17:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:13 INFO - Installing collected packages: blessings 17:44:13 INFO - Running setup.py install for blessings 17:44:13 INFO - Successfully installed blessings 17:44:13 INFO - Cleaning up... 17:44:13 INFO - Return code: 0 17:44:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:14 INFO - Reading from file tmpfile_stdout 17:44:14 INFO - Current package versions: 17:44:14 INFO - blessings == 1.6 17:44:14 INFO - blobuploader == 1.2.4 17:44:14 INFO - docopt == 0.6.1 17:44:14 INFO - functools32 == 3.2.3-2 17:44:14 INFO - jsonschema == 2.5.1 17:44:14 INFO - manifestparser == 1.1 17:44:14 INFO - mozInstall == 1.12 17:44:14 INFO - mozcrash == 1.0 17:44:14 INFO - mozdebug == 0.1 17:44:14 INFO - mozdevice == 0.50 17:44:14 INFO - mozfile == 1.2 17:44:14 INFO - mozhttpd == 0.7 17:44:14 INFO - mozinfo == 0.9 17:44:14 INFO - mozleak == 0.1 17:44:14 INFO - mozlog == 3.4 17:44:14 INFO - moznetwork == 0.27 17:44:14 INFO - mozprocess == 0.25 17:44:14 INFO - mozprofile == 0.28 17:44:14 INFO - mozrunner == 6.13 17:44:14 INFO - mozscreenshot == 0.1 17:44:14 INFO - mozsystemmonitor == 0.3 17:44:14 INFO - moztest == 0.8 17:44:14 INFO - mozversion == 1.4 17:44:14 INFO - psutil == 3.1.1 17:44:14 INFO - requests == 1.2.3 17:44:14 INFO - wsgiref == 0.1.2 17:44:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:14 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:14 INFO - 'HOME': '/Users/cltbld', 17:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:14 INFO - 'LOGNAME': 'cltbld', 17:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:14 INFO - 'MOZ_NO_REMOTE': '1', 17:44:14 INFO - 'NO_EM_RESTART': '1', 17:44:14 INFO - 'PAGER': '/bin/cat', 17:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:14 INFO - 'PWD': '/builds/slave/test', 17:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:14 INFO - 'SHELL': '/bin/bash', 17:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:44:14 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:14 INFO - 'USER': 'cltbld', 17:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:14 INFO - 'XPC_FLAGS': '0x0', 17:44:14 INFO - 'XPC_SERVICE_NAME': '0', 17:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:14 INFO - Cleaning up... 17:44:14 INFO - Return code: 0 17:44:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:14 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 0x1040c9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040cc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a254a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, '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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:14 INFO - 'HOME': '/Users/cltbld', 17:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:14 INFO - 'LOGNAME': 'cltbld', 17:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:14 INFO - 'MOZ_NO_REMOTE': '1', 17:44:14 INFO - 'NO_EM_RESTART': '1', 17:44:14 INFO - 'PAGER': '/bin/cat', 17:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:14 INFO - 'PWD': '/builds/slave/test', 17:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:14 INFO - 'SHELL': '/bin/bash', 17:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:44:14 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:14 INFO - 'USER': 'cltbld', 17:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:14 INFO - 'XPC_FLAGS': '0x0', 17:44:14 INFO - 'XPC_SERVICE_NAME': '0', 17:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:14 INFO - Cleaning up... 17:44:14 INFO - Return code: 0 17:44:14 INFO - Running post-action listener: _resource_record_post_action 17:44:14 INFO - Running post-action listener: _start_resource_monitoring 17:44:14 INFO - Starting resource monitoring. 17:44:14 INFO - [mozharness: 2017-04-27 00:44:14.675846Z] Finished create-virtualenv step (success) 17:44:14 INFO - [mozharness: 2017-04-27 00:44:14.676803Z] Running install step. 17:44:14 INFO - Running pre-action listener: _resource_record_pre_action 17:44:14 INFO - Running main action method: install 17:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:14 INFO - Reading from file tmpfile_stdout 17:44:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:15 INFO - Reading from file tmpfile_stdout 17:44:15 INFO - Output received: 17:44:15 INFO - Usage: mozinstall [options] installer 17:44:15 INFO - Options: 17:44:15 INFO - -h, --help show this help message and exit 17:44:15 INFO - -d DEST, --destination=DEST 17:44:15 INFO - Directory to install application into. [default: 17:44:15 INFO - "/builds/slave/test"] 17:44:15 INFO - --app=APP Application being installed. [default: firefox] 17:44:15 INFO - mkdir: /builds/slave/test/build/application 17:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:44:34 INFO - Reading from file tmpfile_stdout 17:44:34 INFO - Output received: 17:44:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:44:34 INFO - Running post-action listener: _resource_record_post_action 17:44:34 INFO - [mozharness: 2017-04-27 00:44:34.613236Z] Finished install step (success) 17:44:34 INFO - [mozharness: 2017-04-27 00:44:34.613382Z] Running run-tests step. 17:44:34 INFO - Running pre-action listener: _resource_record_pre_action 17:44:34 INFO - Running main action method: run_tests 17:44:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:34 INFO - 2017-04-26 17:44:34.627 screenresolution[1624:7404] starting screenresolution argv=screenresolution get 17:44:34 INFO - 2017-04-26 17:44:34.630 screenresolution[1624:7404] Display 0: 1600x1200x32@60 17:44:34 INFO - 2017-04-26 17:44:34.636 screenresolution[1625:7407] starting screenresolution argv=screenresolution list 17:44:34 INFO - Available Modes on Display 0 17:44:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:34 INFO - Intel Iris: 17:44:34 INFO - Chipset Model: Intel Iris 17:44:34 INFO - Type: GPU 17:44:34 INFO - Bus: Built-In 17:44:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:34 INFO - Vendor: Intel (0x8086) 17:44:34 INFO - Device ID: 0x0a2e 17:44:34 INFO - Revision ID: 0x0009 17:44:34 INFO - Displays: 17:44:34 INFO - Display: 17:44:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:34 INFO - Display Serial Number: 1600x1200 60 17:44:34 INFO - Main Display: Yes 17:44:34 INFO - Mirror: Off 17:44:34 INFO - Online: Yes 17:44:34 INFO - Rotation: Supported 17:44:34 INFO - Return code: 0 17:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:34 INFO - Python 2.7.3 17:44:34 INFO - Return code: 0 17:44:34 INFO - grabbing minidump binary from tooltool 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 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 0x103ea7d30>, '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 0x103dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e9cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:44:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:44:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:44:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:34 INFO - Return code: 0 17:44:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:44:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:34 INFO - ENV: RUST_BACKTRACE is now 1 17:44:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:44:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0346 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:44:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gh6Q7OPrfj/Render', 17:44:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:35 INFO - 'HOME': '/Users/cltbld', 17:44:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:35 INFO - 'LOGNAME': 'cltbld', 17:44:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:35 INFO - 'MOZ_NO_REMOTE': '1', 17:44:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:35 INFO - 'NO_EM_RESTART': '1', 17:44:35 INFO - 'PAGER': '/bin/cat', 17:44:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:35 INFO - 'PWD': '/builds/slave/test', 17:44:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:35 INFO - 'RUST_BACKTRACE': '1', 17:44:35 INFO - 'SHELL': '/bin/bash', 17:44:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lcYWRtlreC/Listeners', 17:44:35 INFO - 'TMPDIR': '/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/', 17:44:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:35 INFO - 'USER': 'cltbld', 17:44:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:35 INFO - 'XPC_FLAGS': '0x0', 17:44:35 INFO - 'XPC_SERVICE_NAME': '0', 17:44:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0346', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:44:35 INFO - mozversion application_buildid: 20170426153825 17:44:35 INFO - mozversion application_changeset: 745f2d85212d7c4bc82240c5a43730d9ecd32125 17:44:35 INFO - mozversion application_display_name: Nightly 17:44:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:35 INFO - mozversion application_name: Firefox 17:44:35 INFO - mozversion application_remotingname: firefox 17:44:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:44:35 INFO - mozversion application_vendor: Mozilla 17:44:35 INFO - mozversion application_version: 55.0a1 17:44:35 INFO - mozversion platform_buildid: 20170426153825 17:44:35 INFO - mozversion platform_changeset: 745f2d85212d7c4bc82240c5a43730d9ecd32125 17:44:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:44:35 INFO - mozversion platform_version: 55.0a1 17:44:35 INFO - using testdate: 1493253875 17:44:35 INFO - actual date: 1493253875 17:44:35 INFO - starting webserver on 'localhost:49242' 17:44:35 INFO - SUITE-START | Running 2 tests 17:44:35 INFO - TEST-START | dromaeo_css 17:44:35 INFO - operating with platform_type : mac_ 17:44:35 INFO - Initialising browser for dromaeo_css test... 17:44:35 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpfhdX5A/profile http://localhost:49242/getInfo.html) 17:44:38 INFO - PID 1635 | 2017-04-26 17:44:37.999 plugin-container[1637:7598] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b47, name = 'com.apple.tsm.portname' 17:44:38 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:44:38 INFO - PID 1635 | 2017-04-26 17:44:38.001 plugin-container[1637:7598] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a23, name = 'com.apple.CFPasteboardClient' 17:44:38 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:44:38 INFO - PID 1635 | 2017-04-26 17:44:38.001 plugin-container[1637:7598] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:44:38 INFO - PID 1635 | __metrics Screen width/height:1600/1200 17:44:38 INFO - PID 1635 | colorDepth:24 17:44:38 INFO - PID 1635 | Browser inner width/height: 1024/689 17:44:38 INFO - PID 1635 | __metrics 17:44:38 ERROR - PID 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:44:39 INFO - TEST-INFO | 1635: exit 0 17:44:39 INFO - Browser initialized. 17:44:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:39 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmpfhdX5A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:41 INFO - PID 1638 | 2017-04-26 17:44:41.325 plugin-container[1639:7732] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 17:44:41 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:44:41 INFO - PID 1638 | 2017-04-26 17:44:41.326 plugin-container[1639:7732] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 17:44:41 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:44:41 INFO - PID 1638 | 2017-04-26 17:44:41.327 plugin-container[1639:7732] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:44:51 INFO - PID 1638 | RSS: Main: 235896832 17:44:51 INFO - PID 1638 | 17:47:54 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 17:47:56 INFO - PID 1638 | RSS: Main: 251916288 17:47:56 INFO - PID 1638 | 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 17:49:39 INFO - PID 1638 | 17:49:39 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:39 INFO - PID 1638 | Full stack: 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 17:49:39 INFO - PID 1638 | 17:49:39 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:39 INFO - PID 1638 | Full stack: 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 17:49:39 INFO - PID 1638 | 17:49:39 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:39 INFO - PID 1638 | Full stack: 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | ************************* 17:49:39 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 17:49:39 INFO - PID 1638 | 17:49:39 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:39 INFO - PID 1638 | Full stack: 17:49:39 INFO - PID 1638 | ************************* 17:50:58 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 17:50:58 INFO - PID 1638 | RSS: Main: 258383872 17:50:58 INFO - PID 1638 | 17:54:00 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 17:54:01 INFO - PID 1638 | RSS: Main: 267243520 17:54:01 INFO - PID 1638 | 17:57:02 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 17:57:03 INFO - PID 1638 | RSS: Main: 261206016 17:57:03 INFO - PID 1638 | 18:00:06 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 18:00:06 INFO - PID 1638 | RSS: Main: 269799424 18:00:06 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 18:03:08 INFO - PID 1638 | RSS: Main: 264441856 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | __start_tp_report 18:03:08 INFO - PID 1638 | _x_x_mozilla_page_load 18:03:08 INFO - PID 1638 | _x_x_mozilla_page_load_details 18:03:08 INFO - PID 1638 | |i|pagename|runs| 18:03:08 INFO - PID 1638 | |0;dojo.html;3210.7912985655917;3430.879919202827;3578.1949061461164;3605.3330133925224;3611.765235259709;6020.1270815731805;6167.352427995063;6182.567220294575;6183.288921773998;6236.968815155929;6112.655464441472;6119;6130.724117414716;6131.448169664729;6160.353162917896;5272.683638981654;5354.973225133869;5391.514763671269;5423.647462914918;5484.232207490954;5325.600579956519;5382.004329199091;5457.645253058558;5481.643693159952;5517.200005999128;5415.48552887479;5482;5487.396386397493;5537.529310008654;5539.667619942797;5221.582273418117;5298.337707786527;5300.284461597674;5304.496072873071;5392;5314.256004159382;5363.839084827461;5378.2470454136455;5392.083345831218;5422.566194704415;5828.912566311508;6163.167972323724;6214.937850621526;6236.064590311489;6236.719347629368;6293.622382657009;6341.460975817061;6499.5775274607;6566.967165164191;6575.605463672195;6647.335266473362;6673.232578253466;6689;6701.3968742812895;6707.463402927754;6348.650824204667;6351.364863513611;6362.363763623694;6369.554131210817;6378.330275321071;6461.676916154268;6526.41262286387;6774.085498457744;6839.418649414756;6865.5537390070485;6301.905471417932;6355.745770169234;6363.331850155667;6432.646204458706;6469.935300646934;6352.0789485525265;6362.77730279438;6565.080888675589;6658.9001164982565;6684.9890065960035;6359.650219237987;6486.772962946275;6497.642629655415;6509.772157974448;6516.57642253252;6247.687615619201;6400.359964003563;6492.870142597121;6506.089147519257;6549.279579246279;4404.977975110104;5158.793648254103;5186.948130518646;5233.502817232433;5242.13504771716;4027.456293400412;4326.783660816946;4588.472325682589;4678.485366609671;4734.313524538922;6126.23422072241;6353.237611486651;6353.841153971188;6363.5545511813725;6364.64994425311;6319.146915166394;6364.459020983269;6550.737970481127;6582.76960306387;6671.466282697373;6302.8424289392215;6347.492200623939;6348;6360.7137678804565;6361.522885783585;5771;5774.711264436762;5786.421357864264;5805.564582656318;5890.558208134407;6717.5297729159465;6796.796096117125;6813.386795188358;6831.282715315019;6855.725770969305;6378.170837791057;6399.93600064012;6530.249021362604;6549.934500654933;6619.702113404812;5723.399043100415;6756.4257038150345;6840.828979275558;6849.589024658537;6850;6476.546641735222;6501.577397469149;6546.083548303337;6557.344265573404;6573.671316434255;5302.3637163540625;6319.146915166394;6354.046892965907;6392.712327945161;6696.866062678621;6462.838429039311;6482.773102941563;6484.902726459201;6498;6501.837454063497;6300.84247893788;6329;6457.838554036187;6488.740450381932;6520.6413647247955;5028.170351892043;6201.875962480815;6208.534359922934;6289.150964619717;6318.84202894913;5275.604329675367;6411.679416029273;6430.7749228776765;6434.453071488976;6452.935470645233;6191.938080619136;6273.278572964167;6307.779227727007;6322.652254125883;6336.58812177207 18:03:08 INFO - PID 1638 | |1;ext.html;768.4505578511366;815.1970309245393;840.6553313141613;1260.539902935429;1261.3441010674449;39246.41130383043;40362.798186009066;40413.595864041425;40515.59484405155;40534.39198412022;40164.397534037016;40524;40531;40561.18877622446;40742.388864167064;6800.625965571904;7244.492885498017;8285.047219569737;8898.510581917992;8925.910740892572;8862.86705699415;8961.014288428267;8971.282297416225;8989.775255618597;9003.369764116482;8932.196102350787;8985.865212021825;9040.36717429777;9064.954675226614;9078.500682462462;8998.370114092017;9012.504312262823;9019.594118264693;9026.368154229207;9047.773805654813;8773.736787896309;8778.64885404583;8785.38502304839;8806.251468625174;8824.691135810215;30468.390632187453;38662.420063699064;38935.026624334336;39001.21997560033;39017.60982390168;3227.289996200832;3668.266346730638;3713.5729391119826;3718.2563487302377;3755.6432138946757;31346.21634459134;31381.52927706086;31433.37133257322;31473.685263147534;31514.684853151633;2712.267687724323;3237.2068843133347;3240.1575590346442;3240.983795081033;3253.300540383805;239931;245020;281158.5942070297;298609;299017;41504.792476038034;48835.02329953452;49546.50453495491;49618.751906240235;49779.519843214286;41494.79252603778;50361.496385036415;51841.48158518367;51852.48147518552;51939.48060519422;14471.059381140192;14517.419303227964;14532.564023079325;14639.341229644479;14689.338979745937;11899;11907;11917.22538035025;11961.40192990347;11972.10209234311;13720.108192967426;13732.931335343259;13749.175049497062;13788;13896.23570703621;4743.549362810528;5908.172855800191;5937.7921772737745;5950.107483877367;5957.79147729836;1010.802893435773;1024.6618615856748;1027.3476342522551;1049.7533079726259;1062.0388548363744;20237.898810505852;23933.64099538508;25009.374765631004;26081;31031.379372412877;1111.261011427408;1115.9163062770324;1148.1618418554501;1151.614209239914;1152.8962393384468;11179;12238.449269782881;12806.231626102464;12873;12931.353432328346;321193;324248;324567;324871;325403;48533;55499.722501388045;55750.72124639351;55872;56000.43999560034;1497.2663394936403;1553.673728517024;1559.384043302889;1563.4527915229578;1573.6144644562155;24205.636915446634;24219.878900605385;24237.03051877905;24266.75733242645;24402.26793196207;39178.4123238146;39249.80375098106;39357;39447.408288875115;39559.208815824095;298705;299332;300720.9927900693;301663;302635.4868225645;34978.65021349754;36370.45444318285;37084.81457592803;37156;37214.62785372112;46438.30342544932;46511.83720407017;46522.77460564214;47263.76368118137;47891;31137.844310778302;31654.208644784063;31980.840095799373;32135.839320803247;32187.195320116247;31000.379992400478;31950.201244969063;32043.519347210276;32285.677143229208;32376.704931802466;37578.436323454625;38029.61970380261;38229;38355.616443835206;38567.614323856404;30881.69118308878;31294.68705312918;31869;31975.520367194047;32169.03492895217;23236.419089522897;24111.276661700176;24778.25665230046;25073.122440714487;25172.74827251704 18:03:08 INFO - PID 1638 | |2;jquery.html;333.86645341863266;388.3436991484391;441.69919586816815;442.9069895321982;448.6321216602386;20455.543139915404;21625.891870540643;22321.55356892861;22376.552468950613;22493.55012899743;19321.806781932177;19819.504512387197;20020;22571;23141.305760827203;6333.524985626073;6601.537892347537;6614.206295244578;6620.470362370998;6622.106015687868;4975.477574854643;5508.394076651565;5914.645121292715;6322.43098121169;6517.185351831021;5636;6553.148090748196;6561.671916404184;6563.343665633446;6563.63899985503;6303.968480157593;6473.834709752243;6529.836754081139;6539.149910511603;6588.604683718992;5501.504864562168;5791.305043394777;5800.564957628152;5825.097109947965;5836.97081514594;28200.576991345148;28394.91422483759;28457.71940262693;28559.428811423655;28633;2273.5680220758004;2339.2865176121277;2343.086196383412;2346.4720437901506;2351.7883390494767;17989.10054497283;18196.363127290613;18715.251389944387;18807.529811754677;19052.85682859019;1906.8093190680959;2186.9890650546804;2233.3300009997097;2252.718410198725;2261.4685548895995;119954;155422;159858;165093.9999999988;165543.172284139;12305.138640295094;12898.226106433644;12923.870761292455;12993.740125197442;13004.219746815032;16547.420840270534;16760.832391676173;16844.57888552796;16847.57881052959;16903.746443803353;8831.080917728304;9184.035676253898;9274.397164184307;9289.72130836076;9395.248380129573;8708.216260536583;8832.205101540892;8844.115588441104;8906.55467226636;9027.232685221697;7243.348098671145;8037.8392432152195;8218.589070546448;8229.876551851727;8231.835363292701;2204.4048107011017;2212.1483228956968;2212.657038159056;2214.976556999716;2278.6354183330586;986.9309148359689;1005.8994100590029;1008.6570566007592;1051.784384201237;1052.58422922945;17250.741238881426;18233;20796.376108716762;21867.234646787605;22191.445213869458;882.4881568690145;905.8324210021167;1004.1163775877327;1027.9486025698686;1064.7018834726289;10848.077913377452;11122.277051991594;11146.498407571517;11162.888371116185;11180.04969577595;462572;528343;541143;548787;556737;96076.51961740287;128002;133698;135860.99999999802;137758;1241.1622155045309;1272;1293.5601895355624;1293.8576756556772;1296.824928634641;16463.753043704113;19105.713414299076;21746.782532174475;22030.44923876916;23303.06787728472;56699.71650141723;56771.43228567827;57141.714291428274;57532.71233643805;57708.42291577198;77728;78276.8258476112;78383.60808195923;78468.60765696135;79395.60302198453;9009.144131307516;9014.143656352637;9077.591508382007;9089.909100908906;9182.724518264462;13996.930015349859;14165.433382664578;14205.431782728576;14339.067960582528;14363.127374524927;11829.526818927146;11856.881431185579;11898.76202475963;12075.27548347102;12170.634880953585;11091.667249982513;11093.833592495957;11107.111431085332;11304.982551570069;11382.260153090023;11867.643970680894;12055.035597152382;12159.696007599881;12197.573084941985;12198.81701774492;8611.354148438766;8834.867476987722;8937.972133204505;9099.681511147079;9162.992070872331;9998.60005599797;10895.564177432814;11594.304341739522;11965.700857478285;12078.27530348182 18:03:08 INFO - PID 1638 | |3;mootools.html;1351.9324033798314;1359.2184493915997;1391.4921053815349;1532.8350453655225;1548.5044785668588;11692.123090768184;12080.637580872566;12221.388930553481;12240.204386714868;12434.378281085954;9605.615775368977;10105.848412273821;12043.638690839289;12299.508019679224;12318.445669944851;2191.835612329082;2542.2119143065615;2596.363890846745;2600.7399260073935;2605.960910586338;2522.268542122782;2573.45957348956;2578.3811885147616;2579.9097031603897;2582.767550920417;2528.1783420388356;2539.3905462688913;2592.157548796649;2593.8962441502317;2595.6755405574304;2535.9239222823344;2563.256655569892;2564.038485567912;2571.4214301782135;2574.0733335999025;2171.4245724882917;2476.8761561921833;2528.24152754173;2544.669193004916;2580.354911272182;12013.87986120145;12178;12239.449224784817;12248.81626775599;12272.079594030394;6681.231658359302;6908.3437073477935;6909.136357955255;6910.516263861532;6928.896066559006;4050.392441133824;4351.5430879757805;4411.955880441186;4435.046465010038;4449.310356894686;1107.767368852542;1260.5588044184553;1271.2563150556934;1298.5909438526835;1310.708951682592;16276.918615406847;16690.499285021346;16853.83146168535;16868.156592170464;16880.57798555046;5924.4667979882015;6039.614352330805;6224.253089629274;6261.812145635638;6269.968650156811;13955.651108722363;14020.088694234842;14028;14036.859631403759;14039.438422462987;6845.281245469254;6883.3116688330765;6915.827104322432;6938.306169383122;6942.965285173542;6089.451949324582;6262.561620686508;6284.465820405317;6321.304656487782;6358.745650173942;4311.504177019683;4436;4442.955570444319;4484;4498.797554110073;1027.5376080763685;1291.122037014839;1304.6086174147717;1318.6044186743939;1324.423875614111;752.2176935986513;786.080286065305;794.9960250198827;796.609661265987;814.4054839966857;5578.3584887738425;5770.769169233267;6122.571420000557;6884.65576721172;7056.611886346198;862.9611667474853;905.4295793649958;917.8944421391492;957.8515330123842;999.115782532464;3404.14896275931;3926.6858651307825;3978.5026871641044;4336.915771057235;4356.6950313477755;14929.850701493064;15219.467318644016;15325.23373831304;15348.616284592752;15426.382944682087;12634.747305053848;15223.31495082724;15229.390824366901;15244.771328430083;15248.313825877862;7539.698412063566;7845.607719613997;8511.404201705822;8774;8811.779705507413;5725.51333136688;6670.966645166744;6760.966195168992;7037.437005039482;7097.680604372712;13148.422189337341;13489.988250881419;13542.390592423168;13564.660883477993;13762.518311859038;13716.108452950526;13857;13930.651733706738;13968.672976067257;14246.928765356108;9427.952860235655;9447.480388578695;9479.004704506204;9563.952180239054;9587.904120958701;8541.487510749126;10823.242373033812;10941.179411544006;10952.835707464235;10952.959468850446;9145.679901203426;9177.954110229406;9186.219171370509;9229.86155207659;9385.671501497414;7991.2807847294025;8530.74407767768;9020.00779914222;9040.502772347321;9048.276137909083;8045.436819422584;8130.349572034104;8135.877961830459;8196.262336389753;8227.465214761021;5141.843085305776;6095.299040610386;6104.298005729398;6152.876942461216;6157.815265542041;5760.6255593386295;6059.848503787441;6199.845003874939;6208.292719502173;6268.686565671789 18:03:08 INFO - PID 1638 | |4;prototype.html;366.9357862374085;406.7559464321408;413.0705911698678;413.9420481132641;415.817040502179;5325.3077099977;6089.360617135203;6205;6208.2239720034995;6228.314885362618;4334.337529676998;5685.545156387489;5895.6462612243295;5995.730192141354;6094.664793436359;4517.322401639747;4570.223062079446;4580.427446569179;4584.610308123813;4591.324166679155;4177.498700155986;4500.279955207167;4601.090547422832;4629.259318509039;4643.585335625473;4536.727796332214;4537.750423726694;4560.950981274309;4568.601484220794;4570.702904311209;4506.256467682829;4534.478534968472;4546.181687296285;4560.452745670541;4571.405717256768;3888.552816426119;4009.799510024487;4067.48162839142;4072.0454181992513;4078.4697989261504;5857.799151173999;5923.555733320019;5931.199288096095;5933.554983376264;6002.96998515009;4571.337156112379;5430.8099216527235;5445.591580631469;5471.343438787371;5479.835604931858;5382.004329199071;6369.26753423353;6371.203599550056;6492.123563318939;6553.606783593;4091.2022155679656;4205.369194620801;4386.824527018915;4629.722216666977;4651.88370290742;6061.333253342173;6425.807225783187;6675.232348279961;6803;6909.965450172767;3561.5370001899587;4274.508431530352;4311.9784401077795;4325.480942286883;4333.848315308949;4388.4953230378915;4400.845970391021;4405.273129933525;4406.669499787528;4423.911521769611;4498.797554110073;5031.974840125776;5088.211327244283;5198.8960220796125;5233.607479439057;5650.604457687922;6529.216494020748;6541.542092053511;6544.9672751635935;6553.475721942234;1423.7437261293067;1470.264867566217;1492.410497853342;1496.9850301497063;1500.6023403798001;851.5699571716243;899.4243684042218;937.7374335186022;979.0747743382577;991.0931497679686;6084.026555751058;6099.603525770899;6105.206323177958;6105.908411373833;6156.4301103218395;5563.7774489019985;6155.984262596711;6680.164979377578;6740.595564266159;6745.797626071226;5196.870078248074;6050.732604393578;6073.301570319381;6094.847628809315;6104.938950610526;3430.142464383904;3470.878519251814;3518.7009104225917;3530.1113904061203;3534.699550538233;5664.762418844533;6190.50475961922;6908.965455172692;6971.616561089088;6988.860222795515;5802.593818432753;6861.780005296707;6958.408535274559;6959.4432445404245;6960.895586566206;5209.47905209476;5655.915161272585;5899.292084949833;7006.614636195059;7013;5321.09541377959;5832.9708351457975;6719.8912179489835;6741.494387920828;6765.748336557753;5377.919331210113;5515.696636685021;6453.321606684145;6639.568428052161;6640.800775976729;5672.914906276326;6373.458256048288;6875.621840798804;6993.440524757905;7006.649667516705;4093.9795301023305;4274.27337352657;4280.165367753259;4287.799416163354;4302.268614335633;5824.767009319749;6633.867322653617;6740.12378390806;6814.977753337039;6815.727370905108;6539.313372096051;6546.574472659262;6551.574147680385;6567.310432404529;6571.014347847861;5519.806806761744;6273.52948528853;6424.51816113784;6453.838654033687;6562.3109573496;5516.703574659871;6377.394147555975;6386.712597933011;6408.711607977559;6421.646809425526;4454.420925279693;5409.675419474844;6403.615783053032;6560.671966401756;6648.401643852077;6321.747130114744;6371.331010243857;6399.77600783989;6410.679466026587;6425.1968503937005 18:03:08 INFO - PID 1638 | |5;yui.html;849.1420025188916;869.9913000869991;889.1730690457875;889.7464222696533;902.760768396375;14604.780928286084;15263.313150908209;15643.530694079182;16779.412720554785;16943.83056169438;14556.927215363909;16697;17240;18021.008844513548;18234.635307293847;1040.8490768838515;1046.8429735539692;1066.7333166708322;1069.2301542889106;1070.5985255529176;1053.952572134252;1072.404815327493;1078.2560033576847;1083.8482612434227;1090.3621381491837;1118.8769235384102;1123.3877536742455;1123.5449642894641;1125.4260327233128;1126.8956422705753;1104.602343156467;1115.007643197555;1118.9328640281528;1120.4117838134962;1121.7083558274826;789.2620399926087;805.0420000199802;830.8753686946945;832.3299743706314;834.8079941613463;16488.09315487648;17132.914335428366;17292.962422254706;17338.91330543339;17358.95846249229;15090.792736581046;16184;16598.917005415016;16719.16404179786;16799.32802687891;10615.787684246348;12410;13931.860681393158;14060.156390616596;14069.226192559405;3304.5869266341706;3449.499822525745;3501.2997400519744;3623.6014038456015;3676.17286110623;122595.09619615205;123080;123994.38002810019;124380.37809810894;130076;13416.0608757388;13698.726025479435;13855.099418537964;13864.47490776014;13871.861281387259;25094.498110037697;25604.359891002874;25823.35441613937;26145.869270653526;26199;7783.844323113506;7896.842063158705;7914.24814642608;7914.722984695508;7928.405369597303;3891.902702432462;3956.3867600521967;4035.5762644922447;4044.0496483326397;4054.8986275343354;4235;4341.891452713644;4358.237308471005;4379.474463064389;4381.824727010884;891.7547674389594;924.2190349154953;930.4417349590192;931.4737173496952;935.1116439382614;649.4057936987698;664.8603793203384;672.1665135232276;677.8408920745482;690.9930900691029;9604.9039509604;11742.590889093193;11981.221220620631;11991.880081199077;12012.819807702892;608.1182285685774;611.8436155665795;647.5531883000715;665.5308007854451;685.1948959972013;4361.909522619345;4568.291914753218;5475.698836564027;5547.639403438763;5591.9720401397735;95793;99869;101777;102418.48790755999;105059;85561;85606;86114.56942715372;86590;88059;65561;70157.64921175361;82518.22372433872;82809.58595207107;83262;9702.223822094356;11108.055815255471;11112.611058612909;11142.777144456903;11340.886591134313;39687.206255875295;40581;41194.38208426816;41811;41941;40380;47593;48474.75762621164;54010;54290.728546357015;13945;16518.339266429208;17367.826321736622;17383;17385.304587816852;15228.46700365482;17870.285188592312;18366.357177498725;18563.35028274004;18730.063496825376;16948.983061016377;17373.739393908847;17408.82591174072;17502.82497175012;17588;17029.148542572573;17058.2323795432;17236.569085772957;17249.655006900044;17361;16181;16397.770167237268;16794.748078778583;16945.06802125895;16955.745663814807;10073.647422340184;11783.410829458664;12081.697957551132;12139.514419423123;12154.204532957292;12866.485340586272;13434;13650.93174534121;13709.520166794115;13755 18:03:08 INFO - PID 1638 | __end_tp_report 18:03:08 INFO - PID 1638 | __start_cc_report 18:03:08 INFO - PID 1638 | _x_x_mozilla_cycle_collect,424 18:03:08 INFO - PID 1638 | __end_cc_report 18:03:08 INFO - PID 1638 | __startTimestamp1493254988883__endTimestamp 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | ------- Summary: start ------- 18:03:08 INFO - PID 1638 | Number of tests: 6 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6043.73 Median:6341.46 stddev:728.18 (11.5%) stddev-sans-first:695.67 18:03:08 INFO - PID 1638 | Values: 3210.8 3430.9 3578.2 3605.3 3611.8 6020.1 6167.4 6182.6 6183.3 6237.0 6112.7 6119.0 6130.7 6131.4 6160.4 5272.7 5355.0 5391.5 5423.6 5484.2 5325.6 5382.0 5457.6 5481.6 5517.2 5415.5 5482.0 5487.4 5537.5 5539.7 5221.6 5298.3 5300.3 5304.5 5392.0 5314.3 5363.8 5378.2 5392.1 5422.6 5828.9 6163.2 6214.9 6236.1 6236.7 6293.6 6341.5 6499.6 6567.0 6575.6 6647.3 6673.2 6689.0 6701.4 6707.5 6348.7 6351.4 6362.4 6369.6 6378.3 6461.7 6526.4 6774.1 6839.4 6865.6 6301.9 6355.7 6363.3 6432.6 6469.9 6352.1 6362.8 6565.1 6658.9 6685.0 6359.7 6486.8 6497.6 6509.8 6516.6 6247.7 6400.4 6492.9 6506.1 6549.3 4405.0 5158.8 5186.9 5233.5 5242.1 4027.5 4326.8 4588.5 4678.5 4734.3 6126.2 6353.2 6353.8 6363.6 6364.6 6319.1 6364.5 6550.7 6582.8 6671.5 6302.8 6347.5 6348.0 6360.7 6361.5 5771.0 5774.7 5786.4 5805.6 5890.6 6717.5 6796.8 6813.4 6831.3 6855.7 6378.2 6399.9 6530.2 6549.9 6619.7 5723.4 6756.4 6840.8 6849.6 6850.0 6476.5 6501.6 6546.1 6557.3 6573.7 5302.4 6319.1 6354.0 6392.7 6696.9 6462.8 6482.8 6484.9 6498.0 6501.8 6300.8 6329.0 6457.8 6488.7 6520.6 5028.2 6201.9 6208.5 6289.2 6318.8 5275.6 6411.7 6430.8 6434.5 6452.9 6191.9 6273.3 6307.8 6322.7 6336.6 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:45625.61 Median:324719.00 stddev:78644.47 (24.2%) stddev-sans-first:78792.97 18:03:08 INFO - PID 1638 | Values: 768.5 815.2 840.7 1260.5 1261.3 39246.4 40362.8 40413.6 40515.6 40534.4 40164.4 40524.0 40531.0 40561.2 40742.4 6800.6 7244.5 8285.0 8898.5 8925.9 8862.9 8961.0 8971.3 8989.8 9003.4 8932.2 8985.9 9040.4 9065.0 9078.5 8998.4 9012.5 9019.6 9026.4 9047.8 8773.7 8778.6 8785.4 8806.3 8824.7 30468.4 38662.4 38935.0 39001.2 39017.6 3227.3 3668.3 3713.6 3718.3 3755.6 31346.2 31381.5 31433.4 31473.7 31514.7 2712.3 3237.2 3240.2 3241.0 3253.3 239931.0 245020.0 281158.6 298609.0 299017.0 41504.8 48835.0 49546.5 49618.8 49779.5 41494.8 50361.5 51841.5 51852.5 51939.5 14471.1 14517.4 14532.6 14639.3 14689.3 11899.0 11907.0 11917.2 11961.4 11972.1 13720.1 13732.9 13749.2 13788.0 13896.2 4743.5 5908.2 5937.8 5950.1 5957.8 1010.8 1024.7 1027.3 1049.8 1062.0 20237.9 23933.6 25009.4 26081.0 31031.4 1111.3 1115.9 1148.2 1151.6 1152.9 11179.0 12238.4 12806.2 12873.0 12931.4 321193.0 324248.0 324567.0 324871.0 325403.0 48533.0 55499.7 55750.7 55872.0 56000.4 1497.3 1553.7 1559.4 1563.5 1573.6 24205.6 24219.9 24237.0 24266.8 24402.3 39178.4 39249.8 39357.0 39447.4 39559.2 298705.0 299332.0 300721.0 301663.0 302635.5 34978.7 36370.5 37084.8 37156.0 37214.6 46438.3 46511.8 46522.8 47263.8 47891.0 31137.8 31654.2 31980.8 32135.8 32187.2 31000.4 31950.2 32043.5 32285.7 32376.7 37578.4 38029.6 38229.0 38355.6 38567.6 30881.7 31294.7 31869.0 31975.5 32169.0 23236.4 24111.3 24778.3 25073.1 25172.7 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:34999.52 Median:12416.23 stddev:89925.82 (724.3%) stddev-sans-first:90140.42 18:03:08 INFO - PID 1638 | Values: 333.9 388.3 441.7 442.9 448.6 20455.5 21625.9 22321.6 22376.6 22493.6 19321.8 19819.5 20020.0 22571.0 23141.3 6333.5 6601.5 6614.2 6620.5 6622.1 4975.5 5508.4 5914.6 6322.4 6517.2 5636.0 6553.1 6561.7 6563.3 6563.6 6304.0 6473.8 6529.8 6539.1 6588.6 5501.5 5791.3 5800.6 5825.1 5837.0 28200.6 28394.9 28457.7 28559.4 28633.0 2273.6 2339.3 2343.1 2346.5 2351.8 17989.1 18196.4 18715.3 18807.5 19052.9 1906.8 2187.0 2233.3 2252.7 2261.5 119954.0 155422.0 159858.0 165094.0 165543.2 12305.1 12898.2 12923.9 12993.7 13004.2 16547.4 16760.8 16844.6 16847.6 16903.7 8831.1 9184.0 9274.4 9289.7 9395.2 8708.2 8832.2 8844.1 8906.6 9027.2 7243.3 8037.8 8218.6 8229.9 8231.8 2204.4 2212.1 2212.7 2215.0 2278.6 986.9 1005.9 1008.7 1051.8 1052.6 17250.7 18233.0 20796.4 21867.2 22191.4 882.5 905.8 1004.1 1027.9 1064.7 10848.1 11122.3 11146.5 11162.9 11180.0 462572.0 528343.0 541143.0 548787.0 556737.0 96076.5 128002.0 133698.0 135861.0 137758.0 1241.2 1272.0 1293.6 1293.9 1296.8 16463.8 19105.7 21746.8 22030.4 23303.1 56699.7 56771.4 57141.7 57532.7 57708.4 77728.0 78276.8 78383.6 78468.6 79395.6 9009.1 9014.1 9077.6 9089.9 9182.7 13996.9 14165.4 14205.4 14339.1 14363.1 11829.5 11856.9 11898.8 12075.3 12170.6 11091.7 11093.8 11107.1 11305.0 11382.3 11867.6 12055.0 12159.7 12197.6 12198.8 8611.4 8834.9 8938.0 9099.7 9163.0 9998.6 10895.6 11594.3 11965.7 12078.3 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7231.35 Median:4014.45 stddev:4620.27 (115.1%) stddev-sans-first:4612.11 18:03:08 INFO - PID 1638 | Values: 1351.9 1359.2 1391.5 1532.8 1548.5 11692.1 12080.6 12221.4 12240.2 12434.4 9605.6 10105.8 12043.6 12299.5 12318.4 2191.8 2542.2 2596.4 2600.7 2606.0 2522.3 2573.5 2578.4 2579.9 2582.8 2528.2 2539.4 2592.2 2593.9 2595.7 2535.9 2563.3 2564.0 2571.4 2574.1 2171.4 2476.9 2528.2 2544.7 2580.4 12013.9 12178.0 12239.4 12248.8 12272.1 6681.2 6908.3 6909.1 6910.5 6928.9 4050.4 4351.5 4412.0 4435.0 4449.3 1107.8 1260.6 1271.3 1298.6 1310.7 16276.9 16690.5 16853.8 16868.2 16880.6 5924.5 6039.6 6224.3 6261.8 6270.0 13955.7 14020.1 14028.0 14036.9 14039.4 6845.3 6883.3 6915.8 6938.3 6943.0 6089.5 6262.6 6284.5 6321.3 6358.7 4311.5 4436.0 4443.0 4484.0 4498.8 1027.5 1291.1 1304.6 1318.6 1324.4 752.2 786.1 795.0 796.6 814.4 5578.4 5770.8 6122.6 6884.7 7056.6 863.0 905.4 917.9 957.9 999.1 3404.1 3926.7 3978.5 4336.9 4356.7 14929.9 15219.5 15325.2 15348.6 15426.4 12634.7 15223.3 15229.4 15244.8 15248.3 7539.7 7845.6 8511.4 8774.0 8811.8 5725.5 6671.0 6761.0 7037.4 7097.7 13148.4 13490.0 13542.4 13564.7 13762.5 13716.1 13857.0 13930.7 13968.7 14246.9 9428.0 9447.5 9479.0 9564.0 9587.9 8541.5 10823.2 10941.2 10952.8 10953.0 9145.7 9178.0 9186.2 9229.9 9385.7 7991.3 8530.7 9020.0 9040.5 9048.3 8045.4 8130.3 8135.9 8196.3 8227.5 5141.8 6095.3 6104.3 6152.9 6157.8 5760.6 6059.8 6199.8 6208.3 6268.7 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:5205.04 Median:5845.38 stddev:1622.05 (27.7%) stddev-sans-first:1585.43 18:03:08 INFO - PID 1638 | Values: 366.9 406.8 413.1 413.9 415.8 5325.3 6089.4 6205.0 6208.2 6228.3 4334.3 5685.5 5895.6 5995.7 6094.7 4517.3 4570.2 4580.4 4584.6 4591.3 4177.5 4500.3 4601.1 4629.3 4643.6 4536.7 4537.8 4561.0 4568.6 4570.7 4506.3 4534.5 4546.2 4560.5 4571.4 3888.6 4009.8 4067.5 4072.0 4078.5 5857.8 5923.6 5931.2 5933.6 6003.0 4571.3 5430.8 5445.6 5471.3 5479.8 5382.0 6369.3 6371.2 6492.1 6553.6 4091.2 4205.4 4386.8 4629.7 4651.9 6061.3 6425.8 6675.2 6803.0 6910.0 3561.5 4274.5 4312.0 4325.5 4333.8 4388.5 4400.8 4405.3 4406.7 4423.9 4498.8 5032.0 5088.2 5198.9 5233.6 5650.6 6529.2 6541.5 6545.0 6553.5 1423.7 1470.3 1492.4 1497.0 1500.6 851.6 899.4 937.7 979.1 991.1 6084.0 6099.6 6105.2 6105.9 6156.4 5563.8 6156.0 6680.2 6740.6 6745.8 5196.9 6050.7 6073.3 6094.8 6104.9 3430.1 3470.9 3518.7 3530.1 3534.7 5664.8 6190.5 6909.0 6971.6 6988.9 5802.6 6861.8 6958.4 6959.4 6960.9 5209.5 5655.9 5899.3 7006.6 7013.0 5321.1 5833.0 6719.9 6741.5 6765.7 5377.9 5515.7 6453.3 6639.6 6640.8 5672.9 6373.5 6875.6 6993.4 7006.6 4094.0 4274.3 4280.2 4287.8 4302.3 5824.8 6633.9 6740.1 6815.0 6815.7 6539.3 6546.6 6551.6 6567.3 6571.0 5519.8 6273.5 6424.5 6453.8 6562.3 5516.7 6377.4 6386.7 6408.7 6421.6 4454.4 5409.7 6403.6 6560.7 6648.4 6321.7 6371.3 6399.8 6410.7 6425.2 18:03:08 INFO - PID 1638 | 18:03:08 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:21219.11 Median:17384.15 stddev:29627.29 (170.4%) stddev-sans-first:29670.92 18:03:08 INFO - PID 1638 | Values: 849.1 870.0 889.2 889.7 902.8 14604.8 15263.3 15643.5 16779.4 16943.8 14556.9 16697.0 17240.0 18021.0 18234.6 1040.8 1046.8 1066.7 1069.2 1070.6 1054.0 1072.4 1078.3 1083.8 1090.4 1118.9 1123.4 1123.5 1125.4 1126.9 1104.6 1115.0 1118.9 1120.4 1121.7 789.3 805.0 830.9 832.3 834.8 16488.1 17132.9 17293.0 17338.9 17359.0 15090.8 16184.0 16598.9 16719.2 16799.3 10615.8 12410.0 13931.9 14060.2 14069.2 3304.6 3449.5 3501.3 3623.6 3676.2 122595.1 123080.0 123994.4 124380.4 130076.0 13416.1 13698.7 13855.1 13864.5 13871.9 25094.5 25604.4 25823.4 26145.9 26199.0 7783.8 7896.8 7914.2 7914.7 7928.4 3891.9 3956.4 4035.6 4044.0 4054.9 4235.0 4341.9 4358.2 4379.5 4381.8 891.8 924.2 930.4 931.5 935.1 649.4 664.9 672.2 677.8 691.0 9604.9 11742.6 11981.2 11991.9 12012.8 608.1 611.8 647.6 665.5 685.2 4361.9 4568.3 5475.7 5547.6 5592.0 95793.0 99869.0 101777.0 102418.5 105059.0 85561.0 85606.0 86114.6 86590.0 88059.0 65561.0 70157.6 82518.2 82809.6 83262.0 9702.2 11108.1 11112.6 11142.8 11340.9 39687.2 40581.0 41194.4 41811.0 41941.0 40380.0 47593.0 48474.8 54010.0 54290.7 13945.0 16518.3 17367.8 17383.0 17385.3 15228.5 17870.3 18366.4 18563.4 18730.1 16949.0 17373.7 17408.8 17502.8 17588.0 17029.1 17058.2 17236.6 17249.7 17361.0 16181.0 16397.8 16794.7 16945.1 16955.7 10073.6 11783.4 12081.7 12139.5 12154.2 12866.5 13434.0 13650.9 13709.5 13755.0 18:03:08 INFO - PID 1638 | -------- Summary: end -------- 18:03:08 INFO - PID 1638 | 18:03:09 INFO - TEST-INFO | 1638: exit 0 18:03:09 INFO - TEST-OK | dromaeo_css | took 1114277ms 18:03:09 INFO - TEST-START | kraken 18:03:09 INFO - operating with platform_type : mac_ 18:03:09 INFO - Initialising browser for kraken test... 18:03:09 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmp8v8FQd/profile http://localhost:49242/getInfo.html) 18:03:12 INFO - PID 1650 | 2017-04-26 18:03:12.185 plugin-container[1651:10146] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 18:03:12 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:12 INFO - PID 1650 | 2017-04-26 18:03:12.187 plugin-container[1651:10146] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0f, name = 'com.apple.CFPasteboardClient' 18:03:12 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:12 INFO - PID 1650 | 2017-04-26 18:03:12.187 plugin-container[1651:10146] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:03:12 INFO - PID 1650 | __metrics Screen width/height:1600/1200 18:03:12 INFO - PID 1650 | colorDepth:24 18:03:12 INFO - PID 1650 | Browser inner width/height: 1024/689 18:03:12 INFO - PID 1650 | __metrics 18:03:12 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 18:03:13 INFO - TEST-INFO | 1650: exit 0 18:03:13 INFO - Browser initialized. 18:03:13 INFO - Running cycle 1/1 for kraken test... 18:03:13 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/T/tmp8v8FQd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:15 INFO - PID 1652 | 2017-04-26 18:03:15.657 plugin-container[1653:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 18:03:15 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:15 INFO - PID 1652 | 2017-04-26 18:03:15.658 plugin-container[1653:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 18:03:15 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:15 INFO - PID 1652 | 2017-04-26 18:03:15.658 plugin-container[1653:10274] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:03:25 INFO - PID 1652 | RSS: Main: 236675072 18:03:25 INFO - PID 1652 | 18:03:28 INFO - PID 1652 | 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) 18:03:29 INFO - PID 1652 | RSS: Main: 248512512 18:03:29 INFO - PID 1652 | 18:03:31 INFO - PID 1652 | 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) 18:03:32 INFO - PID 1652 | RSS: Main: 256946176 18:03:32 INFO - PID 1652 | 18:03:35 INFO - PID 1652 | 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) 18:03:36 INFO - PID 1652 | RSS: Main: 259264512 18:03:36 INFO - PID 1652 | 18:03:38 INFO - PID 1652 | 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) 18:03:39 INFO - PID 1652 | RSS: Main: 261406720 18:03:39 INFO - PID 1652 | 18:03:41 INFO - PID 1652 | 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) 18:03:41 INFO - PID 1652 | RSS: Main: 262172672 18:03:41 INFO - PID 1652 | 18:03:45 INFO - PID 1652 | 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) 18:03:45 INFO - PID 1652 | RSS: Main: 268025856 18:03:45 INFO - PID 1652 | 18:03:48 INFO - PID 1652 | 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) 18:03:49 INFO - PID 1652 | RSS: Main: 268517376 18:03:49 INFO - PID 1652 | 18:03:52 INFO - PID 1652 | 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) 18:03:52 INFO - PID 1652 | RSS: Main: 268492800 18:03:52 INFO - PID 1652 | 18:03:54 INFO - PID 1652 | 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) 18:03:55 INFO - PID 1652 | RSS: Main: 268304384 18:03:55 INFO - PID 1652 | 18:03:56 INFO - PID 1652 | 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) 18:03:57 INFO - PID 1652 | RSS: Main: 268328960 18:03:57 INFO - PID 1652 | 18:03:59 INFO - PID 1652 | 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) 18:04:00 INFO - PID 1652 | RSS: Main: 267931648 18:04:00 INFO - PID 1652 | 18:04:03 INFO - PID 1652 | 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) 18:04:03 INFO - PID 1652 | RSS: Main: 268562432 18:04:03 INFO - PID 1652 | 18:04:07 INFO - PID 1652 | 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) 18:04:07 INFO - PID 1652 | RSS: Main: 268365824 18:04:07 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | 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) 18:04:09 INFO - PID 1652 | RSS: Main: 269819904 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | __start_tp_report 18:04:09 INFO - PID 1652 | _x_x_mozilla_page_load 18:04:09 INFO - PID 1652 | _x_x_mozilla_page_load_details 18:04:09 INFO - PID 1652 | |i|pagename|runs| 18:04:09 INFO - PID 1652 | |0;ai-astar;134;170;115;114;116;133;170;170;116;114 18:04:09 INFO - PID 1652 | |1;audio-beat-detection;135;123;97;130;87;93;96;124;159;143 18:04:09 INFO - PID 1652 | |2;audio-dft;195;202;203;239;204;281;279;200;198;199 18:04:09 INFO - PID 1652 | |3;audio-fft;78;61;52;94;79;76;49;51;75;49 18:04:09 INFO - PID 1652 | |4;audio-oscillator;98;103;118;106;90;57;77;81;115;114 18:04:09 INFO - PID 1652 | |5;imaging-gaussian-blur;133;89;89;90;81;130;138;92;101;137 18:04:09 INFO - PID 1652 | |6;imaging-darkroom;131;95;97;98;96;96;97;97;96;100 18:04:09 INFO - PID 1652 | |7;imaging-desaturate;90;94;122;139;90;85;95;90;88;94 18:04:09 INFO - PID 1652 | |8;json-parse-financial;51;50;49;52;55;58;78;76;75;62 18:04:09 INFO - PID 1652 | |9;json-stringify-tinderbox;56;56;62;58;61;62;54;56;56;59 18:04:09 INFO - PID 1652 | |10;stanford-crypto-aes;82;82;82;79;97;107;83;84;83;81 18:04:09 INFO - PID 1652 | |11;stanford-crypto-ccm;136;145;132;137;137;136;147;156;224;148 18:04:09 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;241;242;199;187;188;182;185;186;182;184 18:04:09 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;69;67;69;68;70;66;68;69;93;96 18:04:09 INFO - PID 1652 | __end_tp_report 18:04:09 INFO - PID 1652 | __start_cc_report 18:04:09 INFO - PID 1652 | _x_x_mozilla_cycle_collect,987 18:04:09 INFO - PID 1652 | __end_cc_report 18:04:09 INFO - PID 1652 | __startTimestamp1493255049758__endTimestamp 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | ------- Summary: start ------- 18:04:09 INFO - PID 1652 | Number of tests: 14 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:135.20 Median:133.50 stddev:25.13 (18.8%) stddev-sans-first:26.65 18:04:09 INFO - PID 1652 | Values: 134.0 170.0 115.0 114.0 116.0 133.0 170.0 170.0 116.0 114.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:123.00 stddev:24.28 (19.7%) stddev-sans-first:25.03 18:04:09 INFO - PID 1652 | Values: 135.0 123.0 97.0 130.0 87.0 93.0 96.0 124.0 159.0 143.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:220.00 Median:203.50 stddev:33.96 (16.7%) stddev-sans-first:34.80 18:04:09 INFO - PID 1652 | Values: 195.0 202.0 203.0 239.0 204.0 281.0 279.0 200.0 198.0 199.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:66.40 Median:75.50 stddev:15.99 (21.2%) stddev-sans-first:16.40 18:04:09 INFO - PID 1652 | Values: 78.0 61.0 52.0 94.0 79.0 76.0 49.0 51.0 75.0 49.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:67.00 stddev:19.62 (29.3%) stddev-sans-first:20.80 18:04:09 INFO - PID 1652 | Values: 98.0 103.0 118.0 106.0 90.0 57.0 77.0 81.0 115.0 114.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:108.00 Median:85.00 stddev:23.40 (27.5%) stddev-sans-first:23.01 18:04:09 INFO - PID 1652 | Values: 133.0 89.0 89.0 90.0 81.0 130.0 138.0 92.0 101.0 137.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:96.50 stddev:10.87 (11.3%) stddev-sans-first:1.45 18:04:09 INFO - PID 1652 | Values: 131.0 95.0 97.0 98.0 96.0 96.0 97.0 97.0 96.0 100.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:90.00 stddev:17.49 (19.4%) stddev-sans-first:18.27 18:04:09 INFO - PID 1652 | Values: 90.0 94.0 122.0 139.0 90.0 85.0 95.0 90.0 88.0 94.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:11.55 (19.2%) stddev-sans-first:11.72 18:04:09 INFO - PID 1652 | Values: 51.0 50.0 49.0 52.0 55.0 58.0 78.0 76.0 75.0 62.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.50 stddev:2.87 (4.9%) stddev-sans-first:2.95 18:04:09 INFO - PID 1652 | Values: 56.0 56.0 62.0 58.0 61.0 62.0 54.0 56.0 56.0 59.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:82.50 stddev:8.86 (10.7%) stddev-sans-first:9.28 18:04:09 INFO - PID 1652 | Values: 82.0 82.0 82.0 79.0 97.0 107.0 83.0 84.0 83.0 81.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:146.00 stddev:27.09 (18.6%) stddev-sans-first:28.27 18:04:09 INFO - PID 1652 | Values: 136.0 145.0 132.0 137.0 137.0 136.0 147.0 156.0 224.0 148.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:187.50 stddev:23.63 (12.6%) stddev-sans-first:19.15 18:04:09 INFO - PID 1652 | Values: 241.0 242.0 199.0 187.0 188.0 182.0 185.0 186.0 182.0 184.0 18:04:09 INFO - PID 1652 | 18:04:09 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:69.00 stddev:11.15 (16.2%) stddev-sans-first:11.70 18:04:09 INFO - PID 1652 | Values: 69.0 67.0 69.0 68.0 70.0 66.0 68.0 69.0 93.0 96.0 18:04:09 INFO - PID 1652 | -------- Summary: end -------- 18:04:09 INFO - PID 1652 | 18:04:10 INFO - TEST-INFO | 1652: exit 0 18:04:10 INFO - TEST-OK | kraken | took 61333ms 18:04:10 INFO - SUITE-END | took 1175s 18:04:10 INFO - Completed test suite (00:19:35) 18:04:10 INFO - javascript benchmark 18:04:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7909.813756187517, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.7912985655917, 3430.879919202827, 3578.1949061461164, 3605.3330133925224, 3611.765235259709, 6020.1270815731805, 6167.352427995063, 6182.567220294575, 6183.288921773998, 6236.968815155929, 6112.655464441472, 6119.0, 6130.724117414716, 6131.448169664729, 6160.353162917896, 5272.683638981654, 5354.973225133869, 5391.514763671269, 5423.647462914918, 5484.232207490954, 5325.600579956519, 5382.004329199091, 5457.645253058558, 5481.643693159952, 5517.200005999128, 5415.48552887479, 5482.0, 5487.396386397493, 5537.529310008654, 5539.667619942797, 5221.582273418117, 5298.337707786527, 5300.284461597674, 5304.496072873071, 5392.0, 5314.256004159382, 5363.839084827461, 5378.2470454136455, 5392.083345831218, 5422.566194704415, 5828.912566311508, 6163.167972323724, 6214.937850621526, 6236.064590311489, 6236.719347629368, 6293.622382657009, 6341.460975817061, 6499.5775274607, 6566.967165164191, 6575.605463672195, 6647.335266473362, 6673.232578253466, 6689.0, 6701.3968742812895, 6707.463402927754, 6348.650824204667, 6351.364863513611, 6362.363763623694, 6369.554131210817, 6378.330275321071, 6461.676916154268, 6526.41262286387, 6774.085498457744, 6839.418649414756, 6865.5537390070485, 6301.905471417932, 6355.745770169234, 6363.331850155667, 6432.646204458706, 6469.935300646934, 6352.0789485525265, 6362.77730279438, 6565.080888675589, 6658.9001164982565, 6684.9890065960035, 6359.650219237987, 6486.772962946275, 6497.642629655415, 6509.772157974448, 6516.57642253252, 6247.687615619201, 6400.359964003563, 6492.870142597121, 6506.089147519257, 6549.279579246279, 4404.977975110104, 5158.793648254103, 5186.948130518646, 5233.502817232433, 5242.13504771716, 4027.456293400412, 4326.783660816946, 4588.472325682589, 4678.485366609671, 4734.313524538922, 6126.23422072241, 6353.237611486651, 6353.841153971188, 6363.5545511813725, 6364.64994425311, 6319.146915166394, 6364.459020983269, 6550.737970481127, 6582.76960306387, 6671.466282697373, 6302.8424289392215, 6347.492200623939, 6348.0, 6360.7137678804565, 6361.522885783585, 5771.0, 5774.711264436762, 5786.421357864264, 5805.564582656318, 5890.558208134407, 6717.5297729159465, 6796.796096117125, 6813.386795188358, 6831.282715315019, 6855.725770969305, 6378.170837791057, 6399.93600064012, 6530.249021362604, 6549.934500654933, 6619.702113404812, 5723.399043100415, 6756.4257038150345, 6840.828979275558, 6849.589024658537, 6850.0, 6476.546641735222, 6501.577397469149, 6546.083548303337, 6557.344265573404, 6573.671316434255, 5302.3637163540625, 6319.146915166394, 6354.046892965907, 6392.712327945161, 6696.866062678621, 6462.838429039311, 6482.773102941563, 6484.902726459201, 6498.0, 6501.837454063497, 6300.84247893788, 6329.0, 6457.838554036187, 6488.740450381932, 6520.6413647247955, 5028.170351892043, 6201.875962480815, 6208.534359922934, 6289.150964619717, 6318.84202894913, 5275.604329675367, 6411.679416029273, 6430.7749228776765, 6434.453071488976, 6452.935470645233, 6191.938080619136, 6273.278572964167, 6307.779227727007, 6322.652254125883, 6336.58812177207], "value": 5995.068638759003, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.4505578511366, 815.1970309245393, 840.6553313141613, 1260.539902935429, 1261.3441010674449, 39246.41130383043, 40362.798186009066, 40413.595864041425, 40515.59484405155, 40534.39198412022, 40164.397534037016, 40524.0, 40531.0, 40561.18877622446, 40742.388864167064, 6800.625965571904, 7244.492885498017, 8285.047219569737, 8898.510581917992, 8925.910740892572, 8862.86705699415, 8961.014288428267, 8971.282297416225, 8989.775255618597, 9003.369764116482, 8932.196102350787, 8985.865212021825, 9040.36717429777, 9064.954675226614, 9078.500682462462, 8998.370114092017, 9012.504312262823, 9019.594118264693, 9026.368154229207, 9047.773805654813, 8773.736787896309, 8778.64885404583, 8785.38502304839, 8806.251468625174, 8824.691135810215, 30468.390632187453, 38662.420063699064, 38935.026624334336, 39001.21997560033, 39017.60982390168, 3227.289996200832, 3668.266346730638, 3713.5729391119826, 3718.2563487302377, 3755.6432138946757, 31346.21634459134, 31381.52927706086, 31433.37133257322, 31473.685263147534, 31514.684853151633, 2712.267687724323, 3237.2068843133347, 3240.1575590346442, 3240.983795081033, 3253.300540383805, 239931.0, 245020.0, 281158.5942070297, 298609.0, 299017.0, 41504.792476038034, 48835.02329953452, 49546.50453495491, 49618.751906240235, 49779.519843214286, 41494.79252603778, 50361.496385036415, 51841.48158518367, 51852.48147518552, 51939.48060519422, 14471.059381140192, 14517.419303227964, 14532.564023079325, 14639.341229644479, 14689.338979745937, 11899.0, 11907.0, 11917.22538035025, 11961.40192990347, 11972.10209234311, 13720.108192967426, 13732.931335343259, 13749.175049497062, 13788.0, 13896.23570703621, 4743.549362810528, 5908.172855800191, 5937.7921772737745, 5950.107483877367, 5957.79147729836, 1010.802893435773, 1024.6618615856748, 1027.3476342522551, 1049.7533079726259, 1062.0388548363744, 20237.898810505852, 23933.64099538508, 25009.374765631004, 26081.0, 31031.379372412877, 1111.261011427408, 1115.9163062770324, 1148.1618418554501, 1151.614209239914, 1152.8962393384468, 11179.0, 12238.449269782881, 12806.231626102464, 12873.0, 12931.353432328346, 321193.0, 324248.0, 324567.0, 324871.0, 325403.0, 48533.0, 55499.722501388045, 55750.72124639351, 55872.0, 56000.43999560034, 1497.2663394936403, 1553.673728517024, 1559.384043302889, 1563.4527915229578, 1573.6144644562155, 24205.636915446634, 24219.878900605385, 24237.03051877905, 24266.75733242645, 24402.26793196207, 39178.4123238146, 39249.80375098106, 39357.0, 39447.408288875115, 39559.208815824095, 298705.0, 299332.0, 300720.9927900693, 301663.0, 302635.4868225645, 34978.65021349754, 36370.45444318285, 37084.81457592803, 37156.0, 37214.62785372112, 46438.30342544932, 46511.83720407017, 46522.77460564214, 47263.76368118137, 47891.0, 31137.844310778302, 31654.208644784063, 31980.840095799373, 32135.839320803247, 32187.195320116247, 31000.379992400478, 31950.201244969063, 32043.519347210276, 32285.677143229208, 32376.704931802466, 37578.436323454625, 38029.61970380261, 38229.0, 38355.616443835206, 38567.614323856404, 30881.69118308878, 31294.68705312918, 31869.0, 31975.520367194047, 32169.03492895217, 23236.419089522897, 24111.276661700176, 24778.25665230046, 25073.122440714487, 25172.74827251704], "value": 17966.470381958196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.86645341863266, 388.3436991484391, 441.69919586816815, 442.9069895321982, 448.6321216602386, 20455.543139915404, 21625.891870540643, 22321.55356892861, 22376.552468950613, 22493.55012899743, 19321.806781932177, 19819.504512387197, 20020.0, 22571.0, 23141.305760827203, 6333.524985626073, 6601.537892347537, 6614.206295244578, 6620.470362370998, 6622.106015687868, 4975.477574854643, 5508.394076651565, 5914.645121292715, 6322.43098121169, 6517.185351831021, 5636.0, 6553.148090748196, 6561.671916404184, 6563.343665633446, 6563.63899985503, 6303.968480157593, 6473.834709752243, 6529.836754081139, 6539.149910511603, 6588.604683718992, 5501.504864562168, 5791.305043394777, 5800.564957628152, 5825.097109947965, 5836.97081514594, 28200.576991345148, 28394.91422483759, 28457.71940262693, 28559.428811423655, 28633.0, 2273.5680220758004, 2339.2865176121277, 2343.086196383412, 2346.4720437901506, 2351.7883390494767, 17989.10054497283, 18196.363127290613, 18715.251389944387, 18807.529811754677, 19052.85682859019, 1906.8093190680959, 2186.9890650546804, 2233.3300009997097, 2252.718410198725, 2261.4685548895995, 119954.0, 155422.0, 159858.0, 165093.9999999988, 165543.172284139, 12305.138640295094, 12898.226106433644, 12923.870761292455, 12993.740125197442, 13004.219746815032, 16547.420840270534, 16760.832391676173, 16844.57888552796, 16847.57881052959, 16903.746443803353, 8831.080917728304, 9184.035676253898, 9274.397164184307, 9289.72130836076, 9395.248380129573, 8708.216260536583, 8832.205101540892, 8844.115588441104, 8906.55467226636, 9027.232685221697, 7243.348098671145, 8037.8392432152195, 8218.589070546448, 8229.876551851727, 8231.835363292701, 2204.4048107011017, 2212.1483228956968, 2212.657038159056, 2214.976556999716, 2278.6354183330586, 986.9309148359689, 1005.8994100590029, 1008.6570566007592, 1051.784384201237, 1052.58422922945, 17250.741238881426, 18233.0, 20796.376108716762, 21867.234646787605, 22191.445213869458, 882.4881568690145, 905.8324210021167, 1004.1163775877327, 1027.9486025698686, 1064.7018834726289, 10848.077913377452, 11122.277051991594, 11146.498407571517, 11162.888371116185, 11180.04969577595, 462572.0, 528343.0, 541143.0, 548787.0, 556737.0, 96076.51961740287, 128002.0, 133698.0, 135860.99999999802, 137758.0, 1241.1622155045309, 1272.0, 1293.5601895355624, 1293.8576756556772, 1296.824928634641, 16463.753043704113, 19105.713414299076, 21746.782532174475, 22030.44923876916, 23303.06787728472, 56699.71650141723, 56771.43228567827, 57141.714291428274, 57532.71233643805, 57708.42291577198, 77728.0, 78276.8258476112, 78383.60808195923, 78468.60765696135, 79395.60302198453, 9009.144131307516, 9014.143656352637, 9077.591508382007, 9089.909100908906, 9182.724518264462, 13996.930015349859, 14165.433382664578, 14205.431782728576, 14339.067960582528, 14363.127374524927, 11829.526818927146, 11856.881431185579, 11898.76202475963, 12075.27548347102, 12170.634880953585, 11091.667249982513, 11093.833592495957, 11107.111431085332, 11304.982551570069, 11382.260153090023, 11867.643970680894, 12055.035597152382, 12159.696007599881, 12197.573084941985, 12198.81701774492, 8611.354148438766, 8834.867476987722, 8937.972133204505, 9099.681511147079, 9162.992070872331, 9998.60005599797, 10895.564177432814, 11594.304341739522, 11965.700857478285, 12078.27530348182], "value": 10598.297042754204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.9324033798314, 1359.2184493915997, 1391.4921053815349, 1532.8350453655225, 1548.5044785668588, 11692.123090768184, 12080.637580872566, 12221.388930553481, 12240.204386714868, 12434.378281085954, 9605.615775368977, 10105.848412273821, 12043.638690839289, 12299.508019679224, 12318.445669944851, 2191.835612329082, 2542.2119143065615, 2596.363890846745, 2600.7399260073935, 2605.960910586338, 2522.268542122782, 2573.45957348956, 2578.3811885147616, 2579.9097031603897, 2582.767550920417, 2528.1783420388356, 2539.3905462688913, 2592.157548796649, 2593.8962441502317, 2595.6755405574304, 2535.9239222823344, 2563.256655569892, 2564.038485567912, 2571.4214301782135, 2574.0733335999025, 2171.4245724882917, 2476.8761561921833, 2528.24152754173, 2544.669193004916, 2580.354911272182, 12013.87986120145, 12178.0, 12239.449224784817, 12248.81626775599, 12272.079594030394, 6681.231658359302, 6908.3437073477935, 6909.136357955255, 6910.516263861532, 6928.896066559006, 4050.392441133824, 4351.5430879757805, 4411.955880441186, 4435.046465010038, 4449.310356894686, 1107.767368852542, 1260.5588044184553, 1271.2563150556934, 1298.5909438526835, 1310.708951682592, 16276.918615406847, 16690.499285021346, 16853.83146168535, 16868.156592170464, 16880.57798555046, 5924.4667979882015, 6039.614352330805, 6224.253089629274, 6261.812145635638, 6269.968650156811, 13955.651108722363, 14020.088694234842, 14028.0, 14036.859631403759, 14039.438422462987, 6845.281245469254, 6883.3116688330765, 6915.827104322432, 6938.306169383122, 6942.965285173542, 6089.451949324582, 6262.561620686508, 6284.465820405317, 6321.304656487782, 6358.745650173942, 4311.504177019683, 4436.0, 4442.955570444319, 4484.0, 4498.797554110073, 1027.5376080763685, 1291.122037014839, 1304.6086174147717, 1318.6044186743939, 1324.423875614111, 752.2176935986513, 786.080286065305, 794.9960250198827, 796.609661265987, 814.4054839966857, 5578.3584887738425, 5770.769169233267, 6122.571420000557, 6884.65576721172, 7056.611886346198, 862.9611667474853, 905.4295793649958, 917.8944421391492, 957.8515330123842, 999.115782532464, 3404.14896275931, 3926.6858651307825, 3978.5026871641044, 4336.915771057235, 4356.6950313477755, 14929.850701493064, 15219.467318644016, 15325.23373831304, 15348.616284592752, 15426.382944682087, 12634.747305053848, 15223.31495082724, 15229.390824366901, 15244.771328430083, 15248.313825877862, 7539.698412063566, 7845.607719613997, 8511.404201705822, 8774.0, 8811.779705507413, 5725.51333136688, 6670.966645166744, 6760.966195168992, 7037.437005039482, 7097.680604372712, 13148.422189337341, 13489.988250881419, 13542.390592423168, 13564.660883477993, 13762.518311859038, 13716.108452950526, 13857.0, 13930.651733706738, 13968.672976067257, 14246.928765356108, 9427.952860235655, 9447.480388578695, 9479.004704506204, 9563.952180239054, 9587.904120958701, 8541.487510749126, 10823.242373033812, 10941.179411544006, 10952.835707464235, 10952.959468850446, 9145.679901203426, 9177.954110229406, 9186.219171370509, 9229.86155207659, 9385.671501497414, 7991.2807847294025, 8530.74407767768, 9020.00779914222, 9040.502772347321, 9048.276137909083, 8045.436819422584, 8130.349572034104, 8135.877961830459, 8196.262336389753, 8227.465214761021, 5141.843085305776, 6095.299040610386, 6104.298005729398, 6152.876942461216, 6157.815265542041, 5760.6255593386295, 6059.848503787441, 6199.845003874939, 6208.292719502173, 6268.686565671789], "value": 5451.36480798249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9357862374085, 406.7559464321408, 413.0705911698678, 413.9420481132641, 415.817040502179, 5325.3077099977, 6089.360617135203, 6205.0, 6208.2239720034995, 6228.314885362618, 4334.337529676998, 5685.545156387489, 5895.6462612243295, 5995.730192141354, 6094.664793436359, 4517.322401639747, 4570.223062079446, 4580.427446569179, 4584.610308123813, 4591.324166679155, 4177.498700155986, 4500.279955207167, 4601.090547422832, 4629.259318509039, 4643.585335625473, 4536.727796332214, 4537.750423726694, 4560.950981274309, 4568.601484220794, 4570.702904311209, 4506.256467682829, 4534.478534968472, 4546.181687296285, 4560.452745670541, 4571.405717256768, 3888.552816426119, 4009.799510024487, 4067.48162839142, 4072.0454181992513, 4078.4697989261504, 5857.799151173999, 5923.555733320019, 5931.199288096095, 5933.554983376264, 6002.96998515009, 4571.337156112379, 5430.8099216527235, 5445.591580631469, 5471.343438787371, 5479.835604931858, 5382.004329199071, 6369.26753423353, 6371.203599550056, 6492.123563318939, 6553.606783593, 4091.2022155679656, 4205.369194620801, 4386.824527018915, 4629.722216666977, 4651.88370290742, 6061.333253342173, 6425.807225783187, 6675.232348279961, 6803.0, 6909.965450172767, 3561.5370001899587, 4274.508431530352, 4311.9784401077795, 4325.480942286883, 4333.848315308949, 4388.4953230378915, 4400.845970391021, 4405.273129933525, 4406.669499787528, 4423.911521769611, 4498.797554110073, 5031.974840125776, 5088.211327244283, 5198.8960220796125, 5233.607479439057, 5650.604457687922, 6529.216494020748, 6541.542092053511, 6544.9672751635935, 6553.475721942234, 1423.7437261293067, 1470.264867566217, 1492.410497853342, 1496.9850301497063, 1500.6023403798001, 851.5699571716243, 899.4243684042218, 937.7374335186022, 979.0747743382577, 991.0931497679686, 6084.026555751058, 6099.603525770899, 6105.206323177958, 6105.908411373833, 6156.4301103218395, 5563.7774489019985, 6155.984262596711, 6680.164979377578, 6740.595564266159, 6745.797626071226, 5196.870078248074, 6050.732604393578, 6073.301570319381, 6094.847628809315, 6104.938950610526, 3430.142464383904, 3470.878519251814, 3518.7009104225917, 3530.1113904061203, 3534.699550538233, 5664.762418844533, 6190.50475961922, 6908.965455172692, 6971.616561089088, 6988.860222795515, 5802.593818432753, 6861.780005296707, 6958.408535274559, 6959.4432445404245, 6960.895586566206, 5209.47905209476, 5655.915161272585, 5899.292084949833, 7006.614636195059, 7013.0, 5321.09541377959, 5832.9708351457975, 6719.8912179489835, 6741.494387920828, 6765.748336557753, 5377.919331210113, 5515.696636685021, 6453.321606684145, 6639.568428052161, 6640.800775976729, 5672.914906276326, 6373.458256048288, 6875.621840798804, 6993.440524757905, 7006.649667516705, 4093.9795301023305, 4274.27337352657, 4280.165367753259, 4287.799416163354, 4302.268614335633, 5824.767009319749, 6633.867322653617, 6740.12378390806, 6814.977753337039, 6815.727370905108, 6539.313372096051, 6546.574472659262, 6551.574147680385, 6567.310432404529, 6571.014347847861, 5519.806806761744, 6273.52948528853, 6424.51816113784, 6453.838654033687, 6562.3109573496, 5516.703574659871, 6377.394147555975, 6386.712597933011, 6408.711607977559, 6421.646809425526, 4454.420925279693, 5409.675419474844, 6403.615783053032, 6560.671966401756, 6648.401643852077, 6321.747130114744, 6371.331010243857, 6399.77600783989, 6410.679466026587, 6425.1968503937005], "value": 4699.2860507025935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.1420025188916, 869.9913000869991, 889.1730690457875, 889.7464222696533, 902.760768396375, 14604.780928286084, 15263.313150908209, 15643.530694079182, 16779.412720554785, 16943.83056169438, 14556.927215363909, 16697.0, 17240.0, 18021.008844513548, 18234.635307293847, 1040.8490768838515, 1046.8429735539692, 1066.7333166708322, 1069.2301542889106, 1070.5985255529176, 1053.952572134252, 1072.404815327493, 1078.2560033576847, 1083.8482612434227, 1090.3621381491837, 1118.8769235384102, 1123.3877536742455, 1123.5449642894641, 1125.4260327233128, 1126.8956422705753, 1104.602343156467, 1115.007643197555, 1118.9328640281528, 1120.4117838134962, 1121.7083558274826, 789.2620399926087, 805.0420000199802, 830.8753686946945, 832.3299743706314, 834.8079941613463, 16488.09315487648, 17132.914335428366, 17292.962422254706, 17338.91330543339, 17358.95846249229, 15090.792736581046, 16184.0, 16598.917005415016, 16719.16404179786, 16799.32802687891, 10615.787684246348, 12410.0, 13931.860681393158, 14060.156390616596, 14069.226192559405, 3304.5869266341706, 3449.499822525745, 3501.2997400519744, 3623.6014038456015, 3676.17286110623, 122595.09619615205, 123080.0, 123994.38002810019, 124380.37809810894, 130076.0, 13416.0608757388, 13698.726025479435, 13855.099418537964, 13864.47490776014, 13871.861281387259, 25094.498110037697, 25604.359891002874, 25823.35441613937, 26145.869270653526, 26199.0, 7783.844323113506, 7896.842063158705, 7914.24814642608, 7914.722984695508, 7928.405369597303, 3891.902702432462, 3956.3867600521967, 4035.5762644922447, 4044.0496483326397, 4054.8986275343354, 4235.0, 4341.891452713644, 4358.237308471005, 4379.474463064389, 4381.824727010884, 891.7547674389594, 924.2190349154953, 930.4417349590192, 931.4737173496952, 935.1116439382614, 649.4057936987698, 664.8603793203384, 672.1665135232276, 677.8408920745482, 690.9930900691029, 9604.9039509604, 11742.590889093193, 11981.221220620631, 11991.880081199077, 12012.819807702892, 608.1182285685774, 611.8436155665795, 647.5531883000715, 665.5308007854451, 685.1948959972013, 4361.909522619345, 4568.291914753218, 5475.698836564027, 5547.639403438763, 5591.9720401397735, 95793.0, 99869.0, 101777.0, 102418.48790755999, 105059.0, 85561.0, 85606.0, 86114.56942715372, 86590.0, 88059.0, 65561.0, 70157.64921175361, 82518.22372433872, 82809.58595207107, 83262.0, 9702.223822094356, 11108.055815255471, 11112.611058612909, 11142.777144456903, 11340.886591134313, 39687.206255875295, 40581.0, 41194.38208426816, 41811.0, 41941.0, 40380.0, 47593.0, 48474.75762621164, 54010.0, 54290.728546357015, 13945.0, 16518.339266429208, 17367.826321736622, 17383.0, 17385.304587816852, 15228.46700365482, 17870.285188592312, 18366.357177498725, 18563.35028274004, 18730.063496825376, 16948.983061016377, 17373.739393908847, 17408.82591174072, 17502.82497175012, 17588.0, 17029.148542572573, 17058.2323795432, 17236.569085772957, 17249.655006900044, 17361.0, 16181.0, 16397.770167237268, 16794.748078778583, 16945.06802125895, 16955.745663814807, 10073.647422340184, 11783.410829458664, 12081.697957551132, 12139.514419423123, 12154.204532957292, 12866.485340586272, 13434.0, 13650.93174534121, 13709.520166794115, 13755.0], "value": 8374.045374315538, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 170.0, 115.0, 114.0, 116.0, 133.0, 170.0, 170.0, 116.0, 114.0], "value": 135.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 97.0, 130.0, 87.0, 93.0, 96.0, 124.0, 159.0, 143.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 202.0, 203.0, 239.0, 204.0, 281.0, 279.0, 200.0, 198.0, 199.0], "value": 220.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 61.0, 52.0, 94.0, 79.0, 76.0, 49.0, 51.0, 75.0, 49.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 103.0, 118.0, 106.0, 90.0, 57.0, 77.0, 81.0, 115.0, 114.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 89.0, 89.0, 90.0, 81.0, 130.0, 138.0, 92.0, 101.0, 137.0], "value": 108.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 95.0, 97.0, 98.0, 96.0, 96.0, 97.0, 97.0, 96.0, 100.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 122.0, 139.0, 90.0, 85.0, 95.0, 90.0, 88.0, 94.0], "value": 98.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 52.0, 55.0, 58.0, 78.0, 76.0, 75.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 62.0, 58.0, 61.0, 62.0, 54.0, 56.0, 56.0, 59.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 79.0, 97.0, 107.0, 83.0, 84.0, 83.0, 81.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 132.0, 137.0, 137.0, 136.0, 147.0, 156.0, 224.0, 148.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [241.0, 242.0, 199.0, 187.0, 188.0, 182.0, 185.0, 186.0, 182.0, 184.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 68.0, 70.0, 66.0, 68.0, 69.0, 93.0, 96.0], "value": 73.5, "unit": "score"}]}]} 18:04:11 INFO - Return code: 0 18:04:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:11 ERROR - # TBPL SUCCESS # 18:04:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:11 INFO - 2017-04-26 18:04:11.088 screenresolution[1657:10661] starting screenresolution argv=screenresolution get 18:04:11 INFO - 2017-04-26 18:04:11.091 screenresolution[1657:10661] Display 0: 1600x1200x32@60 18:04:11 INFO - 2017-04-26 18:04:11.097 screenresolution[1658:10664] starting screenresolution argv=screenresolution list 18:04:11 INFO - Available Modes on Display 0 18:04:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:11 INFO - Intel Iris: 18:04:11 INFO - Chipset Model: Intel Iris 18:04:11 INFO - Type: GPU 18:04:11 INFO - Bus: Built-In 18:04:11 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:11 INFO - Vendor: Intel (0x8086) 18:04:11 INFO - Device ID: 0x0a2e 18:04:11 INFO - Revision ID: 0x0009 18:04:11 INFO - Displays: 18:04:11 INFO - Display: 18:04:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:11 INFO - Display Serial Number: 1600x1200 60 18:04:11 INFO - Main Display: Yes 18:04:11 INFO - Mirror: Off 18:04:11 INFO - Online: Yes 18:04:11 INFO - Rotation: Supported 18:04:11 INFO - Return code: 0 18:04:11 INFO - Running post-action listener: _resource_record_post_action 18:04:11 INFO - [mozharness: 2017-04-27 01:04:11.342984Z] Finished run-tests step (success) 18:04:11 INFO - Running post-run listener: _resource_record_post_run 18:04:11 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39660032; Write bytes: 514184192; Read time: 257; Write time: 1623 18:04:11 INFO - TinderboxPrint: CPU usage
54.2% 18:04:11 INFO - TinderboxPrint: I/O read bytes / time
39,660,032 / 257 18:04:11 INFO - TinderboxPrint: I/O write bytes / time
514,184,192 / 1,623 18:04:11 INFO - TinderboxPrint: CPU idle
2,193.9 (45.8%) 18:04:11 INFO - TinderboxPrint: CPU system
967.1 (20.2%) 18:04:11 INFO - TinderboxPrint: CPU user
1,624.7 (33.9%) 18:04:11 INFO - TinderboxPrint: Swap in / out
247,967,744 / 0 18:04:11 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194116096; Write bytes: 195094528; Read time: 14958; Write time: 418 18:04:11 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 38664704; Write bytes: 302251008; Read time: 244; Write time: 1153 18:04:11 INFO - Running post-run listener: _upload_blobber_files 18:04:11 INFO - Blob upload gear active. 18:04:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:11 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 18:04:11 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'] 18:04:11 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 18:04:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:13 INFO - (blobuploader) - INFO - Done attempting. 18:04:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:14 INFO - (blobuploader) - INFO - Done attempting. 18:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:15 INFO - (blobuploader) - INFO - Done attempting. 18:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:17 INFO - (blobuploader) - INFO - Done attempting. 18:04:17 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:17 INFO - Return code: 0 18:04:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f454a48e8742d68ffc01dea60a35860047fa6acae565d7a002d6f8e14089f4be9463c342012b1ff2d0b408a590e2e1f1d0971278079dc26107e5f17b52efc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d806881880b2ca6530374c9906a5d01852fa78e3b097142e2489054b3b2bfe47fa3383eeb27447cb83f057b7e943199c011f00885507a60d3cb087599ff1cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd140d9106440ad2dc49db5c393d05712f0a6daa0a185b382be7ce719f5aa55ef57ebda0e20d76dc6bd3a191319439129b43b3d20f6fd4755a369007e9b3f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f825318814218e178cd1a71c066f29641b26c3207da7ba9d94e00a85340c95101d4fd00ffbc2cb4fcaf11bd1c3c0c8127a082d0039fb34fb28c4026ad74f3471"} 18:04:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:17 INFO - Contents: 18:04:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f454a48e8742d68ffc01dea60a35860047fa6acae565d7a002d6f8e14089f4be9463c342012b1ff2d0b408a590e2e1f1d0971278079dc26107e5f17b52efc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d806881880b2ca6530374c9906a5d01852fa78e3b097142e2489054b3b2bfe47fa3383eeb27447cb83f057b7e943199c011f00885507a60d3cb087599ff1cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd140d9106440ad2dc49db5c393d05712f0a6daa0a185b382be7ce719f5aa55ef57ebda0e20d76dc6bd3a191319439129b43b3d20f6fd4755a369007e9b3f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f825318814218e178cd1a71c066f29641b26c3207da7ba9d94e00a85340c95101d4fd00ffbc2cb4fcaf11bd1c3c0c8127a082d0039fb34fb28c4026ad74f3471"} 18:04:17 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:17 INFO - Copying logs to upload dir... 18:04:17 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.647272 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-26 18:04:17.236701) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:17.240327) ========= 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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f454a48e8742d68ffc01dea60a35860047fa6acae565d7a002d6f8e14089f4be9463c342012b1ff2d0b408a590e2e1f1d0971278079dc26107e5f17b52efc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d806881880b2ca6530374c9906a5d01852fa78e3b097142e2489054b3b2bfe47fa3383eeb27447cb83f057b7e943199c011f00885507a60d3cb087599ff1cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd140d9106440ad2dc49db5c393d05712f0a6daa0a185b382be7ce719f5aa55ef57ebda0e20d76dc6bd3a191319439129b43b3d20f6fd4755a369007e9b3f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f825318814218e178cd1a71c066f29641b26c3207da7ba9d94e00a85340c95101d4fd00ffbc2cb4fcaf11bd1c3c0c8127a082d0039fb34fb28c4026ad74f3471"} build_url:https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb9f454a48e8742d68ffc01dea60a35860047fa6acae565d7a002d6f8e14089f4be9463c342012b1ff2d0b408a590e2e1f1d0971278079dc26107e5f17b52efc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d806881880b2ca6530374c9906a5d01852fa78e3b097142e2489054b3b2bfe47fa3383eeb27447cb83f057b7e943199c011f00885507a60d3cb087599ff1cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cd140d9106440ad2dc49db5c393d05712f0a6daa0a185b382be7ce719f5aa55ef57ebda0e20d76dc6bd3a191319439129b43b3d20f6fd4755a369007e9b3f19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f825318814218e178cd1a71c066f29641b26c3207da7ba9d94e00a85340c95101d4fd00ffbc2cb4fcaf11bd1c3c0c8127a082d0039fb34fb28c4026ad74f3471"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:17.275597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:17.275928) ========= 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.Gh6Q7OPrfj/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.lcYWRtlreC/Listeners TMPDIR=/var/folders/gk/8kgw34ms467fqz8hdjk7nkb400000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:17.324871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 18:04:17.325208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 18:04:17.325562) ========= ========= Total master_lag: 0.18 =========