builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0015 starttime: 1493581065.29 results: success (0) buildid: 20170430112445 builduid: 9e4ef03c009c463086631de418aa5719 revision: 5278e2a35fc8f2be390243db1e62858bf0982055 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:45.288634) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:45.289292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:45.289582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:45.317851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:45.318229) ========= 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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-30 12:37:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-04-30 12:37:46 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.705870 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:46.049696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:46.050062) ========= 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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.031201 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:46.104925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-30 12:37:46.105304) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5278e2a35fc8f2be390243db1e62858bf0982055 --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 5278e2a35fc8f2be390243db1e62858bf0982055 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-30 12:37:46,201 truncating revision to first 12 chars 2017-04-30 12:37:46,201 Setting DEBUG logging. 2017-04-30 12:37:46,201 attempt 1/10 2017-04-30 12:37:46,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5278e2a35fc8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-30 12:37:47,364 unpacking tar archive at: mozilla-central-5278e2a35fc8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.110339 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-30 12:37:48.241354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:48.241678) ========= script_repo_revision: 5278e2a35fc8f2be390243db1e62858bf0982055 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:48.242113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:48.242382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 12:37:48.264685) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-30 12:37:48.265131) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:37:48 INFO - MultiFileLogger online at 20170430 12:37:48 in /builds/slave/test 12:37:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:37:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:37:48 INFO - {'append_to_log': False, 12:37:48 INFO - 'base_work_dir': '/builds/slave/test', 12:37:48 INFO - 'blob_upload_branch': 'Firefox', 12:37:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:37:48 INFO - 'branch': 'Firefox', 12:37:48 INFO - 'buildbot_json_path': 'buildprops.json', 12:37:48 INFO - 'config_files': ('talos/mac_config.py',), 12:37:48 INFO - 'default_actions': ('clobber', 12:37:48 INFO - 'read-buildbot-config', 12:37:48 INFO - 'download-and-extract', 12:37:48 INFO - 'populate-webroot', 12:37:48 INFO - 'create-virtualenv', 12:37:48 INFO - 'install', 12:37:48 INFO - 'run-tests'), 12:37:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:37:48 INFO - 'download_minidump_stackwalk': True, 12:37:48 INFO - 'download_symbols': 'ondemand', 12:37:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:37:48 INFO - 'tooltool.py': '/tools/tooltool.py', 12:37:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:37:48 INFO - '/tools/misc-python/virtualenv.py')}, 12:37:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:37:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:37:48 INFO - 'gecko_profile': False, 12:37:48 INFO - 'gecko_profile_interval': 0, 12:37:48 INFO - 'installer_path': 'installer.exe', 12:37:48 INFO - 'log_level': 'info', 12:37:48 INFO - 'log_name': 'talos', 12:37:48 INFO - 'log_to_console': True, 12:37:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:37:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:37:48 INFO - 'opt_config_files': (), 12:37:48 INFO - 'pip_index': False, 12:37:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:37:48 INFO - 'cmd': ('bash', 12:37:48 INFO - '-c', 12:37:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:37:48 INFO - 'enabled': True, 12:37:48 INFO - 'halt_on_failure': False, 12:37:48 INFO - 'name': 'check_screen_resolution'},), 12:37:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:37:48 INFO - 'cmd': ('bash', 12:37:48 INFO - '-c', 12:37:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:37:48 INFO - 'enabled': True, 12:37:48 INFO - 'halt_on_failure': False, 12:37:48 INFO - 'name': 'check_screen_resolution'},), 12:37:48 INFO - 'run_cmd_checks_enabled': True, 12:37:48 INFO - 'suite': 'dromaeojs-e10s', 12:37:48 INFO - 'system_bits': '32', 12:37:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:37:48 INFO - 'title': 't-yosemite-r7-0015', 12:37:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:37:48 INFO - 'use_talos_json': True, 12:37:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:37:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:37:48 INFO - 'work_dir': 'build'} 12:37:48 INFO - [mozharness: 2017-04-30 19:37:48.473620Z] Running clobber step. 12:37:48 INFO - Running pre-action listener: _resource_record_pre_action 12:37:48 INFO - Running main action method: clobber 12:37:48 INFO - rmtree: /builds/slave/test/build 12:37:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:37:51 INFO - Running post-action listener: _resource_record_post_action 12:37:51 INFO - [mozharness: 2017-04-30 19:37:51.039875Z] Finished clobber step (success) 12:37:51 INFO - [mozharness: 2017-04-30 19:37:51.040003Z] Running read-buildbot-config step. 12:37:51 INFO - Running pre-action listener: _resource_record_pre_action 12:37:51 INFO - Running main action method: read_buildbot_config 12:37:51 INFO - Using buildbot properties: 12:37:51 INFO - { 12:37:51 INFO - "project": "", 12:37:51 INFO - "product": "firefox", 12:37:51 INFO - "script_repo_revision": "production", 12:37:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:37:51 INFO - "repository": "", 12:37:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:37:51 INFO - "buildid": "20170430112445", 12:37:51 INFO - "pgo_build": "False", 12:37:51 INFO - "basedir": "/builds/slave/test", 12:37:51 INFO - "buildnumber": 135, 12:37:51 INFO - "slavename": "t-yosemite-r7-0015", 12:37:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:37:51 INFO - "platform": "yosemite_r7", 12:37:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:37:51 INFO - "branch": "mozilla-central", 12:37:51 INFO - "repo_path": "mozilla-central", 12:37:51 INFO - "revision": "5278e2a35fc8f2be390243db1e62858bf0982055", 12:37:51 INFO - "stage_platform": "macosx64", 12:37:51 INFO - "builduid": "9e4ef03c009c463086631de418aa5719", 12:37:51 INFO - "slavebuilddir": "test" 12:37:51 INFO - } 12:37:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:37:51 INFO - Running post-action listener: _resource_record_post_action 12:37:51 INFO - [mozharness: 2017-04-30 19:37:51.043414Z] Finished read-buildbot-config step (success) 12:37:51 INFO - [mozharness: 2017-04-30 19:37:51.043526Z] Running download-and-extract step. 12:37:51 INFO - Running pre-action listener: _resource_record_pre_action 12:37:51 INFO - Running main action method: download_and_extract 12:37:51 INFO - mkdir: /builds/slave/test/build/tests 12:37:51 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')]} 12:37:51 INFO - trying https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:37:51 INFO - Downloading https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/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 12:37:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/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 12:37:52 INFO - Downloaded 1325 bytes. 12:37:52 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:37:52 INFO - Using the following test package requirements: 12:37:52 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:37:52 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:37:52 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:37:52 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:37:52 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'jsshell-mac.zip'], 12:37:52 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:37:52 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:37:52 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:37:52 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:37:52 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:37:52 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:37:52 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:37:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:37:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:37:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:37:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:37:54 INFO - Content-Length response header: 52699367 12:37:54 INFO - Bytes received: 52699367 12:38:10 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 12:38:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:38:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:38:10 INFO - Fetch https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:38:12 INFO - Content-Length response header: 52699367 12:38:12 INFO - Bytes received: 52699367 12:38:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:38:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:38:28 INFO - Fetch https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:38:29 INFO - Content-Length response header: 14408811 12:38:29 INFO - Bytes received: 14408811 12:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:29 INFO - trying https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:38:29 INFO - Downloading https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/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 12:38:31 INFO - Downloaded 71209615 bytes. 12:38:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:38:31 INFO - mkdir: /builds/slave/test/properties 12:38:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:38:31 INFO - Writing to file /builds/slave/test/properties/build_url 12:38:31 INFO - Contents: 12:38:31 INFO - build_url:https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:38:32 INFO - Running post-action listener: _resource_record_post_action 12:38:32 INFO - Running post-action listener: set_extra_try_arguments 12:38:32 INFO - [mozharness: 2017-04-30 19:38:32.473846Z] Finished download-and-extract step (success) 12:38:32 INFO - [mozharness: 2017-04-30 19:38:32.474015Z] Running populate-webroot step. 12:38:32 INFO - Running pre-action listener: _resource_record_pre_action 12:38:32 INFO - Running main action method: populate_webroot 12:38:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:38:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:38:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:38:32 INFO - '--tppagecycles', 12:38:32 INFO - '7'], 12:38:32 INFO - 'tests': ['tsvgm']}}, 12:38:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:38:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:38:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:38:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:38:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['damp', 'tps']}, 12:38:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'tests': ['damp', 'tps']}, 12:38:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['dromaeo_dom']}, 12:38:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:38:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:38:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:38:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['a11yr', 12:38:32 INFO - 'ts_paint', 12:38:32 INFO - 'tpaint', 12:38:32 INFO - 'sessionrestore', 12:38:32 INFO - 'sessionrestore_no_auto_restore', 12:38:32 INFO - 'tabpaint']}, 12:38:32 INFO - 'other-e10s': {'tests': ['a11yr', 12:38:32 INFO - 'ts_paint', 12:38:32 INFO - 'tpaint', 12:38:32 INFO - 'sessionrestore', 12:38:32 INFO - 'sessionrestore_no_auto_restore', 12:38:32 INFO - 'tabpaint']}, 12:38:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:38:32 INFO - 'ts_paint', 12:38:32 INFO - 'tpaint', 12:38:32 INFO - 'sessionrestore', 12:38:32 INFO - 'sessionrestore_no_auto_restore', 12:38:32 INFO - 'tabpaint']}, 12:38:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:38:32 INFO - 'ts_paint', 12:38:32 INFO - 'tpaint', 12:38:32 INFO - 'sessionrestore', 12:38:32 INFO - 'sessionrestore_no_auto_restore', 12:38:32 INFO - 'tabpaint']}, 12:38:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['a11yr', 12:38:32 INFO - 'ts_paint', 12:38:32 INFO - 'tpaint', 12:38:32 INFO - 'sessionrestore', 12:38:32 INFO - 'sessionrestore_no_auto_restore', 12:38:32 INFO - 'tabpaint']}, 12:38:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['a11yr', 12:38:32 INFO - 'ts_paint', 12:38:32 INFO - 'tpaint', 12:38:32 INFO - 'sessionrestore', 12:38:32 INFO - 'sessionrestore_no_auto_restore', 12:38:32 INFO - 'tabpaint']}, 12:38:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:38:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:38:32 INFO - 'bloom_basic_ref']}, 12:38:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['tsvgx', 12:38:32 INFO - 'tsvgr_opacity', 12:38:32 INFO - 'tart', 12:38:32 INFO - 'tscrollx', 12:38:32 INFO - 'cart', 12:38:32 INFO - 'tsvg_static']}, 12:38:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:38:32 INFO - 'tsvgr_opacity', 12:38:32 INFO - 'tart', 12:38:32 INFO - 'tscrollx', 12:38:32 INFO - 'cart', 12:38:32 INFO - 'tsvg_static']}, 12:38:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'talos_options': ['--disable-e10s'], 12:38:32 INFO - 'tests': ['tp5o']}, 12:38:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:38:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'talos_options': ['--disable-e10s', 12:38:32 INFO - '--xperf_path', 12:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:32 INFO - 'tests': ['tp5n']}, 12:38:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:38:32 INFO - 'talos_options': ['--xperf_path', 12:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:32 INFO - 'tests': ['tp5n']}}, 12:38:32 INFO - 'talos.zip': {'path': '', 12:38:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:38:32 INFO - Running post-action listener: _resource_record_post_action 12:38:32 INFO - [mozharness: 2017-04-30 19:38:32.493819Z] Finished populate-webroot step (success) 12:38:32 INFO - [mozharness: 2017-04-30 19:38:32.493939Z] Running create-virtualenv step. 12:38:32 INFO - Running pre-action listener: _resource_record_pre_action 12:38:32 INFO - Running main action method: create_virtualenv 12:38:32 INFO - Creating virtualenv /builds/slave/test/build/venv 12:38:32 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 12:38:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:38:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:38:32 INFO - Using real prefix '/tools/python27' 12:38:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:38:33 INFO - Installing distribute.............................................................................................................................................................................................done. 12:38:36 INFO - Installing pip.................done. 12:38:36 INFO - Return code: 0 12:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:38:36 INFO - Reading from file tmpfile_stdout 12:38:36 INFO - Output received: 12:38:36 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) 12:38:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:38:36 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')]} 12:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:36 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')]} 12:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:36 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:36 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 12:38:36 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 12:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:36 INFO - 'HOME': '/Users/cltbld', 12:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:36 INFO - 'LOGNAME': 'cltbld', 12:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:36 INFO - 'MOZ_NO_REMOTE': '1', 12:38:36 INFO - 'NO_EM_RESTART': '1', 12:38:36 INFO - 'PAGER': '/bin/cat', 12:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:36 INFO - 'PWD': '/builds/slave/test', 12:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:36 INFO - 'SHELL': '/bin/bash', 12:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:36 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:36 INFO - 'USER': 'cltbld', 12:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:36 INFO - 'XPC_FLAGS': '0x0', 12:38:36 INFO - 'XPC_SERVICE_NAME': '0', 12:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:36 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 12:38:36 INFO - Cleaning up... 12:38:36 INFO - Return code: 0 12:38:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:38:36 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')]} 12:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:36 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')]} 12:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:36 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:36 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 12:38:36 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 12:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:36 INFO - 'HOME': '/Users/cltbld', 12:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:36 INFO - 'LOGNAME': 'cltbld', 12:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:36 INFO - 'MOZ_NO_REMOTE': '1', 12:38:36 INFO - 'NO_EM_RESTART': '1', 12:38:36 INFO - 'PAGER': '/bin/cat', 12:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:36 INFO - 'PWD': '/builds/slave/test', 12:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:36 INFO - 'SHELL': '/bin/bash', 12:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:36 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:36 INFO - 'USER': 'cltbld', 12:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:36 INFO - 'XPC_FLAGS': '0x0', 12:38:36 INFO - 'XPC_SERVICE_NAME': '0', 12:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:37 INFO - Downloading/unpacking psutil>=3.1.1 12:38:37 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 12:38:37 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 12:38:37 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 12:38:37 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 12:38:37 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 12:38:37 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 12:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:41 INFO - Installing collected packages: psutil 12:38:41 INFO - Running setup.py install for psutil 12:38:41 INFO - building 'psutil._psutil_osx' extension 12:38:41 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 12:38:41 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 12:38:41 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 12:38:41 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 12:38:41 INFO - building 'psutil._psutil_posix' extension 12:38:41 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 12:38:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:38:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:38:42 INFO - ^ 12:38:42 INFO - 1 warning generated. 12:38:42 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 12:38:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:42 INFO - Successfully installed psutil 12:38:42 INFO - Cleaning up... 12:38:42 INFO - Return code: 0 12:38:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:42 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:42 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 12:38:42 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 12:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:42 INFO - 'HOME': '/Users/cltbld', 12:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:42 INFO - 'LOGNAME': 'cltbld', 12:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:42 INFO - 'MOZ_NO_REMOTE': '1', 12:38:42 INFO - 'NO_EM_RESTART': '1', 12:38:42 INFO - 'PAGER': '/bin/cat', 12:38:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:42 INFO - 'PWD': '/builds/slave/test', 12:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:42 INFO - 'SHELL': '/bin/bash', 12:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:42 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:42 INFO - 'USER': 'cltbld', 12:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:42 INFO - 'XPC_FLAGS': '0x0', 12:38:42 INFO - 'XPC_SERVICE_NAME': '0', 12:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:38:42 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 12:38:42 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 12:38:42 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 12:38:42 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 12:38:42 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 12:38:42 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 12:38:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:38:45 INFO - Installing collected packages: mozsystemmonitor 12:38:45 INFO - Running setup.py install for mozsystemmonitor 12:38:45 INFO - Successfully installed mozsystemmonitor 12:38:45 INFO - Cleaning up... 12:38:45 INFO - Return code: 0 12:38:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:45 INFO - 'HOME': '/Users/cltbld', 12:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:45 INFO - 'LOGNAME': 'cltbld', 12:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:45 INFO - 'MOZ_NO_REMOTE': '1', 12:38:45 INFO - 'NO_EM_RESTART': '1', 12:38:45 INFO - 'PAGER': '/bin/cat', 12:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:45 INFO - 'PWD': '/builds/slave/test', 12:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:45 INFO - 'SHELL': '/bin/bash', 12:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:45 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:45 INFO - 'USER': 'cltbld', 12:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:45 INFO - 'XPC_FLAGS': '0x0', 12:38:45 INFO - 'XPC_SERVICE_NAME': '0', 12:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:45 INFO - Downloading/unpacking jsonschema==2.5.1 12:38:45 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 12:38:45 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 12:38:45 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 12:38:45 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 12:38:45 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 12:38:45 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 12:38:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:38:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:38:48 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 12:38:48 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 12:38:48 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 12:38:48 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 12:38:48 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 12:38:48 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 12:38:48 INFO - Downloading functools32-3.2.3-2.tar.gz 12:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:38:48 INFO - warning: no files found matching '*.txt' 12:38:48 INFO - no previously-included directories found matching 'build' 12:38:48 INFO - no previously-included directories found matching 'dist' 12:38:48 INFO - no previously-included directories found matching '.git*' 12:38:48 INFO - Installing collected packages: jsonschema, functools32 12:38:48 INFO - Running setup.py install for functools32 12:38:49 INFO - warning: no files found matching '*.txt' 12:38:49 INFO - no previously-included directories found matching 'build' 12:38:49 INFO - no previously-included directories found matching 'dist' 12:38:49 INFO - no previously-included directories found matching '.git*' 12:38:49 INFO - Successfully installed jsonschema functools32 12:38:49 INFO - Cleaning up... 12:38:49 INFO - Return code: 0 12:38:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:38:49 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')]} 12:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:49 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')]} 12:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:49 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:49 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 12:38:49 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 12:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:49 INFO - 'HOME': '/Users/cltbld', 12:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:49 INFO - 'LOGNAME': 'cltbld', 12:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:49 INFO - 'MOZ_NO_REMOTE': '1', 12:38:49 INFO - 'NO_EM_RESTART': '1', 12:38:49 INFO - 'PAGER': '/bin/cat', 12:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:49 INFO - 'PWD': '/builds/slave/test', 12:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:49 INFO - 'SHELL': '/bin/bash', 12:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:49 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:49 INFO - 'USER': 'cltbld', 12:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:49 INFO - 'XPC_FLAGS': '0x0', 12:38:49 INFO - 'XPC_SERVICE_NAME': '0', 12:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:38:49 INFO - Cleaning up... 12:38:49 INFO - Return code: 0 12:38:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:38:49 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')]} 12:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:49 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')]} 12:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:49 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:49 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 12:38:49 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 12:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:49 INFO - 'HOME': '/Users/cltbld', 12:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:49 INFO - 'LOGNAME': 'cltbld', 12:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:49 INFO - 'MOZ_NO_REMOTE': '1', 12:38:49 INFO - 'NO_EM_RESTART': '1', 12:38:49 INFO - 'PAGER': '/bin/cat', 12:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:49 INFO - 'PWD': '/builds/slave/test', 12:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:49 INFO - 'SHELL': '/bin/bash', 12:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:49 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:49 INFO - 'USER': 'cltbld', 12:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:49 INFO - 'XPC_FLAGS': '0x0', 12:38:49 INFO - 'XPC_SERVICE_NAME': '0', 12:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:38:49 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 12:38:49 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 12:38:49 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 12:38:49 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 12:38:49 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 12:38:49 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 12:38:52 INFO - Downloading blobuploader-1.2.4.tar.gz 12:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:38:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:38:52 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 12:38:52 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 12:38:52 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 12:38:52 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 12:38:52 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 12:38:52 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 12:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:38:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:38:53 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 12:38:53 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 12:38:53 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 12:38:53 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 12:38:53 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 12:38:53 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 12:38:53 INFO - Downloading docopt-0.6.1.tar.gz 12:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:38:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:38:53 INFO - Running setup.py install for blobuploader 12:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:38:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:38:53 INFO - Running setup.py install for requests 12:38:54 INFO - Running setup.py install for docopt 12:38:54 INFO - Successfully installed blobuploader requests docopt 12:38:54 INFO - Cleaning up... 12:38:54 INFO - Return code: 0 12:38:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:54 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:54 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 12:38:54 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 12:38:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:54 INFO - 'HOME': '/Users/cltbld', 12:38:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:54 INFO - 'LOGNAME': 'cltbld', 12:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:54 INFO - 'MOZ_NO_REMOTE': '1', 12:38:54 INFO - 'NO_EM_RESTART': '1', 12:38:54 INFO - 'PAGER': '/bin/cat', 12:38:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:54 INFO - 'PWD': '/builds/slave/test', 12:38:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:54 INFO - 'SHELL': '/bin/bash', 12:38:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:54 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:54 INFO - 'USER': 'cltbld', 12:38:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:54 INFO - 'XPC_FLAGS': '0x0', 12:38:54 INFO - 'XPC_SERVICE_NAME': '0', 12:38:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:38:54 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-KkzBHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:38:54 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Ej181c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:38:54 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-797Kv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-vRxOOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-fcTjv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-C4Sjkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-OejQ_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-8vy9ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ksB9zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-pNGNqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-GcCsCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:38:55 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-gHBpoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:38:56 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MrHg9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:38:56 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-rFAMKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:38:56 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kLBI78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:38:56 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ILvy1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:38:56 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-N5AyXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:38:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:38:56 INFO - Running setup.py install for manifestparser 12:38:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:38:56 INFO - Running setup.py install for mozcrash 12:38:56 INFO - Running setup.py install for mozdebug 12:38:57 INFO - Running setup.py install for mozdevice 12:38:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Running setup.py install for mozfile 12:38:57 INFO - Running setup.py install for mozhttpd 12:38:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Running setup.py install for mozinfo 12:38:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Running setup.py install for mozInstall 12:38:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:38:57 INFO - Running setup.py install for mozleak 12:38:57 INFO - Running setup.py install for mozlog 12:38:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:38:58 INFO - Running setup.py install for moznetwork 12:38:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:38:58 INFO - Running setup.py install for mozprocess 12:38:58 INFO - Running setup.py install for mozprofile 12:38:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:38:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:38:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:38:58 INFO - Running setup.py install for mozrunner 12:38:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:38:58 INFO - Running setup.py install for mozscreenshot 12:38:58 INFO - Running setup.py install for moztest 12:38:59 INFO - Running setup.py install for mozversion 12:38:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:38:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:38:59 INFO - Cleaning up... 12:38:59 INFO - Return code: 0 12:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:59 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:38:59 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 12:38:59 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 12:38:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:38:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:38:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:38:59 INFO - 'HOME': '/Users/cltbld', 12:38:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:38:59 INFO - 'LOGNAME': 'cltbld', 12:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:59 INFO - 'MOZ_NO_REMOTE': '1', 12:38:59 INFO - 'NO_EM_RESTART': '1', 12:38:59 INFO - 'PAGER': '/bin/cat', 12:38:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:59 INFO - 'PWD': '/builds/slave/test', 12:38:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:38:59 INFO - 'SHELL': '/bin/bash', 12:38:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:38:59 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:38:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:38:59 INFO - 'USER': 'cltbld', 12:38:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:38:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:59 INFO - 'XPC_FLAGS': '0x0', 12:38:59 INFO - 'XPC_SERVICE_NAME': '0', 12:38:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:38:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-b4lObO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:38:59 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)) 12:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:38:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-NQVrOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:38:59 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)) 12:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:38:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Oi6XiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:38:59 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)) 12:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:38:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-C74az7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:38:59 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)) 12:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:38:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-krVPQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:38:59 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)) 12:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:38:59 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-YmMEg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0OHLZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-bnaEdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-CDkr88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-uCMi5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ha3pzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-wkH_VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-cv5Vvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-w78zIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:00 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)) 12:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:00 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-OSm5Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-X3D4DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:01 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)) 12:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-t2NW6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:01 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)) 12:39:01 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)) 12:39:01 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)) 12:39:01 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)) 12:39:01 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)) 12:39:01 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)) 12:39:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:03 INFO - Downloading blessings-1.6.tar.gz 12:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:03 INFO - Installing collected packages: blessings 12:39:03 INFO - Running setup.py install for blessings 12:39:04 INFO - Successfully installed blessings 12:39:04 INFO - Cleaning up... 12:39:04 INFO - Return code: 0 12:39:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:04 INFO - Reading from file tmpfile_stdout 12:39:04 INFO - Current package versions: 12:39:04 INFO - blessings == 1.6 12:39:04 INFO - blobuploader == 1.2.4 12:39:04 INFO - docopt == 0.6.1 12:39:04 INFO - functools32 == 3.2.3-2 12:39:04 INFO - jsonschema == 2.5.1 12:39:04 INFO - manifestparser == 1.1 12:39:04 INFO - mozInstall == 1.12 12:39:04 INFO - mozcrash == 1.0 12:39:04 INFO - mozdebug == 0.1 12:39:04 INFO - mozdevice == 0.50 12:39:04 INFO - mozfile == 1.2 12:39:04 INFO - mozhttpd == 0.7 12:39:04 INFO - mozinfo == 0.9 12:39:04 INFO - mozleak == 0.1 12:39:04 INFO - mozlog == 3.4 12:39:04 INFO - moznetwork == 0.27 12:39:04 INFO - mozprocess == 0.25 12:39:04 INFO - mozprofile == 0.28 12:39:04 INFO - mozrunner == 6.13 12:39:04 INFO - mozscreenshot == 0.1 12:39:04 INFO - mozsystemmonitor == 0.3 12:39:04 INFO - moztest == 0.8 12:39:04 INFO - mozversion == 1.4 12:39:04 INFO - psutil == 3.1.1 12:39:04 INFO - requests == 1.2.3 12:39:04 INFO - wsgiref == 0.1.2 12:39:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:39:04 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 12:39:04 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 12:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:04 INFO - 'HOME': '/Users/cltbld', 12:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:04 INFO - 'LOGNAME': 'cltbld', 12:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:04 INFO - 'MOZ_NO_REMOTE': '1', 12:39:04 INFO - 'NO_EM_RESTART': '1', 12:39:04 INFO - 'PAGER': '/bin/cat', 12:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:04 INFO - 'PWD': '/builds/slave/test', 12:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:04 INFO - 'SHELL': '/bin/bash', 12:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:39:04 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:04 INFO - 'USER': 'cltbld', 12:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:04 INFO - 'XPC_FLAGS': '0x0', 12:39:04 INFO - 'XPC_SERVICE_NAME': '0', 12:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 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)) 12:39:04 INFO - Cleaning up... 12:39:04 INFO - Return code: 0 12:39:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 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 0x103526b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103529768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8f1cb6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, '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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 12:39:04 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 12:39:04 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 12:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:04 INFO - 'HOME': '/Users/cltbld', 12:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:04 INFO - 'LOGNAME': 'cltbld', 12:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:04 INFO - 'MOZ_NO_REMOTE': '1', 12:39:04 INFO - 'NO_EM_RESTART': '1', 12:39:04 INFO - 'PAGER': '/bin/cat', 12:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:04 INFO - 'PWD': '/builds/slave/test', 12:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:04 INFO - 'SHELL': '/bin/bash', 12:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:39:04 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:04 INFO - 'USER': 'cltbld', 12:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:04 INFO - 'XPC_FLAGS': '0x0', 12:39:04 INFO - 'XPC_SERVICE_NAME': '0', 12:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:39:05 INFO - Cleaning up... 12:39:05 INFO - Return code: 0 12:39:05 INFO - Running post-action listener: _resource_record_post_action 12:39:05 INFO - Running post-action listener: _start_resource_monitoring 12:39:05 INFO - Starting resource monitoring. 12:39:05 INFO - [mozharness: 2017-04-30 19:39:05.083926Z] Finished create-virtualenv step (success) 12:39:05 INFO - [mozharness: 2017-04-30 19:39:05.084956Z] Running install step. 12:39:05 INFO - Running pre-action listener: _resource_record_pre_action 12:39:05 INFO - Running main action method: install 12:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:05 INFO - Reading from file tmpfile_stdout 12:39:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:39:05 INFO - Reading from file tmpfile_stdout 12:39:05 INFO - Output received: 12:39:05 INFO - Usage: mozinstall [options] installer 12:39:05 INFO - Options: 12:39:05 INFO - -h, --help show this help message and exit 12:39:05 INFO - -d DEST, --destination=DEST 12:39:05 INFO - Directory to install application into. [default: 12:39:05 INFO - "/builds/slave/test"] 12:39:05 INFO - --app=APP Application being installed. [default: firefox] 12:39:05 INFO - mkdir: /builds/slave/test/build/application 12:39:05 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'] 12:39:05 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 12:39:24 INFO - Reading from file tmpfile_stdout 12:39:24 INFO - Output received: 12:39:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:39:24 INFO - Running post-action listener: _resource_record_post_action 12:39:24 INFO - [mozharness: 2017-04-30 19:39:24.965485Z] Finished install step (success) 12:39:24 INFO - [mozharness: 2017-04-30 19:39:24.965644Z] Running run-tests step. 12:39:24 INFO - Running pre-action listener: _resource_record_pre_action 12:39:24 INFO - Running main action method: run_tests 12:39:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:39:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:39:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:39:24 INFO - 2017-04-30 12:39:24.980 screenresolution[1629:7815] starting screenresolution argv=screenresolution get 12:39:24 INFO - 2017-04-30 12:39:24.982 screenresolution[1629:7815] Display 0: 1600x1200x32@60 12:39:24 INFO - 2017-04-30 12:39:24.988 screenresolution[1630:7817] starting screenresolution argv=screenresolution list 12:39:24 INFO - Available Modes on Display 0 12:39:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:39:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:39:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:39:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:39:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:39:25 INFO - Intel Iris: 12:39:25 INFO - Chipset Model: Intel Iris 12:39:25 INFO - Type: GPU 12:39:25 INFO - Bus: Built-In 12:39:25 INFO - VRAM (Dynamic, Max): 1536 MB 12:39:25 INFO - Vendor: Intel (0x8086) 12:39:25 INFO - Device ID: 0x0a2e 12:39:25 INFO - Revision ID: 0x0009 12:39:25 INFO - Displays: 12:39:25 INFO - Display: 12:39:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:39:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:39:25 INFO - Display Serial Number: 1600x1200 60 12:39:25 INFO - Main Display: Yes 12:39:25 INFO - Mirror: Off 12:39:25 INFO - Online: Yes 12:39:25 INFO - Rotation: Supported 12:39:25 INFO - Return code: 0 12:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:39:25 INFO - Python 2.7.3 12:39:25 INFO - Return code: 0 12:39:25 INFO - grabbing minidump binary from tooltool 12:39:25 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')]} 12:39:25 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 0x103304d30>, '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 0x10322adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032f9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:39:25 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 12:39:25 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 12:39:25 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 12:39:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:39:25 INFO - Return code: 0 12:39:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:39:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:39:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:39:25 INFO - ENV: RUST_BACKTRACE is now 1 12:39:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:39:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lRupuvxH8y/Render', 12:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:25 INFO - 'HOME': '/Users/cltbld', 12:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:25 INFO - 'LOGNAME': 'cltbld', 12:39:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:39:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:25 INFO - 'MOZ_NO_REMOTE': '1', 12:39:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:39:25 INFO - 'NO_EM_RESTART': '1', 12:39:25 INFO - 'PAGER': '/bin/cat', 12:39:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:25 INFO - 'PWD': '/builds/slave/test', 12:39:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:25 INFO - 'RUST_BACKTRACE': '1', 12:39:25 INFO - 'SHELL': '/bin/bash', 12:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i0ZmwQ0CPD/Listeners', 12:39:25 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 12:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:25 INFO - 'USER': 'cltbld', 12:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:25 INFO - 'XPC_FLAGS': '0x0', 12:39:25 INFO - 'XPC_SERVICE_NAME': '0', 12:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:39:25 INFO - mozversion application_buildid: 20170430112445 12:39:25 INFO - mozversion application_changeset: 5278e2a35fc8f2be390243db1e62858bf0982055 12:39:25 INFO - mozversion application_display_name: Nightly 12:39:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:25 INFO - mozversion application_name: Firefox 12:39:25 INFO - mozversion application_remotingname: firefox 12:39:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:39:25 INFO - mozversion application_vendor: Mozilla 12:39:25 INFO - mozversion application_version: 55.0a1 12:39:25 INFO - mozversion platform_buildid: 20170430112445 12:39:25 INFO - mozversion platform_changeset: 5278e2a35fc8f2be390243db1e62858bf0982055 12:39:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:39:25 INFO - mozversion platform_version: 55.0a1 12:39:25 INFO - using testdate: 1493581165 12:39:25 INFO - actual date: 1493581165 12:39:25 INFO - starting webserver on 'localhost:49236' 12:39:25 INFO - SUITE-START | Running 2 tests 12:39:25 INFO - TEST-START | dromaeo_css 12:39:25 INFO - operating with platform_type : mac_ 12:39:25 INFO - Initialising browser for dromaeo_css test... 12:39:25 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpLyyX7z/profile http://localhost:49236/getInfo.html) 12:39:28 INFO - PID 1640 | 2017-04-30 12:39:28.380 plugin-container[1642:8001] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 12:39:28 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:39:28 INFO - PID 1640 | 2017-04-30 12:39:28.382 plugin-container[1642:8001] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c0b, name = 'com.apple.CFPasteboardClient' 12:39:28 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:39:28 INFO - PID 1640 | 2017-04-30 12:39:28.382 plugin-container[1642:8001] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:39:28 INFO - PID 1640 | __metrics Screen width/height:1600/1200 12:39:28 INFO - PID 1640 | colorDepth:24 12:39:28 INFO - PID 1640 | Browser inner width/height: 1024/689 12:39:28 INFO - PID 1640 | __metrics 12:39:29 INFO - TEST-INFO | 1640: exit 0 12:39:29 INFO - Browser initialized. 12:39:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:39:29 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpLyyX7z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:32 INFO - PID 1644 | 2017-04-30 12:39:32.035 plugin-container[1645:8144] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 12:39:32 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:39:32 INFO - PID 1644 | 2017-04-30 12:39:32.035 plugin-container[1645:8144] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 12:39:32 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:39:32 INFO - PID 1644 | 2017-04-30 12:39:32.036 plugin-container[1645:8144] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:39:41 INFO - PID 1644 | RSS: Main: 234754048 12:39:41 INFO - PID 1644 | 12:42:44 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 12:42:46 INFO - PID 1644 | RSS: Main: 252141568 12:42:46 INFO - PID 1644 | 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:44:30 INFO - PID 1644 | 12:44:30 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:44:30 INFO - PID 1644 | Full stack: 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:44:30 INFO - PID 1644 | 12:44:30 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:44:30 INFO - PID 1644 | Full stack: 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:44:30 INFO - PID 1644 | 12:44:30 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:44:30 INFO - PID 1644 | Full stack: 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | ************************* 12:44:30 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 12:44:30 INFO - PID 1644 | 12:44:30 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:44:30 INFO - PID 1644 | Full stack: 12:44:30 INFO - PID 1644 | ************************* 12:45:48 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 12:45:49 INFO - PID 1644 | RSS: Main: 257585152 12:45:49 INFO - PID 1644 | 12:48:51 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 12:48:51 INFO - PID 1644 | RSS: Main: 267542528 12:48:51 INFO - PID 1644 | 12:51:53 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 12:51:54 INFO - PID 1644 | RSS: Main: 260775936 12:51:54 INFO - PID 1644 | 12:54:56 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 12:54:57 INFO - PID 1644 | RSS: Main: 269389824 12:54:57 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 12:57:59 INFO - PID 1644 | RSS: Main: 264097792 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | __start_tp_report 12:57:59 INFO - PID 1644 | _x_x_mozilla_page_load 12:57:59 INFO - PID 1644 | _x_x_mozilla_page_load_details 12:57:59 INFO - PID 1644 | |i|pagename|runs| 12:57:59 INFO - PID 1644 | |0;dojo.html;3408.2672225471524;3523.3305671922335;3558.395072837617;3572.4641303804424;3577.123604716843;5885.146653735206;6100.938990610092;6171.012637977924;6210.347913469082;6237.157983672214;6110.480609148228;6117.143599896018;6139.921477737031;6157.784477543287;6162.198914141155;5278.841634750945;5282.867928301795;5318.361796584396;5356.276902618136;5488.368837583689;4914.680545764514;5162.664426812245;5269.3676758789;5401.945980540203;5486.286782718241;5337.70642614656;5400.729963501829;5411.945880541183;5432.782688692448;5478.342598888139;4354.346847972798;5197.688138711689;5281.52466278033;5282.313299271109;5291.391489978663;5295.364556253275;5319.20211968204;5321.3348331458565;5364.704941228231;5423.566114710814;5926.466618004357;6133.907991380088;6172.4136207060255;6180.9381906180815;6202.224721909762;6447.935520644781;6513.381228783258;6525.412712855818;6528.543001989862;6532.052852336385;5510.972445137749;6242.188515492957;6383.265924418705;6461.773837915697;6639.269680335159;6227.875442491125;6252.874942501125;6257.937420625826;6270.404311590391;6290.21372328459;5961.970190149022;6239.906401403982;6687.665616719242;6701.832454188684;6707.966460167668;6294.779682711175;6319.526035547352;6360.6501642409185;6365.840853978688;6433.710483028275;5361.624686271924;6528.738850446024;6552.967235163889;6555.8361040973405;6555.836104097436;6423.100765892778;6425.9036114457385;6426.485881129498;6438.227412710505;6439.8068057958335;5520.227168196456;6129.389354848322;6348.841278968062;6379.138816259839;6416.197975253093;5155.716435596079;5165.715885626251;5174.404943431478;5177.534021938043;5177.922331165036;4275.679324050709;4665;4667.603253723471;4668.719876807402;4689.460712018094;4981.576565991932;6048.42539958712;6088.939110608926;6101.115338276014;6118.357572454917;6287.182666253358;6536.379043990813;6590;6600.405963463311;6613.338666133348;6218.81343559694;6219.564630475823;6230.408111229426;6234.470070044006;6247.0629405589525;5425.538829199562;5550.222968784374;5738.626989245686;5751.4536119068625;5799.449052340021;5583.804566840141;6508.544401891822;6532.281449040602;6709.731610735711;6768.255491895986;6590.308017658077;6600.07598936159;6605.339466053356;6618.2719900811835;6640.103586015826;6521.804345869631;6594.439472644879;6627.138471998609;6718.966405167943;6782.660866956534;6380.776672816429;6417.294097649162;6419.935800641933;6422.807315780534;6425.132607098169;5341.973290133525;6330.588511746721;6361.554691171574;6409.198850143732;6528.118703974903;4697.953020469751;6349.142865713255;6370.617762934239;6378.266499352634;6395.264544577433;6341.460975817107;6349.8730025400155;6361.077643741539;6366.236051673829;6381.617102973836;5178.611604129781;6000.909986350121;6305.7388522294805;6321;6435.935640643534;5361.678299301899;6331.620102793847;6392.232932048184;6404.1674582304;6405.775797847053;6185.783497577563;6272.529560283088;6285.5600107992;6308.14839996613;6352.110704501466 12:57:59 INFO - PID 1644 | |1;ext.html;700.5411455496649;825.3149885594956;1005.627917670462;1102.713294543419;1139.692283083567;32365.352692946155;36022;36033.45949810755;36053.738119165835;36118.45822312661;37730.4340434893;37804.67683631073;38023;38132;38244.61755382446;7457.1051473822945;8306.584670766468;8435.746927592152;8468;8471.872921906177;8357.456765310266;8473.872891906627;8478.279346255576;8489.108643592426;8525.147485251488;8418.200270974277;8504.44721093127;8529.95735021324;8537.402381833273;8595.312375010015;8463.28062114721;8482;8491.235788778979;8495.575221238943;8498.277646400064;7453.881917712332;7944.761657150237;8264.132266112032;8355.456895301786;8361.122082181406;36322.81838590817;36578.451323230176;36786.448203276974;36858.26283474342;36953.815230923945;3578.212793185521;3591.6228795976567;3613.5663720353728;3619.2761447710564;3621.9134259721977;30028.399432011236;30084.24789380261;30090;30101;30220.8488957556;2946.955795663067;2998.175501737018;3022.8488575571355;3023.9848800756076;3041.1332770160398;212703.99999999846;258752.7062364676;299297;300018;300253;44130.11739765187;46874;47443.051138977025;47454;47705.522944770804;42344.57655423468;42885;45372.09255814865;47916;48600.54198374054;13863.752262296442;14013.719725605431;14035.157890526601;14198.077124986843;14209;9924.751881202883;11175.944120279346;11375.943120284512;11416.972472477351;11485.71285717847;10416.531256093494;12723.918466930414;12781.808272875915;12804.167729097579;12901.903338216356;4846.466888642247;5773.480386765212;5821.708914554255;5841.065429531254;5845.941540584625;972.2367941166151;992.2409356842022;997.8453339732353;1058.0424715632364;1080.330195278932;23774.524509509713;24557.754422455546;24620.384490387525;24833.130840420497;24835.379115521897;1120.9047230985457;1128.3004537186996;1135.7274254178938;1165;1166.5333866453486;10643.156095990582;12619.810702839464;12692;12730.936345318214;12757.55348562796;324270.3302636708;331091;331709;333469;333578;52664.47335526596;52772.20841687378;52905;53198.734006330495;53235.46764532383;1518.0284617844588;1520.4830357678443;1552.4954389823354;1560.3290585048312;1571.6070982254437;24123.879380602986;24148.87925560431;24206.394840129138;24249.75750242475;24354.391140221636;37622;37717.62282377251;37745.433818492194;37854.864354069425;37920;270903.4548272618;271460;271730;271738;272918;33488.49767253542;34119.82940085284;34550;35730.928072157876;35903.64096359003;42759.3586096215;44111.33832992572;44415.333769994126;44941;45268.32097518474;27481.35111893293;29720.405591887607;29859.253518662208;32209.51685724763;32821.01536953895;32715.509267361485;33200.501992470614;33390.99827005194;33698.83150584329;33818.49272260869;33741.66258337385;38811.417828732025;40549.594504054585;40895;40951.7952410236;37977.62022379741;38548.42177367285;38869.416958745074;39660.80169599134;39813.40279895746;23431.41421464477;24774.876125619256;25114.24657260285;26089.73910260873;26547.469050618492 12:57:59 INFO - PID 1644 | |2;jquery.html;413.6153377359055;446.96200822930047;446.9999999999999;464.8233671204942;465.2021782642767;18302.176402061905;19602.803971960275;21400.46498837528;21849.563008739817;22162.891855407204;19660.21359145636;21902;23105.30684079476;23358.41603959902;23659.17192898249;5979.820605381846;6137.018077107664;6173.135760993465;6177.444030037295;6202.069689546582;4593.931091033637;6082.756689732405;6120.510359171278;6132.938670613304;6134.6012509186985;5373.274607927939;6026.939730602704;6114.021756518958;6117.877642447148;6120.663363515005;6051.394860513958;6141.048137538689;6168.44483996438;6168.753249870022;6175.07373893915;4935.210366341368;5423;5482.17767334903;5485.149801780731;5493.835184944418;27260.90956361743;27290.5906411404;27667.308317292027;27810.443791124268;28066.298342541395;2149.7635260121374;2220.0564759976946;2222.9555408891893;2223.377454312795;2229.933102006926;17745.024023678692;17871.28514859404;17965;18375.816241837678;18450.53873653156;1890.905454727258;2136.6260904341834;2139.0908863733007;2183.1267493002765;2185.508260641359;148411;148585;158471;163783;171311.14344428323;12053.758924821455;12686.429110690042;12884;12907.290099044643;12994.220346779224;16196.433124840574;16446.588835279214;16542.42101526441;16586.336546538245;16805.91597042007;8872.822543549093;9086.273098152264;9174.770630734152;9242.12199841014;9293.395929264576;8801.07588703177;8804.427712198687;8822.51476168817;8961.731148065568;9018.09819018093;7946.443748937519;8039.703721474168;8098.838023239502;8124.837503249902;8130.430869839172;2211.6240239159383;2222.844400891922;2223.2329846203033;2228.4540287629634;2345.2729653807373;946.6828612414918;950.1258841865363;959.2876715063717;967.4002118686459;999.1557134221571;20816.583668326548;21377.25179618737;21581.35255942324;24744.381390465023;26725;1000.3247807729899;1000.8949060348705;1008.178334657252;1033.7105610429091;1035.8394448860438;10978.615748448767;11156.832647510293;11189.160812938899;11232.943835280772;11233.943830280796;436144;522199.77800221514;527306.3634681802;551738;554923;97219.5695107628;108168.4591577037;127115.82210444628;132115.83460432148;137476;1234.2594443334108;1242.6458459339044;1252.2674235572292;1282.7242142939313;1283.749668814591;16237.756433653269;18620.44138675842;18660;18683.439496815117;19087.041508566195;58305.5423614413;58989;59267.70366148141;59421.21736347916;59918;61681;67396;78826.9055784982;80224.59887700524;82344;8938.955305223431;8963.910360896307;9023.323250756352;9146.222571081267;9373.578188981648;14261.144331340152;14307.356168972214;14452;14580.34388452501;14595.489157879423;11864.347460889734;11914.880851191723;12153.817692734792;12188.842060004285;12278.877211228131;10429.217808664229;10430.113440357654;10617.150627949592;10699.304545204537;10701.411422371844;12127.190032828614;12190.2076365036;12236.388180591113;12348.691282718004;12470.064745143969;8900.287976961958;9096.226820720312;9101.863472048057;9124.817503649758;9163.52584802113;9820.4107753535;11969.461374238006;12190.634280971584;12226.816597751218;12330.81503777426 12:57:59 INFO - PID 1644 | |3;mootools.html;1436.784482327651;1456.7741999990005;1462.1884853906079;1483.473366954731;1499.490173341064;11239.438028098593;11244.269122507052;11684.883151168486;11905.16663833532;11921.165518413714;11654.24247423919;11836;11855.7628847423;11882.52469901205;11894.583689570867;2515.383730985911;2565.2304308707407;2571.190075126339;2572.344052266669;2581.019212699181;2499.187763976706;2534.176392672389;2534.822562420631;2546.783523400504;2559.5520783862844;2214.2250212425683;2509.2597683683266;2517.710463296726;2525.747425257478;2544.0841297133015;2446.987765061181;2483.1184929350093;2491.53906527293;2497.9375515612073;2505.361132911114;2466.5560199164142;2469.3579669285937;2484.254723582936;2515.5723527000455;2525.0783464035494;11145.16411269158;11187.496562654618;11236.157288203418;11262.267952583137;11268.492917818718;6409.294977552466;6653.301403352675;6673.933260667428;6684.699188536528;6699.665016749192;3895.7467764595212;4163.8959026024595;4269.274223382033;4319.179355922396;4337.392765012901;1208.6434501821984;1209.3288225035103;1221.9022478201812;1289.806529020645;1294.0941341061296;16223.51329460118;16504.25730842115;16603;16643.667126657398;16848.83151168497;5529.30883639545;5658.236138121383;5783.421657834267;5821.301443826768;5849.415058494116;11751.764964700658;11822;11826.994705450134;11829.88170118305;11831.17181797266;6610.173728283965;6619.304972977768;6622.470202383798;6630.602163870183;6631.535792494576;5623.762772190112;5936.436038576328;5973.551983601247;6224.937750622526;6252.187215662026;4236.279832428495;4337.284348082531;4342.652587792969;4371.475422949266;4391.67062470316;1247.7504499100035;1260.489501751792;1269.1813780111777;1274.949002039908;1283.7689215941034;802.5144787403536;809.3282575462352;832.0930186097183;838.7861095420628;862.3920136303891;5353.768633214382;6173.166622505994;6189.009758438719;6363.3636636336;6369.649669268235;590.0883135555576;607.5443417436923;608.2184393054903;613.6839527643267;615.5260449453896;3885.300645883768;3898.90252743678;3927.3716205407;3964.781936993493;3965.147493288957;13674.453021879212;14118.364673589713;14273.14361138335;14276.928615356857;14281.571552853224;14154.363053662404;14156.150630961969;14156.575302740934;14167.291635418187;14185.858141418454;7285.781426557318;7805.33654639362;8230.341572674171;8340.833183336299;8401.621927013299;6488.870222595616;7063.1524217094275;7130.974549968963;7131.6077615729555;7177.102862142232;11166.497507612014;12988.35058247065;13333.933285336956;13576.796348054984;13630.659233519242;11171.329720216812;13484.730305394034;13571.38928748189;13925.025248232932;13944.721105578035;8759.255463285692;8981.865272020794;8990.86513702282;9092.136247056518;9096.408733432305;10524.631637892637;10768.784624307627;10773.784524309312;10775.568977241137;10820.458977051274;8768.123187681182;8822.823543529223;9024.639014439612;9165.462122679604;9187.448753074837;8878.067802880863;8935.642574297215;8982.595783189641;8990.595423205841;9032.277417806692;8117.715879944174;8134.349252059939;8170.387220958333;8225.012998439986;8244.505329679998;6010.909836352371;6045.335013148462;6137.263528376623;6170.3212646607935;6240.282367527792;5409.702466364388;6080.847978800565;6127.295361033538;6278.874422511432;6330.588511746721 12:57:59 INFO - PID 1644 | |4;prototype.html;389.15502000098775;396.1976996581921;413.83358120240547;423.13891231344223;423.32268370607034;5563.693996830173;6174.876502469959;6343.492520598353;6375.394337537932;6520.543561950665;5558.388067460442;6009.87980240395;6137.38626137386;6182.103594978726;6325.304216536178;4767.8808029799275;4775.044991001796;4796.3764710587575;4800.039992001596;4812.374391329122;4598;4757.952420475785;4761.238201887699;4793.185158523042;4799.496052914446;4724.503927087658;4734.124187025394;4734.821981888318;4747.406574178228;4748.171953797778;3893.415987601854;4747.596454301389;4764.309175169598;4777;4781.282807578857;3023.5918151049545;3362.663733626642;3668.578113516953;3830.444585535082;3841.2701586698436;4808.543188397097;6083.8174854754425;6097.3292937776805;6108.511319094462;6128.417800308964;4441.489228738704;4905.681130726527;4980.056809389019;5277.337638643853;5368;5379.462053794628;6582.478374069898;6610.8016759497295;6634.502412319047;6684.092419797404;3806.219724956405;4168.853565269545;4341.6526677865695;4352.542982986804;4364.956350436487;6885.690143943534;6987.895181572331;7006.582728958501;7082.539634923765;7124.216336203013;3675.4486826976167;4214.599613036757;4401.625861801783;4407.42703448556;4448.488423831301;4481.75350355727;4488.5960263576435;4491.932621010687;4494.775261236925;4498.347739577743;5102.183650615958;5182.404023537266;5309.858380448222;5338.252644629677;5400.405955344988;5940.376260492586;6511.79531786621;6565.277819439858;6689.531732778756;6697.933020669731;1331.5872079655337;1486.829014663306;1493.0668332292316;1511.871490923262;1523.1850959736487;885.6723012485421;955.1642312976146;984.5520288268821;990.7523119220195;999.6301368493704;5634.211210430543;5882.205902203234;6289.245290565162;6296.811095667137;6327;6542.411182993458;6734.595924244561;6920.515563910478;6929.826754331081;6939.618320992394;6027.517798576104;6176.7838125666285;6285.77999770015;6286.748530058747;6293.496520278367;2918.9270268243463;2967;3571.2857428514403;3619.7466177367332;3623.202895363016;5933.762649494059;6136.846578835565;6685;7052.871540553487;7112.146542414944;5586.692731899703;6333.258353952608;6445.2587952386075;6447.6131432114225;7081.398081163159;6871.725130994804;6994.860102798018;7085.326893945067;7101.680424380916;7131.964340178266;6864.597390913141;6875.724971001304;6880.69266839299;6889.00109484132;7030.191527974144;5913.5564832636865;6393.968030159819;6623.768168114093;6699.43054840344;6798.218204906301;5193.091209038327;5719.428057194247;6691.43122834545;6820.283870193558;7089.326513981164;3705.7220708446434;4383.320585309282;4386.670999674973;4393.20922234001;4404.493483249467;6102.145699601971;6681.365270299314;6724.636523007494;6808.62552559614;6870.141232345957;5594.972025140011;5857.5313974881055;6143.600665956698;6787.185537735503;6795.524313298021;5006.524380183877;6772.5936443813525;6775.661216939232;6788.694508747217;6811;6571.3100124488155;6611.239707433707;6618.371254730793;6641.136652235178;6647.966760166361;5664.915026274692;5871.794487192928;6419.716056788754;6645.235797883112;6809.842326804356;6261.937380626136;6525.836854078686;6526.282108968105;6533.18335208099;6582 12:57:59 INFO - PID 1644 | |5;yui.html;832.184459229955;841.7054031089116;852.5311078906601;857.5721423829325;871.8343514732198;14309.141451512916;14922.701545969074;16431.34274629015;16438.589035274123;16836.915815420936;11205;12632.11575189737;17364.652706945886;17413.912930435363;17434.215460304316;971.6987733802508;993.4982833668987;1006.3056491021208;1012.0486742462099;1013.8073765984476;980.9852852207223;1003.5684655598089;1006.3710181136789;1009.4649835587151;1013.2096964367805;987.9259055570825;1027.5067967375664;1028.9022542858415;1038.096855735511;1046.0585473074218;1012.6354512375539;1032.2980373346122;1034.4672493665769;1036.3988886445843;1038.979220415595;769.4114002787871;771.4561234329784;771.502380964275;774.9147593764682;776.0183368039435;16382.426615068416;16682;16746.16269186548;17317.826821731873;17520.91239543807;16953.406630767862;17266.050367229796;17589.56026099345;17705.29178832845;17705.38031168903;14060.156390616596;14236.928815355961;14390.28048597566;14402.639934001629;14556.981011329211;3560.038789526813;3572.1962558424148;3580.2481478889463;3582.5700915889997;3593.94609080864;119542;120036;120678;121035;121124.39437802843;13065.738685226243;13067.477300908047;13276.535321263902;13536.390862411019;13554.59336219915;25176.496470070495;25262.989480420943;25769.61345579818;25947.22158335253;26328.341791454983;6301.779437719658;7208.855822883513;7241.746538871114;7557.319841214317;7722.3049925506975;3722.8324725387424;3835.1179228777537;3859.3439115350457;3859.4403811447182;3868.2650296443585;3540.929181416357;3563.750537462353;4113.930378101715;4207.621314081747;4275.551067137968;943.2312665177858;951.4576691286039;964.0985678390728;966.3139171188394;970.7330484116924;563.9633423827438;635.5011316116826;660.4089340040637;662.456785435938;691.8998791920769;9742.223466312067;10290.3825770454;10447.582096716198;10669.679909602724;11952.282065133877;586.5366360575183;655.9081728558006;656.980290591283;670.6646676661669;675.3516624040976;4807.735574543363;5407.297051383295;5510.889782204334;5571.331440227199;5593.328800543961;88134;95933.5609965851;98572;99555.50666740004;113199.43400282945;84819.7277040845;86585;87197.5640121808;88322.55838720765;89593.55203224072;70499;71880;72340.63829680817;72572;72676.273237268;12352.197107188003;13010.869891300967;13046.282454465096;13111.541096061592;13202.405891735087;42043.528476503176;42851.357229642206;43264.567354327315;43583.56416435795;43815;52896.73551632371;53037.674058148856;53802;54022.459775401745;54770.45229547813;16673.416430424877;16706.916465417595;16899;17026.233819477904;17042.403515876886;18311.084445777924;18411;18606.162722677782;18786.53033674169;18846.43460696181;16582.66834663324;17139;17445.04052277137;17507.56231094233;17515.386961456286;16599.668006639557;16685.165741712623;17236.569085772957;17325.133743313036;17340.393086241922;14025.228612426414;16359.918200408922;16410.425635102714;16768.664626707643;17056.914715426345;11721.706957326134;11888.76222475563;12047.33739644328;12125.818112728493;12137.150399471951;12168;12226.388680565758;12244.571439999558;12316.692082698004;12332.19840710351 12:57:59 INFO - PID 1644 | __end_tp_report 12:57:59 INFO - PID 1644 | __start_cc_report 12:57:59 INFO - PID 1644 | _x_x_mozilla_cycle_collect,426 12:57:59 INFO - PID 1644 | __end_cc_report 12:57:59 INFO - PID 1644 | __startTimestamp1493582279621__endTimestamp 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | ------- Summary: start ------- 12:57:59 INFO - PID 1644 | Number of tests: 6 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:5948.68 Median:6239.91 stddev:710.27 (11.4%) stddev-sans-first:683.92 12:57:59 INFO - PID 1644 | Values: 3408.3 3523.3 3558.4 3572.5 3577.1 5885.1 6100.9 6171.0 6210.3 6237.2 6110.5 6117.1 6139.9 6157.8 6162.2 5278.8 5282.9 5318.4 5356.3 5488.4 4914.7 5162.7 5269.4 5401.9 5486.3 5337.7 5400.7 5411.9 5432.8 5478.3 4354.3 5197.7 5281.5 5282.3 5291.4 5295.4 5319.2 5321.3 5364.7 5423.6 5926.5 6133.9 6172.4 6180.9 6202.2 6447.9 6513.4 6525.4 6528.5 6532.1 5511.0 6242.2 6383.3 6461.8 6639.3 6227.9 6252.9 6257.9 6270.4 6290.2 5962.0 6239.9 6687.7 6701.8 6708.0 6294.8 6319.5 6360.7 6365.8 6433.7 5361.6 6528.7 6553.0 6555.8 6555.8 6423.1 6425.9 6426.5 6438.2 6439.8 5520.2 6129.4 6348.8 6379.1 6416.2 5155.7 5165.7 5174.4 5177.5 5177.9 4275.7 4665.0 4667.6 4668.7 4689.5 4981.6 6048.4 6088.9 6101.1 6118.4 6287.2 6536.4 6590.0 6600.4 6613.3 6218.8 6219.6 6230.4 6234.5 6247.1 5425.5 5550.2 5738.6 5751.5 5799.4 5583.8 6508.5 6532.3 6709.7 6768.3 6590.3 6600.1 6605.3 6618.3 6640.1 6521.8 6594.4 6627.1 6719.0 6782.7 6380.8 6417.3 6419.9 6422.8 6425.1 5342.0 6330.6 6361.6 6409.2 6528.1 4698.0 6349.1 6370.6 6378.3 6395.3 6341.5 6349.9 6361.1 6366.2 6381.6 5178.6 6000.9 6305.7 6321.0 6435.9 5361.7 6331.6 6392.2 6404.2 6405.8 6185.8 6272.5 6285.6 6308.1 6352.1 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:44525.66 Median:19740.93 stddev:77111.17 (390.6%) stddev-sans-first:77257.29 12:57:59 INFO - PID 1644 | Values: 700.5 825.3 1005.6 1102.7 1139.7 32365.4 36022.0 36033.5 36053.7 36118.5 37730.4 37804.7 38023.0 38132.0 38244.6 7457.1 8306.6 8435.7 8468.0 8471.9 8357.5 8473.9 8478.3 8489.1 8525.1 8418.2 8504.4 8530.0 8537.4 8595.3 8463.3 8482.0 8491.2 8495.6 8498.3 7453.9 7944.8 8264.1 8355.5 8361.1 36322.8 36578.5 36786.4 36858.3 36953.8 3578.2 3591.6 3613.6 3619.3 3621.9 30028.4 30084.2 30090.0 30101.0 30220.8 2947.0 2998.2 3022.8 3024.0 3041.1 212704.0 258752.7 299297.0 300018.0 300253.0 44130.1 46874.0 47443.1 47454.0 47705.5 42344.6 42885.0 45372.1 47916.0 48600.5 13863.8 14013.7 14035.2 14198.1 14209.0 9924.8 11175.9 11375.9 11417.0 11485.7 10416.5 12723.9 12781.8 12804.2 12901.9 4846.5 5773.5 5821.7 5841.1 5845.9 972.2 992.2 997.8 1058.0 1080.3 23774.5 24557.8 24620.4 24833.1 24835.4 1120.9 1128.3 1135.7 1165.0 1166.5 10643.2 12619.8 12692.0 12730.9 12757.6 324270.3 331091.0 331709.0 333469.0 333578.0 52664.5 52772.2 52905.0 53198.7 53235.5 1518.0 1520.5 1552.5 1560.3 1571.6 24123.9 24148.9 24206.4 24249.8 24354.4 37622.0 37717.6 37745.4 37854.9 37920.0 270903.5 271460.0 271730.0 271738.0 272918.0 33488.5 34119.8 34550.0 35730.9 35903.6 42759.4 44111.3 44415.3 44941.0 45268.3 27481.4 29720.4 29859.3 32209.5 32821.0 32715.5 33200.5 33391.0 33698.8 33818.5 33741.7 38811.4 40549.6 40895.0 40951.8 37977.6 38548.4 38869.4 39660.8 39813.4 23431.4 24774.9 25114.2 26089.7 26547.5 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:34600.95 Median:2229.19 stddev:88630.49 (3975.9%) stddev-sans-first:88841.95 12:57:59 INFO - PID 1644 | Values: 413.6 447.0 447.0 464.8 465.2 18302.2 19602.8 21400.5 21849.6 22162.9 19660.2 21902.0 23105.3 23358.4 23659.2 5979.8 6137.0 6173.1 6177.4 6202.1 4593.9 6082.8 6120.5 6132.9 6134.6 5373.3 6026.9 6114.0 6117.9 6120.7 6051.4 6141.0 6168.4 6168.8 6175.1 4935.2 5423.0 5482.2 5485.1 5493.8 27260.9 27290.6 27667.3 27810.4 28066.3 2149.8 2220.1 2223.0 2223.4 2229.9 17745.0 17871.3 17965.0 18375.8 18450.5 1890.9 2136.6 2139.1 2183.1 2185.5 148411.0 148585.0 158471.0 163783.0 171311.1 12053.8 12686.4 12884.0 12907.3 12994.2 16196.4 16446.6 16542.4 16586.3 16805.9 8872.8 9086.3 9174.8 9242.1 9293.4 8801.1 8804.4 8822.5 8961.7 9018.1 7946.4 8039.7 8098.8 8124.8 8130.4 2211.6 2222.8 2223.2 2228.5 2345.3 946.7 950.1 959.3 967.4 999.2 20816.6 21377.3 21581.4 24744.4 26725.0 1000.3 1000.9 1008.2 1033.7 1035.8 10978.6 11156.8 11189.2 11232.9 11233.9 436144.0 522199.8 527306.4 551738.0 554923.0 97219.6 108168.5 127115.8 132115.8 137476.0 1234.3 1242.6 1252.3 1282.7 1283.7 16237.8 18620.4 18660.0 18683.4 19087.0 58305.5 58989.0 59267.7 59421.2 59918.0 61681.0 67396.0 78826.9 80224.6 82344.0 8939.0 8963.9 9023.3 9146.2 9373.6 14261.1 14307.4 14452.0 14580.3 14595.5 11864.3 11914.9 12153.8 12188.8 12278.9 10429.2 10430.1 10617.2 10699.3 10701.4 12127.2 12190.2 12236.4 12348.7 12470.1 8900.3 9096.2 9101.9 9124.8 9163.5 9820.4 11969.5 12190.6 12226.8 12330.8 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:6999.39 Median:3890.52 stddev:4390.59 (112.9%) stddev-sans-first:4383.01 12:57:59 INFO - PID 1644 | Values: 1436.8 1456.8 1462.2 1483.5 1499.5 11239.4 11244.3 11684.9 11905.2 11921.2 11654.2 11836.0 11855.8 11882.5 11894.6 2515.4 2565.2 2571.2 2572.3 2581.0 2499.2 2534.2 2534.8 2546.8 2559.6 2214.2 2509.3 2517.7 2525.7 2544.1 2447.0 2483.1 2491.5 2497.9 2505.4 2466.6 2469.4 2484.3 2515.6 2525.1 11145.2 11187.5 11236.2 11262.3 11268.5 6409.3 6653.3 6673.9 6684.7 6699.7 3895.7 4163.9 4269.3 4319.2 4337.4 1208.6 1209.3 1221.9 1289.8 1294.1 16223.5 16504.3 16603.0 16643.7 16848.8 5529.3 5658.2 5783.4 5821.3 5849.4 11751.8 11822.0 11827.0 11829.9 11831.2 6610.2 6619.3 6622.5 6630.6 6631.5 5623.8 5936.4 5973.6 6224.9 6252.2 4236.3 4337.3 4342.7 4371.5 4391.7 1247.8 1260.5 1269.2 1274.9 1283.8 802.5 809.3 832.1 838.8 862.4 5353.8 6173.2 6189.0 6363.4 6369.6 590.1 607.5 608.2 613.7 615.5 3885.3 3898.9 3927.4 3964.8 3965.1 13674.5 14118.4 14273.1 14276.9 14281.6 14154.4 14156.2 14156.6 14167.3 14185.9 7285.8 7805.3 8230.3 8340.8 8401.6 6488.9 7063.2 7131.0 7131.6 7177.1 11166.5 12988.4 13333.9 13576.8 13630.7 11171.3 13484.7 13571.4 13925.0 13944.7 8759.3 8981.9 8990.9 9092.1 9096.4 10524.6 10768.8 10773.8 10775.6 10820.5 8768.1 8822.8 9024.6 9165.5 9187.4 8878.1 8935.6 8982.6 8990.6 9032.3 8117.7 8134.3 8170.4 8225.0 8244.5 6010.9 6045.3 6137.3 6170.3 6240.3 5409.7 6080.8 6127.3 6278.9 6330.6 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5319.26 Median:6099.74 stddev:1698.96 (27.9%) stddev-sans-first:1662.93 12:57:59 INFO - PID 1644 | Values: 389.2 396.2 413.8 423.1 423.3 5563.7 6174.9 6343.5 6375.4 6520.5 5558.4 6009.9 6137.4 6182.1 6325.3 4767.9 4775.0 4796.4 4800.0 4812.4 4598.0 4758.0 4761.2 4793.2 4799.5 4724.5 4734.1 4734.8 4747.4 4748.2 3893.4 4747.6 4764.3 4777.0 4781.3 3023.6 3362.7 3668.6 3830.4 3841.3 4808.5 6083.8 6097.3 6108.5 6128.4 4441.5 4905.7 4980.1 5277.3 5368.0 5379.5 6582.5 6610.8 6634.5 6684.1 3806.2 4168.9 4341.7 4352.5 4365.0 6885.7 6987.9 7006.6 7082.5 7124.2 3675.4 4214.6 4401.6 4407.4 4448.5 4481.8 4488.6 4491.9 4494.8 4498.3 5102.2 5182.4 5309.9 5338.3 5400.4 5940.4 6511.8 6565.3 6689.5 6697.9 1331.6 1486.8 1493.1 1511.9 1523.2 885.7 955.2 984.6 990.8 999.6 5634.2 5882.2 6289.2 6296.8 6327.0 6542.4 6734.6 6920.5 6929.8 6939.6 6027.5 6176.8 6285.8 6286.7 6293.5 2918.9 2967.0 3571.3 3619.7 3623.2 5933.8 6136.8 6685.0 7052.9 7112.1 5586.7 6333.3 6445.3 6447.6 7081.4 6871.7 6994.9 7085.3 7101.7 7132.0 6864.6 6875.7 6880.7 6889.0 7030.2 5913.6 6394.0 6623.8 6699.4 6798.2 5193.1 5719.4 6691.4 6820.3 7089.3 3705.7 4383.3 4386.7 4393.2 4404.5 6102.1 6681.4 6724.6 6808.6 6870.1 5595.0 5857.5 6143.6 6787.2 6795.5 5006.5 6772.6 6775.7 6788.7 6811.0 6571.3 6611.2 6618.4 6641.1 6648.0 5664.9 5871.8 6419.7 6645.2 6809.8 6261.9 6525.8 6526.3 6533.2 6582.0 12:57:59 INFO - PID 1644 | 12:57:59 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21108.57 Median:18008.23 stddev:29053.51 (161.3%) stddev-sans-first:29095.12 12:57:59 INFO - PID 1644 | Values: 832.2 841.7 852.5 857.6 871.8 14309.1 14922.7 16431.3 16438.6 16836.9 11205.0 12632.1 17364.7 17413.9 17434.2 971.7 993.5 1006.3 1012.0 1013.8 981.0 1003.6 1006.4 1009.5 1013.2 987.9 1027.5 1028.9 1038.1 1046.1 1012.6 1032.3 1034.5 1036.4 1039.0 769.4 771.5 771.5 774.9 776.0 16382.4 16682.0 16746.2 17317.8 17520.9 16953.4 17266.1 17589.6 17705.3 17705.4 14060.2 14236.9 14390.3 14402.6 14557.0 3560.0 3572.2 3580.2 3582.6 3593.9 119542.0 120036.0 120678.0 121035.0 121124.4 13065.7 13067.5 13276.5 13536.4 13554.6 25176.5 25263.0 25769.6 25947.2 26328.3 6301.8 7208.9 7241.7 7557.3 7722.3 3722.8 3835.1 3859.3 3859.4 3868.3 3540.9 3563.8 4113.9 4207.6 4275.6 943.2 951.5 964.1 966.3 970.7 564.0 635.5 660.4 662.5 691.9 9742.2 10290.4 10447.6 10669.7 11952.3 586.5 655.9 657.0 670.7 675.4 4807.7 5407.3 5510.9 5571.3 5593.3 88134.0 95933.6 98572.0 99555.5 113199.4 84819.7 86585.0 87197.6 88322.6 89593.6 70499.0 71880.0 72340.6 72572.0 72676.3 12352.2 13010.9 13046.3 13111.5 13202.4 42043.5 42851.4 43264.6 43583.6 43815.0 52896.7 53037.7 53802.0 54022.5 54770.5 16673.4 16706.9 16899.0 17026.2 17042.4 18311.1 18411.0 18606.2 18786.5 18846.4 16582.7 17139.0 17445.0 17507.6 17515.4 16599.7 16685.2 17236.6 17325.1 17340.4 14025.2 16359.9 16410.4 16768.7 17056.9 11721.7 11888.8 12047.3 12125.8 12137.2 12168.0 12226.4 12244.6 12316.7 12332.2 12:57:59 INFO - PID 1644 | -------- Summary: end -------- 12:57:59 INFO - PID 1644 | 12:58:00 INFO - TEST-INFO | 1644: exit 0 12:58:00 INFO - TEST-OK | dromaeo_css | took 1114685ms 12:58:00 INFO - TEST-START | kraken 12:58:00 INFO - operating with platform_type : mac_ 12:58:00 INFO - Initialising browser for kraken test... 12:58:00 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpR4LAIS/profile http://localhost:49236/getInfo.html) 12:58:03 INFO - PID 1652 | 2017-04-30 12:58:03.097 plugin-container[1653:10336] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 12:58:03 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:58:03 INFO - PID 1652 | 2017-04-30 12:58:03.099 plugin-container[1653:10336] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 12:58:03 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:58:03 INFO - PID 1652 | 2017-04-30 12:58:03.099 plugin-container[1653:10336] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:58:03 INFO - PID 1652 | __metrics Screen width/height:1600/1200 12:58:03 INFO - PID 1652 | colorDepth:24 12:58:03 INFO - PID 1652 | Browser inner width/height: 1024/689 12:58:03 INFO - PID 1652 | __metrics 12:58:04 INFO - TEST-INFO | 1652: exit 0 12:58:04 INFO - Browser initialized. 12:58:04 INFO - Running cycle 1/1 for kraken test... 12:58:04 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpR4LAIS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:06 INFO - PID 1654 | 2017-04-30 12:58:06.489 plugin-container[1655:10456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 12:58:06 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:58:06 INFO - PID 1654 | 2017-04-30 12:58:06.490 plugin-container[1655:10456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 12:58:06 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:58:06 INFO - PID 1654 | 2017-04-30 12:58:06.490 plugin-container[1655:10456] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:58:16 INFO - PID 1654 | RSS: Main: 235761664 12:58:16 INFO - PID 1654 | 12:58:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:20 INFO - PID 1654 | RSS: Main: 248320000 12:58:20 INFO - PID 1654 | 12:58:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 12:58:23 INFO - PID 1654 | RSS: Main: 256614400 12:58:23 INFO - PID 1654 | 12:58:26 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 12:58:27 INFO - PID 1654 | RSS: Main: 259325952 12:58:27 INFO - PID 1654 | 12:58:29 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 12:58:29 INFO - PID 1654 | RSS: Main: 260161536 12:58:29 INFO - PID 1654 | 12:58:31 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:58:32 INFO - PID 1654 | RSS: Main: 260476928 12:58:32 INFO - PID 1654 | 12:58:35 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 12:58:36 INFO - PID 1654 | RSS: Main: 266989568 12:58:36 INFO - PID 1654 | 12:58:39 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 12:58:39 INFO - PID 1654 | RSS: Main: 268783616 12:58:39 INFO - PID 1654 | 12:58:43 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 12:58:43 INFO - PID 1654 | RSS: Main: 265760768 12:58:43 INFO - PID 1654 | 12:58:45 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:58:46 INFO - PID 1654 | RSS: Main: 266506240 12:58:46 INFO - PID 1654 | 12:58:47 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:58:48 INFO - PID 1654 | RSS: Main: 266956800 12:58:48 INFO - PID 1654 | 12:58:50 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:58:51 INFO - PID 1654 | RSS: Main: 266825728 12:58:51 INFO - PID 1654 | 12:58:54 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:58:54 INFO - PID 1654 | RSS: Main: 267096064 12:58:54 INFO - PID 1654 | 12:58:57 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:58:58 INFO - PID 1654 | RSS: Main: 267153408 12:58:58 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 12:59:00 INFO - PID 1654 | RSS: Main: 268627968 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | __start_tp_report 12:59:00 INFO - PID 1654 | _x_x_mozilla_page_load 12:59:00 INFO - PID 1654 | _x_x_mozilla_page_load_details 12:59:00 INFO - PID 1654 | |i|pagename|runs| 12:59:00 INFO - PID 1654 | |0;ai-astar;104;116;116;115;113;116;116;115;117;114 12:59:00 INFO - PID 1654 | |1;audio-beat-detection;144;106;155;145;100;119;144;140;159;138 12:59:00 INFO - PID 1654 | |2;audio-dft;199;199;208;221;283;211;203;197;199;195 12:59:00 INFO - PID 1654 | |3;audio-fft;80;59;60;83;57;60;86;51;74;78 12:59:00 INFO - PID 1654 | |4;audio-oscillator;86;69;83;69;69;67;86;74;90;115 12:59:00 INFO - PID 1654 | |5;imaging-gaussian-blur;94;112;87;114;88;88;89;99;88;89 12:59:00 INFO - PID 1654 | |6;imaging-darkroom;95;96;97;96;97;96;104;146;97;96 12:59:00 INFO - PID 1654 | |7;imaging-desaturate;146;82;146;141;103;147;90;125;144;119 12:59:00 INFO - PID 1654 | |8;json-parse-financial;50;48;48;50;52;51;50;51;51;51 12:59:00 INFO - PID 1654 | |9;json-stringify-tinderbox;54;57;62;62;65;61;55;58;56;57 12:59:00 INFO - PID 1654 | |10;stanford-crypto-aes;82;82;85;82;83;85;83;101;81;84 12:59:00 INFO - PID 1654 | |11;stanford-crypto-ccm;141;177;147;144;149;146;153;153;189;140 12:59:00 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;189;193;191;196;195;189;192;184;190;190 12:59:00 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;72;67;71;71;73;87;99;92;92;99 12:59:00 INFO - PID 1654 | __end_tp_report 12:59:00 INFO - PID 1654 | __start_cc_report 12:59:00 INFO - PID 1654 | _x_x_mozilla_cycle_collect,991 12:59:00 INFO - PID 1654 | __end_cc_report 12:59:00 INFO - PID 1654 | __startTimestamp1493582340666__endTimestamp 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | ------- Summary: start ------- 12:59:00 INFO - PID 1654 | Number of tests: 14 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.00 stddev:3.77 (3.2%) stddev-sans-first:1.22 12:59:00 INFO - PID 1654 | Values: 104.0 116.0 116.0 115.0 113.0 116.0 116.0 115.0 117.0 114.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:144.00 stddev:19.98 (13.9%) stddev-sans-first:20.93 12:59:00 INFO - PID 1654 | Values: 144.0 106.0 155.0 145.0 100.0 119.0 144.0 140.0 159.0 138.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:211.50 Median:205.50 stddev:26.33 (12.8%) stddev-sans-first:27.53 12:59:00 INFO - PID 1654 | Values: 199.0 199.0 208.0 221.0 283.0 211.0 203.0 197.0 199.0 195.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:68.80 Median:76.00 stddev:12.66 (16.7%) stddev-sans-first:12.76 12:59:00 INFO - PID 1654 | Values: 80.0 59.0 60.0 83.0 57.0 60.0 86.0 51.0 74.0 78.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:78.50 stddev:14.79 (18.8%) stddev-sans-first:15.56 12:59:00 INFO - PID 1654 | Values: 86.0 69.0 83.0 69.0 69.0 67.0 86.0 74.0 90.0 115.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:88.50 stddev:10.27 (11.6%) stddev-sans-first:10.89 12:59:00 INFO - PID 1654 | Values: 94.0 112.0 87.0 114.0 88.0 88.0 89.0 99.0 88.0 89.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:96.00 stddev:15.66 (16.3%) stddev-sans-first:16.41 12:59:00 INFO - PID 1654 | Values: 95.0 96.0 97.0 96.0 97.0 96.0 104.0 146.0 97.0 96.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:124.30 Median:146.00 stddev:24.88 (17.0%) stddev-sans-first:25.12 12:59:00 INFO - PID 1654 | Values: 146.0 82.0 146.0 141.0 103.0 147.0 90.0 125.0 144.0 119.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:51.00 stddev:1.32 (2.6%) stddev-sans-first:1.39 12:59:00 INFO - PID 1654 | Values: 50.0 48.0 48.0 50.0 52.0 51.0 50.0 51.0 51.0 51.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.50 stddev:3.59 (6.0%) stddev-sans-first:3.38 12:59:00 INFO - PID 1654 | Values: 54.0 57.0 62.0 62.0 65.0 61.0 55.0 58.0 56.0 57.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.00 stddev:5.85 (7.0%) stddev-sans-first:6.11 12:59:00 INFO - PID 1654 | Values: 82.0 82.0 85.0 82.0 83.0 85.0 83.0 101.0 81.0 84.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:151.00 stddev:16.19 (10.7%) stddev-sans-first:16.48 12:59:00 INFO - PID 1654 | Values: 141.0 177.0 147.0 144.0 149.0 146.0 153.0 153.0 189.0 140.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:191.50 stddev:3.41 (1.8%) stddev-sans-first:3.55 12:59:00 INFO - PID 1654 | Values: 189.0 193.0 191.0 196.0 195.0 189.0 192.0 184.0 190.0 190.0 12:59:00 INFO - PID 1654 | 12:59:00 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:89.50 stddev:12.69 (14.2%) stddev-sans-first:12.90 12:59:00 INFO - PID 1654 | Values: 72.0 67.0 71.0 71.0 73.0 87.0 99.0 92.0 92.0 99.0 12:59:00 INFO - PID 1654 | -------- Summary: end -------- 12:59:00 INFO - PID 1654 | 12:59:01 INFO - TEST-INFO | 1654: exit 0 12:59:01 INFO - TEST-OK | kraken | took 61484ms 12:59:01 INFO - SUITE-END | took 1176s 12:59:01 INFO - Completed test suite (00:19:36) 12:59:01 INFO - javascript benchmark 12:59:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7807.602710949181, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3408.2672225471524, 3523.3305671922335, 3558.395072837617, 3572.4641303804424, 3577.123604716843, 5885.146653735206, 6100.938990610092, 6171.012637977924, 6210.347913469082, 6237.157983672214, 6110.480609148228, 6117.143599896018, 6139.921477737031, 6157.784477543287, 6162.198914141155, 5278.841634750945, 5282.867928301795, 5318.361796584396, 5356.276902618136, 5488.368837583689, 4914.680545764514, 5162.664426812245, 5269.3676758789, 5401.945980540203, 5486.286782718241, 5337.70642614656, 5400.729963501829, 5411.945880541183, 5432.782688692448, 5478.342598888139, 4354.346847972798, 5197.688138711689, 5281.52466278033, 5282.313299271109, 5291.391489978663, 5295.364556253275, 5319.20211968204, 5321.3348331458565, 5364.704941228231, 5423.566114710814, 5926.466618004357, 6133.907991380088, 6172.4136207060255, 6180.9381906180815, 6202.224721909762, 6447.935520644781, 6513.381228783258, 6525.412712855818, 6528.543001989862, 6532.052852336385, 5510.972445137749, 6242.188515492957, 6383.265924418705, 6461.773837915697, 6639.269680335159, 6227.875442491125, 6252.874942501125, 6257.937420625826, 6270.404311590391, 6290.21372328459, 5961.970190149022, 6239.906401403982, 6687.665616719242, 6701.832454188684, 6707.966460167668, 6294.779682711175, 6319.526035547352, 6360.6501642409185, 6365.840853978688, 6433.710483028275, 5361.624686271924, 6528.738850446024, 6552.967235163889, 6555.8361040973405, 6555.836104097436, 6423.100765892778, 6425.9036114457385, 6426.485881129498, 6438.227412710505, 6439.8068057958335, 5520.227168196456, 6129.389354848322, 6348.841278968062, 6379.138816259839, 6416.197975253093, 5155.716435596079, 5165.715885626251, 5174.404943431478, 5177.534021938043, 5177.922331165036, 4275.679324050709, 4665.0, 4667.603253723471, 4668.719876807402, 4689.460712018094, 4981.576565991932, 6048.42539958712, 6088.939110608926, 6101.115338276014, 6118.357572454917, 6287.182666253358, 6536.379043990813, 6590.0, 6600.405963463311, 6613.338666133348, 6218.81343559694, 6219.564630475823, 6230.408111229426, 6234.470070044006, 6247.0629405589525, 5425.538829199562, 5550.222968784374, 5738.626989245686, 5751.4536119068625, 5799.449052340021, 5583.804566840141, 6508.544401891822, 6532.281449040602, 6709.731610735711, 6768.255491895986, 6590.308017658077, 6600.07598936159, 6605.339466053356, 6618.2719900811835, 6640.103586015826, 6521.804345869631, 6594.439472644879, 6627.138471998609, 6718.966405167943, 6782.660866956534, 6380.776672816429, 6417.294097649162, 6419.935800641933, 6422.807315780534, 6425.132607098169, 5341.973290133525, 6330.588511746721, 6361.554691171574, 6409.198850143732, 6528.118703974903, 4697.953020469751, 6349.142865713255, 6370.617762934239, 6378.266499352634, 6395.264544577433, 6341.460975817107, 6349.8730025400155, 6361.077643741539, 6366.236051673829, 6381.617102973836, 5178.611604129781, 6000.909986350121, 6305.7388522294805, 6321.0, 6435.935640643534, 5361.678299301899, 6331.620102793847, 6392.232932048184, 6404.1674582304, 6405.775797847053, 6185.783497577563, 6272.529560283088, 6285.5600107992, 6308.14839996613, 6352.110704501466], "value": 5905.543774602222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5411455496649, 825.3149885594956, 1005.627917670462, 1102.713294543419, 1139.692283083567, 32365.352692946155, 36022.0, 36033.45949810755, 36053.738119165835, 36118.45822312661, 37730.4340434893, 37804.67683631073, 38023.0, 38132.0, 38244.61755382446, 7457.1051473822945, 8306.584670766468, 8435.746927592152, 8468.0, 8471.872921906177, 8357.456765310266, 8473.872891906627, 8478.279346255576, 8489.108643592426, 8525.147485251488, 8418.200270974277, 8504.44721093127, 8529.95735021324, 8537.402381833273, 8595.312375010015, 8463.28062114721, 8482.0, 8491.235788778979, 8495.575221238943, 8498.277646400064, 7453.881917712332, 7944.761657150237, 8264.132266112032, 8355.456895301786, 8361.122082181406, 36322.81838590817, 36578.451323230176, 36786.448203276974, 36858.26283474342, 36953.815230923945, 3578.212793185521, 3591.6228795976567, 3613.5663720353728, 3619.2761447710564, 3621.9134259721977, 30028.399432011236, 30084.24789380261, 30090.0, 30101.0, 30220.8488957556, 2946.955795663067, 2998.175501737018, 3022.8488575571355, 3023.9848800756076, 3041.1332770160398, 212703.99999999846, 258752.7062364676, 299297.0, 300018.0, 300253.0, 44130.11739765187, 46874.0, 47443.051138977025, 47454.0, 47705.522944770804, 42344.57655423468, 42885.0, 45372.09255814865, 47916.0, 48600.54198374054, 13863.752262296442, 14013.719725605431, 14035.157890526601, 14198.077124986843, 14209.0, 9924.751881202883, 11175.944120279346, 11375.943120284512, 11416.972472477351, 11485.71285717847, 10416.531256093494, 12723.918466930414, 12781.808272875915, 12804.167729097579, 12901.903338216356, 4846.466888642247, 5773.480386765212, 5821.708914554255, 5841.065429531254, 5845.941540584625, 972.2367941166151, 992.2409356842022, 997.8453339732353, 1058.0424715632364, 1080.330195278932, 23774.524509509713, 24557.754422455546, 24620.384490387525, 24833.130840420497, 24835.379115521897, 1120.9047230985457, 1128.3004537186996, 1135.7274254178938, 1165.0, 1166.5333866453486, 10643.156095990582, 12619.810702839464, 12692.0, 12730.936345318214, 12757.55348562796, 324270.3302636708, 331091.0, 331709.0, 333469.0, 333578.0, 52664.47335526596, 52772.20841687378, 52905.0, 53198.734006330495, 53235.46764532383, 1518.0284617844588, 1520.4830357678443, 1552.4954389823354, 1560.3290585048312, 1571.6070982254437, 24123.879380602986, 24148.87925560431, 24206.394840129138, 24249.75750242475, 24354.391140221636, 37622.0, 37717.62282377251, 37745.433818492194, 37854.864354069425, 37920.0, 270903.4548272618, 271460.0, 271730.0, 271738.0, 272918.0, 33488.49767253542, 34119.82940085284, 34550.0, 35730.928072157876, 35903.64096359003, 42759.3586096215, 44111.33832992572, 44415.333769994126, 44941.0, 45268.32097518474, 27481.35111893293, 29720.405591887607, 29859.253518662208, 32209.51685724763, 32821.01536953895, 32715.509267361485, 33200.501992470614, 33390.99827005194, 33698.83150584329, 33818.49272260869, 33741.66258337385, 38811.417828732025, 40549.594504054585, 40895.0, 40951.7952410236, 37977.62022379741, 38548.42177367285, 38869.416958745074, 39660.80169599134, 39813.40279895746, 23431.41421464477, 24774.876125619256, 25114.24657260285, 26089.73910260873, 26547.469050618492], "value": 17495.5697259116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.6153377359055, 446.96200822930047, 446.9999999999999, 464.8233671204942, 465.2021782642767, 18302.176402061905, 19602.803971960275, 21400.46498837528, 21849.563008739817, 22162.891855407204, 19660.21359145636, 21902.0, 23105.30684079476, 23358.41603959902, 23659.17192898249, 5979.820605381846, 6137.018077107664, 6173.135760993465, 6177.444030037295, 6202.069689546582, 4593.931091033637, 6082.756689732405, 6120.510359171278, 6132.938670613304, 6134.6012509186985, 5373.274607927939, 6026.939730602704, 6114.021756518958, 6117.877642447148, 6120.663363515005, 6051.394860513958, 6141.048137538689, 6168.44483996438, 6168.753249870022, 6175.07373893915, 4935.210366341368, 5423.0, 5482.17767334903, 5485.149801780731, 5493.835184944418, 27260.90956361743, 27290.5906411404, 27667.308317292027, 27810.443791124268, 28066.298342541395, 2149.7635260121374, 2220.0564759976946, 2222.9555408891893, 2223.377454312795, 2229.933102006926, 17745.024023678692, 17871.28514859404, 17965.0, 18375.816241837678, 18450.53873653156, 1890.905454727258, 2136.6260904341834, 2139.0908863733007, 2183.1267493002765, 2185.508260641359, 148411.0, 148585.0, 158471.0, 163783.0, 171311.14344428323, 12053.758924821455, 12686.429110690042, 12884.0, 12907.290099044643, 12994.220346779224, 16196.433124840574, 16446.588835279214, 16542.42101526441, 16586.336546538245, 16805.91597042007, 8872.822543549093, 9086.273098152264, 9174.770630734152, 9242.12199841014, 9293.395929264576, 8801.07588703177, 8804.427712198687, 8822.51476168817, 8961.731148065568, 9018.09819018093, 7946.443748937519, 8039.703721474168, 8098.838023239502, 8124.837503249902, 8130.430869839172, 2211.6240239159383, 2222.844400891922, 2223.2329846203033, 2228.4540287629634, 2345.2729653807373, 946.6828612414918, 950.1258841865363, 959.2876715063717, 967.4002118686459, 999.1557134221571, 20816.583668326548, 21377.25179618737, 21581.35255942324, 24744.381390465023, 26725.0, 1000.3247807729899, 1000.8949060348705, 1008.178334657252, 1033.7105610429091, 1035.8394448860438, 10978.615748448767, 11156.832647510293, 11189.160812938899, 11232.943835280772, 11233.943830280796, 436144.0, 522199.77800221514, 527306.3634681802, 551738.0, 554923.0, 97219.5695107628, 108168.4591577037, 127115.82210444628, 132115.83460432148, 137476.0, 1234.2594443334108, 1242.6458459339044, 1252.2674235572292, 1282.7242142939313, 1283.749668814591, 16237.756433653269, 18620.44138675842, 18660.0, 18683.439496815117, 19087.041508566195, 58305.5423614413, 58989.0, 59267.70366148141, 59421.21736347916, 59918.0, 61681.0, 67396.0, 78826.9055784982, 80224.59887700524, 82344.0, 8938.955305223431, 8963.910360896307, 9023.323250756352, 9146.222571081267, 9373.578188981648, 14261.144331340152, 14307.356168972214, 14452.0, 14580.34388452501, 14595.489157879423, 11864.347460889734, 11914.880851191723, 12153.817692734792, 12188.842060004285, 12278.877211228131, 10429.217808664229, 10430.113440357654, 10617.150627949592, 10699.304545204537, 10701.411422371844, 12127.190032828614, 12190.2076365036, 12236.388180591113, 12348.691282718004, 12470.064745143969, 8900.287976961958, 9096.226820720312, 9101.863472048057, 9124.817503649758, 9163.52584802113, 9820.4107753535, 11969.461374238006, 12190.634280971584, 12226.816597751218, 12330.81503777426], "value": 10495.75539312312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.784482327651, 1456.7741999990005, 1462.1884853906079, 1483.473366954731, 1499.490173341064, 11239.438028098593, 11244.269122507052, 11684.883151168486, 11905.16663833532, 11921.165518413714, 11654.24247423919, 11836.0, 11855.7628847423, 11882.52469901205, 11894.583689570867, 2515.383730985911, 2565.2304308707407, 2571.190075126339, 2572.344052266669, 2581.019212699181, 2499.187763976706, 2534.176392672389, 2534.822562420631, 2546.783523400504, 2559.5520783862844, 2214.2250212425683, 2509.2597683683266, 2517.710463296726, 2525.747425257478, 2544.0841297133015, 2446.987765061181, 2483.1184929350093, 2491.53906527293, 2497.9375515612073, 2505.361132911114, 2466.5560199164142, 2469.3579669285937, 2484.254723582936, 2515.5723527000455, 2525.0783464035494, 11145.16411269158, 11187.496562654618, 11236.157288203418, 11262.267952583137, 11268.492917818718, 6409.294977552466, 6653.301403352675, 6673.933260667428, 6684.699188536528, 6699.665016749192, 3895.7467764595212, 4163.8959026024595, 4269.274223382033, 4319.179355922396, 4337.392765012901, 1208.6434501821984, 1209.3288225035103, 1221.9022478201812, 1289.806529020645, 1294.0941341061296, 16223.51329460118, 16504.25730842115, 16603.0, 16643.667126657398, 16848.83151168497, 5529.30883639545, 5658.236138121383, 5783.421657834267, 5821.301443826768, 5849.415058494116, 11751.764964700658, 11822.0, 11826.994705450134, 11829.88170118305, 11831.17181797266, 6610.173728283965, 6619.304972977768, 6622.470202383798, 6630.602163870183, 6631.535792494576, 5623.762772190112, 5936.436038576328, 5973.551983601247, 6224.937750622526, 6252.187215662026, 4236.279832428495, 4337.284348082531, 4342.652587792969, 4371.475422949266, 4391.67062470316, 1247.7504499100035, 1260.489501751792, 1269.1813780111777, 1274.949002039908, 1283.7689215941034, 802.5144787403536, 809.3282575462352, 832.0930186097183, 838.7861095420628, 862.3920136303891, 5353.768633214382, 6173.166622505994, 6189.009758438719, 6363.3636636336, 6369.649669268235, 590.0883135555576, 607.5443417436923, 608.2184393054903, 613.6839527643267, 615.5260449453896, 3885.300645883768, 3898.90252743678, 3927.3716205407, 3964.781936993493, 3965.147493288957, 13674.453021879212, 14118.364673589713, 14273.14361138335, 14276.928615356857, 14281.571552853224, 14154.363053662404, 14156.150630961969, 14156.575302740934, 14167.291635418187, 14185.858141418454, 7285.781426557318, 7805.33654639362, 8230.341572674171, 8340.833183336299, 8401.621927013299, 6488.870222595616, 7063.1524217094275, 7130.974549968963, 7131.6077615729555, 7177.102862142232, 11166.497507612014, 12988.35058247065, 13333.933285336956, 13576.796348054984, 13630.659233519242, 11171.329720216812, 13484.730305394034, 13571.38928748189, 13925.025248232932, 13944.721105578035, 8759.255463285692, 8981.865272020794, 8990.86513702282, 9092.136247056518, 9096.408733432305, 10524.631637892637, 10768.784624307627, 10773.784524309312, 10775.568977241137, 10820.458977051274, 8768.123187681182, 8822.823543529223, 9024.639014439612, 9165.462122679604, 9187.448753074837, 8878.067802880863, 8935.642574297215, 8982.595783189641, 8990.595423205841, 9032.277417806692, 8117.715879944174, 8134.349252059939, 8170.387220958333, 8225.012998439986, 8244.505329679998, 6010.909836352371, 6045.335013148462, 6137.263528376623, 6170.3212646607935, 6240.282367527792, 5409.702466364388, 6080.847978800565, 6127.295361033538, 6278.874422511432, 6330.588511746721], "value": 5279.792363513471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.15502000098775, 396.1976996581921, 413.83358120240547, 423.13891231344223, 423.32268370607034, 5563.693996830173, 6174.876502469959, 6343.492520598353, 6375.394337537932, 6520.543561950665, 5558.388067460442, 6009.87980240395, 6137.38626137386, 6182.103594978726, 6325.304216536178, 4767.8808029799275, 4775.044991001796, 4796.3764710587575, 4800.039992001596, 4812.374391329122, 4598.0, 4757.952420475785, 4761.238201887699, 4793.185158523042, 4799.496052914446, 4724.503927087658, 4734.124187025394, 4734.821981888318, 4747.406574178228, 4748.171953797778, 3893.415987601854, 4747.596454301389, 4764.309175169598, 4777.0, 4781.282807578857, 3023.5918151049545, 3362.663733626642, 3668.578113516953, 3830.444585535082, 3841.2701586698436, 4808.543188397097, 6083.8174854754425, 6097.3292937776805, 6108.511319094462, 6128.417800308964, 4441.489228738704, 4905.681130726527, 4980.056809389019, 5277.337638643853, 5368.0, 5379.462053794628, 6582.478374069898, 6610.8016759497295, 6634.502412319047, 6684.092419797404, 3806.219724956405, 4168.853565269545, 4341.6526677865695, 4352.542982986804, 4364.956350436487, 6885.690143943534, 6987.895181572331, 7006.582728958501, 7082.539634923765, 7124.216336203013, 3675.4486826976167, 4214.599613036757, 4401.625861801783, 4407.42703448556, 4448.488423831301, 4481.75350355727, 4488.5960263576435, 4491.932621010687, 4494.775261236925, 4498.347739577743, 5102.183650615958, 5182.404023537266, 5309.858380448222, 5338.252644629677, 5400.405955344988, 5940.376260492586, 6511.79531786621, 6565.277819439858, 6689.531732778756, 6697.933020669731, 1331.5872079655337, 1486.829014663306, 1493.0668332292316, 1511.871490923262, 1523.1850959736487, 885.6723012485421, 955.1642312976146, 984.5520288268821, 990.7523119220195, 999.6301368493704, 5634.211210430543, 5882.205902203234, 6289.245290565162, 6296.811095667137, 6327.0, 6542.411182993458, 6734.595924244561, 6920.515563910478, 6929.826754331081, 6939.618320992394, 6027.517798576104, 6176.7838125666285, 6285.77999770015, 6286.748530058747, 6293.496520278367, 2918.9270268243463, 2967.0, 3571.2857428514403, 3619.7466177367332, 3623.202895363016, 5933.762649494059, 6136.846578835565, 6685.0, 7052.871540553487, 7112.146542414944, 5586.692731899703, 6333.258353952608, 6445.2587952386075, 6447.6131432114225, 7081.398081163159, 6871.725130994804, 6994.860102798018, 7085.326893945067, 7101.680424380916, 7131.964340178266, 6864.597390913141, 6875.724971001304, 6880.69266839299, 6889.00109484132, 7030.191527974144, 5913.5564832636865, 6393.968030159819, 6623.768168114093, 6699.43054840344, 6798.218204906301, 5193.091209038327, 5719.428057194247, 6691.43122834545, 6820.283870193558, 7089.326513981164, 3705.7220708446434, 4383.320585309282, 4386.670999674973, 4393.20922234001, 4404.493483249467, 6102.145699601971, 6681.365270299314, 6724.636523007494, 6808.62552559614, 6870.141232345957, 5594.972025140011, 5857.5313974881055, 6143.600665956698, 6787.185537735503, 6795.524313298021, 5006.524380183877, 6772.5936443813525, 6775.661216939232, 6788.694508747217, 6811.0, 6571.3100124488155, 6611.239707433707, 6618.371254730793, 6641.136652235178, 6647.966760166361, 5664.915026274692, 5871.794487192928, 6419.716056788754, 6645.235797883112, 6809.842326804356, 6261.937380626136, 6525.836854078686, 6526.282108968105, 6533.18335208099, 6582.0], "value": 4784.415040389169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.184459229955, 841.7054031089116, 852.5311078906601, 857.5721423829325, 871.8343514732198, 14309.141451512916, 14922.701545969074, 16431.34274629015, 16438.589035274123, 16836.915815420936, 11205.0, 12632.11575189737, 17364.652706945886, 17413.912930435363, 17434.215460304316, 971.6987733802508, 993.4982833668987, 1006.3056491021208, 1012.0486742462099, 1013.8073765984476, 980.9852852207223, 1003.5684655598089, 1006.3710181136789, 1009.4649835587151, 1013.2096964367805, 987.9259055570825, 1027.5067967375664, 1028.9022542858415, 1038.096855735511, 1046.0585473074218, 1012.6354512375539, 1032.2980373346122, 1034.4672493665769, 1036.3988886445843, 1038.979220415595, 769.4114002787871, 771.4561234329784, 771.502380964275, 774.9147593764682, 776.0183368039435, 16382.426615068416, 16682.0, 16746.16269186548, 17317.826821731873, 17520.91239543807, 16953.406630767862, 17266.050367229796, 17589.56026099345, 17705.29178832845, 17705.38031168903, 14060.156390616596, 14236.928815355961, 14390.28048597566, 14402.639934001629, 14556.981011329211, 3560.038789526813, 3572.1962558424148, 3580.2481478889463, 3582.5700915889997, 3593.94609080864, 119542.0, 120036.0, 120678.0, 121035.0, 121124.39437802843, 13065.738685226243, 13067.477300908047, 13276.535321263902, 13536.390862411019, 13554.59336219915, 25176.496470070495, 25262.989480420943, 25769.61345579818, 25947.22158335253, 26328.341791454983, 6301.779437719658, 7208.855822883513, 7241.746538871114, 7557.319841214317, 7722.3049925506975, 3722.8324725387424, 3835.1179228777537, 3859.3439115350457, 3859.4403811447182, 3868.2650296443585, 3540.929181416357, 3563.750537462353, 4113.930378101715, 4207.621314081747, 4275.551067137968, 943.2312665177858, 951.4576691286039, 964.0985678390728, 966.3139171188394, 970.7330484116924, 563.9633423827438, 635.5011316116826, 660.4089340040637, 662.456785435938, 691.8998791920769, 9742.223466312067, 10290.3825770454, 10447.582096716198, 10669.679909602724, 11952.282065133877, 586.5366360575183, 655.9081728558006, 656.980290591283, 670.6646676661669, 675.3516624040976, 4807.735574543363, 5407.297051383295, 5510.889782204334, 5571.331440227199, 5593.328800543961, 88134.0, 95933.5609965851, 98572.0, 99555.50666740004, 113199.43400282945, 84819.7277040845, 86585.0, 87197.5640121808, 88322.55838720765, 89593.55203224072, 70499.0, 71880.0, 72340.63829680817, 72572.0, 72676.273237268, 12352.197107188003, 13010.869891300967, 13046.282454465096, 13111.541096061592, 13202.405891735087, 42043.528476503176, 42851.357229642206, 43264.567354327315, 43583.56416435795, 43815.0, 52896.73551632371, 53037.674058148856, 53802.0, 54022.459775401745, 54770.45229547813, 16673.416430424877, 16706.916465417595, 16899.0, 17026.233819477904, 17042.403515876886, 18311.084445777924, 18411.0, 18606.162722677782, 18786.53033674169, 18846.43460696181, 16582.66834663324, 17139.0, 17445.04052277137, 17507.56231094233, 17515.386961456286, 16599.668006639557, 16685.165741712623, 17236.569085772957, 17325.133743313036, 17340.393086241922, 14025.228612426414, 16359.918200408922, 16410.425635102714, 16768.664626707643, 17056.914715426345, 11721.706957326134, 11888.76222475563, 12047.33739644328, 12125.818112728493, 12137.150399471951, 12168.0, 12226.388680565758, 12244.571439999558, 12316.692082698004, 12332.19840710351], "value": 8268.511310045582, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 116.0, 115.0, 113.0, 116.0, 116.0, 115.0, 117.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 155.0, 145.0, 100.0, 119.0, 144.0, 140.0, 159.0, 138.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 199.0, 208.0, 221.0, 283.0, 211.0, 203.0, 197.0, 199.0, 195.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 83.0, 57.0, 60.0, 86.0, 51.0, 74.0, 78.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 83.0, 69.0, 69.0, 67.0, 86.0, 74.0, 90.0, 115.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 112.0, 87.0, 114.0, 88.0, 88.0, 89.0, 99.0, 88.0, 89.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 97.0, 96.0, 104.0, 146.0, 97.0, 96.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 82.0, 146.0, 141.0, 103.0, 147.0, 90.0, 125.0, 144.0, 119.0], "value": 124.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 48.0, 50.0, 52.0, 51.0, 50.0, 51.0, 51.0, 51.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 62.0, 62.0, 65.0, 61.0, 55.0, 58.0, 56.0, 57.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 82.0, 83.0, 85.0, 83.0, 101.0, 81.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 177.0, 147.0, 144.0, 149.0, 146.0, 153.0, 153.0, 189.0, 140.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 193.0, 191.0, 196.0, 195.0, 189.0, 192.0, 184.0, 190.0, 190.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 71.0, 71.0, 73.0, 87.0, 99.0, 92.0, 92.0, 99.0], "value": 82.3, "unit": "score"}]}]} 12:59:01 INFO - Return code: 0 12:59:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:59:01 ERROR - # TBPL SUCCESS # 12:59:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:59:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:59:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:59:01 INFO - 2017-04-30 12:59:01.988 screenresolution[1660:10861] starting screenresolution argv=screenresolution get 12:59:01 INFO - 2017-04-30 12:59:01.992 screenresolution[1660:10861] Display 0: 1600x1200x32@60 12:59:01 INFO - 2017-04-30 12:59:01.998 screenresolution[1661:10864] starting screenresolution argv=screenresolution list 12:59:02 INFO - Available Modes on Display 0 12:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:59:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:59:02 INFO - Intel Iris: 12:59:02 INFO - Chipset Model: Intel Iris 12:59:02 INFO - Type: GPU 12:59:02 INFO - Bus: Built-In 12:59:02 INFO - VRAM (Dynamic, Max): 1536 MB 12:59:02 INFO - Vendor: Intel (0x8086) 12:59:02 INFO - Device ID: 0x0a2e 12:59:02 INFO - Revision ID: 0x0009 12:59:02 INFO - Displays: 12:59:02 INFO - Display: 12:59:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:59:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:59:02 INFO - Display Serial Number: 1600x1200 60 12:59:02 INFO - Main Display: Yes 12:59:02 INFO - Mirror: Off 12:59:02 INFO - Online: Yes 12:59:02 INFO - Rotation: Supported 12:59:02 INFO - Return code: 0 12:59:02 INFO - Running post-action listener: _resource_record_post_action 12:59:02 INFO - [mozharness: 2017-04-30 19:59:02.245713Z] Finished run-tests step (success) 12:59:02 INFO - Running post-run listener: _resource_record_post_run 12:59:02 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 35111936; Write bytes: 510606336; Read time: 320; Write time: 1761 12:59:02 INFO - TinderboxPrint: CPU usage
54.0% 12:59:02 INFO - TinderboxPrint: I/O read bytes / time
35,111,936 / 320 12:59:02 INFO - TinderboxPrint: I/O write bytes / time
510,606,336 / 1,761 12:59:02 INFO - TinderboxPrint: CPU idle
2,200.3 (46.0%) 12:59:02 INFO - TinderboxPrint: CPU system
959.1 (20.0%) 12:59:02 INFO - TinderboxPrint: CPU user
1,626.2 (34.0%) 12:59:02 INFO - TinderboxPrint: Swap in / out
239,554,560 / 0 12:59:02 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195162624; Write bytes: 193570816; Read time: 15006; Write time: 334 12:59:02 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34128896; Write bytes: 300192768; Read time: 303; Write time: 1381 12:59:02 INFO - Running post-run listener: _upload_blobber_files 12:59:02 INFO - Blob upload gear active. 12:59:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:59:02 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 12:59:02 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'] 12:59:02 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 12:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 12:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:04 INFO - (blobuploader) - INFO - Done attempting. 12:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:05 INFO - (blobuploader) - INFO - Done attempting. 12:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:06 INFO - (blobuploader) - INFO - Done attempting. 12:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:59:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:09 INFO - (blobuploader) - INFO - Done attempting. 12:59:09 INFO - (blobuploader) - INFO - Iteration through files over. 12:59:09 INFO - Return code: 0 12:59:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:59:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:59:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb562daa16b8769917295722cfd14b4b5a0e09f340b6b7eeab1d5f73dc8d287f8abebbfc5cb065ad2105096c48ea25933042f696efc86c280b642483f8769a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4a34675d46d2e877001cda043ab224a06d568ec3d3d96fcf08879461ba5a9dcd0c53f11636cd4fbb98298c99121c9cc728bdfa3f1cf351690bc5559dce68163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5625e656bbd98016973765274cdc4984ad02b0180e090ffa1b09b4d9c69cdd3093f4a6f2285ded0241df673e57f60d60a87c8ca96a8c25d814716ec8247c4d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb5f7b4cb331133156c906db2f9874ae1b7dcfbe7eb03cf212f7ec60874c933859418a7d1fad57dbb53cb1776aed9809f356d61455c5e698d590d1ce30122237"} 12:59:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:59:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:59:09 INFO - Contents: 12:59:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb562daa16b8769917295722cfd14b4b5a0e09f340b6b7eeab1d5f73dc8d287f8abebbfc5cb065ad2105096c48ea25933042f696efc86c280b642483f8769a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4a34675d46d2e877001cda043ab224a06d568ec3d3d96fcf08879461ba5a9dcd0c53f11636cd4fbb98298c99121c9cc728bdfa3f1cf351690bc5559dce68163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5625e656bbd98016973765274cdc4984ad02b0180e090ffa1b09b4d9c69cdd3093f4a6f2285ded0241df673e57f60d60a87c8ca96a8c25d814716ec8247c4d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb5f7b4cb331133156c906db2f9874ae1b7dcfbe7eb03cf212f7ec60874c933859418a7d1fad57dbb53cb1776aed9809f356d61455c5e698d590d1ce30122237"} 12:59:09 INFO - Running post-run listener: copy_logs_to_upload_dir 12:59:09 INFO - Copying logs to upload dir... 12:59:09 INFO - mkdir: /builds/slave/test/build/upload/logs 12:59:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.778097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-30 12:59:09.084484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 12:59:09.088621) ========= 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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb562daa16b8769917295722cfd14b4b5a0e09f340b6b7eeab1d5f73dc8d287f8abebbfc5cb065ad2105096c48ea25933042f696efc86c280b642483f8769a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4a34675d46d2e877001cda043ab224a06d568ec3d3d96fcf08879461ba5a9dcd0c53f11636cd4fbb98298c99121c9cc728bdfa3f1cf351690bc5559dce68163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5625e656bbd98016973765274cdc4984ad02b0180e090ffa1b09b4d9c69cdd3093f4a6f2285ded0241df673e57f60d60a87c8ca96a8c25d814716ec8247c4d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb5f7b4cb331133156c906db2f9874ae1b7dcfbe7eb03cf212f7ec60874c933859418a7d1fad57dbb53cb1776aed9809f356d61455c5e698d590d1ce30122237"} build_url:https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011040 build_url: 'https://queue.taskcluster.net/v1/task/BNhm3rATQqa4wDAGhIjBbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb562daa16b8769917295722cfd14b4b5a0e09f340b6b7eeab1d5f73dc8d287f8abebbfc5cb065ad2105096c48ea25933042f696efc86c280b642483f8769a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4a34675d46d2e877001cda043ab224a06d568ec3d3d96fcf08879461ba5a9dcd0c53f11636cd4fbb98298c99121c9cc728bdfa3f1cf351690bc5559dce68163", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5625e656bbd98016973765274cdc4984ad02b0180e090ffa1b09b4d9c69cdd3093f4a6f2285ded0241df673e57f60d60a87c8ca96a8c25d814716ec8247c4d19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb5f7b4cb331133156c906db2f9874ae1b7dcfbe7eb03cf212f7ec60874c933859418a7d1fad57dbb53cb1776aed9809f356d61455c5e698d590d1ce30122237"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 12:59:09.123863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 12:59:09.124255) ========= 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.lRupuvxH8y/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.i0ZmwQ0CPD/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.004988 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 12:59:09.173230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 12:59:09.173571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 12:59:09.173930) ========= ========= Total master_lag: 0.18 =========