builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0169 starttime: 1493700565.16 results: success (0) buildid: 20170501200621 builduid: d6453034fb1b4aa89e225e82f56a457d revision: 2e7c10a9b86e30691f67855f6c8f98d984508d7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.159621) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.160418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.160935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.189145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.189494) ========= 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.BGa43sdivZ/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.6ijdbp44CU/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2017-05-01 21:49:25 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147028 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.361963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.362274) ========= 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.BGa43sdivZ/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.6ijdbp44CU/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.035951 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.421367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:25.421744) ========= 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.BGa43sdivZ/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.6ijdbp44CU/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:25,522 truncating revision to first 12 chars 2017-05-01 21:49:25,522 Setting DEBUG logging. 2017-05-01 21:49:25,522 attempt 1/10 2017-05-01 21:49:25,522 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:49:25,845 unpacking tar archive at: mozilla-central-2e7c10a9b86e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600268 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:26.047874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:26.048431) ========= script_repo_revision: 2e7c10a9b86e30691f67855f6c8f98d984508d7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:26.048988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:26.049379) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 21:49:26.070802) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-05-01 21:49:26.071122) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BGa43sdivZ/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.6ijdbp44CU/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:49:26 INFO - MultiFileLogger online at 20170501 21:49:26 in /builds/slave/test 21:49:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:49:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:49:26 INFO - {'append_to_log': False, 21:49:26 INFO - 'base_work_dir': '/builds/slave/test', 21:49:26 INFO - 'blob_upload_branch': 'Firefox', 21:49:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:49:26 INFO - 'branch': 'Firefox', 21:49:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:49:26 INFO - 'config_files': ('talos/mac_config.py',), 21:49:26 INFO - 'default_actions': ('clobber', 21:49:26 INFO - 'read-buildbot-config', 21:49:26 INFO - 'download-and-extract', 21:49:26 INFO - 'populate-webroot', 21:49:26 INFO - 'create-virtualenv', 21:49:26 INFO - 'install', 21:49:26 INFO - 'run-tests'), 21:49:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:49:26 INFO - 'download_minidump_stackwalk': True, 21:49:26 INFO - 'download_symbols': 'ondemand', 21:49:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:49:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:49:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:49:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:49:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:49:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:49:26 INFO - 'gecko_profile': False, 21:49:26 INFO - 'gecko_profile_interval': 0, 21:49:26 INFO - 'installer_path': 'installer.exe', 21:49:26 INFO - 'log_level': 'info', 21:49:26 INFO - 'log_name': 'talos', 21:49:26 INFO - 'log_to_console': True, 21:49:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:49:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:49:26 INFO - 'opt_config_files': (), 21:49:26 INFO - 'pip_index': False, 21:49:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:49:26 INFO - 'cmd': ('bash', 21:49:26 INFO - '-c', 21:49:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:49:26 INFO - 'enabled': True, 21:49:26 INFO - 'halt_on_failure': False, 21:49:26 INFO - 'name': 'check_screen_resolution'},), 21:49:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:49:26 INFO - 'cmd': ('bash', 21:49:26 INFO - '-c', 21:49:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:49:26 INFO - 'enabled': True, 21:49:26 INFO - 'halt_on_failure': False, 21:49:26 INFO - 'name': 'check_screen_resolution'},), 21:49:26 INFO - 'run_cmd_checks_enabled': True, 21:49:26 INFO - 'suite': 'dromaeojs', 21:49:26 INFO - 'system_bits': '32', 21:49:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:49:26 INFO - 'title': 't-yosemite-r7-0169', 21:49:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:49:26 INFO - 'use_talos_json': True, 21:49:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:49:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:49:26 INFO - 'work_dir': 'build'} 21:49:26 INFO - [mozharness: 2017-05-02 04:49:26.281527Z] Running clobber step. 21:49:26 INFO - Running pre-action listener: _resource_record_pre_action 21:49:26 INFO - Running main action method: clobber 21:49:26 INFO - rmtree: /builds/slave/test/build 21:49:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:49:28 INFO - Running post-action listener: _resource_record_post_action 21:49:28 INFO - [mozharness: 2017-05-02 04:49:28.945381Z] Finished clobber step (success) 21:49:28 INFO - [mozharness: 2017-05-02 04:49:28.945615Z] Running read-buildbot-config step. 21:49:28 INFO - Running pre-action listener: _resource_record_pre_action 21:49:28 INFO - Running main action method: read_buildbot_config 21:49:28 INFO - Using buildbot properties: 21:49:28 INFO - { 21:49:28 INFO - "project": "", 21:49:28 INFO - "product": "firefox", 21:49:28 INFO - "script_repo_revision": "production", 21:49:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:49:28 INFO - "repository": "", 21:49:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:49:28 INFO - "buildid": "20170501200621", 21:49:28 INFO - "pgo_build": "False", 21:49:28 INFO - "basedir": "/builds/slave/test", 21:49:28 INFO - "buildnumber": 29, 21:49:28 INFO - "slavename": "t-yosemite-r7-0169", 21:49:28 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:49:28 INFO - "platform": "yosemite_r7", 21:49:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:49:28 INFO - "branch": "mozilla-central", 21:49:28 INFO - "repo_path": "mozilla-central", 21:49:28 INFO - "revision": "2e7c10a9b86e30691f67855f6c8f98d984508d7c", 21:49:28 INFO - "stage_platform": "macosx64", 21:49:28 INFO - "builduid": "d6453034fb1b4aa89e225e82f56a457d", 21:49:28 INFO - "slavebuilddir": "test" 21:49:28 INFO - } 21:49:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 21:49:28 INFO - Running post-action listener: _resource_record_post_action 21:49:28 INFO - [mozharness: 2017-05-02 04:49:28.951577Z] Finished read-buildbot-config step (success) 21:49:28 INFO - [mozharness: 2017-05-02 04:49:28.951823Z] Running download-and-extract step. 21:49:28 INFO - Running pre-action listener: _resource_record_pre_action 21:49:28 INFO - Running main action method: download_and_extract 21:49:28 INFO - mkdir: /builds/slave/test/build/tests 21:49:28 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:49:28 INFO - trying https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 21:49:28 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:49:28 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:49:30 INFO - Downloaded 1325 bytes. 21:49:30 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:49:30 INFO - Using the following test package requirements: 21:49:30 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 21:49:30 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:49:30 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 21:49:30 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 21:49:30 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'jsshell-mac.zip'], 21:49:30 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 21:49:30 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:49:30 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 21:49:30 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 21:49:30 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 21:49:30 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:49:30 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 21:49:30 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:49:30 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:49:30 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:49:30 INFO - Fetch https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:49:31 INFO - Content-Length response header: 52699754 21:49:31 INFO - Bytes received: 52699754 21:49:48 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:49:48 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:49:48 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:49:48 INFO - Fetch https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:49:50 INFO - Content-Length response header: 52699754 21:49:50 INFO - Bytes received: 52699754 21:50:05 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:05 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:05 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:07 INFO - Content-Length response header: 14408811 21:50:07 INFO - Bytes received: 14408811 21:50: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:50:07 INFO - trying https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:50:07 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:07 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:09 INFO - Downloaded 71249404 bytes. 21:50:09 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:09 INFO - mkdir: /builds/slave/test/properties 21:50:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:50:09 INFO - Writing to file /builds/slave/test/properties/build_url 21:50:09 INFO - Contents: 21:50:09 INFO - build_url:https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:50:10 INFO - Running post-action listener: _resource_record_post_action 21:50:10 INFO - Running post-action listener: set_extra_try_arguments 21:50:10 INFO - [mozharness: 2017-05-02 04:50:10.707118Z] Finished download-and-extract step (success) 21:50:10 INFO - [mozharness: 2017-05-02 04:50:10.707276Z] Running populate-webroot step. 21:50:10 INFO - Running pre-action listener: _resource_record_pre_action 21:50:10 INFO - Running main action method: populate_webroot 21:50:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:50:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:50:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:50:10 INFO - '--tppagecycles', 21:50:10 INFO - '7'], 21:50:10 INFO - 'tests': ['tsvgm']}}, 21:50:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:50:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:50:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:50:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:50:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['damp', 'tps']}, 21:50:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'tests': ['damp', 'tps']}, 21:50:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['dromaeo_dom']}, 21:50:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:50:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:50:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:50:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['a11yr', 21:50:10 INFO - 'ts_paint', 21:50:10 INFO - 'tpaint', 21:50:10 INFO - 'sessionrestore', 21:50:10 INFO - 'sessionrestore_no_auto_restore', 21:50:10 INFO - 'tabpaint']}, 21:50:10 INFO - 'other-e10s': {'tests': ['a11yr', 21:50:10 INFO - 'ts_paint', 21:50:10 INFO - 'tpaint', 21:50:10 INFO - 'sessionrestore', 21:50:10 INFO - 'sessionrestore_no_auto_restore', 21:50:10 INFO - 'tabpaint']}, 21:50:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:50:10 INFO - 'ts_paint', 21:50:10 INFO - 'tpaint', 21:50:10 INFO - 'sessionrestore', 21:50:10 INFO - 'sessionrestore_no_auto_restore', 21:50:10 INFO - 'tabpaint']}, 21:50:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:50:10 INFO - 'ts_paint', 21:50:10 INFO - 'tpaint', 21:50:10 INFO - 'sessionrestore', 21:50:10 INFO - 'sessionrestore_no_auto_restore', 21:50:10 INFO - 'tabpaint']}, 21:50:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['a11yr', 21:50:10 INFO - 'ts_paint', 21:50:10 INFO - 'tpaint', 21:50:10 INFO - 'sessionrestore', 21:50:10 INFO - 'sessionrestore_no_auto_restore', 21:50:10 INFO - 'tabpaint']}, 21:50:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['a11yr', 21:50:10 INFO - 'ts_paint', 21:50:10 INFO - 'tpaint', 21:50:10 INFO - 'sessionrestore', 21:50:10 INFO - 'sessionrestore_no_auto_restore', 21:50:10 INFO - 'tabpaint']}, 21:50:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:50:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:50:10 INFO - 'bloom_basic_ref']}, 21:50:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['tsvgx', 21:50:10 INFO - 'tsvgr_opacity', 21:50:10 INFO - 'tart', 21:50:10 INFO - 'tscrollx', 21:50:10 INFO - 'cart', 21:50:10 INFO - 'tsvg_static']}, 21:50:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:50:10 INFO - 'tsvgr_opacity', 21:50:10 INFO - 'tart', 21:50:10 INFO - 'tscrollx', 21:50:10 INFO - 'cart', 21:50:10 INFO - 'tsvg_static']}, 21:50:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'talos_options': ['--disable-e10s'], 21:50:10 INFO - 'tests': ['tp5o']}, 21:50:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:50:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'talos_options': ['--disable-e10s', 21:50:10 INFO - '--xperf_path', 21:50:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:10 INFO - 'tests': ['tp5n']}, 21:50:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:50:10 INFO - 'talos_options': ['--xperf_path', 21:50:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:10 INFO - 'tests': ['tp5n']}}, 21:50:10 INFO - 'talos.zip': {'path': '', 21:50:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:50:10 INFO - Running post-action listener: _resource_record_post_action 21:50:10 INFO - [mozharness: 2017-05-02 04:50:10.726173Z] Finished populate-webroot step (success) 21:50:10 INFO - [mozharness: 2017-05-02 04:50:10.726302Z] Running create-virtualenv step. 21:50:10 INFO - Running pre-action listener: _resource_record_pre_action 21:50:10 INFO - Running main action method: create_virtualenv 21:50:10 INFO - Creating virtualenv /builds/slave/test/build/venv 21:50:10 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:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:50:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:50:10 INFO - Using real prefix '/tools/python27' 21:50:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:50:11 INFO - Installing distribute.............................................................................................................................................................................................done. 21:50:14 INFO - Installing pip.................done. 21:50:14 INFO - Return code: 0 21:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:50:14 INFO - Reading from file tmpfile_stdout 21:50:14 INFO - Output received: 21:50:14 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:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:14 INFO - 'HOME': '/Users/cltbld', 21:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:14 INFO - 'LOGNAME': 'cltbld', 21:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:14 INFO - 'MOZ_NO_REMOTE': '1', 21:50:14 INFO - 'NO_EM_RESTART': '1', 21:50:14 INFO - 'PAGER': '/bin/cat', 21:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:14 INFO - 'PWD': '/builds/slave/test', 21:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:14 INFO - 'SHELL': '/bin/bash', 21:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:14 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:14 INFO - 'USER': 'cltbld', 21:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:14 INFO - 'XPC_FLAGS': '0x0', 21:50:14 INFO - 'XPC_SERVICE_NAME': '0', 21:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:14 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:14 INFO - Cleaning up... 21:50:14 INFO - Return code: 0 21:50:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:15 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:15 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:15 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:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:15 INFO - 'HOME': '/Users/cltbld', 21:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:15 INFO - 'LOGNAME': 'cltbld', 21:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:15 INFO - 'MOZ_NO_REMOTE': '1', 21:50:15 INFO - 'NO_EM_RESTART': '1', 21:50:15 INFO - 'PAGER': '/bin/cat', 21:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:15 INFO - 'PWD': '/builds/slave/test', 21:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:15 INFO - 'SHELL': '/bin/bash', 21:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:15 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:15 INFO - 'USER': 'cltbld', 21:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:15 INFO - 'XPC_FLAGS': '0x0', 21:50:15 INFO - 'XPC_SERVICE_NAME': '0', 21:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:15 INFO - Downloading/unpacking psutil>=3.1.1 21:50:15 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:15 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:15 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:15 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:15 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:15 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:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:50:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:18 INFO - Installing collected packages: psutil 21:50:18 INFO - Running setup.py install for psutil 21:50:18 INFO - building 'psutil._psutil_osx' extension 21:50:18 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:19 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:19 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:19 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:19 INFO - building 'psutil._psutil_posix' extension 21:50:19 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:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:50:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:50:19 INFO - ^ 21:50:19 INFO - 1 warning generated. 21:50:19 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:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:19 INFO - Successfully installed psutil 21:50:19 INFO - Cleaning up... 21:50:19 INFO - Return code: 0 21:50:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:50:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:20 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:20 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:50:20 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:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:20 INFO - 'HOME': '/Users/cltbld', 21:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:20 INFO - 'LOGNAME': 'cltbld', 21:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:20 INFO - 'MOZ_NO_REMOTE': '1', 21:50:20 INFO - 'NO_EM_RESTART': '1', 21:50:20 INFO - 'PAGER': '/bin/cat', 21:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:20 INFO - 'PWD': '/builds/slave/test', 21:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:20 INFO - 'SHELL': '/bin/bash', 21:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:20 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:20 INFO - 'USER': 'cltbld', 21:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:20 INFO - 'XPC_FLAGS': '0x0', 21:50:20 INFO - 'XPC_SERVICE_NAME': '0', 21:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:50:20 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:20 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:20 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:20 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:20 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:20 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:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:50:24 INFO - Installing collected packages: mozsystemmonitor 21:50:24 INFO - Running setup.py install for mozsystemmonitor 21:50:24 INFO - Successfully installed mozsystemmonitor 21:50:24 INFO - Cleaning up... 21:50:24 INFO - Return code: 0 21:50:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:24 INFO - 'HOME': '/Users/cltbld', 21:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:24 INFO - 'LOGNAME': 'cltbld', 21:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:24 INFO - 'MOZ_NO_REMOTE': '1', 21:50:24 INFO - 'NO_EM_RESTART': '1', 21:50:24 INFO - 'PAGER': '/bin/cat', 21:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:24 INFO - 'PWD': '/builds/slave/test', 21:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:24 INFO - 'SHELL': '/bin/bash', 21:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:24 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:24 INFO - 'USER': 'cltbld', 21:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:24 INFO - 'XPC_FLAGS': '0x0', 21:50:24 INFO - 'XPC_SERVICE_NAME': '0', 21:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:24 INFO - Downloading/unpacking jsonschema==2.5.1 21:50:24 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:24 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:24 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:24 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:24 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:24 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:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:50:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:27 INFO - Downloading functools32-3.2.3-2.tar.gz 21:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:50:27 INFO - warning: no files found matching '*.txt' 21:50:27 INFO - no previously-included directories found matching 'build' 21:50:27 INFO - no previously-included directories found matching 'dist' 21:50:27 INFO - no previously-included directories found matching '.git*' 21:50:27 INFO - Installing collected packages: jsonschema, functools32 21:50:27 INFO - Running setup.py install for functools32 21:50:27 INFO - warning: no files found matching '*.txt' 21:50:27 INFO - no previously-included directories found matching 'build' 21:50:27 INFO - no previously-included directories found matching 'dist' 21:50:27 INFO - no previously-included directories found matching '.git*' 21:50:27 INFO - Successfully installed jsonschema functools32 21:50:27 INFO - Cleaning up... 21:50:27 INFO - Return code: 0 21:50:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:27 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:27 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:50:27 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:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:27 INFO - 'HOME': '/Users/cltbld', 21:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:27 INFO - 'LOGNAME': 'cltbld', 21:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:27 INFO - 'MOZ_NO_REMOTE': '1', 21:50:27 INFO - 'NO_EM_RESTART': '1', 21:50:27 INFO - 'PAGER': '/bin/cat', 21:50:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:27 INFO - 'PWD': '/builds/slave/test', 21:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:27 INFO - 'SHELL': '/bin/bash', 21:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:27 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:27 INFO - 'USER': 'cltbld', 21:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:27 INFO - 'XPC_FLAGS': '0x0', 21:50:27 INFO - 'XPC_SERVICE_NAME': '0', 21:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:50:28 INFO - Cleaning up... 21:50:28 INFO - Return code: 0 21:50:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:50:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:28 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:28 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:50:28 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:50:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:28 INFO - 'HOME': '/Users/cltbld', 21:50:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:28 INFO - 'LOGNAME': 'cltbld', 21:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:28 INFO - 'MOZ_NO_REMOTE': '1', 21:50:28 INFO - 'NO_EM_RESTART': '1', 21:50:28 INFO - 'PAGER': '/bin/cat', 21:50:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:28 INFO - 'PWD': '/builds/slave/test', 21:50:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:28 INFO - 'SHELL': '/bin/bash', 21:50:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:28 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:28 INFO - 'USER': 'cltbld', 21:50:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:28 INFO - 'XPC_FLAGS': '0x0', 21:50:28 INFO - 'XPC_SERVICE_NAME': '0', 21:50:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:28 INFO - Downloading/unpacking blobuploader==1.2.4 21:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:50:30 INFO - Downloading blobuploader-1.2.4.tar.gz 21:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:50:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:50:31 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:31 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:31 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:31 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:31 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:31 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:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:50:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:50:31 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:31 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:31 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:31 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:31 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:31 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:32 INFO - Downloading docopt-0.6.1.tar.gz 21:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:50:32 INFO - Installing collected packages: blobuploader, requests, docopt 21:50:32 INFO - Running setup.py install for blobuploader 21:50:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:50:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:50:32 INFO - Running setup.py install for requests 21:50:32 INFO - Running setup.py install for docopt 21:50:33 INFO - Successfully installed blobuploader requests docopt 21:50:33 INFO - Cleaning up... 21:50:33 INFO - Return code: 0 21:50:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:50:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:33 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:33 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:50:33 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:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:33 INFO - 'HOME': '/Users/cltbld', 21:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:33 INFO - 'LOGNAME': 'cltbld', 21:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:33 INFO - 'MOZ_NO_REMOTE': '1', 21:50:33 INFO - 'NO_EM_RESTART': '1', 21:50:33 INFO - 'PAGER': '/bin/cat', 21:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:33 INFO - 'PWD': '/builds/slave/test', 21:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:33 INFO - 'SHELL': '/bin/bash', 21:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:33 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:33 INFO - 'USER': 'cltbld', 21:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:33 INFO - 'XPC_FLAGS': '0x0', 21:50:33 INFO - 'XPC_SERVICE_NAME': '0', 21:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:50:33 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-VlQISW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:50:33 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-X2M46w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:50:33 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-sf7_7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:50:33 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4hWSBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:50:33 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-VSNZS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:50:33 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Zsbfwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-iz8RTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-slNI7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-nzUlKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-HeAMCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-N6T2en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-0N72kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-YDqZQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-VP4f0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:50:34 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Z19OrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:50:35 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-m6qGL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:50:35 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-RmR9Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:50:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:50:35 INFO - Running setup.py install for manifestparser 21:50:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:50:35 INFO - Running setup.py install for mozcrash 21:50:35 INFO - Running setup.py install for mozdebug 21:50:35 INFO - Running setup.py install for mozdevice 21:50:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:50:35 INFO - Running setup.py install for mozfile 21:50:35 INFO - Running setup.py install for mozhttpd 21:50:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Running setup.py install for mozinfo 21:50:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Running setup.py install for mozInstall 21:50:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Running setup.py install for mozleak 21:50:36 INFO - Running setup.py install for mozlog 21:50:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Running setup.py install for moznetwork 21:50:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:50:36 INFO - Running setup.py install for mozprocess 21:50:36 INFO - Running setup.py install for mozprofile 21:50:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:50:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:50:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:50:37 INFO - Running setup.py install for mozrunner 21:50:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:50:37 INFO - Running setup.py install for mozscreenshot 21:50:37 INFO - Running setup.py install for moztest 21:50:37 INFO - Running setup.py install for mozversion 21:50:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:50:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:50:37 INFO - Cleaning up... 21:50:37 INFO - Return code: 0 21:50:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:37 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:37 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:50:37 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:50:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:37 INFO - 'HOME': '/Users/cltbld', 21:50:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:37 INFO - 'LOGNAME': 'cltbld', 21:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:37 INFO - 'MOZ_NO_REMOTE': '1', 21:50:37 INFO - 'NO_EM_RESTART': '1', 21:50:37 INFO - 'PAGER': '/bin/cat', 21:50:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:37 INFO - 'PWD': '/builds/slave/test', 21:50:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:37 INFO - 'SHELL': '/bin/bash', 21:50:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:37 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:37 INFO - 'USER': 'cltbld', 21:50:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:37 INFO - 'XPC_FLAGS': '0x0', 21:50:37 INFO - 'XPC_SERVICE_NAME': '0', 21:50:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-TbLfbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ok2njM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-yUv2lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-XohE54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-XV0uvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-pzWi0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-S4D3cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-boT_L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-r_h8Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:50:38 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:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:50:38 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-3gqORY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-2oWA3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-22fntn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-CLCjdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-g4ucBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-WXYUeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ndtkNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:50:39 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:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:50:39 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-CFBoqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:50:39 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:50:39 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:50:39 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:50:39 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:50:39 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:50:39 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:50:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:50:39 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:39 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:39 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:39 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:39 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:39 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:42 INFO - Downloading blessings-1.6.tar.gz 21:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:50:42 INFO - Installing collected packages: blessings 21:50:42 INFO - Running setup.py install for blessings 21:50:42 INFO - Successfully installed blessings 21:50:42 INFO - Cleaning up... 21:50:42 INFO - Return code: 0 21:50:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:50:43 INFO - Reading from file tmpfile_stdout 21:50:43 INFO - Current package versions: 21:50:43 INFO - blessings == 1.6 21:50:43 INFO - blobuploader == 1.2.4 21:50:43 INFO - docopt == 0.6.1 21:50:43 INFO - functools32 == 3.2.3-2 21:50:43 INFO - jsonschema == 2.5.1 21:50:43 INFO - manifestparser == 1.1 21:50:43 INFO - mozInstall == 1.12 21:50:43 INFO - mozcrash == 1.0 21:50:43 INFO - mozdebug == 0.1 21:50:43 INFO - mozdevice == 0.50 21:50:43 INFO - mozfile == 1.2 21:50:43 INFO - mozhttpd == 0.7 21:50:43 INFO - mozinfo == 0.9 21:50:43 INFO - mozleak == 0.1 21:50:43 INFO - mozlog == 3.4 21:50:43 INFO - moznetwork == 0.27 21:50:43 INFO - mozprocess == 0.25 21:50:43 INFO - mozprofile == 0.28 21:50:43 INFO - mozrunner == 6.13 21:50:43 INFO - mozscreenshot == 0.1 21:50:43 INFO - mozsystemmonitor == 0.3 21:50:43 INFO - moztest == 0.8 21:50:43 INFO - mozversion == 1.4 21:50:43 INFO - psutil == 3.1.1 21:50:43 INFO - requests == 1.2.3 21:50:43 INFO - wsgiref == 0.1.2 21:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:50: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:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:43 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 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:43 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:50:43 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:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:43 INFO - 'HOME': '/Users/cltbld', 21:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:43 INFO - 'LOGNAME': 'cltbld', 21:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:43 INFO - 'MOZ_NO_REMOTE': '1', 21:50:43 INFO - 'NO_EM_RESTART': '1', 21:50:43 INFO - 'PAGER': '/bin/cat', 21:50:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:43 INFO - 'PWD': '/builds/slave/test', 21:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:43 INFO - 'SHELL': '/bin/bash', 21:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:43 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:43 INFO - 'USER': 'cltbld', 21:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:43 INFO - 'XPC_FLAGS': '0x0', 21:50:43 INFO - 'XPC_SERVICE_NAME': '0', 21:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 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:50:43 INFO - Cleaning up... 21:50:43 INFO - Return code: 0 21:50:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:50: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:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50: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:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80435b3700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, '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.BGa43sdivZ/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.6ijdbp44CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:50:43 INFO - 'HOME': '/Users/cltbld', 21:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:50:43 INFO - 'LOGNAME': 'cltbld', 21:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:43 INFO - 'MOZ_NO_REMOTE': '1', 21:50:43 INFO - 'NO_EM_RESTART': '1', 21:50:43 INFO - 'PAGER': '/bin/cat', 21:50:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:50:43 INFO - 'PWD': '/builds/slave/test', 21:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:50:43 INFO - 'SHELL': '/bin/bash', 21:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:50:43 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:50:43 INFO - 'USER': 'cltbld', 21:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:43 INFO - 'XPC_FLAGS': '0x0', 21:50:43 INFO - 'XPC_SERVICE_NAME': '0', 21:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:50:43 INFO - Cleaning up... 21:50:43 INFO - Return code: 0 21:50:43 INFO - Running post-action listener: _resource_record_post_action 21:50:43 INFO - Running post-action listener: _start_resource_monitoring 21:50:43 INFO - Starting resource monitoring. 21:50:43 INFO - [mozharness: 2017-05-02 04:50:43.711327Z] Finished create-virtualenv step (success) 21:50:43 INFO - [mozharness: 2017-05-02 04:50:43.712245Z] Running install step. 21:50:43 INFO - Running pre-action listener: _resource_record_pre_action 21:50:43 INFO - Running main action method: install 21:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:50:43 INFO - Reading from file tmpfile_stdout 21:50:43 INFO - Detecting whether we're running mozinstall >=1.0... 21:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:50:44 INFO - Reading from file tmpfile_stdout 21:50:44 INFO - Output received: 21:50:44 INFO - Usage: mozinstall [options] installer 21:50:44 INFO - Options: 21:50:44 INFO - -h, --help show this help message and exit 21:50:44 INFO - -d DEST, --destination=DEST 21:50:44 INFO - Directory to install application into. [default: 21:50:44 INFO - "/builds/slave/test"] 21:50:44 INFO - --app=APP Application being installed. [default: firefox] 21:50:44 INFO - mkdir: /builds/slave/test/build/application 21:50:44 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:50:44 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:03 INFO - Reading from file tmpfile_stdout 21:51:03 INFO - Output received: 21:51:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:51:03 INFO - Running post-action listener: _resource_record_post_action 21:51:03 INFO - [mozharness: 2017-05-02 04:51:03.755382Z] Finished install step (success) 21:51:03 INFO - [mozharness: 2017-05-02 04:51:03.755520Z] Running run-tests step. 21:51:03 INFO - Running pre-action listener: _resource_record_pre_action 21:51:03 INFO - Running main action method: run_tests 21:51:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:51:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:51:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:51:03 INFO - 2017-05-01 21:51:03.769 screenresolution[1622:7528] starting screenresolution argv=screenresolution get 21:51:03 INFO - 2017-05-01 21:51:03.772 screenresolution[1622:7528] Display 0: 1600x1200x32@60 21:51:03 INFO - 2017-05-01 21:51:03.778 screenresolution[1623:7530] starting screenresolution argv=screenresolution list 21:51:03 INFO - Available Modes on Display 0 21:51:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:51:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:51:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:51:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:51:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:51:04 INFO - Intel Iris: 21:51:04 INFO - Chipset Model: Intel Iris 21:51:04 INFO - Type: GPU 21:51:04 INFO - Bus: Built-In 21:51:04 INFO - VRAM (Dynamic, Max): 1536 MB 21:51:04 INFO - Vendor: Intel (0x8086) 21:51:04 INFO - Device ID: 0x0a2e 21:51:04 INFO - Revision ID: 0x0009 21:51:04 INFO - Displays: 21:51:04 INFO - Display: 21:51:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:51:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:51:04 INFO - Display Serial Number: 1600x1200 60 21:51:04 INFO - Main Display: Yes 21:51:04 INFO - Mirror: Off 21:51:04 INFO - Online: Yes 21:51:04 INFO - Rotation: Supported 21:51:04 INFO - Return code: 0 21:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:51:04 INFO - Python 2.7.3 21:51:04 INFO - Return code: 0 21:51:04 INFO - grabbing minidump binary from tooltool 21:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:04 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 0x102d0dd30>, '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 0x102c33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d02be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:51:04 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:04 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:04 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:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:51:04 INFO - Return code: 0 21:51:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:51:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:51:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:51:04 INFO - ENV: RUST_BACKTRACE is now 1 21:51:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:51:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BGa43sdivZ/Render', 21:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:04 INFO - 'HOME': '/Users/cltbld', 21:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:04 INFO - 'LOGNAME': 'cltbld', 21:51:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:51:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:04 INFO - 'MOZ_NO_REMOTE': '1', 21:51:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:51:04 INFO - 'NO_EM_RESTART': '1', 21:51:04 INFO - 'PAGER': '/bin/cat', 21:51:04 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:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:04 INFO - 'PWD': '/builds/slave/test', 21:51:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:04 INFO - 'RUST_BACKTRACE': '1', 21:51:04 INFO - 'SHELL': '/bin/bash', 21:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ijdbp44CU/Listeners', 21:51:04 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 21:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:04 INFO - 'USER': 'cltbld', 21:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:04 INFO - 'XPC_FLAGS': '0x0', 21:51:04 INFO - 'XPC_SERVICE_NAME': '0', 21:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:51:04 INFO - mozversion application_buildid: 20170501200621 21:51:04 INFO - mozversion application_changeset: 2e7c10a9b86e30691f67855f6c8f98d984508d7c 21:51:04 INFO - mozversion application_display_name: Nightly 21:51:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:51:04 INFO - mozversion application_name: Firefox 21:51:04 INFO - mozversion application_remotingname: firefox 21:51:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:51:04 INFO - mozversion application_vendor: Mozilla 21:51:04 INFO - mozversion application_version: 55.0a1 21:51:04 INFO - mozversion platform_buildid: 20170501200621 21:51:04 INFO - mozversion platform_changeset: 2e7c10a9b86e30691f67855f6c8f98d984508d7c 21:51:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:51:04 INFO - mozversion platform_version: 55.0a1 21:51:04 INFO - using testdate: 1493700664 21:51:04 INFO - actual date: 1493700664 21:51:04 INFO - starting webserver on 'localhost:49234' 21:51:04 INFO - SUITE-START | Running 2 tests 21:51:04 INFO - TEST-START | dromaeo_css 21:51:04 INFO - operating with platform_type : mac_ 21:51:04 INFO - Initialising browser for dromaeo_css test... 21:51:04 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpazqIiI/profile http://localhost:49234/getInfo.html) 21:51:07 INFO - PID 1633 | __metrics Screen width/height:1600/1200 21:51:07 INFO - PID 1633 | colorDepth:24 21:51:07 INFO - PID 1633 | Browser inner width/height: 1024/689 21:51:07 INFO - PID 1633 | __metrics 21:51:07 INFO - PID 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:51:07 INFO - PID 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:51:08 INFO - TEST-INFO | 1633: exit 0 21:51:08 INFO - Browser initialized. 21:51:08 INFO - Running cycle 1/1 for dromaeo_css test... 21:51:08 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpazqIiI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:20 INFO - PID 1635 | RSS: Main: 240963584 21:51:20 INFO - PID 1635 | 21:54:25 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 21:54:27 INFO - PID 1635 | RSS: Main: 393162752 21:54:27 INFO - PID 1635 | 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 21:56:10 INFO - PID 1635 | 21:56:10 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:10 INFO - PID 1635 | Full stack: 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 21:56:10 INFO - PID 1635 | 21:56:10 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:10 INFO - PID 1635 | Full stack: 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 21:56:10 INFO - PID 1635 | 21:56:10 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:10 INFO - PID 1635 | Full stack: 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | ************************* 21:56:10 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 21:56:10 INFO - PID 1635 | 21:56:10 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:56:10 INFO - PID 1635 | Full stack: 21:56:10 INFO - PID 1635 | ************************* 21:57:29 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 21:57:30 INFO - PID 1635 | RSS: Main: 367767552 21:57:30 INFO - PID 1635 | 22:00:32 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 22:00:33 INFO - PID 1635 | RSS: Main: 344731648 22:00:33 INFO - PID 1635 | 22:03:35 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 22:03:36 INFO - PID 1635 | RSS: Main: 323624960 22:03:36 INFO - PID 1635 | 22:06:40 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 22:06:40 INFO - PID 1635 | RSS: Main: 333107200 22:06:40 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 22:09:43 INFO - PID 1635 | RSS: Main: 368803840 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | __start_tp_report 22:09:43 INFO - PID 1635 | _x_x_mozilla_page_load 22:09:43 INFO - PID 1635 | _x_x_mozilla_page_load_details 22:09:43 INFO - PID 1635 | |i|pagename|runs| 22:09:43 INFO - PID 1635 | |0;dojo.html;3562.5012498250235;3565.8573657053716;3606.080449485381;3614.230161019224;3617.222297206101;6062.605930614507;6167.7841275555365;6250.687465626717;6263.248410190783;6263.342349053347;6183.81448556544;6212.285587157478;6261.655608941506;6273.654948977804;6286.2456505219325;5238.292830467895;5288.894222115556;5386.2997810284605;5406.945930540694;5432.266644003068;5485.369182543998;5510.91733623996;5518.613697041209;5519.365272993597;5524.806631767889;5329.9467005330225;5402.945970540283;5409;5412.783488660449;5449.373322067973;5411;5436.83689489312;5442.727863606804;5474.616776825624;5484.561235101222;5352.411234764173;5400.594955378362;5414.675119492843;5416.593755468356;5417.241586177938;5151.330327057459;6124.173236613089;6155.44600985909;6261.123442718023;6261.311255761862;6508.381703738185;6516.380943810331;6520.739170433177;6522.119513865615;6524.706388212542;6586.769463068769;6660.866782664368;6779.084823548807;6782.864342713167;6797.728090876359;5836.241288632451;6264.4362007419095;6278.937210627927;6330.968345158245;6356.809295721136;6356.77751278703;6926.376626103674;6945.236024037352;6947.40947019509;6956.269591692901;6356.650384228819;6430.228372595318;6435.549511534241;6483.222013358333;6589.7364105435245;6702.530822842452;6742.865142697118;6756.121704178426;6761.154855643044;6765.560238584476;6643.56816806906;6657.567258128206;6661.134052573135;6662.200535935622;6687.531872768859;6460;6526.151600291932;6588.439982601437;6590.472762179014;6659.9001014984815;5326.121190003683;5343.946560534423;5353.7590808413715;5357.223202635596;5359.169328754049;4594.356790049395;4701.2242979908615;4705.411823522059;4740.7392593407;4816.710997340171;6285.277193122849;6299.244090709144;6353.809385718436;6375.71309291083;6393.488520918316;6459.966405375118;6492.35076492347;6578.934210657928;6735.8989615155815;6762.323767623198;6266.091416744546;6311.116443697886;6312.652804095819;6328.050792381179;6330.778422755274;5763.6541807491685;5812.79655212074;5814.563907706939;5827.155062515912;5828.446297601721;6845.178578570603;6854.520183587101;6856.828579285658;6857.451403887577;6903.6203008835;6730.865382692221;6738.66306684654;6740.62926539045;6756.054152418764;6756.189257289157;6982.231954484901;6985.371316581329;6991.825204369931;6994.720211191496;7017.684204210721;6584.242812076481;6618.867622647616;6619.205695316593;6633.668316584248;6636.966815166086;6516.087747715418;6537.313582074004;6568.310327415553;6651.13535240435;6743.325667433218;5415.918761218506;6465.030245463218;6497.18785151856;6503;6505.577137486048;6269.247690277196;6331.303556608861;6341.841453963688;6518.5111116667385;6533.542652014314;6238.781642642486;6340.524460665376;6415.133956915944;6418.4544313731985;6426.903596446151;6331.841703957438;6359;6495.350464953467;6531.085648009187;6537.150170477998;5962.777630585632;6284.591501552384;6302.810915672537;6323.083152942706;6361.236651601837 22:09:43 INFO - PID 1635 | |1;ext.html;768.750156199235;798.4730078148422;807.4549678966698;1126.2116518437092;1137.675762407713;26556.734432655667;27048.459030819373;27049.864750676268;27074.32314192146;27118.322041948937;26853.865730671318;34953.47569786449;38042.80978595103;38043.858684239516;38110.23779524408;6925.411340036103;8345.165483451667;8345.749627511153;8351;8352.24829765321;5970.462658360747;8233.670653173866;8335.49987000782;8373.037100733402;8374.958125209365;6093.695315234243;8173.100958894517;8295.585220738969;8296.294814940737;8305.83388332233;8261.256486916176;8319.584020798997;8338.416310858242;8339.499630022217;8340.082590914995;5834.183214349994;8154.306883914875;8248.257656810856;8249;8255.504669719776;25929.870350648314;35572;35682;35695.82152089223;35710.82144589286;3581.6955558777536;3614.4397618369194;3616.9276614467826;3618.276344731038;3630.7095432365613;30353.848230758926;30386;30391.848040759654;30417.23956901073;30428.69571304281;3064.69353064694;3147.134538002045;3154.9053528393956;3165.430222559938;3176.9682303176905;289207;293467;295373;295950;296357;47501.81245468822;47607.76196118997;47616.7619161902;47691.523084768705;47767.522324777005;51439.45681629557;51489.22766158511;51549.7422512885;51561;51905.2214216787;13799.965002624844;13942.651433714238;13950.302484875716;13956.790648140286;13971.510997115052;11236.494357753922;11264.66206013821;11281.266717663326;11291.096712262999;11321.547138114383;8563.443376180529;10569.260151789455;12317.753644927052;12591.559295424617;12665.873341266653;4888.266759986031;5527.39198688144;5647.37878833328;5649.576281778883;5675.517581005661;886.5434301334818;986.4032260482305;1001.5092604623827;1014.4674046125843;1041.614602597044;20355;23887.522249554913;24312.149074782297;24457;24545.509089818104;1096.3586302013252;1099.312929419113;1120.383788916093;1136.7499150186945;1143.2454579977175;11860.347680877634;12325.904596218665;12431.067669924792;12452.190607610477;12503.749925001632;298047;298820;298961;299771;299869;52810.47189528133;52816.471835281154;52968.20547691711;53048.93902121936;53115;1500.1599104501513;1550.0699580251758;1566.5535322433052;1567.639442928133;1572.6933248016755;23665.053397863892;23760.168394106124;23771;23794;23863.64204536968;37772.81113594415;37879.24241515099;37881.05297367478;37915.62084379121;37938.8103059483;267464;267868;268827;269234;269339;32795.67204328022;33535.83232083824;33538;33573.49639755455;33617.32765344728;36466.27067458689;36553.08617284589;36583.90248292556;42958;43269.567304327815;26289.474210516066;27628.447431050863;29064;29984;30208.697913020587;28879.42241155207;29392.11823645294;29670.406591868472;29739.066960647488;30169.849150754108;34653.82673086618;35833.64166358303;35833.64166358303;35864.641353587176;35919.82040089783;24051;28406.57390139191;29501.704982949897;29672.851635741685;30256;21518.569628607027;23460.530789383774;23477.413064672837;23851.284461466184;23940.40148996289 22:09:43 INFO - PID 1635 | |2;jquery.html;439.14366984380456;441.1507847393766;442.17092950717404;446.34833143610325;462.11043740798976;18960.241590336387;20784.688229676565;21275.04262308196;21506.677399839016;21578.89210553949;17821.37625183119;21032.89483552584;21787.455313617167;21800.781992180073;21907.890460547675;5782.450667186621;6024.0662697282;6040.1241819936085;6049.727762250687;6053.818385448443;5742.39704830993;5903.616264942786;5951.196588460567;6020.217371741667;6032.396760323976;5956.672383018954;5973.402659734035;5977.551683623724;5990.940090599103;6012.969935150318;5840.269966254218;6067.998780201261;6088.117223002684;6116.877662446771;6126.693665316717;4513.729176249402;5319.255304257407;5420.620556561043;5433.185022246695;5445.618806683534;26622.201333960013;26642.33394165142;26988.59517107245;27372.041978530655;27455.039073632528;2175.4343870593602;2238.418011317069;2248.9437764055865;2254.6505291679814;2257.7064981552294;17037.659246815118;17312.740308895376;17617.911910440365;17778.02220877851;17778.555536111573;1897.724829899657;2309.58427483053;2318.93043208704;2322.744498105207;2344.296710986714;146287.26856365651;148565;151467.9999999989;152504;153325;20972;22426;22630;22651.97788685513;22978.770212297663;38678.80660596735;38760.61239387626;38765.22469550593;38924.80537597294;38926.80536597299;9455.858162127573;9595.033581122747;10155.898441015643;10448.947755261175;11015.889841101647;8500.002489457143;8517.48895066298;8531.445456045338;8710.25962793157;8728.82160908282;8551.700690475804;10793.946030269955;10805.785743560018;10937.945310273557;10967.780644387067;3518.912788268303;4102.405151253051;4131.995981948752;4182.581741825793;4185.979070104691;868.7750272116285;923.7690577355661;953.1564565359567;955.7945041816043;966.6981930409565;17839.197236124404;20552.28067017677;20600.48498787542;20634.174633014813;20871.47821304449;852.7910661887753;958.8849338079475;985.1330828870691;988.0860204311127;996.9252306076928;10363.740906477247;10554.947225263824;10591.152707783358;10602.893971060344;10788.136949044057;516028;518613;520003;536920;537324;118487;122391;124117;126162.36918815348;128346.71653283534;1111.4609414433994;1134.9092072634169;1163.9349994754705;1164.295601161302;1165.2542372881362;14543;15549;17791;17824.643507129524;17982.5504362392;44931.32603011023;49844;51555.48444515507;51835.481645184576;52057.7397113012;72365;72539.63730181316;72938;73386.63306683433;73657.52684946379;11903.285802851857;11944.16390852632;12248.877511224773;12299.692507687021;12494.187877788278;13373.933130334286;13401.731965360443;13483.258420786951;13670;13708.65728356799;11534.538618455168;11647.12646551529;11695.76608467843;11758.764824703629;11862.347570883685;10171.186305095722;10179;10395.532201050819;10493.370397775852;10496.475176241005;10945.795962443966;11012.284201526874;11139.997400234019;11717.238379505305;12005.159638825548;11941.820872686743;12085.81871271914;12124.393780311126;12216.877831221575;12259.816102758288;11352.864713528581;11508.59719909799;11743.823842642196;11750.70623234426;11783.76432471363 22:09:43 INFO - PID 1635 | |3;mootools.html;1165.9125565582574;1375.8624137586244;1407.0572716280092;1428.3001329348622;1428.31440908364;9631.181349585286;10818.242723009393;11458.083353331735;11474.885251147485;11475.483603237843;11062.1703372247;11166.162537809676;11171.329720216792;11171.720706982329;11261.268017578872;2095.1933505600377;2452.8226451303385;2491.314888405694;2496.151308555091;2500.8499490030567;2154.9461263468384;2445.6698345723366;2534.2017264561605;2535.1760677779703;2537.936551586207;2241.4172315198084;2309.4919117794057;2470.481198948223;2482.1312540610734;2484.503099380122;2439.42673471734;2445.119756887519;2449.130558651671;2453.2394957563033;2453.5338285725743;2336.707911511061;2435.2085572189108;2435.695538057743;2437.0617312334703;2447.877606119687;11316.830247546293;11441.199116061878;11462.48418821155;11476.967072963473;11502.424878756112;6411.422971932502;6676.833079173011;6677.833054173636;6678.966605166992;6681.933180668179;3898.298306304864;4081.673456126771;4255.2978758504805;4260.829566817323;4263.680223983214;1235.308227392654;1236.3570943109623;1267.3979859566725;1281.2312612432559;1286.183273621248;16212.432564860292;16238.350465981346;16245.268962896698;16257.674846503121;16258.918705406397;5699.772009119672;5863.149843272701;5912.9113063304085;5984.401559843981;6026.21659184312;13584.728305433837;13608.86391136076;13610.047296689138;13618.182909025292;13620.93189534046;6616.768413105518;6719.764808231688;6748.4938629602975;6766.898496522556;6767.984802279599;5070.7464626768515;5227.712475813867;6102.877942441126;6152.538559608047;6261.812145635638;4112.794360282034;4509.954900451019;4519.231730605805;4609.1703493371515;4664.813407463731;1391.4851504943033;1421.594845469057;1426.108682073704;1444.2129039673403;1449.1377630309948;705.206642527157;777.7122464687989;791.639803889229;793.0998316910349;795.5862951265425;6508.316626754217;6573.868522629521;6625.536212465177;6694.49791265657;6797.320267973262;883.9822611595351;914.1635403605759;920.8112336970905;955.3790036476207;960.5245403525299;4041;4256.29771087767;4345.847895323712;4352.760598167068;4414.735115893057;14370.712585748226;15013.924930375279;15053.548393548212;15057.096574205583;15058.397664093533;14399.856001439852;14518.056326338965;14804.555863324118;14845.257737113101;14890.478833240784;8192.057913340042;8257.21556452136;8326.292265157408;8343.624536895853;8419.410641255054;5453.672779633234;5804.303483581828;6778.7288508459105;6782.966085169543;6973.965130174317;12730.554430594884;13050.673733156747;13330.533431329857;13426.261555614536;13473.124246923919;13008.739825203254;13187.73624527485;13528.053036287365;13551.390187441391;13596.79604805909;8381.580920953806;9138.817223655622;9323.160915517636;9332.066793320613;9340.71977840666;9851.113399794052;10198.490075496344;10833.02502774754;10909.39998300101;10922.726931826768;8660.307175426076;8696.956515217384;8708.998465176586;8869.73390798277;8952.955235223782;8741.519216443157;8808.603612837309;8859.64561417536;8882.955585222033;8936.24041956441;7964.123946365779;8026.317762989977;8144.75565733029;8155.714549990722;8166.7958301042945;5047.990401919704;5904.291485021825;5948.226730525004;6062.939370606237;6118;5974.581779275409;6121.051237058263;6123.295820980644;6229.96885015572;6351.364863513611 22:09:43 INFO - PID 1635 | |4;prototype.html;394.9723519353645;399.65629558579616;404.76546533074134;406.3031900291004;411.2186844994512;5242.895142097156;5337.558859108039;5869.50109240715;6052.273727152742;6059.878802423949;4868.294097355882;5310.20346947957;5436.483534064268;5976.850578735533;5984.222051133346;4278.807453664593;4464.955350446503;4494.8651540453675;4508;4528.343390208418;4025.295573274665;4522.8643140705835;4522.932156017662;4526.886827829314;4534.433195850519;3882.611738826123;4240.130773191504;4279.657627389817;4291.313389857623;4472;3707.518022657051;3888.51393575803;4247.299195632717;4282.357646353056;4283.378910058024;3680.803738784879;3681.889543313705;3697.0942119180704;3705.981470092659;3707.2927072927073;4978.800847966077;5045.823396181153;5296.364436267634;5517.36550296717;5857.255622945385;4208.431861698662;5041.294218809369;5047.848564543069;5070.569001634829;5075.593952483792;6308.495320374359;6341.556091073627;6363.649999250039;6368.713407896656;6368.808935731936;3424.74314426419;3648.41625339947;4087.89780255493;4095.692823038284;4152.730072545275;4952.504749525091;5826;6004.889095517299;6279.843003924892;6394.840128996766;4159.9376009359885;4193.496780386312;4215.536291007987;4222.4933008038615;4228.640565551901;4107.979460102681;4176.14389050244;4257.936130958038;4288.957110428856;4291.699581029298;5036.748162591855;5182.144946083929;5305.336832895888;5450.781968721207;5454.045542030208;5335.813246536352;5628.395907166438;6518.543701940818;6528.21661400635;6528.869422611616;1403.2632867744517;1600.287871897018;1631.5268572113955;1638.189096397291;1663.4178037686713;978.8923218445965;1131.7283851875654;1151.9884801151882;1152.8731839497648;1166.7724793665154;6106.328303886569;6121.602095863755;6123.8162855114415;6134.141220229171;6137.447629713347;5818.854528636818;6631.750442283343;6641.734330626818;6654.334566543307;6699.464042876558;5202.713850738246;5573.191887176336;5956.9873121569435;6082.711688259767;6110;3455.4298540740997;3467.531883195736;3479.251960828434;3484.5295885055193;3491.9349598372232;6053.880032194058;6185.453691536717;6855.451563874878;6865.798485265059;6963.512554121265;5683.744231509592;6460.741570337133;6842.384185423336;6844.28135045823;6848.589084654936;5713.514351280188;5752.79191369817;6444.806655800334;6666.899996500057;6941.889297712442;5173.560247379015;6034.547408944434;6599.472042236705;6676.9332306676315;6710.825605519112;5491.670499770026;5560.4161563035295;6098.939010609837;6283.37166283368;6424.13274207976;5443.755031023693;6798.796036118924;6928.653567321715;6950.721971121098;6966.407855332353;4579.175748365326;4678.906421871476;4750.976245118753;4754.595859351855;4763.285507173951;6592.318958665702;6631.270560238273;6673.232578253563;6704.820933196633;6717.56335838169;6090.330063693079;6422.967885160544;6429.51778616615;6440.710168042356;6448.709808058742;5369.785208591613;6386.489080873426;6458.515611329075;6460.515461340512;6467.773627923;5841.415858414124;6199.969000154971;6377.692573022427;6380.680965951777;6385.775183532286;5303.681779093266;6298;6462.933615953315;6463.578012837168;6491.707873145625;5971.164037034905;6303.9684801575695;6323.36766323364;6327.335629758809;6328.177336946167 22:09:43 INFO - PID 1635 | |5;yui.html;713.5362014690454;849.0024221539693;858.8196478739465;867.6052396159746;881.7354793561932;11539.711507212314;12455.06587005976;12772.616821495358;12777.041721870863;14058;12796.360181990909;16525.752113718303;16884.662306753857;16938.40715574955;17026.914865425686;977.8484334928097;993.5926270229171;996.0637001218868;998.6654470752306;1000.9099181073702;1019.5819713917296;1019.8113349030416;1020.6733845169549;1022.7392015036193;1024.359775140537;697.5988806436294;715.6529083394549;892.7098692924793;949.5964215208543;1069.978600427991;1053.7945100705365;1055.614700634267;1055.9683209503728;1056.271172890703;1065.0414626835832;779.3142035009156;780.1574299756306;781.0510230070435;782.5617654113714;788.6293442082269;16037.35850565976;16367.908022994252;16565.923214990988;16776;17126;16606.335746570123;16665.4167104152;16936.661266774594;17123.058231797248;17133.14334283281;12116.818247726203;13968.93015534926;14095.78856317156;14249.501267455693;14325.78511322331;3419.5212670226188;3439.5872495300723;3442.0362298556192;3447.775894566845;3448.499967504698;126731.36634316861;127731.36134319362;129038.3548082263;130353.34823325918;130998;10953.616623418142;11921.225120367322;12072.698182545506;12178.330191839534;12297.016238700882;17175.941451482442;18542.81457185438;18863.81136188648;23594.528109437717;24251.272461826175;7522.811929701692;7779.8833017504785;7798.103218129874;7803.92196078032;7808.2191780822595;3834.0989867381145;3866.4586957825927;3884.4561761353434;3907.5897030811357;3914.706397020235;4026.939595906064;4165.687573432005;4166.166766646622;4167.374893765898;4170.311898536707;847.51268020887;870.7474832298689;885.7298523950257;886.4149661223562;888.5024386343669;541.5721579951794;652.2401402366285;667.6361383046251;668.214847554122;687.5874475314871;10556.472176391304;11077.836827133196;11187.272827266203;11812.678116000701;12081.758364832654;650.9902351464732;651.3584119642148;659.7657831469759;665.374547924949;674.9291324410964;5289.2859463972645;5395.136778115482;5572.58205634579;5621.494065534122;5679.403662615366;106505;106802.46598766957;108212;108841;113558;63870.403239919375;81738.59130704308;95150.57274140893;97033;98915.50542247243;74740;75043.62478187574;75665;76026;76724;10877.891221088004;11021.44892755343;11119.27724697892;11168.050715689258;11328.093752499944;33865.7508086247;38885.6111438882;39505.604943950195;40372.3944140844;43475.56524434715;46512.76743616396;72618;73603.63198183975;74036.62981685057;74301;16055.839441605902;16349.346026159295;16421.58946026359;16457.09485978283;16473.67052658916;17779.377721779674;17895.910520447316;18070.457886263433;18412.171452284947;18446.90776546109;16426.589335266715;16452.83547164561;16762.413315533897;16896.831031689526;17033.31866725367;16349.427770027993;16386.508404747878;16543.586410339838;16610.169491525616;16722.08028558441;16016.439424620083;16063;16378.099204543865;16385.34458621642;16506.33974641001;11191.88808111941;11386.373749443861;11924.167786236683;12054.276743395425;12081.033517318769;12927.418266178232;13598.320083995959;13771.311434428439;13908.095973761672;13933.164010159422 22:09:43 INFO - PID 1635 | __end_tp_report 22:09:43 INFO - PID 1635 | __start_cc_report 22:09:43 INFO - PID 1635 | _x_x_mozilla_cycle_collect,1657 22:09:43 INFO - PID 1635 | __end_cc_report 22:09:43 INFO - PID 1635 | __startTimestamp1493701783309__endTimestamp 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | ------- Summary: start ------- 22:09:43 INFO - PID 1635 | Number of tests: 6 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:6137.78 Median:6353.81 stddev:718.45 (11.3%) stddev-sans-first:691.66 22:09:43 INFO - PID 1635 | Values: 3562.5 3565.9 3606.1 3614.2 3617.2 6062.6 6167.8 6250.7 6263.2 6263.3 6183.8 6212.3 6261.7 6273.7 6286.2 5238.3 5288.9 5386.3 5406.9 5432.3 5485.4 5510.9 5518.6 5519.4 5524.8 5329.9 5402.9 5409.0 5412.8 5449.4 5411.0 5436.8 5442.7 5474.6 5484.6 5352.4 5400.6 5414.7 5416.6 5417.2 5151.3 6124.2 6155.4 6261.1 6261.3 6508.4 6516.4 6520.7 6522.1 6524.7 6586.8 6660.9 6779.1 6782.9 6797.7 5836.2 6264.4 6278.9 6331.0 6356.8 6356.8 6926.4 6945.2 6947.4 6956.3 6356.7 6430.2 6435.5 6483.2 6589.7 6702.5 6742.9 6756.1 6761.2 6765.6 6643.6 6657.6 6661.1 6662.2 6687.5 6460.0 6526.2 6588.4 6590.5 6659.9 5326.1 5343.9 5353.8 5357.2 5359.2 4594.4 4701.2 4705.4 4740.7 4816.7 6285.3 6299.2 6353.8 6375.7 6393.5 6460.0 6492.4 6578.9 6735.9 6762.3 6266.1 6311.1 6312.7 6328.1 6330.8 5763.7 5812.8 5814.6 5827.2 5828.4 6845.2 6854.5 6856.8 6857.5 6903.6 6730.9 6738.7 6740.6 6756.1 6756.2 6982.2 6985.4 6991.8 6994.7 7017.7 6584.2 6618.9 6619.2 6633.7 6637.0 6516.1 6537.3 6568.3 6651.1 6743.3 5415.9 6465.0 6497.2 6503.0 6505.6 6269.2 6331.3 6341.8 6518.5 6533.5 6238.8 6340.5 6415.1 6418.5 6426.9 6331.8 6359.0 6495.4 6531.1 6537.2 5962.8 6284.6 6302.8 6323.1 6361.2 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:43023.95 Median:16746.69 stddev:75437.96 (450.5%) stddev-sans-first:75582.87 22:09:43 INFO - PID 1635 | Values: 768.8 798.5 807.5 1126.2 1137.7 26556.7 27048.5 27049.9 27074.3 27118.3 26853.9 34953.5 38042.8 38043.9 38110.2 6925.4 8345.2 8345.7 8351.0 8352.2 5970.5 8233.7 8335.5 8373.0 8375.0 6093.7 8173.1 8295.6 8296.3 8305.8 8261.3 8319.6 8338.4 8339.5 8340.1 5834.2 8154.3 8248.3 8249.0 8255.5 25929.9 35572.0 35682.0 35695.8 35710.8 3581.7 3614.4 3616.9 3618.3 3630.7 30353.8 30386.0 30391.8 30417.2 30428.7 3064.7 3147.1 3154.9 3165.4 3177.0 289207.0 293467.0 295373.0 295950.0 296357.0 47501.8 47607.8 47616.8 47691.5 47767.5 51439.5 51489.2 51549.7 51561.0 51905.2 13800.0 13942.7 13950.3 13956.8 13971.5 11236.5 11264.7 11281.3 11291.1 11321.5 8563.4 10569.3 12317.8 12591.6 12665.9 4888.3 5527.4 5647.4 5649.6 5675.5 886.5 986.4 1001.5 1014.5 1041.6 20355.0 23887.5 24312.1 24457.0 24545.5 1096.4 1099.3 1120.4 1136.7 1143.2 11860.3 12325.9 12431.1 12452.2 12503.7 298047.0 298820.0 298961.0 299771.0 299869.0 52810.5 52816.5 52968.2 53048.9 53115.0 1500.2 1550.1 1566.6 1567.6 1572.7 23665.1 23760.2 23771.0 23794.0 23863.6 37772.8 37879.2 37881.1 37915.6 37938.8 267464.0 267868.0 268827.0 269234.0 269339.0 32795.7 33535.8 33538.0 33573.5 33617.3 36466.3 36553.1 36583.9 42958.0 43269.6 26289.5 27628.4 29064.0 29984.0 30208.7 28879.4 29392.1 29670.4 29739.1 30169.8 34653.8 35833.6 35833.6 35864.6 35919.8 24051.0 28406.6 29501.7 29672.9 30256.0 21518.6 23460.5 23477.4 23851.3 23940.4 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:35307.66 Median:12332.21 stddev:89016.14 (721.8%) stddev-sans-first:89227.35 22:09:43 INFO - PID 1635 | Values: 439.1 441.2 442.2 446.3 462.1 18960.2 20784.7 21275.0 21506.7 21578.9 17821.4 21032.9 21787.5 21800.8 21907.9 5782.5 6024.1 6040.1 6049.7 6053.8 5742.4 5903.6 5951.2 6020.2 6032.4 5956.7 5973.4 5977.6 5990.9 6013.0 5840.3 6068.0 6088.1 6116.9 6126.7 4513.7 5319.3 5420.6 5433.2 5445.6 26622.2 26642.3 26988.6 27372.0 27455.0 2175.4 2238.4 2248.9 2254.7 2257.7 17037.7 17312.7 17617.9 17778.0 17778.6 1897.7 2309.6 2318.9 2322.7 2344.3 146287.3 148565.0 151468.0 152504.0 153325.0 20972.0 22426.0 22630.0 22652.0 22978.8 38678.8 38760.6 38765.2 38924.8 38926.8 9455.9 9595.0 10155.9 10448.9 11015.9 8500.0 8517.5 8531.4 8710.3 8728.8 8551.7 10793.9 10805.8 10937.9 10967.8 3518.9 4102.4 4132.0 4182.6 4186.0 868.8 923.8 953.2 955.8 966.7 17839.2 20552.3 20600.5 20634.2 20871.5 852.8 958.9 985.1 988.1 996.9 10363.7 10554.9 10591.2 10602.9 10788.1 516028.0 518613.0 520003.0 536920.0 537324.0 118487.0 122391.0 124117.0 126162.4 128346.7 1111.5 1134.9 1163.9 1164.3 1165.3 14543.0 15549.0 17791.0 17824.6 17982.6 44931.3 49844.0 51555.5 51835.5 52057.7 72365.0 72539.6 72938.0 73386.6 73657.5 11903.3 11944.2 12248.9 12299.7 12494.2 13373.9 13401.7 13483.3 13670.0 13708.7 11534.5 11647.1 11695.8 11758.8 11862.3 10171.2 10179.0 10395.5 10493.4 10496.5 10945.8 11012.3 11140.0 11717.2 12005.2 11941.8 12085.8 12124.4 12216.9 12259.8 11352.9 11508.6 11743.8 11750.7 11783.8 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7056.69 Median:4097.23 stddev:4468.65 (109.1%) stddev-sans-first:4459.26 22:09:43 INFO - PID 1635 | Values: 1165.9 1375.9 1407.1 1428.3 1428.3 9631.2 10818.2 11458.1 11474.9 11475.5 11062.2 11166.2 11171.3 11171.7 11261.3 2095.2 2452.8 2491.3 2496.2 2500.8 2154.9 2445.7 2534.2 2535.2 2537.9 2241.4 2309.5 2470.5 2482.1 2484.5 2439.4 2445.1 2449.1 2453.2 2453.5 2336.7 2435.2 2435.7 2437.1 2447.9 11316.8 11441.2 11462.5 11477.0 11502.4 6411.4 6676.8 6677.8 6679.0 6681.9 3898.3 4081.7 4255.3 4260.8 4263.7 1235.3 1236.4 1267.4 1281.2 1286.2 16212.4 16238.4 16245.3 16257.7 16258.9 5699.8 5863.1 5912.9 5984.4 6026.2 13584.7 13608.9 13610.0 13618.2 13620.9 6616.8 6719.8 6748.5 6766.9 6768.0 5070.7 5227.7 6102.9 6152.5 6261.8 4112.8 4510.0 4519.2 4609.2 4664.8 1391.5 1421.6 1426.1 1444.2 1449.1 705.2 777.7 791.6 793.1 795.6 6508.3 6573.9 6625.5 6694.5 6797.3 884.0 914.2 920.8 955.4 960.5 4041.0 4256.3 4345.8 4352.8 4414.7 14370.7 15013.9 15053.5 15057.1 15058.4 14399.9 14518.1 14804.6 14845.3 14890.5 8192.1 8257.2 8326.3 8343.6 8419.4 5453.7 5804.3 6778.7 6783.0 6974.0 12730.6 13050.7 13330.5 13426.3 13473.1 13008.7 13187.7 13528.1 13551.4 13596.8 8381.6 9138.8 9323.2 9332.1 9340.7 9851.1 10198.5 10833.0 10909.4 10922.7 8660.3 8697.0 8709.0 8869.7 8953.0 8741.5 8808.6 8859.6 8883.0 8936.2 7964.1 8026.3 8144.8 8155.7 8166.8 5048.0 5904.3 5948.2 6062.9 6118.0 5974.6 6121.1 6123.3 6230.0 6351.4 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5116.22 Median:5538.89 stddev:1592.45 (28.8%) stddev-sans-first:1556.99 22:09:43 INFO - PID 1635 | Values: 395.0 399.7 404.8 406.3 411.2 5242.9 5337.6 5869.5 6052.3 6059.9 4868.3 5310.2 5436.5 5976.9 5984.2 4278.8 4465.0 4494.9 4508.0 4528.3 4025.3 4522.9 4522.9 4526.9 4534.4 3882.6 4240.1 4279.7 4291.3 4472.0 3707.5 3888.5 4247.3 4282.4 4283.4 3680.8 3681.9 3697.1 3706.0 3707.3 4978.8 5045.8 5296.4 5517.4 5857.3 4208.4 5041.3 5047.8 5070.6 5075.6 6308.5 6341.6 6363.6 6368.7 6368.8 3424.7 3648.4 4087.9 4095.7 4152.7 4952.5 5826.0 6004.9 6279.8 6394.8 4159.9 4193.5 4215.5 4222.5 4228.6 4108.0 4176.1 4257.9 4289.0 4291.7 5036.7 5182.1 5305.3 5450.8 5454.0 5335.8 5628.4 6518.5 6528.2 6528.9 1403.3 1600.3 1631.5 1638.2 1663.4 978.9 1131.7 1152.0 1152.9 1166.8 6106.3 6121.6 6123.8 6134.1 6137.4 5818.9 6631.8 6641.7 6654.3 6699.5 5202.7 5573.2 5957.0 6082.7 6110.0 3455.4 3467.5 3479.3 3484.5 3491.9 6053.9 6185.5 6855.5 6865.8 6963.5 5683.7 6460.7 6842.4 6844.3 6848.6 5713.5 5752.8 6444.8 6666.9 6941.9 5173.6 6034.5 6599.5 6676.9 6710.8 5491.7 5560.4 6098.9 6283.4 6424.1 5443.8 6798.8 6928.7 6950.7 6966.4 4579.2 4678.9 4751.0 4754.6 4763.3 6592.3 6631.3 6673.2 6704.8 6717.6 6090.3 6423.0 6429.5 6440.7 6448.7 5369.8 6386.5 6458.5 6460.5 6467.8 5841.4 6200.0 6377.7 6380.7 6385.8 5303.7 6298.0 6462.9 6463.6 6491.7 5971.2 6304.0 6323.4 6327.3 6328.2 22:09:43 INFO - PID 1635 | 22:09:43 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21687.31 Median:17129.57 stddev:31383.19 (183.2%) stddev-sans-first:31431.71 22:09:43 INFO - PID 1635 | Values: 713.5 849.0 858.8 867.6 881.7 11539.7 12455.1 12772.6 12777.0 14058.0 12796.4 16525.8 16884.7 16938.4 17026.9 977.8 993.6 996.1 998.7 1000.9 1019.6 1019.8 1020.7 1022.7 1024.4 697.6 715.7 892.7 949.6 1070.0 1053.8 1055.6 1056.0 1056.3 1065.0 779.3 780.2 781.1 782.6 788.6 16037.4 16367.9 16565.9 16776.0 17126.0 16606.3 16665.4 16936.7 17123.1 17133.1 12116.8 13968.9 14095.8 14249.5 14325.8 3419.5 3439.6 3442.0 3447.8 3448.5 126731.4 127731.4 129038.4 130353.3 130998.0 10953.6 11921.2 12072.7 12178.3 12297.0 17175.9 18542.8 18863.8 23594.5 24251.3 7522.8 7779.9 7798.1 7803.9 7808.2 3834.1 3866.5 3884.5 3907.6 3914.7 4026.9 4165.7 4166.2 4167.4 4170.3 847.5 870.7 885.7 886.4 888.5 541.6 652.2 667.6 668.2 687.6 10556.5 11077.8 11187.3 11812.7 12081.8 651.0 651.4 659.8 665.4 674.9 5289.3 5395.1 5572.6 5621.5 5679.4 106505.0 106802.5 108212.0 108841.0 113558.0 63870.4 81738.6 95150.6 97033.0 98915.5 74740.0 75043.6 75665.0 76026.0 76724.0 10877.9 11021.4 11119.3 11168.1 11328.1 33865.8 38885.6 39505.6 40372.4 43475.6 46512.8 72618.0 73603.6 74036.6 74301.0 16055.8 16349.3 16421.6 16457.1 16473.7 17779.4 17895.9 18070.5 18412.2 18446.9 16426.6 16452.8 16762.4 16896.8 17033.3 16349.4 16386.5 16543.6 16610.2 16722.1 16016.4 16063.0 16378.1 16385.3 16506.3 11191.9 11386.4 11924.2 12054.3 12081.0 12927.4 13598.3 13771.3 13908.1 13933.2 22:09:43 INFO - PID 1635 | -------- Summary: end -------- 22:09:43 INFO - PID 1635 | 22:09:43 INFO - TEST-INFO | 1635: exit 0 22:09:43 INFO - TEST-OK | dromaeo_css | took 1119558ms 22:09:43 INFO - TEST-START | kraken 22:09:43 INFO - operating with platform_type : mac_ 22:09:43 INFO - Initialising browser for kraken test... 22:09:43 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpXZpv5Y/profile http://localhost:49234/getInfo.html) 22:09:46 INFO - PID 1646 | __metrics Screen width/height:1600/1200 22:09:46 INFO - PID 1646 | colorDepth:24 22:09:46 INFO - PID 1646 | Browser inner width/height: 1024/689 22:09:46 INFO - PID 1646 | __metrics 22:09:46 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:09:46 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:09:47 INFO - TEST-INFO | 1646: exit 0 22:09:47 INFO - Browser initialized. 22:09:47 INFO - Running cycle 1/1 for kraken test... 22:09:47 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpXZpv5Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:09:59 INFO - PID 1647 | RSS: Main: 243335168 22:09:59 INFO - PID 1647 | 22:10:02 INFO - PID 1647 | 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:03 INFO - PID 1647 | RSS: Main: 310513664 22:10:03 INFO - PID 1647 | 22:10:06 INFO - PID 1647 | 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:07 INFO - PID 1647 | RSS: Main: 293126144 22:10:07 INFO - PID 1647 | 22:10:10 INFO - PID 1647 | 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:10 INFO - PID 1647 | RSS: Main: 387436544 22:10:10 INFO - PID 1647 | 22:10:12 INFO - PID 1647 | 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:13 INFO - PID 1647 | RSS: Main: 289157120 22:10:13 INFO - PID 1647 | 22:10:15 INFO - PID 1647 | 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:16 INFO - PID 1647 | RSS: Main: 291831808 22:10:16 INFO - PID 1647 | 22:10:18 INFO - PID 1647 | 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:19 INFO - PID 1647 | RSS: Main: 354357248 22:10:19 INFO - PID 1647 | 22:10:22 INFO - PID 1647 | 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:23 INFO - PID 1647 | RSS: Main: 370888704 22:10:23 INFO - PID 1647 | 22:10:25 INFO - PID 1647 | 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:10:26 INFO - PID 1647 | RSS: Main: 373645312 22:10:26 INFO - PID 1647 | 22:10:27 INFO - PID 1647 | 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:10:28 INFO - PID 1647 | RSS: Main: 329863168 22:10:28 INFO - PID 1647 | 22:10:30 INFO - PID 1647 | 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:10:30 INFO - PID 1647 | RSS: Main: 332677120 22:10:30 INFO - PID 1647 | 22:10:33 INFO - PID 1647 | 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:10:33 INFO - PID 1647 | RSS: Main: 336117760 22:10:33 INFO - PID 1647 | 22:10:36 INFO - PID 1647 | 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:10:37 INFO - PID 1647 | RSS: Main: 351457280 22:10:37 INFO - PID 1647 | 22:10:40 INFO - PID 1647 | 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:10:41 INFO - PID 1647 | RSS: Main: 343941120 22:10:41 INFO - PID 1647 | 22:10:42 INFO - PID 1647 | 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:10:43 INFO - PID 1647 | RSS: Main: 386588672 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | __start_tp_report 22:10:43 INFO - PID 1647 | _x_x_mozilla_page_load 22:10:43 INFO - PID 1647 | _x_x_mozilla_page_load_details 22:10:43 INFO - PID 1647 | |i|pagename|runs| 22:10:43 INFO - PID 1647 | |0;ai-astar;117;162;152;111;112;111;111;112;110;111 22:10:43 INFO - PID 1647 | |1;audio-beat-detection;162;142;88;175;143;151;107;113;152;140 22:10:43 INFO - PID 1647 | |2;audio-dft;185;185;183;187;186;184;186;182;184;182 22:10:43 INFO - PID 1647 | |3;audio-fft;81;58;58;89;79;86;87;82;80;59 22:10:43 INFO - PID 1647 | |4;audio-oscillator;92;70;86;69;69;68;88;68;68;90 22:10:43 INFO - PID 1647 | |5;imaging-gaussian-blur;87;86;87;86;86;93;101;86;87;86 22:10:43 INFO - PID 1647 | |6;imaging-darkroom;93;93;93;103;93;94;94;94;94;94 22:10:43 INFO - PID 1647 | |7;imaging-desaturate;86;85;85;87;86;85;85;83;84;85 22:10:43 INFO - PID 1647 | |8;json-parse-financial;48;49;46;46;48;50;48;49;48;49 22:10:43 INFO - PID 1647 | |9;json-stringify-tinderbox;53;53;58;57;65;60;58;56;57;58 22:10:43 INFO - PID 1647 | |10;stanford-crypto-aes;83;80;83;80;82;83;81;82;78;81 22:10:43 INFO - PID 1647 | |11;stanford-crypto-ccm;136;138;137;133;133;145;145;139;185;135 22:10:43 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;219;232;185;183;179;184;239;200;185;181 22:10:43 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;58;56;72;67;88;72;68;67;68;67 22:10:43 INFO - PID 1647 | __end_tp_report 22:10:43 INFO - PID 1647 | __start_cc_report 22:10:43 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2186 22:10:43 INFO - PID 1647 | __end_cc_report 22:10:43 INFO - PID 1647 | __startTimestamp1493701843019__endTimestamp 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | ------- Summary: start ------- 22:10:43 INFO - PID 1647 | Number of tests: 14 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:120.90 Median:112.00 stddev:19.27 (17.2%) stddev-sans-first:20.38 22:10:43 INFO - PID 1647 | Values: 117.0 162.0 152.0 111.0 112.0 111.0 111.0 112.0 110.0 111.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:151.50 stddev:26.74 (17.7%) stddev-sans-first:26.83 22:10:43 INFO - PID 1647 | Values: 162.0 142.0 88.0 175.0 143.0 151.0 107.0 113.0 152.0 140.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.71 (0.9%) stddev-sans-first:1.80 22:10:43 INFO - PID 1647 | Values: 185.0 185.0 183.0 187.0 186.0 184.0 186.0 182.0 184.0 182.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:75.90 Median:81.50 stddev:12.53 (15.4%) stddev-sans-first:13.15 22:10:43 INFO - PID 1647 | Values: 81.0 58.0 58.0 89.0 79.0 86.0 87.0 82.0 80.0 59.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.00 stddev:10.62 (13.6%) stddev-sans-first:9.74 22:10:43 INFO - PID 1647 | Values: 92.0 70.0 86.0 69.0 69.0 68.0 88.0 68.0 68.0 90.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:86.50 stddev:4.88 (5.6%) stddev-sans-first:5.15 22:10:43 INFO - PID 1647 | Values: 87.0 86.0 87.0 86.0 86.0 93.0 101.0 86.0 87.0 86.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:3.03 (3.2%) stddev-sans-first:3.16 22:10:43 INFO - PID 1647 | Values: 93.0 93.0 93.0 103.0 93.0 94.0 94.0 94.0 94.0 94.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.10 (1.3%) stddev-sans-first:1.12 22:10:43 INFO - PID 1647 | Values: 86.0 85.0 85.0 87.0 86.0 85.0 85.0 83.0 84.0 85.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.50 stddev:1.29 (2.7%) stddev-sans-first:1.36 22:10:43 INFO - PID 1647 | Values: 48.0 49.0 46.0 46.0 48.0 50.0 48.0 49.0 48.0 49.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:3.44 (5.9%) stddev-sans-first:3.24 22:10:43 INFO - PID 1647 | Values: 53.0 53.0 58.0 57.0 65.0 60.0 58.0 56.0 57.0 58.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:1.64 (2.0%) stddev-sans-first:1.62 22:10:43 INFO - PID 1647 | Values: 83.0 80.0 83.0 80.0 82.0 83.0 81.0 82.0 78.0 81.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:138.50 stddev:15.49 (11.2%) stddev-sans-first:16.25 22:10:43 INFO - PID 1647 | Values: 136.0 138.0 137.0 133.0 133.0 145.0 145.0 139.0 185.0 135.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.70 Median:192.50 stddev:22.82 (11.9%) stddev-sans-first:22.99 22:10:43 INFO - PID 1647 | Values: 219.0 232.0 185.0 183.0 179.0 184.0 239.0 200.0 185.0 181.0 22:10:43 INFO - PID 1647 | 22:10:43 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:8.68 (12.8%) stddev-sans-first:8.37 22:10:43 INFO - PID 1647 | Values: 58.0 56.0 72.0 67.0 88.0 72.0 68.0 67.0 68.0 67.0 22:10:43 INFO - PID 1647 | -------- Summary: end -------- 22:10:43 INFO - PID 1647 | 22:10:44 INFO - TEST-INFO | 1647: exit 0 22:10:44 INFO - TEST-OK | kraken | took 60179ms 22:10:44 INFO - SUITE-END | took 1179s 22:10:44 INFO - Completed test suite (00:19:39) 22:10:44 INFO - javascript benchmark 22:10:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7821.942734745962, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3562.5012498250235, 3565.8573657053716, 3606.080449485381, 3614.230161019224, 3617.222297206101, 6062.605930614507, 6167.7841275555365, 6250.687465626717, 6263.248410190783, 6263.342349053347, 6183.81448556544, 6212.285587157478, 6261.655608941506, 6273.654948977804, 6286.2456505219325, 5238.292830467895, 5288.894222115556, 5386.2997810284605, 5406.945930540694, 5432.266644003068, 5485.369182543998, 5510.91733623996, 5518.613697041209, 5519.365272993597, 5524.806631767889, 5329.9467005330225, 5402.945970540283, 5409.0, 5412.783488660449, 5449.373322067973, 5411.0, 5436.83689489312, 5442.727863606804, 5474.616776825624, 5484.561235101222, 5352.411234764173, 5400.594955378362, 5414.675119492843, 5416.593755468356, 5417.241586177938, 5151.330327057459, 6124.173236613089, 6155.44600985909, 6261.123442718023, 6261.311255761862, 6508.381703738185, 6516.380943810331, 6520.739170433177, 6522.119513865615, 6524.706388212542, 6586.769463068769, 6660.866782664368, 6779.084823548807, 6782.864342713167, 6797.728090876359, 5836.241288632451, 6264.4362007419095, 6278.937210627927, 6330.968345158245, 6356.809295721136, 6356.77751278703, 6926.376626103674, 6945.236024037352, 6947.40947019509, 6956.269591692901, 6356.650384228819, 6430.228372595318, 6435.549511534241, 6483.222013358333, 6589.7364105435245, 6702.530822842452, 6742.865142697118, 6756.121704178426, 6761.154855643044, 6765.560238584476, 6643.56816806906, 6657.567258128206, 6661.134052573135, 6662.200535935622, 6687.531872768859, 6460.0, 6526.151600291932, 6588.439982601437, 6590.472762179014, 6659.9001014984815, 5326.121190003683, 5343.946560534423, 5353.7590808413715, 5357.223202635596, 5359.169328754049, 4594.356790049395, 4701.2242979908615, 4705.411823522059, 4740.7392593407, 4816.710997340171, 6285.277193122849, 6299.244090709144, 6353.809385718436, 6375.71309291083, 6393.488520918316, 6459.966405375118, 6492.35076492347, 6578.934210657928, 6735.8989615155815, 6762.323767623198, 6266.091416744546, 6311.116443697886, 6312.652804095819, 6328.050792381179, 6330.778422755274, 5763.6541807491685, 5812.79655212074, 5814.563907706939, 5827.155062515912, 5828.446297601721, 6845.178578570603, 6854.520183587101, 6856.828579285658, 6857.451403887577, 6903.6203008835, 6730.865382692221, 6738.66306684654, 6740.62926539045, 6756.054152418764, 6756.189257289157, 6982.231954484901, 6985.371316581329, 6991.825204369931, 6994.720211191496, 7017.684204210721, 6584.242812076481, 6618.867622647616, 6619.205695316593, 6633.668316584248, 6636.966815166086, 6516.087747715418, 6537.313582074004, 6568.310327415553, 6651.13535240435, 6743.325667433218, 5415.918761218506, 6465.030245463218, 6497.18785151856, 6503.0, 6505.577137486048, 6269.247690277196, 6331.303556608861, 6341.841453963688, 6518.5111116667385, 6533.542652014314, 6238.781642642486, 6340.524460665376, 6415.133956915944, 6418.4544313731985, 6426.903596446151, 6331.841703957438, 6359.0, 6495.350464953467, 6531.085648009187, 6537.150170477998, 5962.777630585632, 6284.591501552384, 6302.810915672537, 6323.083152942706, 6361.236651601837], "value": 6090.108825156031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.750156199235, 798.4730078148422, 807.4549678966698, 1126.2116518437092, 1137.675762407713, 26556.734432655667, 27048.459030819373, 27049.864750676268, 27074.32314192146, 27118.322041948937, 26853.865730671318, 34953.47569786449, 38042.80978595103, 38043.858684239516, 38110.23779524408, 6925.411340036103, 8345.165483451667, 8345.749627511153, 8351.0, 8352.24829765321, 5970.462658360747, 8233.670653173866, 8335.49987000782, 8373.037100733402, 8374.958125209365, 6093.695315234243, 8173.100958894517, 8295.585220738969, 8296.294814940737, 8305.83388332233, 8261.256486916176, 8319.584020798997, 8338.416310858242, 8339.499630022217, 8340.082590914995, 5834.183214349994, 8154.306883914875, 8248.257656810856, 8249.0, 8255.504669719776, 25929.870350648314, 35572.0, 35682.0, 35695.82152089223, 35710.82144589286, 3581.6955558777536, 3614.4397618369194, 3616.9276614467826, 3618.276344731038, 3630.7095432365613, 30353.848230758926, 30386.0, 30391.848040759654, 30417.23956901073, 30428.69571304281, 3064.69353064694, 3147.134538002045, 3154.9053528393956, 3165.430222559938, 3176.9682303176905, 289207.0, 293467.0, 295373.0, 295950.0, 296357.0, 47501.81245468822, 47607.76196118997, 47616.7619161902, 47691.523084768705, 47767.522324777005, 51439.45681629557, 51489.22766158511, 51549.7422512885, 51561.0, 51905.2214216787, 13799.965002624844, 13942.651433714238, 13950.302484875716, 13956.790648140286, 13971.510997115052, 11236.494357753922, 11264.66206013821, 11281.266717663326, 11291.096712262999, 11321.547138114383, 8563.443376180529, 10569.260151789455, 12317.753644927052, 12591.559295424617, 12665.873341266653, 4888.266759986031, 5527.39198688144, 5647.37878833328, 5649.576281778883, 5675.517581005661, 886.5434301334818, 986.4032260482305, 1001.5092604623827, 1014.4674046125843, 1041.614602597044, 20355.0, 23887.522249554913, 24312.149074782297, 24457.0, 24545.509089818104, 1096.3586302013252, 1099.312929419113, 1120.383788916093, 1136.7499150186945, 1143.2454579977175, 11860.347680877634, 12325.904596218665, 12431.067669924792, 12452.190607610477, 12503.749925001632, 298047.0, 298820.0, 298961.0, 299771.0, 299869.0, 52810.47189528133, 52816.471835281154, 52968.20547691711, 53048.93902121936, 53115.0, 1500.1599104501513, 1550.0699580251758, 1566.5535322433052, 1567.639442928133, 1572.6933248016755, 23665.053397863892, 23760.168394106124, 23771.0, 23794.0, 23863.64204536968, 37772.81113594415, 37879.24241515099, 37881.05297367478, 37915.62084379121, 37938.8103059483, 267464.0, 267868.0, 268827.0, 269234.0, 269339.0, 32795.67204328022, 33535.83232083824, 33538.0, 33573.49639755455, 33617.32765344728, 36466.27067458689, 36553.08617284589, 36583.90248292556, 42958.0, 43269.567304327815, 26289.474210516066, 27628.447431050863, 29064.0, 29984.0, 30208.697913020587, 28879.42241155207, 29392.11823645294, 29670.406591868472, 29739.066960647488, 30169.849150754108, 34653.82673086618, 35833.64166358303, 35833.64166358303, 35864.641353587176, 35919.82040089783, 24051.0, 28406.57390139191, 29501.704982949897, 29672.851635741685, 30256.0, 21518.569628607027, 23460.530789383774, 23477.413064672837, 23851.284461466184, 23940.40148996289], "value": 16744.62731562215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.14366984380456, 441.1507847393766, 442.17092950717404, 446.34833143610325, 462.11043740798976, 18960.241590336387, 20784.688229676565, 21275.04262308196, 21506.677399839016, 21578.89210553949, 17821.37625183119, 21032.89483552584, 21787.455313617167, 21800.781992180073, 21907.890460547675, 5782.450667186621, 6024.0662697282, 6040.1241819936085, 6049.727762250687, 6053.818385448443, 5742.39704830993, 5903.616264942786, 5951.196588460567, 6020.217371741667, 6032.396760323976, 5956.672383018954, 5973.402659734035, 5977.551683623724, 5990.940090599103, 6012.969935150318, 5840.269966254218, 6067.998780201261, 6088.117223002684, 6116.877662446771, 6126.693665316717, 4513.729176249402, 5319.255304257407, 5420.620556561043, 5433.185022246695, 5445.618806683534, 26622.201333960013, 26642.33394165142, 26988.59517107245, 27372.041978530655, 27455.039073632528, 2175.4343870593602, 2238.418011317069, 2248.9437764055865, 2254.6505291679814, 2257.7064981552294, 17037.659246815118, 17312.740308895376, 17617.911910440365, 17778.02220877851, 17778.555536111573, 1897.724829899657, 2309.58427483053, 2318.93043208704, 2322.744498105207, 2344.296710986714, 146287.26856365651, 148565.0, 151467.9999999989, 152504.0, 153325.0, 20972.0, 22426.0, 22630.0, 22651.97788685513, 22978.770212297663, 38678.80660596735, 38760.61239387626, 38765.22469550593, 38924.80537597294, 38926.80536597299, 9455.858162127573, 9595.033581122747, 10155.898441015643, 10448.947755261175, 11015.889841101647, 8500.002489457143, 8517.48895066298, 8531.445456045338, 8710.25962793157, 8728.82160908282, 8551.700690475804, 10793.946030269955, 10805.785743560018, 10937.945310273557, 10967.780644387067, 3518.912788268303, 4102.405151253051, 4131.995981948752, 4182.581741825793, 4185.979070104691, 868.7750272116285, 923.7690577355661, 953.1564565359567, 955.7945041816043, 966.6981930409565, 17839.197236124404, 20552.28067017677, 20600.48498787542, 20634.174633014813, 20871.47821304449, 852.7910661887753, 958.8849338079475, 985.1330828870691, 988.0860204311127, 996.9252306076928, 10363.740906477247, 10554.947225263824, 10591.152707783358, 10602.893971060344, 10788.136949044057, 516028.0, 518613.0, 520003.0, 536920.0, 537324.0, 118487.0, 122391.0, 124117.0, 126162.36918815348, 128346.71653283534, 1111.4609414433994, 1134.9092072634169, 1163.9349994754705, 1164.295601161302, 1165.2542372881362, 14543.0, 15549.0, 17791.0, 17824.643507129524, 17982.5504362392, 44931.32603011023, 49844.0, 51555.48444515507, 51835.481645184576, 52057.7397113012, 72365.0, 72539.63730181316, 72938.0, 73386.63306683433, 73657.52684946379, 11903.285802851857, 11944.16390852632, 12248.877511224773, 12299.692507687021, 12494.187877788278, 13373.933130334286, 13401.731965360443, 13483.258420786951, 13670.0, 13708.65728356799, 11534.538618455168, 11647.12646551529, 11695.76608467843, 11758.764824703629, 11862.347570883685, 10171.186305095722, 10179.0, 10395.532201050819, 10493.370397775852, 10496.475176241005, 10945.795962443966, 11012.284201526874, 11139.997400234019, 11717.238379505305, 12005.159638825548, 11941.820872686743, 12085.81871271914, 12124.393780311126, 12216.877831221575, 12259.816102758288, 11352.864713528581, 11508.59719909799, 11743.823842642196, 11750.70623234426, 11783.76432471363], "value": 11085.921321886008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1165.9125565582574, 1375.8624137586244, 1407.0572716280092, 1428.3001329348622, 1428.31440908364, 9631.181349585286, 10818.242723009393, 11458.083353331735, 11474.885251147485, 11475.483603237843, 11062.1703372247, 11166.162537809676, 11171.329720216792, 11171.720706982329, 11261.268017578872, 2095.1933505600377, 2452.8226451303385, 2491.314888405694, 2496.151308555091, 2500.8499490030567, 2154.9461263468384, 2445.6698345723366, 2534.2017264561605, 2535.1760677779703, 2537.936551586207, 2241.4172315198084, 2309.4919117794057, 2470.481198948223, 2482.1312540610734, 2484.503099380122, 2439.42673471734, 2445.119756887519, 2449.130558651671, 2453.2394957563033, 2453.5338285725743, 2336.707911511061, 2435.2085572189108, 2435.695538057743, 2437.0617312334703, 2447.877606119687, 11316.830247546293, 11441.199116061878, 11462.48418821155, 11476.967072963473, 11502.424878756112, 6411.422971932502, 6676.833079173011, 6677.833054173636, 6678.966605166992, 6681.933180668179, 3898.298306304864, 4081.673456126771, 4255.2978758504805, 4260.829566817323, 4263.680223983214, 1235.308227392654, 1236.3570943109623, 1267.3979859566725, 1281.2312612432559, 1286.183273621248, 16212.432564860292, 16238.350465981346, 16245.268962896698, 16257.674846503121, 16258.918705406397, 5699.772009119672, 5863.149843272701, 5912.9113063304085, 5984.401559843981, 6026.21659184312, 13584.728305433837, 13608.86391136076, 13610.047296689138, 13618.182909025292, 13620.93189534046, 6616.768413105518, 6719.764808231688, 6748.4938629602975, 6766.898496522556, 6767.984802279599, 5070.7464626768515, 5227.712475813867, 6102.877942441126, 6152.538559608047, 6261.812145635638, 4112.794360282034, 4509.954900451019, 4519.231730605805, 4609.1703493371515, 4664.813407463731, 1391.4851504943033, 1421.594845469057, 1426.108682073704, 1444.2129039673403, 1449.1377630309948, 705.206642527157, 777.7122464687989, 791.639803889229, 793.0998316910349, 795.5862951265425, 6508.316626754217, 6573.868522629521, 6625.536212465177, 6694.49791265657, 6797.320267973262, 883.9822611595351, 914.1635403605759, 920.8112336970905, 955.3790036476207, 960.5245403525299, 4041.0, 4256.29771087767, 4345.847895323712, 4352.760598167068, 4414.735115893057, 14370.712585748226, 15013.924930375279, 15053.548393548212, 15057.096574205583, 15058.397664093533, 14399.856001439852, 14518.056326338965, 14804.555863324118, 14845.257737113101, 14890.478833240784, 8192.057913340042, 8257.21556452136, 8326.292265157408, 8343.624536895853, 8419.410641255054, 5453.672779633234, 5804.303483581828, 6778.7288508459105, 6782.966085169543, 6973.965130174317, 12730.554430594884, 13050.673733156747, 13330.533431329857, 13426.261555614536, 13473.124246923919, 13008.739825203254, 13187.73624527485, 13528.053036287365, 13551.390187441391, 13596.79604805909, 8381.580920953806, 9138.817223655622, 9323.160915517636, 9332.066793320613, 9340.71977840666, 9851.113399794052, 10198.490075496344, 10833.02502774754, 10909.39998300101, 10922.726931826768, 8660.307175426076, 8696.956515217384, 8708.998465176586, 8869.73390798277, 8952.955235223782, 8741.519216443157, 8808.603612837309, 8859.64561417536, 8882.955585222033, 8936.24041956441, 7964.123946365779, 8026.317762989977, 8144.75565733029, 8155.714549990722, 8166.7958301042945, 5047.990401919704, 5904.291485021825, 5948.226730525004, 6062.939370606237, 6118.0, 5974.581779275409, 6121.051237058263, 6123.295820980644, 6229.96885015572, 6351.364863513611], "value": 5345.157731067411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9723519353645, 399.65629558579616, 404.76546533074134, 406.3031900291004, 411.2186844994512, 5242.895142097156, 5337.558859108039, 5869.50109240715, 6052.273727152742, 6059.878802423949, 4868.294097355882, 5310.20346947957, 5436.483534064268, 5976.850578735533, 5984.222051133346, 4278.807453664593, 4464.955350446503, 4494.8651540453675, 4508.0, 4528.343390208418, 4025.295573274665, 4522.8643140705835, 4522.932156017662, 4526.886827829314, 4534.433195850519, 3882.611738826123, 4240.130773191504, 4279.657627389817, 4291.313389857623, 4472.0, 3707.518022657051, 3888.51393575803, 4247.299195632717, 4282.357646353056, 4283.378910058024, 3680.803738784879, 3681.889543313705, 3697.0942119180704, 3705.981470092659, 3707.2927072927073, 4978.800847966077, 5045.823396181153, 5296.364436267634, 5517.36550296717, 5857.255622945385, 4208.431861698662, 5041.294218809369, 5047.848564543069, 5070.569001634829, 5075.593952483792, 6308.495320374359, 6341.556091073627, 6363.649999250039, 6368.713407896656, 6368.808935731936, 3424.74314426419, 3648.41625339947, 4087.89780255493, 4095.692823038284, 4152.730072545275, 4952.504749525091, 5826.0, 6004.889095517299, 6279.843003924892, 6394.840128996766, 4159.9376009359885, 4193.496780386312, 4215.536291007987, 4222.4933008038615, 4228.640565551901, 4107.979460102681, 4176.14389050244, 4257.936130958038, 4288.957110428856, 4291.699581029298, 5036.748162591855, 5182.144946083929, 5305.336832895888, 5450.781968721207, 5454.045542030208, 5335.813246536352, 5628.395907166438, 6518.543701940818, 6528.21661400635, 6528.869422611616, 1403.2632867744517, 1600.287871897018, 1631.5268572113955, 1638.189096397291, 1663.4178037686713, 978.8923218445965, 1131.7283851875654, 1151.9884801151882, 1152.8731839497648, 1166.7724793665154, 6106.328303886569, 6121.602095863755, 6123.8162855114415, 6134.141220229171, 6137.447629713347, 5818.854528636818, 6631.750442283343, 6641.734330626818, 6654.334566543307, 6699.464042876558, 5202.713850738246, 5573.191887176336, 5956.9873121569435, 6082.711688259767, 6110.0, 3455.4298540740997, 3467.531883195736, 3479.251960828434, 3484.5295885055193, 3491.9349598372232, 6053.880032194058, 6185.453691536717, 6855.451563874878, 6865.798485265059, 6963.512554121265, 5683.744231509592, 6460.741570337133, 6842.384185423336, 6844.28135045823, 6848.589084654936, 5713.514351280188, 5752.79191369817, 6444.806655800334, 6666.899996500057, 6941.889297712442, 5173.560247379015, 6034.547408944434, 6599.472042236705, 6676.9332306676315, 6710.825605519112, 5491.670499770026, 5560.4161563035295, 6098.939010609837, 6283.37166283368, 6424.13274207976, 5443.755031023693, 6798.796036118924, 6928.653567321715, 6950.721971121098, 6966.407855332353, 4579.175748365326, 4678.906421871476, 4750.976245118753, 4754.595859351855, 4763.285507173951, 6592.318958665702, 6631.270560238273, 6673.232578253563, 6704.820933196633, 6717.56335838169, 6090.330063693079, 6422.967885160544, 6429.51778616615, 6440.710168042356, 6448.709808058742, 5369.785208591613, 6386.489080873426, 6458.515611329075, 6460.515461340512, 6467.773627923, 5841.415858414124, 6199.969000154971, 6377.692573022427, 6380.680965951777, 6385.775183532286, 5303.681779093266, 6298.0, 6462.933615953315, 6463.578012837168, 6491.707873145625, 5971.164037034905, 6303.9684801575695, 6323.36766323364, 6327.335629758809, 6328.177336946167], "value": 4640.72587549554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.5362014690454, 849.0024221539693, 858.8196478739465, 867.6052396159746, 881.7354793561932, 11539.711507212314, 12455.06587005976, 12772.616821495358, 12777.041721870863, 14058.0, 12796.360181990909, 16525.752113718303, 16884.662306753857, 16938.40715574955, 17026.914865425686, 977.8484334928097, 993.5926270229171, 996.0637001218868, 998.6654470752306, 1000.9099181073702, 1019.5819713917296, 1019.8113349030416, 1020.6733845169549, 1022.7392015036193, 1024.359775140537, 697.5988806436294, 715.6529083394549, 892.7098692924793, 949.5964215208543, 1069.978600427991, 1053.7945100705365, 1055.614700634267, 1055.9683209503728, 1056.271172890703, 1065.0414626835832, 779.3142035009156, 780.1574299756306, 781.0510230070435, 782.5617654113714, 788.6293442082269, 16037.35850565976, 16367.908022994252, 16565.923214990988, 16776.0, 17126.0, 16606.335746570123, 16665.4167104152, 16936.661266774594, 17123.058231797248, 17133.14334283281, 12116.818247726203, 13968.93015534926, 14095.78856317156, 14249.501267455693, 14325.78511322331, 3419.5212670226188, 3439.5872495300723, 3442.0362298556192, 3447.775894566845, 3448.499967504698, 126731.36634316861, 127731.36134319362, 129038.3548082263, 130353.34823325918, 130998.0, 10953.616623418142, 11921.225120367322, 12072.698182545506, 12178.330191839534, 12297.016238700882, 17175.941451482442, 18542.81457185438, 18863.81136188648, 23594.528109437717, 24251.272461826175, 7522.811929701692, 7779.8833017504785, 7798.103218129874, 7803.92196078032, 7808.2191780822595, 3834.0989867381145, 3866.4586957825927, 3884.4561761353434, 3907.5897030811357, 3914.706397020235, 4026.939595906064, 4165.687573432005, 4166.166766646622, 4167.374893765898, 4170.311898536707, 847.51268020887, 870.7474832298689, 885.7298523950257, 886.4149661223562, 888.5024386343669, 541.5721579951794, 652.2401402366285, 667.6361383046251, 668.214847554122, 687.5874475314871, 10556.472176391304, 11077.836827133196, 11187.272827266203, 11812.678116000701, 12081.758364832654, 650.9902351464732, 651.3584119642148, 659.7657831469759, 665.374547924949, 674.9291324410964, 5289.2859463972645, 5395.136778115482, 5572.58205634579, 5621.494065534122, 5679.403662615366, 106505.0, 106802.46598766957, 108212.0, 108841.0, 113558.0, 63870.403239919375, 81738.59130704308, 95150.57274140893, 97033.0, 98915.50542247243, 74740.0, 75043.62478187574, 75665.0, 76026.0, 76724.0, 10877.891221088004, 11021.44892755343, 11119.27724697892, 11168.050715689258, 11328.093752499944, 33865.7508086247, 38885.6111438882, 39505.604943950195, 40372.3944140844, 43475.56524434715, 46512.76743616396, 72618.0, 73603.63198183975, 74036.62981685057, 74301.0, 16055.839441605902, 16349.346026159295, 16421.58946026359, 16457.09485978283, 16473.67052658916, 17779.377721779674, 17895.910520447316, 18070.457886263433, 18412.171452284947, 18446.90776546109, 16426.589335266715, 16452.83547164561, 16762.413315533897, 16896.831031689526, 17033.31866725367, 16349.427770027993, 16386.508404747878, 16543.586410339838, 16610.169491525616, 16722.08028558441, 16016.439424620083, 16063.0, 16378.099204543865, 16385.34458621642, 16506.33974641001, 11191.88808111941, 11386.373749443861, 11924.167786236683, 12054.276743395425, 12081.033517318769, 12927.418266178232, 13598.320083995959, 13771.311434428439, 13908.095973761672, 13933.164010159422], "value": 8166.533120117781, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 162.0, 152.0, 111.0, 112.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 120.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 142.0, 88.0, 175.0, 143.0, 151.0, 107.0, 113.0, 152.0, 140.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 183.0, 187.0, 186.0, 184.0, 186.0, 182.0, 184.0, 182.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 89.0, 79.0, 86.0, 87.0, 82.0, 80.0, 59.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 69.0, 69.0, 68.0, 88.0, 68.0, 68.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 86.0, 86.0, 93.0, 101.0, 86.0, 87.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 103.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 87.0, 86.0, 85.0, 85.0, 83.0, 84.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 46.0, 46.0, 48.0, 50.0, 48.0, 49.0, 48.0, 49.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 57.0, 65.0, 60.0, 58.0, 56.0, 57.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 83.0, 80.0, 82.0, 83.0, 81.0, 82.0, 78.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 137.0, 133.0, 133.0, 145.0, 145.0, 139.0, 185.0, 135.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 232.0, 185.0, 183.0, 179.0, 184.0, 239.0, 200.0, 185.0, 181.0], "value": 198.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 72.0, 67.0, 88.0, 72.0, 68.0, 67.0, 68.0, 67.0], "value": 68.3, "unit": "score"}]}]} 22:10:44 INFO - Return code: 0 22:10:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:10:44 ERROR - # TBPL SUCCESS # 22:10:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:10:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:10:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:10:44 INFO - 2017-05-01 22:10:44.345 screenresolution[1652:9994] starting screenresolution argv=screenresolution get 22:10:44 INFO - 2017-05-01 22:10:44.348 screenresolution[1652:9994] Display 0: 1600x1200x32@60 22:10:44 INFO - 2017-05-01 22:10:44.355 screenresolution[1653:9997] starting screenresolution argv=screenresolution list 22:10:44 INFO - Available Modes on Display 0 22:10:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:10:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:10:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:10:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:10:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:10:44 INFO - Intel Iris: 22:10:44 INFO - Chipset Model: Intel Iris 22:10:44 INFO - Type: GPU 22:10:44 INFO - Bus: Built-In 22:10:44 INFO - VRAM (Dynamic, Max): 1536 MB 22:10:44 INFO - Vendor: Intel (0x8086) 22:10:44 INFO - Device ID: 0x0a2e 22:10:44 INFO - Revision ID: 0x0009 22:10:44 INFO - Displays: 22:10:44 INFO - Display: 22:10:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:10:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:10:44 INFO - Display Serial Number: 1600x1200 60 22:10:44 INFO - Main Display: Yes 22:10:44 INFO - Mirror: Off 22:10:44 INFO - Online: Yes 22:10:44 INFO - Rotation: Supported 22:10:44 INFO - Return code: 0 22:10:44 INFO - Running post-action listener: _resource_record_post_action 22:10:44 INFO - [mozharness: 2017-05-02 05:10:44.598476Z] Finished run-tests step (success) 22:10:44 INFO - Running post-run listener: _resource_record_post_run 22:10:44 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 39220736; Write bytes: 509480960; Read time: 382; Write time: 1569 22:10:44 INFO - TinderboxPrint: CPU usage
53.4% 22:10:44 INFO - TinderboxPrint: I/O read bytes / time
39,220,736 / 382 22:10:44 INFO - TinderboxPrint: I/O write bytes / time
509,480,960 / 1,569 22:10:44 INFO - TinderboxPrint: CPU idle
2,238.9 (46.6%) 22:10:44 INFO - TinderboxPrint: CPU system
956.5 (19.9%) 22:10:44 INFO - TinderboxPrint: CPU user
1,606.4 (33.5%) 22:10:44 INFO - TinderboxPrint: Swap in / out
247,922,688 / 0 22:10:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209717760; Write bytes: 210946048; Read time: 16316; Write time: 450 22:10:44 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 34424320; Write bytes: 296945664; Read time: 346; Write time: 1113 22:10:45 INFO - Running post-run listener: _upload_blobber_files 22:10:45 INFO - Blob upload gear active. 22:10:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:10:45 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:10:45 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:10:45 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:10:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:10:46 INFO - (blobuploader) - INFO - Done attempting. 22:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:10:47 INFO - (blobuploader) - INFO - Done attempting. 22:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:10:48 INFO - (blobuploader) - INFO - Done attempting. 22:10:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:10:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:10:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:10:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:10:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:10:50 INFO - (blobuploader) - INFO - Done attempting. 22:10:50 INFO - (blobuploader) - INFO - Iteration through files over. 22:10:50 INFO - Return code: 0 22:10:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:10:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:10:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80964b5b9066a202afcadaeff92cdc9c46328caae7a2f00753f70fc1af696c1efe7503bb28486ea590d87826b0b13d9f8c7bdfc8ab733ae7007f619b7f1539bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a4b95f592a183af9a6cde092d9b239242008e225268239715d5c803ae293c41949d2072a155cad3ac82db6f2ab12e73af7302740f9f5f5c2e3d02fe113fcd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95dcc3d1534bd72ec5a7feccbbe20ca01dd1f687bfa28e05e473e39472aa7e9352c01184a5c96bcc9223c245be594ae37db0a30ccdfb64b04c1b33735078e652", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3773d1a73c72de8d2cb1c2f4e3d5d93332b05f4b4d8c88199f4be5ec69864caa8744d7760155630fe3b28329a94dc7e0486e57476fecbe63148c441ad04331d4"} 22:10:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:10:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:10:50 INFO - Contents: 22:10:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80964b5b9066a202afcadaeff92cdc9c46328caae7a2f00753f70fc1af696c1efe7503bb28486ea590d87826b0b13d9f8c7bdfc8ab733ae7007f619b7f1539bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a4b95f592a183af9a6cde092d9b239242008e225268239715d5c803ae293c41949d2072a155cad3ac82db6f2ab12e73af7302740f9f5f5c2e3d02fe113fcd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95dcc3d1534bd72ec5a7feccbbe20ca01dd1f687bfa28e05e473e39472aa7e9352c01184a5c96bcc9223c245be594ae37db0a30ccdfb64b04c1b33735078e652", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3773d1a73c72de8d2cb1c2f4e3d5d93332b05f4b4d8c88199f4be5ec69864caa8744d7760155630fe3b28329a94dc7e0486e57476fecbe63148c441ad04331d4"} 22:10:50 INFO - Running post-run listener: copy_logs_to_upload_dir 22:10:50 INFO - Copying logs to upload dir... 22:10:50 INFO - mkdir: /builds/slave/test/build/upload/logs 22:10:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.813584 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-05-01 22:10:50.924312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 22:10:50.928338) ========= 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.BGa43sdivZ/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.6ijdbp44CU/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80964b5b9066a202afcadaeff92cdc9c46328caae7a2f00753f70fc1af696c1efe7503bb28486ea590d87826b0b13d9f8c7bdfc8ab733ae7007f619b7f1539bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a4b95f592a183af9a6cde092d9b239242008e225268239715d5c803ae293c41949d2072a155cad3ac82db6f2ab12e73af7302740f9f5f5c2e3d02fe113fcd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95dcc3d1534bd72ec5a7feccbbe20ca01dd1f687bfa28e05e473e39472aa7e9352c01184a5c96bcc9223c245be594ae37db0a30ccdfb64b04c1b33735078e652", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3773d1a73c72de8d2cb1c2f4e3d5d93332b05f4b4d8c88199f4be5ec69864caa8744d7760155630fe3b28329a94dc7e0486e57476fecbe63148c441ad04331d4"} 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.010939 build_url: 'https://queue.taskcluster.net/v1/task/B6FKcWS0QbOgFbvecfeIew/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80964b5b9066a202afcadaeff92cdc9c46328caae7a2f00753f70fc1af696c1efe7503bb28486ea590d87826b0b13d9f8c7bdfc8ab733ae7007f619b7f1539bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a4b95f592a183af9a6cde092d9b239242008e225268239715d5c803ae293c41949d2072a155cad3ac82db6f2ab12e73af7302740f9f5f5c2e3d02fe113fcd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95dcc3d1534bd72ec5a7feccbbe20ca01dd1f687bfa28e05e473e39472aa7e9352c01184a5c96bcc9223c245be594ae37db0a30ccdfb64b04c1b33735078e652", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3773d1a73c72de8d2cb1c2f4e3d5d93332b05f4b4d8c88199f4be5ec69864caa8744d7760155630fe3b28329a94dc7e0486e57476fecbe63148c441ad04331d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 22:10:50.963220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 22:10:50.963530) ========= 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.BGa43sdivZ/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.6ijdbp44CU/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005075 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 22:10:51.011798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 22:10:51.012133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 22:10:51.012453) ========= ========= Total master_lag: 0.18 =========