builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1493700599.12 results: success (0) buildid: 20170501200621 builduid: d6453034fb1b4aa89e225e82f56a457d revision: 2e7c10a9b86e30691f67855f6c8f98d984508d7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:59.119793) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:59.120325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:59.120660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:59.163613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 21:49:59.163985) ========= 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.XzByr4iqlL/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.Rr3mA0eofC/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-01 21:49:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.6M=0s 2017-05-01 21:49:59 (23.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137625 ========= master_lag: 1.96 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 21:50:01.264074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 21:50:01.268483) ========= 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.XzByr4iqlL/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.Rr3mA0eofC/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.029441 ========= master_lag: 1.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 21:50:02.660028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 21:50:02.660409) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2e7c10a9b86e30691f67855f6c8f98d984508d7c --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 2e7c10a9b86e30691f67855f6c8f98d984508d7c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XzByr4iqlL/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.Rr3mA0eofC/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-01 21:50:02,757 truncating revision to first 12 chars 2017-05-01 21:50:02,757 Setting DEBUG logging. 2017-05-01 21:50:02,757 attempt 1/10 2017-05-01 21:50:02,757 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2e7c10a9b86e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 21:50:03,876 unpacking tar archive at: mozilla-central-2e7c10a9b86e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.409127 ========= master_lag: 1.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 21:50:05.291314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 21:50:05.291630) ========= script_repo_revision: 2e7c10a9b86e30691f67855f6c8f98d984508d7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 21:50:05.292001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 21:50:05.292260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 21:50:05.325368) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-01 21:50:05.325720) ========= /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.XzByr4iqlL/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.Rr3mA0eofC/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:50:05 INFO - MultiFileLogger online at 20170501 21:50:05 in /builds/slave/test 21:50:05 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 21:50:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:50:05 INFO - {'append_to_log': False, 21:50:05 INFO - 'base_work_dir': '/builds/slave/test', 21:50:05 INFO - 'blob_upload_branch': 'Firefox', 21:50:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:50:05 INFO - 'branch': 'Firefox', 21:50:05 INFO - 'buildbot_json_path': 'buildprops.json', 21:50:05 INFO - 'config_files': ('talos/mac_config.py',), 21:50:05 INFO - 'default_actions': ('clobber', 21:50:05 INFO - 'read-buildbot-config', 21:50:05 INFO - 'download-and-extract', 21:50:05 INFO - 'populate-webroot', 21:50:05 INFO - 'create-virtualenv', 21:50:05 INFO - 'install', 21:50:05 INFO - 'run-tests'), 21:50:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:50:05 INFO - 'download_minidump_stackwalk': True, 21:50:05 INFO - 'download_symbols': 'ondemand', 21:50:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:50:05 INFO - 'tooltool.py': '/tools/tooltool.py', 21:50:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:50:05 INFO - '/tools/misc-python/virtualenv.py')}, 21:50:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:50:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:50:05 INFO - 'gecko_profile': False, 21:50:05 INFO - 'gecko_profile_interval': 0, 21:50:05 INFO - 'installer_path': 'installer.exe', 21:50:05 INFO - 'log_level': 'info', 21:50:05 INFO - 'log_name': 'talos', 21:50:05 INFO - 'log_to_console': True, 21:50:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:50:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:50:05 INFO - 'opt_config_files': (), 21:50:05 INFO - 'pip_index': False, 21:50:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:50:05 INFO - 'cmd': ('bash', 21:50:05 INFO - '-c', 21:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:50:05 INFO - 'enabled': True, 21:50:05 INFO - 'halt_on_failure': False, 21:50:05 INFO - 'name': 'check_screen_resolution'},), 21:50:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:50:05 INFO - 'cmd': ('bash', 21:50:05 INFO - '-c', 21:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:50:05 INFO - 'enabled': True, 21:50:05 INFO - 'halt_on_failure': False, 21:50:05 INFO - 'name': 'check_screen_resolution'},), 21:50:05 INFO - 'run_cmd_checks_enabled': True, 21:50:05 INFO - 'suite': 'dromaeojs-e10s', 21:50:05 INFO - 'system_bits': '32', 21:50:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:50:05 INFO - 'title': 't-yosemite-r7-0153', 21:50:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:50:05 INFO - 'use_talos_json': True, 21:50:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:50:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:50:05 INFO - 'work_dir': 'build'} 21:50:05 INFO - [mozharness: 2017-05-02 04:50:05.526477Z] Running clobber step. 21:50:05 INFO - Running pre-action listener: _resource_record_pre_action 21:50:05 INFO - Running main action method: clobber 21:50:05 INFO - rmtree: /builds/slave/test/build 21:50:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:50:08 INFO - Running post-action listener: _resource_record_post_action 21:50:08 INFO - [mozharness: 2017-05-02 04:50:08.127902Z] Finished clobber step (success) 21:50:08 INFO - [mozharness: 2017-05-02 04:50:08.128039Z] Running read-buildbot-config step. 21:50:08 INFO - Running pre-action listener: _resource_record_pre_action 21:50:08 INFO - Running main action method: read_buildbot_config 21:50:08 INFO - Using buildbot properties: 21:50:08 INFO - { 21:50:08 INFO - "project": "", 21:50:08 INFO - "product": "firefox", 21:50:08 INFO - "script_repo_revision": "production", 21:50:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:50:08 INFO - "repository": "", 21:50:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:50:08 INFO - "buildid": "20170501200621", 21:50:08 INFO - "pgo_build": "False", 21:50:08 INFO - "basedir": "/builds/slave/test", 21:50:08 INFO - "buildnumber": 208, 21:50:08 INFO - "slavename": "t-yosemite-r7-0153", 21:50:08 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:50:08 INFO - "platform": "yosemite_r7", 21:50:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:50:08 INFO - "branch": "mozilla-central", 21:50:08 INFO - "repo_path": "mozilla-central", 21:50:08 INFO - "revision": "2e7c10a9b86e30691f67855f6c8f98d984508d7c", 21:50:08 INFO - "stage_platform": "macosx64", 21:50:08 INFO - "builduid": "d6453034fb1b4aa89e225e82f56a457d", 21:50:08 INFO - "slavebuilddir": "test" 21:50:08 INFO - } 21:50:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 21:50:08 INFO - Running post-action listener: _resource_record_post_action 21:50:08 INFO - [mozharness: 2017-05-02 04:50:08.131246Z] Finished read-buildbot-config step (success) 21:50:08 INFO - [mozharness: 2017-05-02 04:50:08.131379Z] Running download-and-extract step. 21:50:08 INFO - Running pre-action listener: _resource_record_pre_action 21:50:08 INFO - Running main action method: download_and_extract 21:50:08 INFO - mkdir: /builds/slave/test/build/tests 21:50: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')]} 21:50:08 INFO - trying https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 21:50:08 INFO - Downloading https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/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 21:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/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 21:50:09 INFO - Downloaded 1325 bytes. 21:50:09 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:50:09 INFO - Using the following test package requirements: 21:50:09 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 21:50:09 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:50:09 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 21:50:09 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 21:50:09 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'jsshell-mac.zip'], 21:50:09 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 21:50:09 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:50:09 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 21:50:09 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 21:50:09 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 21:50:09 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:50:09 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 21:50:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:50:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:50:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:50:09 INFO - Fetch https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:50:11 INFO - Content-Length response header: 52699754 21:50:11 INFO - Bytes received: 52699754 21:50:27 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 21:50:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:50:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:50:27 INFO - Fetch https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:50:29 INFO - Content-Length response header: 52699754 21:50:29 INFO - Bytes received: 52699754 21:50:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 21:50:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:50:45 INFO - Fetch https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 21:50:46 INFO - Content-Length response header: 14408811 21:50:46 INFO - Bytes received: 14408811 21:50:47 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')]} 21:50:47 INFO - trying https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:50:47 INFO - Downloading https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 21:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/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 21:50:49 INFO - Downloaded 71249404 bytes. 21:50:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:50:49 INFO - mkdir: /builds/slave/test/properties 21:50:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:50:49 INFO - Writing to file /builds/slave/test/properties/build_url 21:50:49 INFO - Contents: 21:50:49 INFO - build_url:https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:50:49 INFO - Running post-action listener: _resource_record_post_action 21:50:49 INFO - Running post-action listener: set_extra_try_arguments 21:50:49 INFO - [mozharness: 2017-05-02 04:50:49.802834Z] Finished download-and-extract step (success) 21:50:49 INFO - [mozharness: 2017-05-02 04:50:49.802985Z] Running populate-webroot step. 21:50:49 INFO - Running pre-action listener: _resource_record_pre_action 21:50:49 INFO - Running main action method: populate_webroot 21:50:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:50:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:50:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:50:49 INFO - '--tppagecycles', 21:50:49 INFO - '7'], 21:50:49 INFO - 'tests': ['tsvgm']}}, 21:50:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:50:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:50:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:50:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:50:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['damp', 'tps']}, 21:50:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'tests': ['damp', 'tps']}, 21:50:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['dromaeo_dom']}, 21:50:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:50:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:50:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:50:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['a11yr', 21:50:49 INFO - 'ts_paint', 21:50:49 INFO - 'tpaint', 21:50:49 INFO - 'sessionrestore', 21:50:49 INFO - 'sessionrestore_no_auto_restore', 21:50:49 INFO - 'tabpaint']}, 21:50:49 INFO - 'other-e10s': {'tests': ['a11yr', 21:50:49 INFO - 'ts_paint', 21:50:49 INFO - 'tpaint', 21:50:49 INFO - 'sessionrestore', 21:50:49 INFO - 'sessionrestore_no_auto_restore', 21:50:49 INFO - 'tabpaint']}, 21:50:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:50:49 INFO - 'ts_paint', 21:50:49 INFO - 'tpaint', 21:50:49 INFO - 'sessionrestore', 21:50:49 INFO - 'sessionrestore_no_auto_restore', 21:50:49 INFO - 'tabpaint']}, 21:50:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:50:49 INFO - 'ts_paint', 21:50:49 INFO - 'tpaint', 21:50:49 INFO - 'sessionrestore', 21:50:49 INFO - 'sessionrestore_no_auto_restore', 21:50:49 INFO - 'tabpaint']}, 21:50:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['a11yr', 21:50:49 INFO - 'ts_paint', 21:50:49 INFO - 'tpaint', 21:50:49 INFO - 'sessionrestore', 21:50:49 INFO - 'sessionrestore_no_auto_restore', 21:50:49 INFO - 'tabpaint']}, 21:50:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['a11yr', 21:50:49 INFO - 'ts_paint', 21:50:49 INFO - 'tpaint', 21:50:49 INFO - 'sessionrestore', 21:50:49 INFO - 'sessionrestore_no_auto_restore', 21:50:49 INFO - 'tabpaint']}, 21:50:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:50:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:50:49 INFO - 'bloom_basic_ref']}, 21:50:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['tsvgx', 21:50:49 INFO - 'tsvgr_opacity', 21:50:49 INFO - 'tart', 21:50:49 INFO - 'tscrollx', 21:50:49 INFO - 'cart', 21:50:49 INFO - 'tsvg_static']}, 21:50:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:50:49 INFO - 'tsvgr_opacity', 21:50:49 INFO - 'tart', 21:50:49 INFO - 'tscrollx', 21:50:49 INFO - 'cart', 21:50:49 INFO - 'tsvg_static']}, 21:50:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'talos_options': ['--disable-e10s'], 21:50:49 INFO - 'tests': ['tp5o']}, 21:50:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:50:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'talos_options': ['--disable-e10s', 21:50:49 INFO - '--xperf_path', 21:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:49 INFO - 'tests': ['tp5n']}, 21:50:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:50:49 INFO - 'talos_options': ['--xperf_path', 21:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:49 INFO - 'tests': ['tp5n']}}, 21:50:49 INFO - 'talos.zip': {'path': '', 21:50:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:50:49 INFO - Running post-action listener: _resource_record_post_action 21:50:49 INFO - [mozharness: 2017-05-02 04:50:49.822265Z] Finished populate-webroot step (success) 21:50:49 INFO - [mozharness: 2017-05-02 04:50:49.822366Z] Running create-virtualenv step. 21:50:49 INFO - Running pre-action listener: _resource_record_pre_action 21:50:49 INFO - Running main action method: create_virtualenv 21:50:49 INFO - Creating virtualenv /builds/slave/test/build/venv 21:50:49 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 21:50:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:50:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:50:49 INFO - Using real prefix '/tools/python27' 21:50:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:50:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:50:53 INFO - Installing pip.................done. 21:50:53 INFO - Return code: 0 21:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:50:53 INFO - Reading from file tmpfile_stdout 21:50:53 INFO - Output received: 21:50:53 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) 21:50:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:53 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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:50:53 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 21:50:53 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 21:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:53 INFO - 'HOME': '/Users/cltbld', 21:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:53 INFO - 'LOGNAME': 'cltbld', 21:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:53 INFO - 'MOZ_NO_REMOTE': '1', 21:50:53 INFO - 'NO_EM_RESTART': '1', 21:50:53 INFO - 'PAGER': '/bin/cat', 21:50:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:53 INFO - 'PWD': '/builds/slave/test', 21:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:53 INFO - 'SHELL': '/bin/bash', 21:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:50:53 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:53 INFO - 'USER': 'cltbld', 21:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:53 INFO - 'XPC_FLAGS': '0x0', 21:50:53 INFO - 'XPC_SERVICE_NAME': '0', 21:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:54 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 21:50:54 INFO - Cleaning up... 21:50:54 INFO - Return code: 0 21:50:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:50: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')]} 21:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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')]} 21:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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', '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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:50: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 psutil>=3.1.1 21:50:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:50:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:54 INFO - 'HOME': '/Users/cltbld', 21:50:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:54 INFO - 'LOGNAME': 'cltbld', 21:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:54 INFO - 'MOZ_NO_REMOTE': '1', 21:50:54 INFO - 'NO_EM_RESTART': '1', 21:50:54 INFO - 'PAGER': '/bin/cat', 21:50:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:54 INFO - 'PWD': '/builds/slave/test', 21:50:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:54 INFO - 'SHELL': '/bin/bash', 21:50:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:50:54 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:50:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:54 INFO - 'USER': 'cltbld', 21:50:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:54 INFO - 'XPC_FLAGS': '0x0', 21:50:54 INFO - 'XPC_SERVICE_NAME': '0', 21:50:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:54 INFO - Downloading/unpacking psutil>=3.1.1 21:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:57 INFO - Installing collected packages: psutil 21:50:57 INFO - Running setup.py install for psutil 21:50:58 INFO - building 'psutil._psutil_osx' extension 21:50:58 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 21:50:58 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 21:50:58 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 21:50:58 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 21:50:58 INFO - building 'psutil._psutil_posix' extension 21:50:58 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 21:50:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:50:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:50:58 INFO - ^ 21:50:58 INFO - 1 warning generated. 21:50:58 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 21:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:59 INFO - Successfully installed psutil 21:50:59 INFO - Cleaning up... 21:50:59 INFO - Return code: 0 21:50:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:50: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')]} 21:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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')]} 21:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:00 INFO - 'HOME': '/Users/cltbld', 21:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:00 INFO - 'LOGNAME': 'cltbld', 21:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:00 INFO - 'MOZ_NO_REMOTE': '1', 21:51:00 INFO - 'NO_EM_RESTART': '1', 21:51:00 INFO - 'PAGER': '/bin/cat', 21:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:00 INFO - 'PWD': '/builds/slave/test', 21:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:00 INFO - 'SHELL': '/bin/bash', 21:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:00 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:00 INFO - 'USER': 'cltbld', 21:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:00 INFO - 'XPC_FLAGS': '0x0', 21:51:00 INFO - 'XPC_SERVICE_NAME': '0', 21:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:51:00 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 21:51:00 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 21:51:00 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 21:51:00 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 21:51:00 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 21:51:00 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 21:51:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:51:03 INFO - Installing collected packages: mozsystemmonitor 21:51:03 INFO - Running setup.py install for mozsystemmonitor 21:51:03 INFO - Successfully installed mozsystemmonitor 21:51:03 INFO - Cleaning up... 21:51:03 INFO - Return code: 0 21:51:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:51:03 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')]} 21:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:03 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')]} 21:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:03 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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:03 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 21:51:03 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 21:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:03 INFO - 'HOME': '/Users/cltbld', 21:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:03 INFO - 'LOGNAME': 'cltbld', 21:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:03 INFO - 'MOZ_NO_REMOTE': '1', 21:51:03 INFO - 'NO_EM_RESTART': '1', 21:51:03 INFO - 'PAGER': '/bin/cat', 21:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:03 INFO - 'PWD': '/builds/slave/test', 21:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:03 INFO - 'SHELL': '/bin/bash', 21:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:03 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:03 INFO - 'USER': 'cltbld', 21:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:03 INFO - 'XPC_FLAGS': '0x0', 21:51:03 INFO - 'XPC_SERVICE_NAME': '0', 21:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:03 INFO - Downloading/unpacking jsonschema==2.5.1 21:51:03 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 21:51:03 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 21:51:03 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 21:51:03 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 21:51:03 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 21:51:03 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 21:51:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:51:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:51:06 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 21:51:06 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 21:51:06 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 21:51:06 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 21:51:06 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 21:51:06 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 21:51:06 INFO - Downloading functools32-3.2.3-2.tar.gz 21:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:51:07 INFO - warning: no files found matching '*.txt' 21:51:07 INFO - no previously-included directories found matching 'build' 21:51:07 INFO - no previously-included directories found matching 'dist' 21:51:07 INFO - no previously-included directories found matching '.git*' 21:51:07 INFO - Installing collected packages: jsonschema, functools32 21:51:07 INFO - Running setup.py install for functools32 21:51:07 INFO - warning: no files found matching '*.txt' 21:51:07 INFO - no previously-included directories found matching 'build' 21:51:07 INFO - no previously-included directories found matching 'dist' 21:51:07 INFO - no previously-included directories found matching '.git*' 21:51:07 INFO - Successfully installed jsonschema functools32 21:51:07 INFO - Cleaning up... 21:51:07 INFO - Return code: 0 21:51:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:07 INFO - 'HOME': '/Users/cltbld', 21:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:07 INFO - 'LOGNAME': 'cltbld', 21:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:07 INFO - 'MOZ_NO_REMOTE': '1', 21:51:07 INFO - 'NO_EM_RESTART': '1', 21:51:07 INFO - 'PAGER': '/bin/cat', 21:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:07 INFO - 'PWD': '/builds/slave/test', 21:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:07 INFO - 'SHELL': '/bin/bash', 21:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:07 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:07 INFO - 'USER': 'cltbld', 21:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:07 INFO - 'XPC_FLAGS': '0x0', 21:51:07 INFO - 'XPC_SERVICE_NAME': '0', 21:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:51:07 INFO - Cleaning up... 21:51:07 INFO - Return code: 0 21:51:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:07 INFO - 'HOME': '/Users/cltbld', 21:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:07 INFO - 'LOGNAME': 'cltbld', 21:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:07 INFO - 'MOZ_NO_REMOTE': '1', 21:51:07 INFO - 'NO_EM_RESTART': '1', 21:51:07 INFO - 'PAGER': '/bin/cat', 21:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:07 INFO - 'PWD': '/builds/slave/test', 21:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:07 INFO - 'SHELL': '/bin/bash', 21:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:07 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:07 INFO - 'USER': 'cltbld', 21:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:07 INFO - 'XPC_FLAGS': '0x0', 21:51:07 INFO - 'XPC_SERVICE_NAME': '0', 21:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:10 INFO - Downloading blobuploader-1.2.4.tar.gz 21:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:51:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:51: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 21:51: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 21:51: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 21:51: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 21:51: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 21:51: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 21:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:51:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:11 INFO - Downloading docopt-0.6.1.tar.gz 21:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:51:11 INFO - Installing collected packages: blobuploader, requests, docopt 21:51:11 INFO - Running setup.py install for blobuploader 21:51:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:51:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:51:11 INFO - Running setup.py install for requests 21:51:12 INFO - Running setup.py install for docopt 21:51:12 INFO - Successfully installed blobuploader requests docopt 21:51:12 INFO - Cleaning up... 21:51:12 INFO - Return code: 0 21:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:12 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')]} 21:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:12 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')]} 21:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:12 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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:12 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 21:51:12 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 21:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:12 INFO - 'HOME': '/Users/cltbld', 21:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:12 INFO - 'LOGNAME': 'cltbld', 21:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:12 INFO - 'MOZ_NO_REMOTE': '1', 21:51:12 INFO - 'NO_EM_RESTART': '1', 21:51:12 INFO - 'PAGER': '/bin/cat', 21:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:12 INFO - 'PWD': '/builds/slave/test', 21:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:12 INFO - 'SHELL': '/bin/bash', 21:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:12 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:12 INFO - 'USER': 'cltbld', 21:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:12 INFO - 'XPC_FLAGS': '0x0', 21:51:12 INFO - 'XPC_SERVICE_NAME': '0', 21:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ymDNZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-typpqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-lyCZQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7jMFGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-2Rlvzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-O4dkXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-mADCLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-RYozTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-76impZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-sfBnz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:13 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-KpoUuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ZlH8_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-m_Wjyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Ejt8Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-xgT_hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Hhkw5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:14 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ftCPqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:51:14 INFO - Running setup.py install for manifestparser 21:51:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:51:14 INFO - Running setup.py install for mozcrash 21:51:14 INFO - Running setup.py install for mozdebug 21:51:15 INFO - Running setup.py install for mozdevice 21:51:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Running setup.py install for mozfile 21:51:15 INFO - Running setup.py install for mozhttpd 21:51:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Running setup.py install for mozinfo 21:51:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Running setup.py install for mozInstall 21:51:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:51:15 INFO - Running setup.py install for mozleak 21:51:15 INFO - Running setup.py install for mozlog 21:51:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:51:16 INFO - Running setup.py install for moznetwork 21:51:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:51:16 INFO - Running setup.py install for mozprocess 21:51:16 INFO - Running setup.py install for mozprofile 21:51:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:51:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:51:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:51:16 INFO - Running setup.py install for mozrunner 21:51:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:51:16 INFO - Running setup.py install for mozscreenshot 21:51:16 INFO - Running setup.py install for moztest 21:51:17 INFO - Running setup.py install for mozversion 21:51:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:51:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:51:17 INFO - Cleaning up... 21:51:17 INFO - Return code: 0 21:51:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:17 INFO - 'HOME': '/Users/cltbld', 21:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:17 INFO - 'LOGNAME': 'cltbld', 21:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:17 INFO - 'MOZ_NO_REMOTE': '1', 21:51:17 INFO - 'NO_EM_RESTART': '1', 21:51:17 INFO - 'PAGER': '/bin/cat', 21:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:17 INFO - 'PWD': '/builds/slave/test', 21:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:17 INFO - 'SHELL': '/bin/bash', 21:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:17 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:17 INFO - 'USER': 'cltbld', 21:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:17 INFO - 'XPC_FLAGS': '0x0', 21:51:17 INFO - 'XPC_SERVICE_NAME': '0', 21:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_3KBfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:17 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)) 21:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-pANChT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:17 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)) 21:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Z_IVXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:17 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)) 21:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Z_Thq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:17 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)) 21:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vPt6mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-CpNKDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-mRF8JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-SeOpWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EKe0w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:18 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)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_6AH94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:18 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)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-QjM4ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:18 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)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-eDB_Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:18 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)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Kk8ibK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:18 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)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-BCmjat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:51:18 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)) 21:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:18 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-taX1hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:51:19 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-as5F7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:51:19 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-GgFOo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:51:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:21 INFO - Downloading blessings-1.6.tar.gz 21:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:51:21 INFO - Installing collected packages: blessings 21:51:21 INFO - Running setup.py install for blessings 21:51:22 INFO - Successfully installed blessings 21:51:22 INFO - Cleaning up... 21:51:22 INFO - Return code: 0 21:51:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:22 INFO - Reading from file tmpfile_stdout 21:51:22 INFO - Current package versions: 21:51:22 INFO - blessings == 1.6 21:51:22 INFO - blobuploader == 1.2.4 21:51:22 INFO - docopt == 0.6.1 21:51:22 INFO - functools32 == 3.2.3-2 21:51:22 INFO - jsonschema == 2.5.1 21:51:22 INFO - manifestparser == 1.1 21:51:22 INFO - mozInstall == 1.12 21:51:22 INFO - mozcrash == 1.0 21:51:22 INFO - mozdebug == 0.1 21:51:22 INFO - mozdevice == 0.50 21:51:22 INFO - mozfile == 1.2 21:51:22 INFO - mozhttpd == 0.7 21:51:22 INFO - mozinfo == 0.9 21:51:22 INFO - mozleak == 0.1 21:51:22 INFO - mozlog == 3.4 21:51:22 INFO - moznetwork == 0.27 21:51:22 INFO - mozprocess == 0.25 21:51:22 INFO - mozprofile == 0.28 21:51:22 INFO - mozrunner == 6.13 21:51:22 INFO - mozscreenshot == 0.1 21:51:22 INFO - mozsystemmonitor == 0.3 21:51:22 INFO - moztest == 0.8 21:51:22 INFO - mozversion == 1.4 21:51:22 INFO - psutil == 3.1.1 21:51:22 INFO - requests == 1.2.3 21:51:22 INFO - wsgiref == 0.1.2 21:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 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 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:22 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 21:51:22 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 21:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:22 INFO - 'HOME': '/Users/cltbld', 21:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:22 INFO - 'LOGNAME': 'cltbld', 21:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:22 INFO - 'MOZ_NO_REMOTE': '1', 21:51:22 INFO - 'NO_EM_RESTART': '1', 21:51:22 INFO - 'PAGER': '/bin/cat', 21:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:22 INFO - 'PWD': '/builds/slave/test', 21:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:22 INFO - 'SHELL': '/bin/bash', 21:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:22 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:22 INFO - 'USER': 'cltbld', 21:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:22 INFO - 'XPC_FLAGS': '0x0', 21:51:22 INFO - 'XPC_SERVICE_NAME': '0', 21:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:51:22 INFO - Cleaning up... 21:51:22 INFO - Return code: 0 21:51:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10218eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102191768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602d583d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, '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.XzByr4iqlL/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.Rr3mA0eofC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 21:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:22 INFO - 'HOME': '/Users/cltbld', 21:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:22 INFO - 'LOGNAME': 'cltbld', 21:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:22 INFO - 'MOZ_NO_REMOTE': '1', 21:51:22 INFO - 'NO_EM_RESTART': '1', 21:51:22 INFO - 'PAGER': '/bin/cat', 21:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:22 INFO - 'PWD': '/builds/slave/test', 21:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:22 INFO - 'SHELL': '/bin/bash', 21:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:22 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:22 INFO - 'USER': 'cltbld', 21:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:22 INFO - 'XPC_FLAGS': '0x0', 21:51:22 INFO - 'XPC_SERVICE_NAME': '0', 21:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:51:22 INFO - Cleaning up... 21:51:22 INFO - Return code: 0 21:51:22 INFO - Running post-action listener: _resource_record_post_action 21:51:22 INFO - Running post-action listener: _start_resource_monitoring 21:51:23 INFO - Starting resource monitoring. 21:51:23 INFO - [mozharness: 2017-05-02 04:51:23.005056Z] Finished create-virtualenv step (success) 21:51:23 INFO - [mozharness: 2017-05-02 04:51:23.005981Z] Running install step. 21:51:23 INFO - Running pre-action listener: _resource_record_pre_action 21:51:23 INFO - Running main action method: install 21:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:51:23 INFO - Reading from file tmpfile_stdout 21:51:23 INFO - Detecting whether we're running mozinstall >=1.0... 21:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:51:23 INFO - Reading from file tmpfile_stdout 21:51:23 INFO - Output received: 21:51:23 INFO - Usage: mozinstall [options] installer 21:51:23 INFO - Options: 21:51:23 INFO - -h, --help show this help message and exit 21:51:23 INFO - -d DEST, --destination=DEST 21:51:23 INFO - Directory to install application into. [default: 21:51:23 INFO - "/builds/slave/test"] 21:51:23 INFO - --app=APP Application being installed. [default: firefox] 21:51:23 INFO - mkdir: /builds/slave/test/build/application 21:51:23 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'] 21:51:23 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 21:51:43 INFO - Reading from file tmpfile_stdout 21:51:43 INFO - Output received: 21:51:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:51:43 INFO - Running post-action listener: _resource_record_post_action 21:51:43 INFO - [mozharness: 2017-05-02 04:51:43.228163Z] Finished install step (success) 21:51:43 INFO - [mozharness: 2017-05-02 04:51:43.228314Z] Running run-tests step. 21:51:43 INFO - Running pre-action listener: _resource_record_pre_action 21:51:43 INFO - Running main action method: run_tests 21:51:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:51:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:51:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:51:43 INFO - 2017-05-01 21:51:43.242 screenresolution[1630:7494] starting screenresolution argv=screenresolution get 21:51:43 INFO - 2017-05-01 21:51:43.245 screenresolution[1630:7494] Display 0: 1600x1200x32@60 21:51:43 INFO - 2017-05-01 21:51:43.251 screenresolution[1631:7496] starting screenresolution argv=screenresolution list 21:51:43 INFO - Available Modes on Display 0 21:51:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:51:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:51:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:51:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:51:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:51:43 INFO - Intel Iris: 21:51:43 INFO - Chipset Model: Intel Iris 21:51:43 INFO - Type: GPU 21:51:43 INFO - Bus: Built-In 21:51:43 INFO - VRAM (Dynamic, Max): 1536 MB 21:51:43 INFO - Vendor: Intel (0x8086) 21:51:43 INFO - Device ID: 0x0a2e 21:51:43 INFO - Revision ID: 0x0009 21:51:43 INFO - Displays: 21:51:43 INFO - Display: 21:51:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:51:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:51:43 INFO - Display Serial Number: 1600x1200 60 21:51:43 INFO - Main Display: Yes 21:51:43 INFO - Mirror: Off 21:51:43 INFO - Online: Yes 21:51:43 INFO - Rotation: Supported 21:51:43 INFO - Return code: 0 21:51:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:51:43 INFO - Python 2.7.3 21:51:43 INFO - Return code: 0 21:51:43 INFO - grabbing minidump binary from tooltool 21:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:43 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 0x101f6cd30>, '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 0x101e92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f61be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:51:43 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 21:51:43 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 21:51:43 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 21:51:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:51:43 INFO - Return code: 0 21:51:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:51:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:51:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:51:43 INFO - ENV: RUST_BACKTRACE is now 1 21:51:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:51:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:51:43 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/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 21:51:43 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/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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 21:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XzByr4iqlL/Render', 21:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:43 INFO - 'HOME': '/Users/cltbld', 21:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:43 INFO - 'LOGNAME': 'cltbld', 21:51:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:51:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:43 INFO - 'MOZ_NO_REMOTE': '1', 21:51:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:51:43 INFO - 'NO_EM_RESTART': '1', 21:51:43 INFO - 'PAGER': '/bin/cat', 21:51:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:43 INFO - 'PWD': '/builds/slave/test', 21:51:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:43 INFO - 'RUST_BACKTRACE': '1', 21:51:43 INFO - 'SHELL': '/bin/bash', 21:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rr3mA0eofC/Listeners', 21:51:43 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 21:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:43 INFO - 'USER': 'cltbld', 21:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:43 INFO - 'XPC_FLAGS': '0x0', 21:51:43 INFO - 'XPC_SERVICE_NAME': '0', 21:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:43 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/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 21:51:43 INFO - mozversion application_buildid: 20170501200621 21:51:43 INFO - mozversion application_changeset: 2e7c10a9b86e30691f67855f6c8f98d984508d7c 21:51:43 INFO - mozversion application_display_name: Nightly 21:51:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:51:43 INFO - mozversion application_name: Firefox 21:51:43 INFO - mozversion application_remotingname: firefox 21:51:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:51:43 INFO - mozversion application_vendor: Mozilla 21:51:43 INFO - mozversion application_version: 55.0a1 21:51:43 INFO - mozversion platform_buildid: 20170501200621 21:51:43 INFO - mozversion platform_changeset: 2e7c10a9b86e30691f67855f6c8f98d984508d7c 21:51:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:51:43 INFO - mozversion platform_version: 55.0a1 21:51:43 INFO - using testdate: 1493700703 21:51:43 INFO - actual date: 1493700703 21:51:43 INFO - starting webserver on 'localhost:49234' 21:51:43 INFO - SUITE-START | Running 2 tests 21:51:43 INFO - TEST-START | dromaeo_css 21:51:43 INFO - operating with platform_type : mac_ 21:51:43 INFO - Initialising browser for dromaeo_css test... 21:51:43 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpcsKFC6/profile http://localhost:49234/getInfo.html) 21:51:46 INFO - PID 1641 | 2017-05-01 21:51:46.618 plugin-container[1643:7681] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983b, name = 'com.apple.tsm.portname' 21:51:46 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:46 INFO - PID 1641 | 2017-05-01 21:51:46.620 plugin-container[1643:7681] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4927, name = 'com.apple.CFPasteboardClient' 21:51:46 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:46 INFO - PID 1641 | 2017-05-01 21:51:46.620 plugin-container[1643:7681] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:51:46 INFO - PID 1641 | __metrics Screen width/height:1600/1200 21:51:46 INFO - PID 1641 | colorDepth:24 21:51:46 INFO - PID 1641 | Browser inner width/height: 1024/689 21:51:46 INFO - PID 1641 | __metrics 21:51:47 INFO - TEST-INFO | 1641: exit 0 21:51:47 INFO - Browser initialized. 21:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 21:51:47 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpcsKFC6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:50 INFO - PID 1644 | 2017-05-01 21:51:50.145 plugin-container[1645:7813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 21:51:50 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:50 INFO - PID 1644 | 2017-05-01 21:51:50.146 plugin-container[1645:7813] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 21:51:50 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:50 INFO - PID 1644 | 2017-05-01 21:51:50.146 plugin-container[1645:7813] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:51:59 INFO - PID 1644 | RSS: Main: 235073536 21:51:59 INFO - PID 1644 | 21:55:03 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 21:55:05 INFO - PID 1644 | RSS: Main: 251990016 21:55:05 INFO - PID 1644 | 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 21:56:48 INFO - PID 1644 | 21:56:48 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:48 INFO - PID 1644 | Full stack: 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 21:56:48 INFO - PID 1644 | 21:56:48 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:48 INFO - PID 1644 | Full stack: 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 21:56:48 INFO - PID 1644 | 21:56:48 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:48 INFO - PID 1644 | Full stack: 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | ************************* 21:56:48 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 21:56:48 INFO - PID 1644 | 21:56:48 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:48 INFO - PID 1644 | Full stack: 21:56:48 INFO - PID 1644 | ************************* 21:58:06 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 21:58:07 INFO - PID 1644 | RSS: Main: 257781760 21:58:07 INFO - PID 1644 | 22:01:09 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 22:01:10 INFO - PID 1644 | RSS: Main: 266612736 22:01:10 INFO - PID 1644 | 22:04:12 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 22:04:12 INFO - PID 1644 | RSS: Main: 259801088 22:04:12 INFO - PID 1644 | 22:07:15 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 22:07:16 INFO - PID 1644 | RSS: Main: 268947456 22:07:16 INFO - PID 1644 | 22:10:17 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 22:10:18 INFO - PID 1644 | RSS: Main: 264417280 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | __start_tp_report 22:10:18 INFO - PID 1644 | _x_x_mozilla_page_load 22:10:18 INFO - PID 1644 | _x_x_mozilla_page_load_details 22:10:18 INFO - PID 1644 | |i|pagename|runs| 22:10:18 INFO - PID 1644 | |0;dojo.html;3032.6209223847018;3614.548181477314;3642.4900513928073;3688.2807852468777;3693.445983102535;6240.18877545919;6246.250449946007;6274.2470903491585;6300;6303.495720342373;6102.701334035026;6228.096925945735;6233.065040243954;6285.402886725765;6311.179546658939;5458.2904222451225;5477.452254774531;5531.751071201786;5584.106542953128;5639.520640745521;5458.4541545845495;5510.531604813596;5624.859378515549;5641.435856414367;5661.264035675356;5546.251256080418;5564.86087847803;5575.553955683536;5588.776448942038;5683.971580142114;5374.677519348852;5478.369987451454;5479.232907392969;5489.1217405215375;5495.203195536665;5371.919421208685;5452.454754524516;5475.342958844924;5497.367802702701;5502.944970550283;5128.2564028216075;5754.050581654022;6237;6243.313235544087;6269.404406581368;6716.5634233774645;6772.356626120511;6775.661216939134;6792.320767923217;6816.182058153004;6637.535372523926;6695.966520167368;6789.219239787439;6865.622390768505;6878;6346.460550853137;6355.745770169234;6358.809235722936;6379.553431259814;6419.16550848396;7066.611336376549;7073.575585464889;7076.964615176994;7080.575165490087;7142.5000249982;6400.9039864402075;6490.0589414534625;6652.467802575782;6677.866442671119;6720.193576770721;6694.497912656473;6759.256481787;6780.796576102724;6860.759873404407;6880.724771009203;5612.270404847425;6417.294097649255;6758.425533829582;6768.052472653832;6768.492363072691;6740.797776066725;6746.763863264762;6798.116244888133;6823.69293381799;6830.829229269308;5265.947340526545;5343.70609616467;5347.465253474699;5389.434109418533;5410.269613602192;4760.666753327234;4791.089692958327;4799.952000480021;4847.466778654345;4924.409070911442;5945.583809133405;6007.429294217042;6460.967695161494;6483.189601299838;6512.381323774234;6626.9337306627285;6762.323767623297;6786.694598743068;6798;6906.240313565504;6396.264429590564;6458.38645328693;6465.806025819139;6505.121808555785;6517.706703198272;6007.459328660354;6090.512758979271;6104.725287362079;6104.725287362079;6131.846703832351;6827.93172068273;6851.212110607344;7025.297470252934;7099.290070992859;7111.92888071123;5683.573731970201;6836.453083753388;6841.589504629738;6875.621840798804;6888.758893438706;7046.2249152594195;7095.609741464269;7097.574145551283;7101.928980710127;7127.465440092117;6404.295527491879;6577.309382514767;6634.668266586747;6767.1879374475375;6815.965920170367;6759.831004224934;6808.693608787517;6843.7604683835825;6863.725450981905;6875.48433867472;6541;6610.10763546915;6661.566998145105;6661.766838160641;6663.46692264608;6348.968255158695;6468.417842394207;6554.246261679968;6610.933890661032;6661.766838160641;5940.762369505172;6096.738245038883;6418.101465794699;6483.351664833479;6544.116544266463;6630.9668451657435;6660.933390666031;6662.800115996528;6691.966540167268;6707.966460167668;6210.161628180319;6364.681765911593;6395.16862807832;6480.935190648033;6481.8703625928165 22:10:18 INFO - PID 1644 | |1;ext.html;746.3805041815294;795.5505139596128;820.8891799607052;1195.2589394575364;1266.2276011632907;24651;32883.50674739881;35735;36172.276554468925;36178;27258;36273;36715.632843671556;36738;36740.89777306685;6825.6587170641515;7663.3869290456905;7812.960935195344;7897.170797066312;8067.959660201691;7111.324424179695;7951.244631760002;8001.079875814268;8149.674013039471;8160.9591952040455;7190.8561828763395;7800.570968596725;8127.512349259034;8128.30909372704;8164.265216130547;7308.890366644505;7717.765157574817;8111.067227268851;8143.0228372595375;8149;7340.155882073523;7592.278733520307;8090;8096;8112.797180070486;35588.64411355905;35779.64220357789;35927.4610880837;35950.82024589887;35999;3110.626724793039;3598.5501812273465;3641.198936234024;3643.617420170897;3644.1436262478296;29042.983495577555;29180.832766689306;29376.70623293761;29477.557836632466;29553.85223073871;3100.3644252928098;3138.8901388451295;3142.025971948703;3147.512135618983;3160.5259211118287;299230;301020;301115;305716.9999999978;307063;45526.54473455223;45608;45645.771771140935;45645.85885352893;45765;46412.83967900829;47745.5225447748;50222;50475.24287135696;50498.74750626223;14191.71616567663;14250.714985700228;14278.928605356907;14309;14316.141031538142;11588.76822463546;11591.24656897299;11591.304521728724;11594.71013224676;11607.129465290138;13087.345632718516;13286.867131328756;13287.402066907012;13323.600291991255;13385.063045586716;5972.731227094791;5985.102234664835;5998.1602575639445;6006.909896351558;6028.487578555784;970.2529052629436;976.9902300977042;989.0900371657948;1006.8741407324085;1021.3922715983978;23853;23859.880700596732;24003.63994540083;24076.157334493208;24106;927.2813569483704;940.3793496292415;1038.127972503101;1124.780667769777;1134.8581427321585;10921.798602153756;11809;12161.878381216251;12277.877221227853;12293.692657683629;337516;338627;340178;340355;340822;51303.486965130614;51493.227601586004;51608.22587661188;51705.224421633706;51711.74144129255;1462.590474667095;1513.7805018272288;1518.5596177108737;1520.9543713688606;1531.119606226402;16367.754483682516;23544.6468302979;23584.938677759197;23629.527409452057;23774.762252377946;35867.28265434729;36816;36908.89273321805;36966.44550331801;37007;286922.56538717175;287787;287971;288215;288714;33390.66609333973;33709.49435758417;33794;33806.661933380354;33840.661593384735;41324.793376032925;41800.3729944045;41858;42881;42976.92557686083;29266.70733292725;29696.406071878875;30217.244568885955;30477.695223047485;30699;29600.555991659712;29617.111486655434;30056.948006819657;30504.542431863098;31193.8440307797;36169.63830361663;36233.91298261056;36294.91115266546;36343.63656363508;36671.449928250564;24152.91311890934;24573;28935.85532072326;30384.696153038185;30828.53757193599;20889.642173259297;23367.649485257396;23884.88057559701;24053.398665033514;24315.75684243135 22:10:18 INFO - PID 1644 | |2;jquery.html;432.450787499875;440.9007973206029;441.37545373296774;456.9840055598054;457.83975608537037;16363.83636163638;19777.11003004863;21584.352469425903;21845.563088738214;21883.781162188374;21430.03564839582;22910.96900639471;23289.650655240144;23384.713840738754;23678.88160559195;5912.586118971673;6146.078088286748;6157.661328626924;6157.692115394235;6167.568270221086;5829.475347218749;6086.7565297388055;6136.8465788355425;6147.415995480422;6158.230221222348;6062.42406971337;6063.545234107438;6088.908666369985;6115.571909966304;6134.877302453949;5768.538516918637;5826.941730582682;6120.816375508742;6140.754369825224;6147.323794382614;5219.556337711299;5404.405515393303;5466.01611709892;5474.562035037187;5493.697846618435;28011.719882801113;28358.574621380696;28401.005964791133;28450.146495605164;28752;2198.1866709317655;2255.988720056406;2269.6028195065796;2271.943201419961;2282.8630282182958;17551.210195541233;17689.911550442295;17730;17835.197416116178;17962;1722.2249987505672;2143.957120857574;2156.7304086989125;2197.165077270643;2201.9779802201933;132698;157324;157800;159433;163439;10713.35719856811;12283.815742763865;12877.871221287854;12918.870811291954;13004;16466.6706665866;16804.159792010596;16805.41181058657;16824.812774339258;16827.663446730996;8921.286297096216;9185.494797786187;9190.310726695525;9198.402103863227;9204.217641500414;7193.424526037905;8692.78268043304;8695;8789.516576588221;8939.463632182089;8018.879716804253;8149.755507334789;8167.63245653947;8189.385796065319;8194.918050819535;1921.6644432119542;1954.7752008519203;2057.2182570623067;2134.51973306008;2156.1914282144194;832.8375966686559;906.5376657904384;909.8217807938735;958.4153666263574;968.1770495079268;21012.369628911158;21532.89233553822;21583.352499424727;21673.916304184728;22055.22806701758;988.8467287570438;995.6863587969766;1000.8248556502583;1016.004315770549;1018.4449475036123;10575.947120264349;10770.407627580558;11231.438428078727;11263.155263355282;11271.605493807678;543079;545143;548365;556134;556581;132682;136326;137277.3136134313;138252;140749;1186.9287842729464;1221.7617564574823;1250.206119114369;1254.5922575163108;1255.604484587352;21948.451288717908;22850.08846549814;23203.651945221172;23245.070197191922;23645.408864778517;57082.1254110261;57511.71244143753;57572;57766.42233577611;58240.70879645574;76544;76719.23280767121;77813;80145.59927200327;80378.19621803708;7996.200379961957;9066.138716821892;9101.226395756436;9231.446113233227;9276;14149;14317.284135792961;14373.640658983191;14602.561923142322;14748.262586870827;10583.682489525327;11967.461464233957;12014.067576025776;12165.69585760363;12251.877481225074;11139.610113645984;11153.665390038312;11453.484593193492;11535.307881527135;11639.185257032264;11896.22674526153;12034.939825300817;12145.089118315986;12331.075169362513;12352.938235308766;7098.858022839618;8792.252658524098;8838.469691818511;9254.241694078373;9258.35191536586;11296.03983661398;11820.468078936641;12057.397130143634;12328.568500102454;12561.685957851127 22:10:18 INFO - PID 1644 | |3;mootools.html;1302.6352621266046;1415.2852809331287;1429.6568823482366;1447.442734547199;1451.5427640293308;9130.954345228272;11646.184767066308;11843.052555795548;11856.7628647427;11929.522819087226;11612.593559225408;11776.7644647107;11802.881971180286;11849.348285844275;11887.821682674767;2507.34808949673;2550.1839411388364;2550.4389034412397;2550.5536531107073;2559.923202303934;2466.5930121529927;2519.735427780084;2523.1925783749207;2525.103588226181;2527.2670925431603;1873.6252749450096;2411.288669842401;2478.6405971134177;2491.9750802492017;2522.255934499327;2450.803935685141;2470.4441500662206;2495.7504249575077;2505.1732928133674;2505.361132911114;2418.467937053845;2487.601983682602;2491.9252422427357;2507.5987841945384;2525.7726804587674;11866;11893.286402815773;11936.522539098425;11957.581484647995;11968.34174120423;6510.511711621647;6737.090492783461;6742.359475849787;6777;6799.626020568867;3737.8878633641034;3835.386338185877;4291.034517233628;4359.215341238576;4361.193179261847;1262.236347010064;1278.9951179213597;1279.349638965733;1294.4951468927127;1296.5526893221822;16221.432249871315;16257;16363.754543681735;16534.338626454926;16836.74744878828;5439.755211015514;5495.340559132929;5655.660660360391;5664.631798933056;5664.971675141598;11638.476268567934;11684.415779211005;11745.530178792924;11761.176717629854;11788.351640659674;6583.177102862142;6608.702608382634;6620.2386725527185;6629.933700662931;6648.33516648341;6005.879882402328;6122.632642041492;6216.906746398808;6319.968400158062;6343.1436756038265;4199.790010499462;4275.893102672396;4321.978390108029;4343.131373725268;4354.477462704495;1248.2836100362001;1271.097520760252;1272.63093702827;1286.2604002698486;1286.8777466140702;623.03118650498;772.3820943245381;796.7171654062724;799.1409235072321;799.9160088190772;5587.469190426903;6570.737170513222;6711.228208756055;6734.461243100638;6786.8303292417095;794.9682012719427;906;913.2921985461321;929.0941332201049;940.5579377692474;3848.037990502374;3877.5734669186368;3881.204353107606;4273.273543497613;4342.435483387139;14862.331195096247;15074.397024118913;15212.315445804965;15263.465778697693;15384;14655.633609159857;14999.850001500063;15008.099514029193;15178.24108794578;15186.46847360337;8280.213379728915;8468.110848360957;8670.263027642595;8699.173578510032;8767.912320876838;6528.281888992302;6826.863462730618;6847.897281540881;7090.822729431599;7105.8630619100695;13316.667083322995;13383.464661413434;13439.596812095653;13603.659908502366;13904.791428128385;13610.659733506742;13777.242251676254;13858.4456621734;13986.020978531405;14184.078034927697;9414.62341506332;9429.811403772022;9514.143727064597;9573;9590.280728945218;10747.677569672922;10749.14006879432;10883;10883.23817332779;10888.945555272174;9124.817503650023;9127.22418594427;9178.954105229432;9266.860997084914;9318.440893546409;9060.63757449721;9062.184403403462;9107.59015844302;9171.266298695955;9252.676156334495;8034.959825200836;8210.466319689202;8215.137410571804;8232.670693172446;8233.34133269325;5639.295088113986;6014.278286605635;6042;6205.231509019907;6229.750809967551;6081.787137450168;6102.755889764359;6268.153799237227;6295.464885484785;6305.5270854687 22:10:18 INFO - PID 1644 | |4;prototype.html;388.31041822470246;392.3859160413952;414.815407143821;419.45470887845795;421.87765547991086;4845.449456174026;6247.468965137969;6384.488531307779;6422.197225346832;6478.643674597895;5041.344625198719;5703.973284808732;6174.845628859281;6275.497960163188;6336.651484168369;4510.751908645023;4552.362669226311;4562.520935301795;4568.817247310104;4580.633549316047;3903.2193561287713;4458.687891847572;4493.0115374617535;4515.909681806362;4522.095580883836;3905.7265991380614;4075.655033838841;4485.080558485519;4493.842715504958;4496.673481323018;4345.261305578059;4414.183376075436;4472.884945849826;4494.16857881293;4496.595306422438;3768.9623103768886;3807.390817469219;3836.3478208704587;3855.633714797118;3856.1323702166787;6078.601921558066;6111.54163437744;6133.926562851483;6134.447899689049;6162.291336496315;4727.983483551018;5100.642954993152;5380.811671591515;5384.811531596375;5395.379531353866;5614.6631202128;5689.800856970028;6339.36606339367;6496.967515162394;6675.566088204251;3458.858576669693;3633.6729694327637;4288.142371525707;4357.760323182224;4367.67242456817;5179.559737422323;5795.420457954171;6587.868242635121;6738.494612904003;7209.170945341248;4067.389891516237;4083.4487344208746;4366.345048242725;4419.9779001105435;4453.688241823042;3706.870259540903;4492.842750503782;4517.6160026397465;4536.364908912755;4536.500984891659;4236.195122926696;4960.379952505937;5397.649152805055;5425.484578964992;5429.077056900336;6153.661548614779;6189.6286222826775;6256.968715156486;6762.594244345355;6824.590524568542;1425.8521889878539;1455.4760286296926;1518.1953564610774;1541.5817447947916;1545.3663997760864;839.7816567692322;970.8593443972343;1000.1898462245605;1009.6920439266095;1014.1734486393713;6376.936230637727;6383.425491705676;6403.711832967528;6405.839854003687;6432.935670643327;6860.862782744417;6957.443404527626;6972.1981972072845;7039.049728286615;7070.292970702992;6311.181735050321;6381.872362552723;6427.357264273629;6493.610383377012;6494.285628580852;3473.3574288756663;3628.077119126867;3667.009907325007;3686.64976827201;3693.4829123922673;5703;6686.96656516724;7262.891056634155;7297.197308296083;7302.342789149002;5917.875603635295;6476.384743449365;6584.934150658528;6626.319521426946;7269.8546029079125;6305.959516679788;7250.891236631454;7312.195658477457;7320;7327.4720221523485;7050.823729406806;7065.505414621133;7072.575645461289;7081.433485321265;7199.496035277481;6767.593944363157;6856.617555219129;6944.4444444445335;6960.651967401711;6984.6158461283085;6143.447089761943;6366.236051673829;6934.133233345832;7356.388482088995;7437.70249190048;3780.4707340972836;4418.8453404130705;4457.04173602677;4458;4517.5030746617185;6844.555103918229;7063.481351509245;7102.680379382837;7136.6483829390845;7154.35610795031;5632.929743348751;6624;6777.593344399352;6796.898046529405;6860.279670634512;6418.326075761977;6689.331066893272;6808.319168083152;6830.658467076726;6831;6063.059820857459;6105.603135796159;6273.9372606273355;6691.464682825265;6723;6609.3060228675295;6812.897806533005;6825.385715285648;6839.435211795577;6843.657817109025;5388.488093631099;5488.204210389391;6177.918864198837;6596.868062638624;6632.767853125118 22:10:18 INFO - PID 1644 | |5;yui.html;801.5951944268147;811.9675212991481;817.9427440079197;844.1558441558442;865.7878819689175;15967.600809979742;16379.918100409512;16449.83550164498;18354.908225458887;19552.31566895159;15303.617409564766;15592.84407155928;17284.740728889075;18396.988165650884;18745.343912963013;972.3193764364937;1000.6497725795949;1002.5889385352007;1004.2417974429333;1007.1892126837893;969.4764826993415;1019.2610357490834;1022.2895087913903;1025.1337619711333;1027.1064174168484;1065.440643662076;1068.8931106889327;1069.6042464288225;1071.5553045486115;1072.7479042425025;1067.556963860005;1071.7320669832543;1072.9946350268237;1073.8603981482436;1074.7796701676139;773.8993930789018;777.5762209595783;787.8896954426385;791.3194652598761;794.8688466403037;15323.157226352547;15601.765973510406;16102.114383708891;16817.747733784003;16990.660186796318;16878.240479178465;17132.743008854875;17435;17573;17702.468925932244;13867.37596808146;14075.648108797259;14213.644658883508;14222.857771422257;14441.422343106264;3554.697850682695;3564.4475106358295;3572.6605972432576;3573.0888623401124;3578.58846232684;122571;123476.38261808634;134599;135005;136083.31958340146;12996.805047924288;13443.327833608477;13445.058845880694;13573.914086873026;13630.454781808816;19716.901415493117;24862.881170347377;25498.745012550007;25507.872460637576;25725;6708.396244338033;7906.960465197637;8015.719449819228;8017.639206235734;8030.83938321242;3480.738944579167;3941.7832019238645;4023.517177938666;4034;4035.0315924177985;4130.545639979599;4258.446401967724;4297.290946993711;4297.935530967038;4298.656107511391;876.0205013798942;909.9135582119688;912.8995810460844;914.679862048291;914.977125571866;544.2625242796033;635.8505751148476;648.4682560300603;661.6129564204898;685.2975699907535;10994.725131871768;11197.66407007791;11284.71788205285;11436.142289328334;11724.706882327839;637.7066549387241;639.859230969186;651.7686221391338;673.4309508465338;674.6289540752566;4685.8594242172785;6008.3390827009;6152.077188421773;6170.969145154246;6245.156903817927;101223;101532.47701284487;101649.49175254077;104070;106893;88109;89417.65873511902;89480;92507.07492925119;93746.53126734322;83244.6702131908;83340.58329708313;83646;84558;85418.14581854227;12244.122631181843;12570.622881313575;12730.981521478445;12757.617271481871;12783.977281817619;40802;40846.1830763389;41172.38241426321;42016.78991605023;42027.57972420237;51668;55145.345639630876;55274.44725552854;55853;57256.42743572678;13348.532801351907;13802.516911908035;16705.498835034967;17197.312107515558;17199.57001074983;18018.72971905396;18241.54396140054;18577.989640193242;18609.720854187468;18740.531486712942;16489.422870199487;17345.306187752347;17365.913170434065;17414.303427862742;17418.82581174172;16249.512514624581;16478.83521164773;17275;17350;17557.473275801745;16164.595885102966;16462.341506339613;16648.08435536057;16995.745063823804;17106.828931710523;11611.187216894736;11712.941435292769;12404.317762522787;12413.44139513742;12429.564965226175;12691.555795547112;13285.202887826761;13293.667658308234;13435.328233588478;13639.931800341332 22:10:18 INFO - PID 1644 | __end_tp_report 22:10:18 INFO - PID 1644 | __start_cc_report 22:10:18 INFO - PID 1644 | _x_x_mozilla_cycle_collect,419 22:10:18 INFO - PID 1644 | __end_cc_report 22:10:18 INFO - PID 1644 | __startTimestamp1493701818110__endTimestamp 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | ------- Summary: start ------- 22:10:18 INFO - PID 1644 | Number of tests: 6 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6233.82 Median:6465.81 stddev:751.89 (11.6%) stddev-sans-first:711.02 22:10:18 INFO - PID 1644 | Values: 3032.6 3614.5 3642.5 3688.3 3693.4 6240.2 6246.3 6274.2 6300.0 6303.5 6102.7 6228.1 6233.1 6285.4 6311.2 5458.3 5477.5 5531.8 5584.1 5639.5 5458.5 5510.5 5624.9 5641.4 5661.3 5546.3 5564.9 5575.6 5588.8 5684.0 5374.7 5478.4 5479.2 5489.1 5495.2 5371.9 5452.5 5475.3 5497.4 5502.9 5128.3 5754.1 6237.0 6243.3 6269.4 6716.6 6772.4 6775.7 6792.3 6816.2 6637.5 6696.0 6789.2 6865.6 6878.0 6346.5 6355.7 6358.8 6379.6 6419.2 7066.6 7073.6 7077.0 7080.6 7142.5 6400.9 6490.1 6652.5 6677.9 6720.2 6694.5 6759.3 6780.8 6860.8 6880.7 5612.3 6417.3 6758.4 6768.1 6768.5 6740.8 6746.8 6798.1 6823.7 6830.8 5265.9 5343.7 5347.5 5389.4 5410.3 4760.7 4791.1 4800.0 4847.5 4924.4 5945.6 6007.4 6461.0 6483.2 6512.4 6626.9 6762.3 6786.7 6798.0 6906.2 6396.3 6458.4 6465.8 6505.1 6517.7 6007.5 6090.5 6104.7 6104.7 6131.8 6827.9 6851.2 7025.3 7099.3 7111.9 5683.6 6836.5 6841.6 6875.6 6888.8 7046.2 7095.6 7097.6 7101.9 7127.5 6404.3 6577.3 6634.7 6767.2 6816.0 6759.8 6808.7 6843.8 6863.7 6875.5 6541.0 6610.1 6661.6 6661.8 6663.5 6349.0 6468.4 6554.2 6610.9 6661.8 5940.8 6096.7 6418.1 6483.4 6544.1 6631.0 6660.9 6662.8 6692.0 6708.0 6210.2 6364.7 6395.2 6480.9 6481.9 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:45092.83 Median:33823.66 stddev:81730.03 (241.6%) stddev-sans-first:81891.48 22:10:18 INFO - PID 1644 | Values: 746.4 795.6 820.9 1195.3 1266.2 24651.0 32883.5 35735.0 36172.3 36178.0 27258.0 36273.0 36715.6 36738.0 36740.9 6825.7 7663.4 7813.0 7897.2 8068.0 7111.3 7951.2 8001.1 8149.7 8161.0 7190.9 7800.6 8127.5 8128.3 8164.3 7308.9 7717.8 8111.1 8143.0 8149.0 7340.2 7592.3 8090.0 8096.0 8112.8 35588.6 35779.6 35927.5 35950.8 35999.0 3110.6 3598.6 3641.2 3643.6 3644.1 29043.0 29180.8 29376.7 29477.6 29553.9 3100.4 3138.9 3142.0 3147.5 3160.5 299230.0 301020.0 301115.0 305717.0 307063.0 45526.5 45608.0 45645.8 45645.9 45765.0 46412.8 47745.5 50222.0 50475.2 50498.7 14191.7 14250.7 14278.9 14309.0 14316.1 11588.8 11591.2 11591.3 11594.7 11607.1 13087.3 13286.9 13287.4 13323.6 13385.1 5972.7 5985.1 5998.2 6006.9 6028.5 970.3 977.0 989.1 1006.9 1021.4 23853.0 23859.9 24003.6 24076.2 24106.0 927.3 940.4 1038.1 1124.8 1134.9 10921.8 11809.0 12161.9 12277.9 12293.7 337516.0 338627.0 340178.0 340355.0 340822.0 51303.5 51493.2 51608.2 51705.2 51711.7 1462.6 1513.8 1518.6 1521.0 1531.1 16367.8 23544.6 23584.9 23629.5 23774.8 35867.3 36816.0 36908.9 36966.4 37007.0 286922.6 287787.0 287971.0 288215.0 288714.0 33390.7 33709.5 33794.0 33806.7 33840.7 41324.8 41800.4 41858.0 42881.0 42976.9 29266.7 29696.4 30217.2 30477.7 30699.0 29600.6 29617.1 30056.9 30504.5 31193.8 36169.6 36233.9 36294.9 36343.6 36671.4 24152.9 24573.0 28935.9 30384.7 30828.5 20889.6 23367.6 23884.9 24053.4 24315.8 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:35995.81 Median:22880.53 stddev:93476.60 (408.5%) stddev-sans-first:93700.69 22:10:18 INFO - PID 1644 | Values: 432.5 440.9 441.4 457.0 457.8 16363.8 19777.1 21584.4 21845.6 21883.8 21430.0 22911.0 23289.7 23384.7 23678.9 5912.6 6146.1 6157.7 6157.7 6167.6 5829.5 6086.8 6136.8 6147.4 6158.2 6062.4 6063.5 6088.9 6115.6 6134.9 5768.5 5826.9 6120.8 6140.8 6147.3 5219.6 5404.4 5466.0 5474.6 5493.7 28011.7 28358.6 28401.0 28450.1 28752.0 2198.2 2256.0 2269.6 2271.9 2282.9 17551.2 17689.9 17730.0 17835.2 17962.0 1722.2 2144.0 2156.7 2197.2 2202.0 132698.0 157324.0 157800.0 159433.0 163439.0 10713.4 12283.8 12877.9 12918.9 13004.0 16466.7 16804.2 16805.4 16824.8 16827.7 8921.3 9185.5 9190.3 9198.4 9204.2 7193.4 8692.8 8695.0 8789.5 8939.5 8018.9 8149.8 8167.6 8189.4 8194.9 1921.7 1954.8 2057.2 2134.5 2156.2 832.8 906.5 909.8 958.4 968.2 21012.4 21532.9 21583.4 21673.9 22055.2 988.8 995.7 1000.8 1016.0 1018.4 10575.9 10770.4 11231.4 11263.2 11271.6 543079.0 545143.0 548365.0 556134.0 556581.0 132682.0 136326.0 137277.3 138252.0 140749.0 1186.9 1221.8 1250.2 1254.6 1255.6 21948.5 22850.1 23203.7 23245.1 23645.4 57082.1 57511.7 57572.0 57766.4 58240.7 76544.0 76719.2 77813.0 80145.6 80378.2 7996.2 9066.1 9101.2 9231.4 9276.0 14149.0 14317.3 14373.6 14602.6 14748.3 10583.7 11967.5 12014.1 12165.7 12251.9 11139.6 11153.7 11453.5 11535.3 11639.2 11896.2 12034.9 12145.1 12331.1 12352.9 7098.9 8792.3 8838.5 9254.2 9258.4 11296.0 11820.5 12057.4 12328.6 12561.7 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:7148.41 Median:3841.71 stddev:4538.48 (118.1%) stddev-sans-first:4529.95 22:10:18 INFO - PID 1644 | Values: 1302.6 1415.3 1429.7 1447.4 1451.5 9131.0 11646.2 11843.1 11856.8 11929.5 11612.6 11776.8 11802.9 11849.3 11887.8 2507.3 2550.2 2550.4 2550.6 2559.9 2466.6 2519.7 2523.2 2525.1 2527.3 1873.6 2411.3 2478.6 2492.0 2522.3 2450.8 2470.4 2495.8 2505.2 2505.4 2418.5 2487.6 2491.9 2507.6 2525.8 11866.0 11893.3 11936.5 11957.6 11968.3 6510.5 6737.1 6742.4 6777.0 6799.6 3737.9 3835.4 4291.0 4359.2 4361.2 1262.2 1279.0 1279.3 1294.5 1296.6 16221.4 16257.0 16363.8 16534.3 16836.7 5439.8 5495.3 5655.7 5664.6 5665.0 11638.5 11684.4 11745.5 11761.2 11788.4 6583.2 6608.7 6620.2 6629.9 6648.3 6005.9 6122.6 6216.9 6320.0 6343.1 4199.8 4275.9 4322.0 4343.1 4354.5 1248.3 1271.1 1272.6 1286.3 1286.9 623.0 772.4 796.7 799.1 799.9 5587.5 6570.7 6711.2 6734.5 6786.8 795.0 906.0 913.3 929.1 940.6 3848.0 3877.6 3881.2 4273.3 4342.4 14862.3 15074.4 15212.3 15263.5 15384.0 14655.6 14999.9 15008.1 15178.2 15186.5 8280.2 8468.1 8670.3 8699.2 8767.9 6528.3 6826.9 6847.9 7090.8 7105.9 13316.7 13383.5 13439.6 13603.7 13904.8 13610.7 13777.2 13858.4 13986.0 14184.1 9414.6 9429.8 9514.1 9573.0 9590.3 10747.7 10749.1 10883.0 10883.2 10888.9 9124.8 9127.2 9179.0 9266.9 9318.4 9060.6 9062.2 9107.6 9171.3 9252.7 8035.0 8210.5 8215.1 8232.7 8233.3 5639.3 6014.3 6042.0 6205.2 6229.8 6081.8 6102.8 6268.2 6295.5 6305.5 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5360.57 Median:6138.95 stddev:1749.52 (28.5%) stddev-sans-first:1714.16 22:10:18 INFO - PID 1644 | Values: 388.3 392.4 414.8 419.5 421.9 4845.4 6247.5 6384.5 6422.2 6478.6 5041.3 5704.0 6174.8 6275.5 6336.7 4510.8 4552.4 4562.5 4568.8 4580.6 3903.2 4458.7 4493.0 4515.9 4522.1 3905.7 4075.7 4485.1 4493.8 4496.7 4345.3 4414.2 4472.9 4494.2 4496.6 3769.0 3807.4 3836.3 3855.6 3856.1 6078.6 6111.5 6133.9 6134.4 6162.3 4728.0 5100.6 5380.8 5384.8 5395.4 5614.7 5689.8 6339.4 6497.0 6675.6 3458.9 3633.7 4288.1 4357.8 4367.7 5179.6 5795.4 6587.9 6738.5 7209.2 4067.4 4083.4 4366.3 4420.0 4453.7 3706.9 4492.8 4517.6 4536.4 4536.5 4236.2 4960.4 5397.6 5425.5 5429.1 6153.7 6189.6 6257.0 6762.6 6824.6 1425.9 1455.5 1518.2 1541.6 1545.4 839.8 970.9 1000.2 1009.7 1014.2 6376.9 6383.4 6403.7 6405.8 6432.9 6860.9 6957.4 6972.2 7039.0 7070.3 6311.2 6381.9 6427.4 6493.6 6494.3 3473.4 3628.1 3667.0 3686.6 3693.5 5703.0 6687.0 7262.9 7297.2 7302.3 5917.9 6476.4 6584.9 6626.3 7269.9 6306.0 7250.9 7312.2 7320.0 7327.5 7050.8 7065.5 7072.6 7081.4 7199.5 6767.6 6856.6 6944.4 6960.7 6984.6 6143.4 6366.2 6934.1 7356.4 7437.7 3780.5 4418.8 4457.0 4458.0 4517.5 6844.6 7063.5 7102.7 7136.6 7154.4 5632.9 6624.0 6777.6 6796.9 6860.3 6418.3 6689.3 6808.3 6830.7 6831.0 6063.1 6105.6 6273.9 6691.5 6723.0 6609.3 6812.9 6825.4 6839.4 6843.7 5388.5 5488.2 6177.9 6596.9 6632.8 22:10:18 INFO - PID 1644 | 22:10:18 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21995.76 Median:17496.24 stddev:31093.46 (177.7%) stddev-sans-first:31139.96 22:10:18 INFO - PID 1644 | Values: 801.6 812.0 817.9 844.2 865.8 15967.6 16379.9 16449.8 18354.9 19552.3 15303.6 15592.8 17284.7 18397.0 18745.3 972.3 1000.6 1002.6 1004.2 1007.2 969.5 1019.3 1022.3 1025.1 1027.1 1065.4 1068.9 1069.6 1071.6 1072.7 1067.6 1071.7 1073.0 1073.9 1074.8 773.9 777.6 787.9 791.3 794.9 15323.2 15601.8 16102.1 16817.7 16990.7 16878.2 17132.7 17435.0 17573.0 17702.5 13867.4 14075.6 14213.6 14222.9 14441.4 3554.7 3564.4 3572.7 3573.1 3578.6 122571.0 123476.4 134599.0 135005.0 136083.3 12996.8 13443.3 13445.1 13573.9 13630.5 19716.9 24862.9 25498.7 25507.9 25725.0 6708.4 7907.0 8015.7 8017.6 8030.8 3480.7 3941.8 4023.5 4034.0 4035.0 4130.5 4258.4 4297.3 4297.9 4298.7 876.0 909.9 912.9 914.7 915.0 544.3 635.9 648.5 661.6 685.3 10994.7 11197.7 11284.7 11436.1 11724.7 637.7 639.9 651.8 673.4 674.6 4685.9 6008.3 6152.1 6171.0 6245.2 101223.0 101532.5 101649.5 104070.0 106893.0 88109.0 89417.7 89480.0 92507.1 93746.5 83244.7 83340.6 83646.0 84558.0 85418.1 12244.1 12570.6 12731.0 12757.6 12784.0 40802.0 40846.2 41172.4 42016.8 42027.6 51668.0 55145.3 55274.4 55853.0 57256.4 13348.5 13802.5 16705.5 17197.3 17199.6 18018.7 18241.5 18578.0 18609.7 18740.5 16489.4 17345.3 17365.9 17414.3 17418.8 16249.5 16478.8 17275.0 17350.0 17557.5 16164.6 16462.3 16648.1 16995.7 17106.8 11611.2 11712.9 12404.3 12413.4 12429.6 12691.6 13285.2 13293.7 13435.3 13639.9 22:10:18 INFO - PID 1644 | -------- Summary: end -------- 22:10:18 INFO - PID 1644 | 22:10:18 INFO - TEST-INFO | 1644: exit 0 22:10:18 INFO - TEST-OK | dromaeo_css | took 1114915ms 22:10:18 INFO - TEST-START | kraken 22:10:18 INFO - operating with platform_type : mac_ 22:10:18 INFO - Initialising browser for kraken test... 22:10:18 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpgYvf8S/profile http://localhost:49234/getInfo.html) 22:10:21 INFO - PID 1657 | 2017-05-01 22:10:21.392 plugin-container[1658:10193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 22:10:21 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:10:21 INFO - PID 1657 | 2017-05-01 22:10:21.395 plugin-container[1658:10193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9813, name = 'com.apple.CFPasteboardClient' 22:10:21 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:10:21 INFO - PID 1657 | 2017-05-01 22:10:21.395 plugin-container[1658:10193] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:10:21 INFO - PID 1657 | __metrics Screen width/height:1600/1200 22:10:21 INFO - PID 1657 | colorDepth:24 22:10:21 INFO - PID 1657 | Browser inner width/height: 1024/689 22:10:21 INFO - PID 1657 | __metrics 22:10:22 INFO - TEST-INFO | 1657: exit 0 22:10:22 INFO - Browser initialized. 22:10:22 INFO - Running cycle 1/1 for kraken test... 22:10:22 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpgYvf8S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:24 INFO - PID 1659 | 2017-05-01 22:10:24.804 plugin-container[1660:10318] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463f, name = 'com.apple.tsm.portname' 22:10:24 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:10:24 INFO - PID 1659 | 2017-05-01 22:10:24.805 plugin-container[1660:10318] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 22:10:24 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:10:24 INFO - PID 1659 | 2017-05-01 22:10:24.806 plugin-container[1660:10318] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:10:34 INFO - PID 1659 | RSS: Main: 234876928 22:10:34 INFO - PID 1659 | 22:10:37 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 22:10:38 INFO - PID 1659 | RSS: Main: 248242176 22:10:38 INFO - PID 1659 | 22:10:40 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 22:10:41 INFO - PID 1659 | RSS: Main: 256450560 22:10:41 INFO - PID 1659 | 22:10:45 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 22:10:45 INFO - PID 1659 | RSS: Main: 259313664 22:10:45 INFO - PID 1659 | 22:10:47 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 22:10:48 INFO - PID 1659 | RSS: Main: 260288512 22:10:48 INFO - PID 1659 | 22:10:50 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:10:50 INFO - PID 1659 | RSS: Main: 260616192 22:10:50 INFO - PID 1659 | 22:10:54 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 22:10:54 INFO - PID 1659 | RSS: Main: 267698176 22:10:54 INFO - PID 1659 | 22:10:57 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 22:10:58 INFO - PID 1659 | RSS: Main: 268619776 22:10:58 INFO - PID 1659 | 22:11:01 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 22:11:02 INFO - PID 1659 | RSS: Main: 268607488 22:11:02 INFO - PID 1659 | 22:11:03 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:11:04 INFO - PID 1659 | RSS: Main: 268419072 22:11:04 INFO - PID 1659 | 22:11:06 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:11:07 INFO - PID 1659 | RSS: Main: 268464128 22:11:07 INFO - PID 1659 | 22:11:09 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:11:09 INFO - PID 1659 | RSS: Main: 267988992 22:11:09 INFO - PID 1659 | 22:11:12 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:11:13 INFO - PID 1659 | RSS: Main: 268226560 22:11:13 INFO - PID 1659 | 22:11:16 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:11:17 INFO - PID 1659 | RSS: Main: 268070912 22:11:17 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 22:11:19 INFO - PID 1659 | RSS: Main: 269840384 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | __start_tp_report 22:11:19 INFO - PID 1659 | _x_x_mozilla_page_load 22:11:19 INFO - PID 1659 | _x_x_mozilla_page_load_details 22:11:19 INFO - PID 1659 | |i|pagename|runs| 22:11:19 INFO - PID 1659 | |0;ai-astar;102;114;113;112;113;114;113;114;114;112 22:11:19 INFO - PID 1659 | |1;audio-beat-detection;148;109;115;160;109;113;112;112;139;108 22:11:19 INFO - PID 1659 | |2;audio-dft;200;202;208;261;205;280;229;278;264;199 22:11:19 INFO - PID 1659 | |3;audio-fft;85;59;62;88;60;60;64;74;95;61 22:11:19 INFO - PID 1659 | |4;audio-oscillator;89;76;107;93;104;103;119;104;80;90 22:11:19 INFO - PID 1659 | |5;imaging-gaussian-blur;111;88;136;134;88;102;89;89;89;96 22:11:19 INFO - PID 1659 | |6;imaging-darkroom;102;113;120;93;149;143;91;154;120;99 22:11:19 INFO - PID 1659 | |7;imaging-desaturate;91;129;84;76;77;121;146;133;94;93 22:11:19 INFO - PID 1659 | |8;json-parse-financial;51;60;49;50;49;50;53;52;55;73 22:11:19 INFO - PID 1659 | |9;json-stringify-tinderbox;60;84;92;102;64;61;54;55;58;48 22:11:19 INFO - PID 1659 | |10;stanford-crypto-aes;82;93;76;88;73;88;77;110;108;70 22:11:19 INFO - PID 1659 | |11;stanford-crypto-ccm;149;173;162;136;140;144;144;149;185;143 22:11:19 INFO - PID 1659 | |12;stanford-crypto-pbkdf2;229;195;192;185;184;188;191;177;190;184 22:11:19 INFO - PID 1659 | |13;stanford-crypto-sha256-iterative;68;69;68;71;69;89;102;99;94;73 22:11:19 INFO - PID 1659 | __end_tp_report 22:11:19 INFO - PID 1659 | __start_cc_report 22:11:19 INFO - PID 1659 | _x_x_mozilla_cycle_collect,1001 22:11:19 INFO - PID 1659 | __end_cc_report 22:11:19 INFO - PID 1659 | __startTimestamp1493701879465__endTimestamp 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | ------- Summary: start ------- 22:11:19 INFO - PID 1659 | Number of tests: 14 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.63 (3.2%) stddev-sans-first:0.83 22:11:19 INFO - PID 1659 | Values: 102.0 114.0 113.0 112.0 113.0 114.0 113.0 114.0 114.0 112.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:114.00 stddev:19.06 (16.7%) stddev-sans-first:17.85 22:11:19 INFO - PID 1659 | Values: 148.0 109.0 115.0 160.0 109.0 113.0 112.0 112.0 139.0 108.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#2] audio-dft Cycles:10 Average:232.60 Median:245.00 stddev:34.33 (14.0%) stddev-sans-first:34.33 22:11:19 INFO - PID 1659 | Values: 200.0 202.0 208.0 261.0 205.0 280.0 229.0 278.0 264.0 199.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#3] audio-fft Cycles:10 Average:70.80 Median:69.00 stddev:13.69 (19.8%) stddev-sans-first:13.52 22:11:19 INFO - PID 1659 | Values: 85.0 59.0 62.0 88.0 60.0 60.0 64.0 74.0 95.0 61.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:78.00 stddev:13.23 (17.0%) stddev-sans-first:13.75 22:11:19 INFO - PID 1659 | Values: 89.0 76.0 107.0 93.0 104.0 103.0 119.0 104.0 80.0 90.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:102.20 Median:88.50 stddev:18.84 (21.3%) stddev-sans-first:19.72 22:11:19 INFO - PID 1659 | Values: 111.0 88.0 136.0 134.0 88.0 102.0 89.0 89.0 89.0 96.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#6] imaging-darkroom Cycles:10 Average:118.40 Median:151.50 stddev:23.30 (15.4%) stddev-sans-first:23.94 22:11:19 INFO - PID 1659 | Values: 102.0 113.0 120.0 93.0 149.0 143.0 91.0 154.0 120.0 99.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#7] imaging-desaturate Cycles:10 Average:104.40 Median:80.50 stddev:25.43 (31.6%) stddev-sans-first:26.51 22:11:19 INFO - PID 1659 | Values: 91.0 129.0 84.0 76.0 77.0 121.0 146.0 133.0 94.0 93.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:52.50 stddev:7.41 (14.1%) stddev-sans-first:7.76 22:11:19 INFO - PID 1659 | Values: 51.0 60.0 49.0 50.0 49.0 50.0 53.0 52.0 55.0 73.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:60.50 stddev:18.20 (30.1%) stddev-sans-first:19.09 22:11:19 INFO - PID 1659 | Values: 60.0 84.0 92.0 102.0 64.0 61.0 54.0 55.0 58.0 48.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:79.50 stddev:13.89 (17.5%) stddev-sans-first:14.64 22:11:19 INFO - PID 1659 | Values: 82.0 93.0 76.0 88.0 73.0 88.0 77.0 110.0 108.0 70.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:149.00 stddev:15.83 (10.6%) stddev-sans-first:16.74 22:11:19 INFO - PID 1659 | Values: 149.0 173.0 162.0 136.0 140.0 144.0 144.0 149.0 185.0 143.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.50 Median:190.50 stddev:14.14 (7.4%) stddev-sans-first:5.43 22:11:19 INFO - PID 1659 | Values: 229.0 195.0 192.0 185.0 184.0 188.0 191.0 177.0 190.0 184.0 22:11:19 INFO - PID 1659 | 22:11:19 INFO - PID 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.20 Median:72.00 stddev:14.07 (19.5%) stddev-sans-first:14.21 22:11:19 INFO - PID 1659 | Values: 68.0 69.0 68.0 71.0 69.0 89.0 102.0 99.0 94.0 73.0 22:11:19 INFO - PID 1659 | -------- Summary: end -------- 22:11:19 INFO - PID 1659 | 22:11:20 INFO - TEST-INFO | 1659: exit 0 22:11:20 INFO - TEST-OK | kraken | took 61763ms 22:11:20 INFO - SUITE-END | took 1176s 22:11:20 INFO - Completed test suite (00:19:36) 22:11:20 INFO - javascript benchmark 22:11:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7895.383719236472, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.6209223847018, 3614.548181477314, 3642.4900513928073, 3688.2807852468777, 3693.445983102535, 6240.18877545919, 6246.250449946007, 6274.2470903491585, 6300.0, 6303.495720342373, 6102.701334035026, 6228.096925945735, 6233.065040243954, 6285.402886725765, 6311.179546658939, 5458.2904222451225, 5477.452254774531, 5531.751071201786, 5584.106542953128, 5639.520640745521, 5458.4541545845495, 5510.531604813596, 5624.859378515549, 5641.435856414367, 5661.264035675356, 5546.251256080418, 5564.86087847803, 5575.553955683536, 5588.776448942038, 5683.971580142114, 5374.677519348852, 5478.369987451454, 5479.232907392969, 5489.1217405215375, 5495.203195536665, 5371.919421208685, 5452.454754524516, 5475.342958844924, 5497.367802702701, 5502.944970550283, 5128.2564028216075, 5754.050581654022, 6237.0, 6243.313235544087, 6269.404406581368, 6716.5634233774645, 6772.356626120511, 6775.661216939134, 6792.320767923217, 6816.182058153004, 6637.535372523926, 6695.966520167368, 6789.219239787439, 6865.622390768505, 6878.0, 6346.460550853137, 6355.745770169234, 6358.809235722936, 6379.553431259814, 6419.16550848396, 7066.611336376549, 7073.575585464889, 7076.964615176994, 7080.575165490087, 7142.5000249982, 6400.9039864402075, 6490.0589414534625, 6652.467802575782, 6677.866442671119, 6720.193576770721, 6694.497912656473, 6759.256481787, 6780.796576102724, 6860.759873404407, 6880.724771009203, 5612.270404847425, 6417.294097649255, 6758.425533829582, 6768.052472653832, 6768.492363072691, 6740.797776066725, 6746.763863264762, 6798.116244888133, 6823.69293381799, 6830.829229269308, 5265.947340526545, 5343.70609616467, 5347.465253474699, 5389.434109418533, 5410.269613602192, 4760.666753327234, 4791.089692958327, 4799.952000480021, 4847.466778654345, 4924.409070911442, 5945.583809133405, 6007.429294217042, 6460.967695161494, 6483.189601299838, 6512.381323774234, 6626.9337306627285, 6762.323767623297, 6786.694598743068, 6798.0, 6906.240313565504, 6396.264429590564, 6458.38645328693, 6465.806025819139, 6505.121808555785, 6517.706703198272, 6007.459328660354, 6090.512758979271, 6104.725287362079, 6104.725287362079, 6131.846703832351, 6827.93172068273, 6851.212110607344, 7025.297470252934, 7099.290070992859, 7111.92888071123, 5683.573731970201, 6836.453083753388, 6841.589504629738, 6875.621840798804, 6888.758893438706, 7046.2249152594195, 7095.609741464269, 7097.574145551283, 7101.928980710127, 7127.465440092117, 6404.295527491879, 6577.309382514767, 6634.668266586747, 6767.1879374475375, 6815.965920170367, 6759.831004224934, 6808.693608787517, 6843.7604683835825, 6863.725450981905, 6875.48433867472, 6541.0, 6610.10763546915, 6661.566998145105, 6661.766838160641, 6663.46692264608, 6348.968255158695, 6468.417842394207, 6554.246261679968, 6610.933890661032, 6661.766838160641, 5940.762369505172, 6096.738245038883, 6418.101465794699, 6483.351664833479, 6544.116544266463, 6630.9668451657435, 6660.933390666031, 6662.800115996528, 6691.966540167268, 6707.966460167668, 6210.161628180319, 6364.681765911593, 6395.16862807832, 6480.935190648033, 6481.8703625928165], "value": 6182.707875065748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.3805041815294, 795.5505139596128, 820.8891799607052, 1195.2589394575364, 1266.2276011632907, 24651.0, 32883.50674739881, 35735.0, 36172.276554468925, 36178.0, 27258.0, 36273.0, 36715.632843671556, 36738.0, 36740.89777306685, 6825.6587170641515, 7663.3869290456905, 7812.960935195344, 7897.170797066312, 8067.959660201691, 7111.324424179695, 7951.244631760002, 8001.079875814268, 8149.674013039471, 8160.9591952040455, 7190.8561828763395, 7800.570968596725, 8127.512349259034, 8128.30909372704, 8164.265216130547, 7308.890366644505, 7717.765157574817, 8111.067227268851, 8143.0228372595375, 8149.0, 7340.155882073523, 7592.278733520307, 8090.0, 8096.0, 8112.797180070486, 35588.64411355905, 35779.64220357789, 35927.4610880837, 35950.82024589887, 35999.0, 3110.626724793039, 3598.5501812273465, 3641.198936234024, 3643.617420170897, 3644.1436262478296, 29042.983495577555, 29180.832766689306, 29376.70623293761, 29477.557836632466, 29553.85223073871, 3100.3644252928098, 3138.8901388451295, 3142.025971948703, 3147.512135618983, 3160.5259211118287, 299230.0, 301020.0, 301115.0, 305716.9999999978, 307063.0, 45526.54473455223, 45608.0, 45645.771771140935, 45645.85885352893, 45765.0, 46412.83967900829, 47745.5225447748, 50222.0, 50475.24287135696, 50498.74750626223, 14191.71616567663, 14250.714985700228, 14278.928605356907, 14309.0, 14316.141031538142, 11588.76822463546, 11591.24656897299, 11591.304521728724, 11594.71013224676, 11607.129465290138, 13087.345632718516, 13286.867131328756, 13287.402066907012, 13323.600291991255, 13385.063045586716, 5972.731227094791, 5985.102234664835, 5998.1602575639445, 6006.909896351558, 6028.487578555784, 970.2529052629436, 976.9902300977042, 989.0900371657948, 1006.8741407324085, 1021.3922715983978, 23853.0, 23859.880700596732, 24003.63994540083, 24076.157334493208, 24106.0, 927.2813569483704, 940.3793496292415, 1038.127972503101, 1124.780667769777, 1134.8581427321585, 10921.798602153756, 11809.0, 12161.878381216251, 12277.877221227853, 12293.692657683629, 337516.0, 338627.0, 340178.0, 340355.0, 340822.0, 51303.486965130614, 51493.227601586004, 51608.22587661188, 51705.224421633706, 51711.74144129255, 1462.590474667095, 1513.7805018272288, 1518.5596177108737, 1520.9543713688606, 1531.119606226402, 16367.754483682516, 23544.6468302979, 23584.938677759197, 23629.527409452057, 23774.762252377946, 35867.28265434729, 36816.0, 36908.89273321805, 36966.44550331801, 37007.0, 286922.56538717175, 287787.0, 287971.0, 288215.0, 288714.0, 33390.66609333973, 33709.49435758417, 33794.0, 33806.661933380354, 33840.661593384735, 41324.793376032925, 41800.3729944045, 41858.0, 42881.0, 42976.92557686083, 29266.70733292725, 29696.406071878875, 30217.244568885955, 30477.695223047485, 30699.0, 29600.555991659712, 29617.111486655434, 30056.948006819657, 30504.542431863098, 31193.8440307797, 36169.63830361663, 36233.91298261056, 36294.91115266546, 36343.63656363508, 36671.449928250564, 24152.91311890934, 24573.0, 28935.85532072326, 30384.696153038185, 30828.53757193599, 20889.642173259297, 23367.649485257396, 23884.88057559701, 24053.398665033514, 24315.75684243135], "value": 16974.648846466378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.450787499875, 440.9007973206029, 441.37545373296774, 456.9840055598054, 457.83975608537037, 16363.83636163638, 19777.11003004863, 21584.352469425903, 21845.563088738214, 21883.781162188374, 21430.03564839582, 22910.96900639471, 23289.650655240144, 23384.713840738754, 23678.88160559195, 5912.586118971673, 6146.078088286748, 6157.661328626924, 6157.692115394235, 6167.568270221086, 5829.475347218749, 6086.7565297388055, 6136.8465788355425, 6147.415995480422, 6158.230221222348, 6062.42406971337, 6063.545234107438, 6088.908666369985, 6115.571909966304, 6134.877302453949, 5768.538516918637, 5826.941730582682, 6120.816375508742, 6140.754369825224, 6147.323794382614, 5219.556337711299, 5404.405515393303, 5466.01611709892, 5474.562035037187, 5493.697846618435, 28011.719882801113, 28358.574621380696, 28401.005964791133, 28450.146495605164, 28752.0, 2198.1866709317655, 2255.988720056406, 2269.6028195065796, 2271.943201419961, 2282.8630282182958, 17551.210195541233, 17689.911550442295, 17730.0, 17835.197416116178, 17962.0, 1722.2249987505672, 2143.957120857574, 2156.7304086989125, 2197.165077270643, 2201.9779802201933, 132698.0, 157324.0, 157800.0, 159433.0, 163439.0, 10713.35719856811, 12283.815742763865, 12877.871221287854, 12918.870811291954, 13004.0, 16466.6706665866, 16804.159792010596, 16805.41181058657, 16824.812774339258, 16827.663446730996, 8921.286297096216, 9185.494797786187, 9190.310726695525, 9198.402103863227, 9204.217641500414, 7193.424526037905, 8692.78268043304, 8695.0, 8789.516576588221, 8939.463632182089, 8018.879716804253, 8149.755507334789, 8167.63245653947, 8189.385796065319, 8194.918050819535, 1921.6644432119542, 1954.7752008519203, 2057.2182570623067, 2134.51973306008, 2156.1914282144194, 832.8375966686559, 906.5376657904384, 909.8217807938735, 958.4153666263574, 968.1770495079268, 21012.369628911158, 21532.89233553822, 21583.352499424727, 21673.916304184728, 22055.22806701758, 988.8467287570438, 995.6863587969766, 1000.8248556502583, 1016.004315770549, 1018.4449475036123, 10575.947120264349, 10770.407627580558, 11231.438428078727, 11263.155263355282, 11271.605493807678, 543079.0, 545143.0, 548365.0, 556134.0, 556581.0, 132682.0, 136326.0, 137277.3136134313, 138252.0, 140749.0, 1186.9287842729464, 1221.7617564574823, 1250.206119114369, 1254.5922575163108, 1255.604484587352, 21948.451288717908, 22850.08846549814, 23203.651945221172, 23245.070197191922, 23645.408864778517, 57082.1254110261, 57511.71244143753, 57572.0, 57766.42233577611, 58240.70879645574, 76544.0, 76719.23280767121, 77813.0, 80145.59927200327, 80378.19621803708, 7996.200379961957, 9066.138716821892, 9101.226395756436, 9231.446113233227, 9276.0, 14149.0, 14317.284135792961, 14373.640658983191, 14602.561923142322, 14748.262586870827, 10583.682489525327, 11967.461464233957, 12014.067576025776, 12165.69585760363, 12251.877481225074, 11139.610113645984, 11153.665390038312, 11453.484593193492, 11535.307881527135, 11639.185257032264, 11896.22674526153, 12034.939825300817, 12145.089118315986, 12331.075169362513, 12352.938235308766, 7098.858022839618, 8792.252658524098, 8838.469691818511, 9254.241694078373, 9258.35191536586, 11296.03983661398, 11820.468078936641, 12057.397130143634, 12328.568500102454, 12561.685957851127], "value": 10550.070658212568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.6352621266046, 1415.2852809331287, 1429.6568823482366, 1447.442734547199, 1451.5427640293308, 9130.954345228272, 11646.184767066308, 11843.052555795548, 11856.7628647427, 11929.522819087226, 11612.593559225408, 11776.7644647107, 11802.881971180286, 11849.348285844275, 11887.821682674767, 2507.34808949673, 2550.1839411388364, 2550.4389034412397, 2550.5536531107073, 2559.923202303934, 2466.5930121529927, 2519.735427780084, 2523.1925783749207, 2525.103588226181, 2527.2670925431603, 1873.6252749450096, 2411.288669842401, 2478.6405971134177, 2491.9750802492017, 2522.255934499327, 2450.803935685141, 2470.4441500662206, 2495.7504249575077, 2505.1732928133674, 2505.361132911114, 2418.467937053845, 2487.601983682602, 2491.9252422427357, 2507.5987841945384, 2525.7726804587674, 11866.0, 11893.286402815773, 11936.522539098425, 11957.581484647995, 11968.34174120423, 6510.511711621647, 6737.090492783461, 6742.359475849787, 6777.0, 6799.626020568867, 3737.8878633641034, 3835.386338185877, 4291.034517233628, 4359.215341238576, 4361.193179261847, 1262.236347010064, 1278.9951179213597, 1279.349638965733, 1294.4951468927127, 1296.5526893221822, 16221.432249871315, 16257.0, 16363.754543681735, 16534.338626454926, 16836.74744878828, 5439.755211015514, 5495.340559132929, 5655.660660360391, 5664.631798933056, 5664.971675141598, 11638.476268567934, 11684.415779211005, 11745.530178792924, 11761.176717629854, 11788.351640659674, 6583.177102862142, 6608.702608382634, 6620.2386725527185, 6629.933700662931, 6648.33516648341, 6005.879882402328, 6122.632642041492, 6216.906746398808, 6319.968400158062, 6343.1436756038265, 4199.790010499462, 4275.893102672396, 4321.978390108029, 4343.131373725268, 4354.477462704495, 1248.2836100362001, 1271.097520760252, 1272.63093702827, 1286.2604002698486, 1286.8777466140702, 623.03118650498, 772.3820943245381, 796.7171654062724, 799.1409235072321, 799.9160088190772, 5587.469190426903, 6570.737170513222, 6711.228208756055, 6734.461243100638, 6786.8303292417095, 794.9682012719427, 906.0, 913.2921985461321, 929.0941332201049, 940.5579377692474, 3848.037990502374, 3877.5734669186368, 3881.204353107606, 4273.273543497613, 4342.435483387139, 14862.331195096247, 15074.397024118913, 15212.315445804965, 15263.465778697693, 15384.0, 14655.633609159857, 14999.850001500063, 15008.099514029193, 15178.24108794578, 15186.46847360337, 8280.213379728915, 8468.110848360957, 8670.263027642595, 8699.173578510032, 8767.912320876838, 6528.281888992302, 6826.863462730618, 6847.897281540881, 7090.822729431599, 7105.8630619100695, 13316.667083322995, 13383.464661413434, 13439.596812095653, 13603.659908502366, 13904.791428128385, 13610.659733506742, 13777.242251676254, 13858.4456621734, 13986.020978531405, 14184.078034927697, 9414.62341506332, 9429.811403772022, 9514.143727064597, 9573.0, 9590.280728945218, 10747.677569672922, 10749.14006879432, 10883.0, 10883.23817332779, 10888.945555272174, 9124.817503650023, 9127.22418594427, 9178.954105229432, 9266.860997084914, 9318.440893546409, 9060.63757449721, 9062.184403403462, 9107.59015844302, 9171.266298695955, 9252.676156334495, 8034.959825200836, 8210.466319689202, 8215.137410571804, 8232.670693172446, 8233.34133269325, 5639.295088113986, 6014.278286605635, 6042.0, 6205.231509019907, 6229.750809967551, 6081.787137450168, 6102.755889764359, 6268.153799237227, 6295.464885484785, 6305.5270854687], "value": 5386.7851992825645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.31041822470246, 392.3859160413952, 414.815407143821, 419.45470887845795, 421.87765547991086, 4845.449456174026, 6247.468965137969, 6384.488531307779, 6422.197225346832, 6478.643674597895, 5041.344625198719, 5703.973284808732, 6174.845628859281, 6275.497960163188, 6336.651484168369, 4510.751908645023, 4552.362669226311, 4562.520935301795, 4568.817247310104, 4580.633549316047, 3903.2193561287713, 4458.687891847572, 4493.0115374617535, 4515.909681806362, 4522.095580883836, 3905.7265991380614, 4075.655033838841, 4485.080558485519, 4493.842715504958, 4496.673481323018, 4345.261305578059, 4414.183376075436, 4472.884945849826, 4494.16857881293, 4496.595306422438, 3768.9623103768886, 3807.390817469219, 3836.3478208704587, 3855.633714797118, 3856.1323702166787, 6078.601921558066, 6111.54163437744, 6133.926562851483, 6134.447899689049, 6162.291336496315, 4727.983483551018, 5100.642954993152, 5380.811671591515, 5384.811531596375, 5395.379531353866, 5614.6631202128, 5689.800856970028, 6339.36606339367, 6496.967515162394, 6675.566088204251, 3458.858576669693, 3633.6729694327637, 4288.142371525707, 4357.760323182224, 4367.67242456817, 5179.559737422323, 5795.420457954171, 6587.868242635121, 6738.494612904003, 7209.170945341248, 4067.389891516237, 4083.4487344208746, 4366.345048242725, 4419.9779001105435, 4453.688241823042, 3706.870259540903, 4492.842750503782, 4517.6160026397465, 4536.364908912755, 4536.500984891659, 4236.195122926696, 4960.379952505937, 5397.649152805055, 5425.484578964992, 5429.077056900336, 6153.661548614779, 6189.6286222826775, 6256.968715156486, 6762.594244345355, 6824.590524568542, 1425.8521889878539, 1455.4760286296926, 1518.1953564610774, 1541.5817447947916, 1545.3663997760864, 839.7816567692322, 970.8593443972343, 1000.1898462245605, 1009.6920439266095, 1014.1734486393713, 6376.936230637727, 6383.425491705676, 6403.711832967528, 6405.839854003687, 6432.935670643327, 6860.862782744417, 6957.443404527626, 6972.1981972072845, 7039.049728286615, 7070.292970702992, 6311.181735050321, 6381.872362552723, 6427.357264273629, 6493.610383377012, 6494.285628580852, 3473.3574288756663, 3628.077119126867, 3667.009907325007, 3686.64976827201, 3693.4829123922673, 5703.0, 6686.96656516724, 7262.891056634155, 7297.197308296083, 7302.342789149002, 5917.875603635295, 6476.384743449365, 6584.934150658528, 6626.319521426946, 7269.8546029079125, 6305.959516679788, 7250.891236631454, 7312.195658477457, 7320.0, 7327.4720221523485, 7050.823729406806, 7065.505414621133, 7072.575645461289, 7081.433485321265, 7199.496035277481, 6767.593944363157, 6856.617555219129, 6944.4444444445335, 6960.651967401711, 6984.6158461283085, 6143.447089761943, 6366.236051673829, 6934.133233345832, 7356.388482088995, 7437.70249190048, 3780.4707340972836, 4418.8453404130705, 4457.04173602677, 4458.0, 4517.5030746617185, 6844.555103918229, 7063.481351509245, 7102.680379382837, 7136.6483829390845, 7154.35610795031, 5632.929743348751, 6624.0, 6777.593344399352, 6796.898046529405, 6860.279670634512, 6418.326075761977, 6689.331066893272, 6808.319168083152, 6830.658467076726, 6831.0, 6063.059820857459, 6105.603135796159, 6273.9372606273355, 6691.464682825265, 6723.0, 6609.3060228675295, 6812.897806533005, 6825.385715285648, 6839.435211795577, 6843.657817109025, 5388.488093631099, 5488.204210389391, 6177.918864198837, 6596.868062638624, 6632.767853125118], "value": 4812.660265476539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.5951944268147, 811.9675212991481, 817.9427440079197, 844.1558441558442, 865.7878819689175, 15967.600809979742, 16379.918100409512, 16449.83550164498, 18354.908225458887, 19552.31566895159, 15303.617409564766, 15592.84407155928, 17284.740728889075, 18396.988165650884, 18745.343912963013, 972.3193764364937, 1000.6497725795949, 1002.5889385352007, 1004.2417974429333, 1007.1892126837893, 969.4764826993415, 1019.2610357490834, 1022.2895087913903, 1025.1337619711333, 1027.1064174168484, 1065.440643662076, 1068.8931106889327, 1069.6042464288225, 1071.5553045486115, 1072.7479042425025, 1067.556963860005, 1071.7320669832543, 1072.9946350268237, 1073.8603981482436, 1074.7796701676139, 773.8993930789018, 777.5762209595783, 787.8896954426385, 791.3194652598761, 794.8688466403037, 15323.157226352547, 15601.765973510406, 16102.114383708891, 16817.747733784003, 16990.660186796318, 16878.240479178465, 17132.743008854875, 17435.0, 17573.0, 17702.468925932244, 13867.37596808146, 14075.648108797259, 14213.644658883508, 14222.857771422257, 14441.422343106264, 3554.697850682695, 3564.4475106358295, 3572.6605972432576, 3573.0888623401124, 3578.58846232684, 122571.0, 123476.38261808634, 134599.0, 135005.0, 136083.31958340146, 12996.805047924288, 13443.327833608477, 13445.058845880694, 13573.914086873026, 13630.454781808816, 19716.901415493117, 24862.881170347377, 25498.745012550007, 25507.872460637576, 25725.0, 6708.396244338033, 7906.960465197637, 8015.719449819228, 8017.639206235734, 8030.83938321242, 3480.738944579167, 3941.7832019238645, 4023.517177938666, 4034.0, 4035.0315924177985, 4130.545639979599, 4258.446401967724, 4297.290946993711, 4297.935530967038, 4298.656107511391, 876.0205013798942, 909.9135582119688, 912.8995810460844, 914.679862048291, 914.977125571866, 544.2625242796033, 635.8505751148476, 648.4682560300603, 661.6129564204898, 685.2975699907535, 10994.725131871768, 11197.66407007791, 11284.71788205285, 11436.142289328334, 11724.706882327839, 637.7066549387241, 639.859230969186, 651.7686221391338, 673.4309508465338, 674.6289540752566, 4685.8594242172785, 6008.3390827009, 6152.077188421773, 6170.969145154246, 6245.156903817927, 101223.0, 101532.47701284487, 101649.49175254077, 104070.0, 106893.0, 88109.0, 89417.65873511902, 89480.0, 92507.07492925119, 93746.53126734322, 83244.6702131908, 83340.58329708313, 83646.0, 84558.0, 85418.14581854227, 12244.122631181843, 12570.622881313575, 12730.981521478445, 12757.617271481871, 12783.977281817619, 40802.0, 40846.1830763389, 41172.38241426321, 42016.78991605023, 42027.57972420237, 51668.0, 55145.345639630876, 55274.44725552854, 55853.0, 57256.42743572678, 13348.532801351907, 13802.516911908035, 16705.498835034967, 17197.312107515558, 17199.57001074983, 18018.72971905396, 18241.54396140054, 18577.989640193242, 18609.720854187468, 18740.531486712942, 16489.422870199487, 17345.306187752347, 17365.913170434065, 17414.303427862742, 17418.82581174172, 16249.512514624581, 16478.83521164773, 17275.0, 17350.0, 17557.473275801745, 16164.595885102966, 16462.341506339613, 16648.08435536057, 16995.745063823804, 17106.828931710523, 11611.187216894736, 11712.941435292769, 12404.317762522787, 12413.44139513742, 12429.564965226175, 12691.555795547112, 13285.202887826761, 13293.667658308234, 13435.328233588478, 13639.931800341332], "value": 8438.405966985056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 113.0, 112.0, 113.0, 114.0, 113.0, 114.0, 114.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 115.0, 160.0, 109.0, 113.0, 112.0, 112.0, 139.0, 108.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 208.0, 261.0, 205.0, 280.0, 229.0, 278.0, 264.0, 199.0], "value": 232.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 62.0, 88.0, 60.0, 60.0, 64.0, 74.0, 95.0, 61.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 76.0, 107.0, 93.0, 104.0, 103.0, 119.0, 104.0, 80.0, 90.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 88.0, 136.0, 134.0, 88.0, 102.0, 89.0, 89.0, 89.0, 96.0], "value": 102.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 120.0, 93.0, 149.0, 143.0, 91.0, 154.0, 120.0, 99.0], "value": 118.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 129.0, 84.0, 76.0, 77.0, 121.0, 146.0, 133.0, 94.0, 93.0], "value": 104.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 60.0, 49.0, 50.0, 49.0, 50.0, 53.0, 52.0, 55.0, 73.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 84.0, 92.0, 102.0, 64.0, 61.0, 54.0, 55.0, 58.0, 48.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 93.0, 76.0, 88.0, 73.0, 88.0, 77.0, 110.0, 108.0, 70.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 173.0, 162.0, 136.0, 140.0, 144.0, 144.0, 149.0, 185.0, 143.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 195.0, 192.0, 185.0, 184.0, 188.0, 191.0, 177.0, 190.0, 184.0], "value": 191.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 71.0, 69.0, 89.0, 102.0, 99.0, 94.0, 73.0], "value": 80.2, "unit": "score"}]}]} 22:11:20 INFO - Return code: 0 22:11:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:11:20 ERROR - # TBPL SUCCESS # 22:11:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:11:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:11:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:11:20 INFO - 2017-05-01 22:11:20.827 screenresolution[1665:10706] starting screenresolution argv=screenresolution get 22:11:20 INFO - 2017-05-01 22:11:20.830 screenresolution[1665:10706] Display 0: 1600x1200x32@60 22:11:20 INFO - 2017-05-01 22:11:20.836 screenresolution[1666:10709] starting screenresolution argv=screenresolution list 22:11:20 INFO - Available Modes on Display 0 22:11:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:11:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:11:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:11:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:11:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:11:21 INFO - Intel Iris: 22:11:21 INFO - Chipset Model: Intel Iris 22:11:21 INFO - Type: GPU 22:11:21 INFO - Bus: Built-In 22:11:21 INFO - VRAM (Dynamic, Max): 1536 MB 22:11:21 INFO - Vendor: Intel (0x8086) 22:11:21 INFO - Device ID: 0x0a2e 22:11:21 INFO - Revision ID: 0x0009 22:11:21 INFO - Displays: 22:11:21 INFO - Display: 22:11:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:11:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:11:21 INFO - Display Serial Number: 1600x1200 60 22:11:21 INFO - Main Display: Yes 22:11:21 INFO - Mirror: Off 22:11:21 INFO - Online: Yes 22:11:21 INFO - Rotation: Supported 22:11:21 INFO - Return code: 0 22:11:21 INFO - Running post-action listener: _resource_record_post_action 22:11:21 INFO - [mozharness: 2017-05-02 05:11:21.080977Z] Finished run-tests step (success) 22:11:21 INFO - Running post-run listener: _resource_record_post_run 22:11:21 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 41683968; Write bytes: 516097024; Read time: 415; Write time: 1885 22:11:21 INFO - TinderboxPrint: CPU usage
54.0% 22:11:21 INFO - TinderboxPrint: I/O read bytes / time
41,683,968 / 415 22:11:21 INFO - TinderboxPrint: I/O write bytes / time
516,097,024 / 1,885 22:11:21 INFO - TinderboxPrint: CPU idle
2,201.8 (46.0%) 22:11:21 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 22:11:21 INFO - TinderboxPrint: CPU user
1,628.1 (34.0%) 22:11:21 INFO - TinderboxPrint: Swap in / out
249,159,680 / 0 22:11:21 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208134656; Write bytes: 203489280; Read time: 16388; Write time: 517 22:11:21 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36621312; Write bytes: 301480960; Read time: 377; Write time: 1265 22:11:21 INFO - Running post-run listener: _upload_blobber_files 22:11:21 INFO - Blob upload gear active. 22:11:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:11:21 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 22:11:21 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'] 22:11:21 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 22:11:22 INFO - (blobuploader) - INFO - Open directory for files ... 22:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:23 INFO - (blobuploader) - INFO - Done attempting. 22:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:11:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:24 INFO - (blobuploader) - INFO - Done attempting. 22:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:25 INFO - (blobuploader) - INFO - Done attempting. 22:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:11:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:11:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:11:27 INFO - (blobuploader) - INFO - Done attempting. 22:11:27 INFO - (blobuploader) - INFO - Iteration through files over. 22:11:27 INFO - Return code: 0 22:11:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:11:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:11:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a789d4df4c81a7dc783be4b6fddb0bed0b963be126b9321b54f7cca460ecf9a17cef07e5b794548b5bb5a491e5857c8efb1eb6a4eeeeb3e5d95f3793c38f3693", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be52ea049d5d1b59333b2280cd480bd22f9cc645bf0b48a171b2f47ae65fca77c31e1f3df2a70650d23757da5117562547c9750656ac3eeb6d36853b821e13ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b35d2842f4811e7e86796e8d26a54006f3babcf810946f8feb9245d39c63b99ec253451cf4d1ac17b0bd42f86a192be8103c729157ad303b7c73defba3e1ccfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa0be48bba0bb3e5becde1fa3fef94451f6d84c2511bd2ac334b41aad7fb34049ae4c059b5bbef4539dab4635e1928750185b23bcf513c8e875aa3b37222de"} 22:11:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:11:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:11:27 INFO - Contents: 22:11:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a789d4df4c81a7dc783be4b6fddb0bed0b963be126b9321b54f7cca460ecf9a17cef07e5b794548b5bb5a491e5857c8efb1eb6a4eeeeb3e5d95f3793c38f3693", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be52ea049d5d1b59333b2280cd480bd22f9cc645bf0b48a171b2f47ae65fca77c31e1f3df2a70650d23757da5117562547c9750656ac3eeb6d36853b821e13ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b35d2842f4811e7e86796e8d26a54006f3babcf810946f8feb9245d39c63b99ec253451cf4d1ac17b0bd42f86a192be8103c729157ad303b7c73defba3e1ccfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa0be48bba0bb3e5becde1fa3fef94451f6d84c2511bd2ac334b41aad7fb34049ae4c059b5bbef4539dab4635e1928750185b23bcf513c8e875aa3b37222de"} 22:11:27 INFO - Running post-run listener: copy_logs_to_upload_dir 22:11:27 INFO - Copying logs to upload dir... 22:11:27 INFO - mkdir: /builds/slave/test/build/upload/logs 22:11:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.166474 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-01 22:11:27.533570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 22:11:27.536709) ========= 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.XzByr4iqlL/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.Rr3mA0eofC/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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/a789d4df4c81a7dc783be4b6fddb0bed0b963be126b9321b54f7cca460ecf9a17cef07e5b794548b5bb5a491e5857c8efb1eb6a4eeeeb3e5d95f3793c38f3693", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be52ea049d5d1b59333b2280cd480bd22f9cc645bf0b48a171b2f47ae65fca77c31e1f3df2a70650d23757da5117562547c9750656ac3eeb6d36853b821e13ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b35d2842f4811e7e86796e8d26a54006f3babcf810946f8feb9245d39c63b99ec253451cf4d1ac17b0bd42f86a192be8103c729157ad303b7c73defba3e1ccfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa0be48bba0bb3e5becde1fa3fef94451f6d84c2511bd2ac334b41aad7fb34049ae4c059b5bbef4539dab4635e1928750185b23bcf513c8e875aa3b37222de"} build_url:https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/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/a789d4df4c81a7dc783be4b6fddb0bed0b963be126b9321b54f7cca460ecf9a17cef07e5b794548b5bb5a491e5857c8efb1eb6a4eeeeb3e5d95f3793c38f3693", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be52ea049d5d1b59333b2280cd480bd22f9cc645bf0b48a171b2f47ae65fca77c31e1f3df2a70650d23757da5117562547c9750656ac3eeb6d36853b821e13ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b35d2842f4811e7e86796e8d26a54006f3babcf810946f8feb9245d39c63b99ec253451cf4d1ac17b0bd42f86a192be8103c729157ad303b7c73defba3e1ccfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa0be48bba0bb3e5becde1fa3fef94451f6d84c2511bd2ac334b41aad7fb34049ae4c059b5bbef4539dab4635e1928750185b23bcf513c8e875aa3b37222de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 22:11:27.572046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 22:11:27.572379) ========= 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.XzByr4iqlL/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.Rr3mA0eofC/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005227 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 22:11:27.621165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 22:11:27.621486) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 22:11:27.621793) ========= ========= Total master_lag: 4.66 =========