builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0294 starttime: 1492948131.72 results: success (0) buildid: 20170423030206 builduid: 1c36ef7c1cb0492aa1fb5c5bd442fc41 revision: 070fc3c2f8400c09f1037f5444c3d33b499e7128 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.718841) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.719261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.719542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.747313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.747697) ========= 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.EBiz4UEjiV/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.QgstyK8hYv/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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-23 04:48:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.3M=0.001s 2017-04-23 04:48:52 (16.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168579 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.969009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.969350) ========= 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.EBiz4UEjiV/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.QgstyK8hYv/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.027357 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:52.021015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-23 04:48:52.021366) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 070fc3c2f8400c09f1037f5444c3d33b499e7128 --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 070fc3c2f8400c09f1037f5444c3d33b499e7128 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EBiz4UEjiV/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.QgstyK8hYv/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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-23 04:48:52,266 truncating revision to first 12 chars 2017-04-23 04:48:52,266 Setting DEBUG logging. 2017-04-23 04:48:52,266 attempt 1/10 2017-04-23 04:48:52,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/070fc3c2f840?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-23 04:48:54,596 unpacking tar archive at: mozilla-central-070fc3c2f840/testing/mozharness/ program finished with exit code 0 elapsedTime=2.603162 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-23 04:48:54.651385) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:54.651865) ========= script_repo_revision: 070fc3c2f8400c09f1037f5444c3d33b499e7128 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:54.652453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:54.652883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:54.675125) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-23 04:48:54.675678) ========= /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.EBiz4UEjiV/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.QgstyK8hYv/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:48:55 INFO - MultiFileLogger online at 20170423 04:48:55 in /builds/slave/test 04:48:55 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 04:48:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:55 INFO - {'append_to_log': False, 04:48:55 INFO - 'base_work_dir': '/builds/slave/test', 04:48:55 INFO - 'blob_upload_branch': 'Firefox', 04:48:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:55 INFO - 'branch': 'Firefox', 04:48:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:55 INFO - 'config_files': ('talos/mac_config.py',), 04:48:55 INFO - 'default_actions': ('clobber', 04:48:55 INFO - 'read-buildbot-config', 04:48:55 INFO - 'download-and-extract', 04:48:55 INFO - 'populate-webroot', 04:48:55 INFO - 'create-virtualenv', 04:48:55 INFO - 'install', 04:48:55 INFO - 'run-tests'), 04:48:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:55 INFO - 'download_minidump_stackwalk': True, 04:48:55 INFO - 'download_symbols': 'ondemand', 04:48:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:55 INFO - 'gecko_profile': False, 04:48:55 INFO - 'gecko_profile_interval': 0, 04:48:55 INFO - 'installer_path': 'installer.exe', 04:48:55 INFO - 'log_level': 'info', 04:48:55 INFO - 'log_name': 'talos', 04:48:55 INFO - 'log_to_console': True, 04:48:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:55 INFO - 'opt_config_files': (), 04:48:55 INFO - 'pip_index': False, 04:48:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:55 INFO - 'cmd': ('bash', 04:48:55 INFO - '-c', 04:48:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:55 INFO - 'enabled': True, 04:48:55 INFO - 'halt_on_failure': False, 04:48:55 INFO - 'name': 'check_screen_resolution'},), 04:48:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:55 INFO - 'cmd': ('bash', 04:48:55 INFO - '-c', 04:48:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:55 INFO - 'enabled': True, 04:48:55 INFO - 'halt_on_failure': False, 04:48:55 INFO - 'name': 'check_screen_resolution'},), 04:48:55 INFO - 'run_cmd_checks_enabled': True, 04:48:55 INFO - 'suite': 'dromaeojs-e10s', 04:48:55 INFO - 'system_bits': '32', 04:48:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:55 INFO - 'title': 't-yosemite-r7-0294', 04:48:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:55 INFO - 'use_talos_json': True, 04:48:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:55 INFO - 'work_dir': 'build'} 04:48:55 INFO - [mozharness: 2017-04-23 11:48:55.047521Z] Running clobber step. 04:48:55 INFO - Running pre-action listener: _resource_record_pre_action 04:48:55 INFO - Running main action method: clobber 04:48:55 INFO - rmtree: /builds/slave/test/build 04:48:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:57 INFO - Running post-action listener: _resource_record_post_action 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.513797Z] Finished clobber step (success) 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.514066Z] Running read-buildbot-config step. 04:48:57 INFO - Running pre-action listener: _resource_record_pre_action 04:48:57 INFO - Running main action method: read_buildbot_config 04:48:57 INFO - Using buildbot properties: 04:48:57 INFO - { 04:48:57 INFO - "project": "", 04:48:57 INFO - "product": "firefox", 04:48:57 INFO - "script_repo_revision": "production", 04:48:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:48:57 INFO - "repository": "", 04:48:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:48:57 INFO - "buildid": "20170423030206", 04:48:57 INFO - "stage_platform": "macosx64", 04:48:57 INFO - "basedir": "/builds/slave/test", 04:48:57 INFO - "nightly_build": "True", 04:48:57 INFO - "buildnumber": 48, 04:48:57 INFO - "slavename": "t-yosemite-r7-0294", 04:48:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:48:57 INFO - "platform": "yosemite_r7", 04:48:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:57 INFO - "branch": "mozilla-central", 04:48:57 INFO - "repo_path": "mozilla-central", 04:48:57 INFO - "revision": "070fc3c2f8400c09f1037f5444c3d33b499e7128", 04:48:57 INFO - "pgo_build": "False", 04:48:57 INFO - "builduid": "1c36ef7c1cb0492aa1fb5c5bd442fc41", 04:48:57 INFO - "slavebuilddir": "test" 04:48:57 INFO - } 04:48:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:48:57 INFO - Running post-action listener: _resource_record_post_action 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.520076Z] Finished read-buildbot-config step (success) 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.520295Z] Running download-and-extract step. 04:48:57 INFO - Running pre-action listener: _resource_record_pre_action 04:48:57 INFO - Running main action method: download_and_extract 04:48:57 INFO - mkdir: /builds/slave/test/build/tests 04:48:57 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')]} 04:48:57 INFO - trying https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/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 04:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/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 04:48:58 INFO - Downloaded 1325 bytes. 04:48:58 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:58 INFO - Using the following test package requirements: 04:48:58 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:48:58 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:58 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:58 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:48:58 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'jsshell-mac.zip'], 04:48:58 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:48:58 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:58 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:48:58 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:48:58 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:48:58 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:48:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:49:00 INFO - Content-Length response header: 52523695 04:49:00 INFO - Bytes received: 52523695 04:49:16 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 04:49:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:49:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:49:16 INFO - Fetch https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:49:18 INFO - Content-Length response header: 52523695 04:49:18 INFO - Bytes received: 52523695 04:49:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:49:33 INFO - Fetch https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:49:34 INFO - Content-Length response header: 14408811 04:49:34 INFO - Bytes received: 14408811 04:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:34 INFO - trying https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/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 04:49:37 INFO - Downloaded 71119849 bytes. 04:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:37 INFO - mkdir: /builds/slave/test/properties 04:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:37 INFO - Contents: 04:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:38 INFO - Running post-action listener: _resource_record_post_action 04:49:38 INFO - Running post-action listener: set_extra_try_arguments 04:49:38 INFO - [mozharness: 2017-04-23 11:49:38.687066Z] Finished download-and-extract step (success) 04:49:38 INFO - [mozharness: 2017-04-23 11:49:38.687192Z] Running populate-webroot step. 04:49:38 INFO - Running pre-action listener: _resource_record_pre_action 04:49:38 INFO - Running main action method: populate_webroot 04:49:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:38 INFO - '--tppagecycles', 04:49:38 INFO - '7'], 04:49:38 INFO - 'tests': ['tsvgm']}}, 04:49:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['damp', 'tps']}, 04:49:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'tests': ['damp', 'tps']}, 04:49:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['dromaeo_dom']}, 04:49:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:49:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:49:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['a11yr', 04:49:38 INFO - 'ts_paint', 04:49:38 INFO - 'tpaint', 04:49:38 INFO - 'sessionrestore', 04:49:38 INFO - 'sessionrestore_no_auto_restore', 04:49:38 INFO - 'tabpaint']}, 04:49:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:38 INFO - 'ts_paint', 04:49:38 INFO - 'tpaint', 04:49:38 INFO - 'sessionrestore', 04:49:38 INFO - 'sessionrestore_no_auto_restore', 04:49:38 INFO - 'tabpaint']}, 04:49:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:38 INFO - 'ts_paint', 04:49:38 INFO - 'tpaint', 04:49:38 INFO - 'sessionrestore', 04:49:38 INFO - 'sessionrestore_no_auto_restore', 04:49:38 INFO - 'tabpaint']}, 04:49:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:38 INFO - 'ts_paint', 04:49:38 INFO - 'tpaint', 04:49:38 INFO - 'sessionrestore', 04:49:38 INFO - 'sessionrestore_no_auto_restore', 04:49:38 INFO - 'tabpaint']}, 04:49:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['a11yr', 04:49:38 INFO - 'ts_paint', 04:49:38 INFO - 'tpaint', 04:49:38 INFO - 'sessionrestore', 04:49:38 INFO - 'sessionrestore_no_auto_restore', 04:49:38 INFO - 'tabpaint']}, 04:49:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['a11yr', 04:49:38 INFO - 'ts_paint', 04:49:38 INFO - 'tpaint', 04:49:38 INFO - 'sessionrestore', 04:49:38 INFO - 'sessionrestore_no_auto_restore', 04:49:38 INFO - 'tabpaint']}, 04:49:38 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:49:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:49:38 INFO - 'bloom_basic_ref']}, 04:49:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['tsvgx', 04:49:38 INFO - 'tsvgr_opacity', 04:49:38 INFO - 'tart', 04:49:38 INFO - 'tscrollx', 04:49:38 INFO - 'cart', 04:49:38 INFO - 'tsvg_static']}, 04:49:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:38 INFO - 'tsvgr_opacity', 04:49:38 INFO - 'tart', 04:49:38 INFO - 'tscrollx', 04:49:38 INFO - 'cart', 04:49:38 INFO - 'tsvg_static']}, 04:49:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'talos_options': ['--disable-e10s'], 04:49:38 INFO - 'tests': ['tp5o']}, 04:49:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:49:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'talos_options': ['--disable-e10s', 04:49:38 INFO - '--xperf_path', 04:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:38 INFO - 'tests': ['tp5n']}, 04:49:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:49:38 INFO - 'talos_options': ['--xperf_path', 04:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:38 INFO - 'tests': ['tp5n']}}, 04:49:38 INFO - 'talos.zip': {'path': '', 04:49:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:38 INFO - Running post-action listener: _resource_record_post_action 04:49:38 INFO - [mozharness: 2017-04-23 11:49:38.705963Z] Finished populate-webroot step (success) 04:49:38 INFO - [mozharness: 2017-04-23 11:49:38.706097Z] Running create-virtualenv step. 04:49:38 INFO - Running pre-action listener: _resource_record_pre_action 04:49:38 INFO - Running main action method: create_virtualenv 04:49:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:38 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 04:49:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:38 INFO - Using real prefix '/tools/python27' 04:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:42 INFO - Installing pip.................done. 04:49:42 INFO - Return code: 0 04:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:49:42 INFO - Reading from file tmpfile_stdout 04:49:42 INFO - Output received: 04:49:42 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) 04:49:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:49: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', 'pip>=1.5'] in /builds/slave/test/build 04:49: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 pip>=1.5 04:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:42 INFO - 'HOME': '/Users/cltbld', 04:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PAGER': '/bin/cat', 04:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:49:42 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - 'XPC_FLAGS': '0x0', 04:49:42 INFO - 'XPC_SERVICE_NAME': '0', 04:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:43 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 04:49:43 INFO - Cleaning up... 04:49:43 INFO - Return code: 0 04:49:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:43 INFO - 'HOME': '/Users/cltbld', 04:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:43 INFO - 'LOGNAME': 'cltbld', 04:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:43 INFO - 'MOZ_NO_REMOTE': '1', 04:49:43 INFO - 'NO_EM_RESTART': '1', 04:49:43 INFO - 'PAGER': '/bin/cat', 04:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:43 INFO - 'PWD': '/builds/slave/test', 04:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:43 INFO - 'SHELL': '/bin/bash', 04:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:49:43 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:43 INFO - 'USER': 'cltbld', 04:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:43 INFO - 'XPC_FLAGS': '0x0', 04:49:43 INFO - 'XPC_SERVICE_NAME': '0', 04:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:43 INFO - Downloading/unpacking psutil>=3.1.1 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 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 04:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:47 INFO - Installing collected packages: psutil 04:49:47 INFO - Running setup.py install for psutil 04:49:47 INFO - building 'psutil._psutil_osx' extension 04:49:47 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 04:49:48 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 04:49:48 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 04:49:48 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 04:49:48 INFO - building 'psutil._psutil_posix' extension 04:49:48 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 04:49:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:48 INFO - ^ 04:49:48 INFO - 1 warning generated. 04:49:48 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 04:49:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:48 INFO - Successfully installed psutil 04:49:48 INFO - Cleaning up... 04:49:48 INFO - Return code: 0 04:49:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:48 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')]} 04:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:48 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')]} 04:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:48 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:49:48 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 04:49:48 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 04:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:48 INFO - 'HOME': '/Users/cltbld', 04:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:48 INFO - 'LOGNAME': 'cltbld', 04:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:48 INFO - 'MOZ_NO_REMOTE': '1', 04:49:48 INFO - 'NO_EM_RESTART': '1', 04:49:48 INFO - 'PAGER': '/bin/cat', 04:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:48 INFO - 'PWD': '/builds/slave/test', 04:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:48 INFO - 'SHELL': '/bin/bash', 04:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:49:48 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:48 INFO - 'USER': 'cltbld', 04:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:48 INFO - 'XPC_FLAGS': '0x0', 04:49:48 INFO - 'XPC_SERVICE_NAME': '0', 04:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:51 INFO - Installing collected packages: mozsystemmonitor 04:49:51 INFO - Running setup.py install for mozsystemmonitor 04:49:51 INFO - Successfully installed mozsystemmonitor 04:49:51 INFO - Cleaning up... 04:49:51 INFO - Return code: 0 04:49:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:51 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:49:51 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 04:49:51 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 04:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:51 INFO - 'HOME': '/Users/cltbld', 04:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:51 INFO - 'LOGNAME': 'cltbld', 04:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:51 INFO - 'MOZ_NO_REMOTE': '1', 04:49:51 INFO - 'NO_EM_RESTART': '1', 04:49:51 INFO - 'PAGER': '/bin/cat', 04:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:51 INFO - 'PWD': '/builds/slave/test', 04:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:51 INFO - 'SHELL': '/bin/bash', 04:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:49:51 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:51 INFO - 'USER': 'cltbld', 04:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:51 INFO - 'XPC_FLAGS': '0x0', 04:49:51 INFO - 'XPC_SERVICE_NAME': '0', 04:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:52 INFO - Downloading/unpacking jsonschema==2.5.1 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:55 INFO - warning: no files found matching '*.txt' 04:49:55 INFO - no previously-included directories found matching 'build' 04:49:55 INFO - no previously-included directories found matching 'dist' 04:49:55 INFO - no previously-included directories found matching '.git*' 04:49:55 INFO - Installing collected packages: jsonschema, functools32 04:49:55 INFO - Running setup.py install for functools32 04:49:55 INFO - warning: no files found matching '*.txt' 04:49:55 INFO - no previously-included directories found matching 'build' 04:49:55 INFO - no previously-included directories found matching 'dist' 04:49:55 INFO - no previously-included directories found matching '.git*' 04:49:55 INFO - Successfully installed jsonschema functools32 04:49:55 INFO - Cleaning up... 04:49:55 INFO - Return code: 0 04:49:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49:55 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')]} 04:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:55 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')]} 04:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:55 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:49:55 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 04:49:55 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 04:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:55 INFO - 'HOME': '/Users/cltbld', 04:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:55 INFO - 'LOGNAME': 'cltbld', 04:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:55 INFO - 'MOZ_NO_REMOTE': '1', 04:49:55 INFO - 'NO_EM_RESTART': '1', 04:49:55 INFO - 'PAGER': '/bin/cat', 04:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:55 INFO - 'PWD': '/builds/slave/test', 04:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:55 INFO - 'SHELL': '/bin/bash', 04:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:49:55 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:55 INFO - 'USER': 'cltbld', 04:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:55 INFO - 'XPC_FLAGS': '0x0', 04:49:55 INFO - 'XPC_SERVICE_NAME': '0', 04:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:55 INFO - Cleaning up... 04:49:55 INFO - Return code: 0 04:49:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:55 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')]} 04:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:55 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')]} 04:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:55 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:49:55 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 04:49:55 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 04:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:55 INFO - 'HOME': '/Users/cltbld', 04:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:55 INFO - 'LOGNAME': 'cltbld', 04:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:55 INFO - 'MOZ_NO_REMOTE': '1', 04:49:55 INFO - 'NO_EM_RESTART': '1', 04:49:55 INFO - 'PAGER': '/bin/cat', 04:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:55 INFO - 'PWD': '/builds/slave/test', 04:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:55 INFO - 'SHELL': '/bin/bash', 04:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:49:55 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:55 INFO - 'USER': 'cltbld', 04:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:55 INFO - 'XPC_FLAGS': '0x0', 04:49:55 INFO - 'XPC_SERVICE_NAME': '0', 04:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:59 INFO - Downloading docopt-0.6.1.tar.gz 04:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:59 INFO - Running setup.py install for blobuploader 04:49:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:59 INFO - Running setup.py install for requests 04:50:00 INFO - Running setup.py install for docopt 04:50:00 INFO - Successfully installed blobuploader requests docopt 04:50:00 INFO - Cleaning up... 04:50:00 INFO - Return code: 0 04:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:00 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:50:00 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 04:50:00 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 04:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:00 INFO - 'HOME': '/Users/cltbld', 04:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:00 INFO - 'LOGNAME': 'cltbld', 04:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:00 INFO - 'MOZ_NO_REMOTE': '1', 04:50:00 INFO - 'NO_EM_RESTART': '1', 04:50:00 INFO - 'PAGER': '/bin/cat', 04:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:00 INFO - 'PWD': '/builds/slave/test', 04:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:00 INFO - 'SHELL': '/bin/bash', 04:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:50:00 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:00 INFO - 'USER': 'cltbld', 04:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:00 INFO - 'XPC_FLAGS': '0x0', 04:50:00 INFO - 'XPC_SERVICE_NAME': '0', 04:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-QXyF1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-dhbpSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-1E9l6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-al2JbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-S6ZBiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-KN5nZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-SEdf9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-FIh30Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-K0xnW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:01 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-i7sZaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-UOUNvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Jmy0Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-tQnd0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-3DaPFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-BVnRYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-bZ48m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:02 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-a6BVXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:02 INFO - Running setup.py install for manifestparser 04:50:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozcrash 04:50:03 INFO - Running setup.py install for mozdebug 04:50:03 INFO - Running setup.py install for mozdevice 04:50:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozfile 04:50:03 INFO - Running setup.py install for mozhttpd 04:50:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozinfo 04:50:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozInstall 04:50:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozleak 04:50:04 INFO - Running setup.py install for mozlog 04:50:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Running setup.py install for moznetwork 04:50:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Running setup.py install for mozprocess 04:50:04 INFO - Running setup.py install for mozprofile 04:50:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Running setup.py install for mozrunner 04:50:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Running setup.py install for mozscreenshot 04:50:04 INFO - Running setup.py install for moztest 04:50:05 INFO - Running setup.py install for mozversion 04:50:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:05 INFO - Cleaning up... 04:50:05 INFO - Return code: 0 04:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:05 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')]} 04:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:05 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')]} 04:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:05 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:50:05 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 04:50:05 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 04:50:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:50:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:05 INFO - 'HOME': '/Users/cltbld', 04:50:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:05 INFO - 'LOGNAME': 'cltbld', 04:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:05 INFO - 'MOZ_NO_REMOTE': '1', 04:50:05 INFO - 'NO_EM_RESTART': '1', 04:50:05 INFO - 'PAGER': '/bin/cat', 04:50:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:05 INFO - 'PWD': '/builds/slave/test', 04:50:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:05 INFO - 'SHELL': '/bin/bash', 04:50:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:50:05 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:50:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:05 INFO - 'USER': 'cltbld', 04:50:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:05 INFO - 'XPC_FLAGS': '0x0', 04:50:05 INFO - 'XPC_SERVICE_NAME': '0', 04:50:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:05 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Q4xkIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:05 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Zm9z3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:05 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-E2jk4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:05 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-BG1NtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-BOKYIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-yQNuFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-R9inmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-wgnZ61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-WsdnAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-lTnfLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-_NlIxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-TXvInt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-L1HDOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:06 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-SQsNB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:07 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)) 04:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:07 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-AihWO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:07 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)) 04:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:07 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-X5e23F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:07 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)) 04:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:07 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-fQI4_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:07 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)) 04:50:07 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)) 04:50:07 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)) 04:50:07 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)) 04:50:07 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)) 04:50:07 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)) 04:50:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:09 INFO - Downloading blessings-1.6.tar.gz 04:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:10 INFO - Installing collected packages: blessings 04:50:10 INFO - Running setup.py install for blessings 04:50:10 INFO - Successfully installed blessings 04:50:10 INFO - Cleaning up... 04:50:10 INFO - Return code: 0 04:50:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:10 INFO - Reading from file tmpfile_stdout 04:50:10 INFO - Current package versions: 04:50:10 INFO - blessings == 1.6 04:50:10 INFO - blobuploader == 1.2.4 04:50:10 INFO - docopt == 0.6.1 04:50:10 INFO - functools32 == 3.2.3-2 04:50:10 INFO - jsonschema == 2.5.1 04:50:10 INFO - manifestparser == 1.1 04:50:10 INFO - mozInstall == 1.12 04:50:10 INFO - mozcrash == 1.0 04:50:10 INFO - mozdebug == 0.1 04:50:10 INFO - mozdevice == 0.50 04:50:10 INFO - mozfile == 1.2 04:50:10 INFO - mozhttpd == 0.7 04:50:10 INFO - mozinfo == 0.9 04:50:10 INFO - mozleak == 0.1 04:50:10 INFO - mozlog == 3.4 04:50:10 INFO - moznetwork == 0.27 04:50:10 INFO - mozprocess == 0.25 04:50:10 INFO - mozprofile == 0.28 04:50:10 INFO - mozrunner == 6.13 04:50:10 INFO - mozscreenshot == 0.1 04:50:10 INFO - mozsystemmonitor == 0.3 04:50:10 INFO - moztest == 0.8 04:50:10 INFO - mozversion == 1.4 04:50:10 INFO - psutil == 3.1.1 04:50:10 INFO - requests == 1.2.3 04:50:10 INFO - wsgiref == 0.1.2 04:50:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:10 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')]} 04:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:10 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')]} 04:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:10 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:50:10 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 04:50:10 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 04:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:10 INFO - 'HOME': '/Users/cltbld', 04:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:10 INFO - 'LOGNAME': 'cltbld', 04:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:10 INFO - 'MOZ_NO_REMOTE': '1', 04:50:10 INFO - 'NO_EM_RESTART': '1', 04:50:10 INFO - 'PAGER': '/bin/cat', 04:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:10 INFO - 'PWD': '/builds/slave/test', 04:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:10 INFO - 'SHELL': '/bin/bash', 04:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:50:10 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:10 INFO - 'USER': 'cltbld', 04:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:10 INFO - 'XPC_FLAGS': '0x0', 04:50:10 INFO - 'XPC_SERVICE_NAME': '0', 04:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 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)) 04:50:10 INFO - Cleaning up... 04:50:10 INFO - Return code: 0 04:50:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50:10 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')]} 04:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:10 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')]} 04:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:10 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 0x1066bdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066c0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91814aea80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, '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.EBiz4UEjiV/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.QgstyK8hYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 04:50:10 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 04:50:10 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 04:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:10 INFO - 'HOME': '/Users/cltbld', 04:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:10 INFO - 'LOGNAME': 'cltbld', 04:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:10 INFO - 'MOZ_NO_REMOTE': '1', 04:50:10 INFO - 'NO_EM_RESTART': '1', 04:50:10 INFO - 'PAGER': '/bin/cat', 04:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:10 INFO - 'PWD': '/builds/slave/test', 04:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:10 INFO - 'SHELL': '/bin/bash', 04:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:50:10 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:10 INFO - 'USER': 'cltbld', 04:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:10 INFO - 'XPC_FLAGS': '0x0', 04:50:10 INFO - 'XPC_SERVICE_NAME': '0', 04:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:50:11 INFO - Cleaning up... 04:50:11 INFO - Return code: 0 04:50:11 INFO - Running post-action listener: _resource_record_post_action 04:50:11 INFO - Running post-action listener: _start_resource_monitoring 04:50:11 INFO - Starting resource monitoring. 04:50:11 INFO - [mozharness: 2017-04-23 11:50:11.216670Z] Finished create-virtualenv step (success) 04:50:11 INFO - [mozharness: 2017-04-23 11:50:11.217637Z] Running install step. 04:50:11 INFO - Running pre-action listener: _resource_record_pre_action 04:50:11 INFO - Running main action method: install 04:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:11 INFO - Reading from file tmpfile_stdout 04:50:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:11 INFO - Reading from file tmpfile_stdout 04:50:11 INFO - Output received: 04:50:11 INFO - Usage: mozinstall [options] installer 04:50:11 INFO - Options: 04:50:11 INFO - -h, --help show this help message and exit 04:50:11 INFO - -d DEST, --destination=DEST 04:50:11 INFO - Directory to install application into. [default: 04:50:11 INFO - "/builds/slave/test"] 04:50:11 INFO - --app=APP Application being installed. [default: firefox] 04:50:11 INFO - mkdir: /builds/slave/test/build/application 04:50:11 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'] 04:50:11 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 04:50:31 INFO - Reading from file tmpfile_stdout 04:50:31 INFO - Output received: 04:50:31 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:50:31 INFO - Running post-action listener: _resource_record_post_action 04:50:31 INFO - [mozharness: 2017-04-23 11:50:31.287026Z] Finished install step (success) 04:50:31 INFO - [mozharness: 2017-04-23 11:50:31.287142Z] Running run-tests step. 04:50:31 INFO - Running pre-action listener: _resource_record_pre_action 04:50:31 INFO - Running main action method: run_tests 04:50:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:31 INFO - 2017-04-23 04:50:31.299 screenresolution[1677:13165] starting screenresolution argv=screenresolution get 04:50:31 INFO - 2017-04-23 04:50:31.302 screenresolution[1677:13165] Display 0: 1600x1200x32@60 04:50:31 INFO - 2017-04-23 04:50:31.307 screenresolution[1678:13168] starting screenresolution argv=screenresolution list 04:50:31 INFO - Available Modes on Display 0 04:50:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:31 INFO - Intel Iris: 04:50:31 INFO - Chipset Model: Intel Iris 04:50:31 INFO - Type: GPU 04:50:31 INFO - Bus: Built-In 04:50:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:50:31 INFO - Vendor: Intel (0x8086) 04:50:31 INFO - Device ID: 0x0a2e 04:50:31 INFO - Revision ID: 0x0009 04:50:31 INFO - Displays: 04:50:31 INFO - Display: 04:50:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:31 INFO - Display Serial Number: 1600x1200 60 04:50:31 INFO - Main Display: Yes 04:50:31 INFO - Mirror: Off 04:50:31 INFO - Online: Yes 04:50:31 INFO - Rotation: Supported 04:50:31 INFO - Return code: 0 04:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:31 INFO - Python 2.7.3 04:50:31 INFO - Return code: 0 04:50:31 INFO - grabbing minidump binary from tooltool 04:50:31 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')]} 04:50:31 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 0x10649bd30>, '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 0x1063c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106490be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:31 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 04:50:31 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 04:50:31 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 04:50:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:31 INFO - Return code: 0 04:50:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:50:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:31 INFO - ENV: RUST_BACKTRACE is now 1 04:50:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:50:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:31 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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 04:50:31 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0294 --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 04:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBiz4UEjiV/Render', 04:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:31 INFO - 'HOME': '/Users/cltbld', 04:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:31 INFO - 'LOGNAME': 'cltbld', 04:50:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:31 INFO - 'MOZ_NO_REMOTE': '1', 04:50:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:31 INFO - 'NO_EM_RESTART': '1', 04:50:31 INFO - 'PAGER': '/bin/cat', 04:50:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:31 INFO - 'PWD': '/builds/slave/test', 04:50:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:31 INFO - 'RUST_BACKTRACE': '1', 04:50:31 INFO - 'SHELL': '/bin/bash', 04:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgstyK8hYv/Listeners', 04:50:31 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 04:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:31 INFO - 'USER': 'cltbld', 04:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:31 INFO - 'XPC_FLAGS': '0x0', 04:50:31 INFO - 'XPC_SERVICE_NAME': '0', 04:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:31 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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 04:50:31 INFO - mozversion application_buildid: 20170423030206 04:50:31 INFO - mozversion application_changeset: 070fc3c2f8400c09f1037f5444c3d33b499e7128 04:50:31 INFO - mozversion application_display_name: Nightly 04:50:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:31 INFO - mozversion application_name: Firefox 04:50:31 INFO - mozversion application_remotingname: firefox 04:50:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:50:31 INFO - mozversion application_vendor: Mozilla 04:50:31 INFO - mozversion application_version: 55.0a1 04:50:31 INFO - mozversion platform_buildid: 20170423030206 04:50:31 INFO - mozversion platform_changeset: 070fc3c2f8400c09f1037f5444c3d33b499e7128 04:50:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:50:31 INFO - mozversion platform_version: 55.0a1 04:50:31 INFO - using testdate: 1492948231 04:50:31 INFO - actual date: 1492948231 04:50:31 INFO - starting webserver on 'localhost:49253' 04:50:31 INFO - SUITE-START | Running 2 tests 04:50:31 INFO - TEST-START | dromaeo_css 04:50:31 INFO - operating with platform_type : mac_ 04:50:31 INFO - Initialising browser for dromaeo_css test... 04:50:31 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpFlrpds/profile http://localhost:49253/getInfo.html) 04:50:35 INFO - PID 1688 | 2017-04-23 04:50:35.095 plugin-container[1691:13367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c3b, name = 'com.apple.tsm.portname' 04:50:35 INFO - PID 1688 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:35 INFO - PID 1688 | 2017-04-23 04:50:35.096 plugin-container[1691:13367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 04:50:35 INFO - PID 1688 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:35 INFO - PID 1688 | 2017-04-23 04:50:35.096 plugin-container[1691:13367] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:35 INFO - PID 1688 | __metrics Screen width/height:1600/1200 04:50:35 INFO - PID 1688 | colorDepth:24 04:50:35 INFO - PID 1688 | Browser inner width/height: 1024/689 04:50:35 INFO - PID 1688 | __metrics 04:50:35 ERROR - PID 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:50:36 INFO - TEST-INFO | 1688: exit 0 04:50:36 INFO - Browser initialized. 04:50:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:36 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpFlrpds/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:38 INFO - PID 1693 | 2017-04-23 04:50:38.608 plugin-container[1694:13506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:50:38 INFO - PID 1693 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:38 INFO - PID 1693 | 2017-04-23 04:50:38.609 plugin-container[1694:13506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:50:38 INFO - PID 1693 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:38 INFO - PID 1693 | 2017-04-23 04:50:38.609 plugin-container[1694:13506] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:48 INFO - PID 1693 | RSS: Main: 236134400 04:50:48 INFO - PID 1693 | 04:53:52 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 04:53:54 INFO - PID 1693 | RSS: Main: 253018112 04:53:54 INFO - PID 1693 | 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1693 | 04:55:36 ERROR - PID 1693 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1693 | Full stack: 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1693 | 04:55:36 ERROR - PID 1693 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1693 | Full stack: 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1693 | 04:55:36 ERROR - PID 1693 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1693 | Full stack: 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | ************************* 04:55:36 INFO - PID 1693 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1693 | 04:55:36 ERROR - PID 1693 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1693 | Full stack: 04:55:36 INFO - PID 1693 | ************************* 04:56:55 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 04:56:56 INFO - PID 1693 | RSS: Main: 256929792 04:56:56 INFO - PID 1693 | 04:59:58 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 04:59:58 INFO - PID 1693 | RSS: Main: 266665984 04:59:58 INFO - PID 1693 | 05:03:00 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 05:03:01 INFO - PID 1693 | RSS: Main: 260136960 05:03:01 INFO - PID 1693 | 05:06:04 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 05:06:04 INFO - PID 1693 | RSS: Main: 269475840 05:06:04 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 05:09:06 INFO - PID 1693 | RSS: Main: 265064448 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | __start_tp_report 05:09:06 INFO - PID 1693 | _x_x_mozilla_page_load 05:09:06 INFO - PID 1693 | _x_x_mozilla_page_load_details 05:09:06 INFO - PID 1693 | |i|pagename|runs| 05:09:06 INFO - PID 1693 | |0;dojo.html;3020.924476888078;3548.059764162496;3601.639836016397;3609.8917032489016;3612.0789198754314;5244.606654500909;5909.468147866691;6120.326764055956;6153.907691384633;6170.136180934667;6104.550104788481;6117;6132.3555089925;6180.134781130634;6189.597676151058;5302.92045619315;5341.332333458317;5379.085555455582;5425.348958125031;5473.8357849264385;4103.343465045593;4447.777611119447;4578.412685936594;4787.688800227991;5391.595630327722;4729.7635118244125;5344.331958505187;5403.324584426947;5442.537384322337;5510.008198524264;5248.947510524922;5282.498162674578;5319.069162896516;5350.785968561253;5430.15832545956;5295.4704529547125;5313.734313284321;5323.307969963918;5351.57187425005;5378.784848606051;5306.946930530722;5420.7018613976215;6171.938280617182;6179.104029915637;6207.565470417073;5432.6468779529205;6310.463610593105;6372.808815735489;6541.967290163567;6606.867862642768;6709.463242940553;6713.832154196135;6723.058771771955;6726.966365168192;6731.831704207385;6254.124422580842;6275.1842260506755;6305.243370795488;6317.273513546001;6322.71547780351;5759.94240057594;6206.844828879224;6628.204615446178;6750.493712971449;6857.725690972405;5296.25852380667;5893.882122357529;5981.700914954235;6335.873282534416;6476.125723027425;6106;6608;6639.269680335159;6672.733090676318;6686.899696504556;5388.568914486832;6511.511636627272;6573.80278591643;6573.967130164414;6592.76925307612;6292.905606415908;6375.649339286291;6574.8356291093105;6580;6610.537262391683;4476.731396116178;5166.870828229249;5263.842084737464;5319.468053194727;5328.600354973392;4689.6717229793585;4695.929561056587;4710.905781884411;4727.57451829337;4743.335932969387;5750.971245143747;6198.194234749544;6240.375962403723;6291.150694656254;6291.559590828598;6373.649449280334;6448.774292899726;6614.173228346457;6644.169478815148;6682.064510968468;6250;6271.498280137669;6309.652969086653;6330.208723909512;6347.1114044033875;5822.243108395966;5834.3290521589715;5835.183074369592;5847.590668653239;5884.823455296348;6499.057636642566;6606.900896486461;6803.353681400259;6814.250432452525;6866.725330986705;6658.267590564937;6676.532642714963;6698.698558564779;6711.429528490133;6736.562123461959;6840.657967101724;6865.691043902936;6865.931340686529;6875.140607424072;6904.4131248842405;5224.582033437392;6316.905246421215;6341.682915854281;6464.5798023128345;6623.569467984566;6551.6069035858;6553.967230163818;6675.165604299463;6679.298673639198;6701.765438209639;6478.1578394808375;6493.188351456068;6513.54405191632;6533.575317604341;6535.967320163369;6149.44654981036;6297.937020629735;6404.583702059351;6495.675216239264;6495.935040649533;5932.792352267823;6225.782097626561;6362.6818659067785;6369.235691717024;6375.6812159392775;5240.973795131;5284.867878302919;6329.335419780857;6412.102305677302;6465;6190.2571691397325;6331.3352098029045;6359.650219237987;6360.077788720702;6371.23545174582 05:09:06 INFO - PID 1693 | |1;ext.html;667.2993356975177;758.2872100225787;827.6523859978806;1252.7244006318606;1265.2598230035428;34442.483362749546;35612.2877542449;35622;35688;35785.10537236567;35984.640153598455;36001.45997810028;36373.0906727332;36452;36463.635363646354;7937.880931786028;8058.113607503199;8336.583170841464;8568.1860223279;8578.356623253281;7845.783903494939;8519.233269005788;8588.055313915464;8641.30869530436;8646.913530864675;8173.591320433984;8567.82864342716;8670.653173873037;8673.262772664331;8694.304455643565;7711.26742959418;8594.355423343242;8651.178138076873;8673.522956237404;8675.69635062776;7355.77932662021;8118.472299300585;8220.219079187467;8379.203975622306;8421.36839737016;37298.813505932565;37342.43986340207;37354.43968340477;37407.06482337936;37556.24887502262;3494.353544594258;3501.107217659506;3502.22950950793;3542.787432754017;3547.3614749345106;30542.84728576365;30578.38843223145;30633.693663063306;30669.38661226763;30754;3161.541576471399;3189.569408129896;3190.1386625611185;3198.7441004719567;3206.695363940422;231691.8415407912;237990;286077;286719.5664021687;288407;46926.061478770236;47046;47063;47076.5292347079;47135.29297060547;42773.57226427696;46606.76696616495;47988;48593;48651;13869.09850859691;13875.306234688225;13934.860651393356;13949.3722782473;14016.369263383172;11235.775284494264;11472.827907581393;11477.426128693533;11504.42477876103;11509.539618415338;10838.295510791773;13317.600471985856;13349.466021359036;13397.732045359038;13504.594862154152;6014.368491308437;6021.5182785377065;6047.637141771508;6068.786242751379;6079.908801367983;1026.4918865161792;1050.5902697947654;1051.358671210561;1080.719013056611;1086.6196831109207;23414.88292558526;24297.51404971926;24339.634905476432;24357;24581.508369832503;1011.716719318592;1100.6642973892879;1146.6674664347245;1173.495396979307;1178.8172833210865;12402;12465.314407707481;12546.874531254753;12583.685407864694;12590.307533085585;324687;325085;326948;326989;328719.069213962;51920.96158076818;51978.48021519812;52339.73830130825;52351;52470.47529524732;1487.605784467117;1496.9700605988037;1535.7619568966827;1549.1711934115194;1549.8760099192264;23713.17003904855;23984.160554380513;24014.51970960536;24036.158734444212;24077.79611019477;37073.25853482969;37193.442098368;37241;37370.626293736714;37473.6252637481;284354;285391;285982;286198;286692;33624.99125026253;33711;33717;34383.828080859435;34429;43838.78080609577;44591;44616.55383446124;44632.55367446284;44689;29701.257468563457;30240;30376.240593985327;31206.687933120378;31236.37527249488;30432;30546;30768.84615576908;31160.37679246357;31222.68777312198;36141.63858361383;36718.26563468769;36877.815610922844;37361.81319093387;37364;30866;31151.84424077865;31234.375312494078;31778.682213178497;31807.36385272328;23569.050379977216;23694.526109478058;23825.285241442783;24463.755362446147;24860.254192374257 05:09:06 INFO - PID 1693 | |2;jquery.html;438.8310500457323;442.29233226837056;447.4116536754168;454.62720569133313;465.3043699668995;18222.81777182228;19343;19986.800131998676;20140;20158.798412015876;20860.269890553835;22230.11079556816;22418.32745017652;22523.54952900941;22634.320970370874;6104.206453161094;6256.468200202966;6270.7178176981915;6277.089821975811;6288.24541055074;6031.215941927543;6214.601714614221;6263.592866463665;6266.436020758131;6283.12036314914;6060.363661815512;6216.844578885519;6227.813165605039;6236.158118653992;6237.71930263137;6134.846628834271;6246.781362652308;6255.655938923357;6279.497640188774;6282.308946015912;4607;4961.751912404366;5489.560835133179;5521.089020311644;5602.803901863415;24182.637260441108;27301.317467063283;28209.858950705115;28243.293917652016;28254.434911301865;1752.8510076643372;2167.2956289205913;2187.6937228787983;2191.638379667353;2197.637389830676;17749.7337539937;17907.925524468574;18057.187426565837;18291.817081829144;18591.814081859142;2172.4894649757452;2182.159868450642;2224.8887555622155;2225.6550234713645;2230.174835310945;170265;171269.2873071266;173189;173863;175642.24357756387;12047.096467764954;12529.18560293578;12735.68160795969;12846.84378405948;12962.935185324013;13914.721705566035;15418.768718469231;16582.419615313647;16611.41860034917;16679.6664066718;7903.9724835770985;8782.165694259034;9065.81868362629;9211.815763684823;9216.723498295061;7731.304182623591;8152.317517611348;8623.568821559022;8792.692255771017;8794.120587941283;7449.441291903129;8081.676732930617;8166.305864001626;8197.877031844528;8247.711330103417;2115.3336698940093;2202.64757638777;2207.2054060538194;2209.723784526934;2383.427977285439;894.3784070071368;985.1281615769952;998.8401855703053;1003.4130033930087;1025.123519390925;16227.269772860249;16722.414715484898;18576;20304.08631611581;20596.588068238852;953.3612479638658;997.2769741937037;1001.8447140693204;1012.3875055591409;1038.1694644284541;10478.790424191473;10851.274066533042;10893.509792059376;10912;10938.671839844817;513564;532457;537473;555047.2247638816;568006;120348.79651203551;135321.64678353287;137293;137940.31029844788;140630.2968485151;1066.328213225663;1167.0160726764534;1211;1226.2826246645811;1233.105998151351;18702.345417910306;20779.272725455143;22562;22795.886020570455;22824.85875706241;42868.35697464603;58429;58437.4156258449;59459.405405945385;61091;57768.71115644563;68667;70280.29719702738;79600;82714.58642706748;7748.14770375247;7950.602469876368;8813.735587932373;8938.597763100806;8975.955120224357;11618.186726929034;13582.86417135816;13856;13927.094738841943;14165.291735413395;9484.668036618961;10225.750334926304;11721.472533736172;11770.293782373084;12106.273623582612;9433.858492122486;11161;11200.775984480428;11311.490982905625;11437.199396042197;9707.83505979287;10155.375139977568;11958.521659133885;12025.158238923541;12216.694582635506;8602.483850968962;8689.478631282143;8745.650173992968;9075.546222688707;9133.041030691948;11303.7739245213;11626.476808543466;11898.940505297418;12087.576934807239;12117.212381195193 05:09:06 INFO - PID 1693 | |3;mootools.html;1197.6886009637494;1394.1217033269038;1407.1064873805144;1408.4718230663495;1419.7160567886422;10641.66979127609;10698.197635177354;11791.705207369798;11859.525618975242;12157.635270941864;11763.235389699663;11910.166288359818;11912.583059592916;11930.403479826018;11968.581099661513;2536.2010966545527;2590.222933120066;2590.766830985211;2598.116640342283;2598.8180827342094;2503.2990762586505;2555.718870924197;2557.360659835041;2559.2834006478215;2566.153169454076;2494.5260400523935;2517.471331020479;2541.275736415122;2552.3619095226195;2558.6289987951736;2481.268025932345;2508.2475257422793;2538.9746102538925;2541.4789968056502;2545.6253623043535;2437.707475102999;2517.8489290642437;2534.657821194152;2554.463562651845;2558.616207568861;11780.764384712258;11865.466054027589;11871.406429678482;11886.346250956194;11900.345480998541;6628.270890202074;6842.897356539655;6866.896996545056;6876.106106206161;6878.105846239957;4068.3897415387632;4386.8903277418;4438.733675979452;4441.289393697025;4462.910741785178;1211.2066596379386;1222.2727477151082;1271.0467149637773;1274.8533918599387;1275.5280546197873;15042.849571504365;15561.844381556266;16669.91665041679;16823;16847.32610695571;4915.238138088602;5326.813561525328;5668.829935101953;5781.566382521328;5788.392218816964;12166.35754173193;12323.137380383287;12342.95084917792;12347.814782778265;12448.31534265624;6613.074169616258;6652.168478940132;6653.800385988428;6666.366695163952;6668.499862510331;5276.5251127398715;6007.369226231182;6056.818295451144;6185.474234690102;6199.814005579839;4369.737815731003;4436.6228870546365;4444.688871779009;4469.5530446955045;4530.116627257653;1286.2539726958341;1301.2322729589398;1303.2506308872437;1313.299277435704;1325.7812460944028;667.506045526307;788.5111231036794;790.4624855098588;790.9485883417559;802.5273622901924;6108.572399932051;6155.907661385083;6182.443580077815;6291.622502649856;6342.112104305401;583.2650859916536;584.4185035889317;605.1467430922378;612.9387061293835;613.6502193749609;3678.7240956928335;4298.76356800379;4302.827886884552;4436.977815110969;4495.640348772155;14585.270736463135;14606.48877289311;14858;15235.238238088274;15256.542303730906;14534.636634084021;15027.248637568078;15081.698366032619;15091.54725358241;15109.39562417491;8391.160883911682;8457.830843383097;8606.956965215133;8626.309895208367;8629.69796057135;5723.627964182315;6874.8625027500175;6889.862202755817;7118.644067796693;7118.85762284741;12966.222026678051;13211.933940330622;13291.069625126534;13444.46222151103;13694.246816425193;13623;13778.311084445939;13785.931070344584;13948.568193331294;13983.650408739455;9476.336656433983;9513.476758778057;9521.047895210424;9599.040095990345;9622.470764107762;10653.414062226651;10745.570177192825;10764.784704306026;10765.730856728644;10772.299800512941;8962.68630597926;9203.125703058198;9243.537823108953;9253.67612133572;9313;8863;8908.376413650982;8926.330525210506;8979.50612716307;9104.317176211944;7312.670929808278;7988.241117093867;8072.757817265491;8146.185381461806;8192.016957965083;6029.668368239789;6041.9395806041375;6098.298695650057;6248.468880145057;6322.988321868479;6025.939740602538;6044.425779550936;6156.045812899008;6229.875402492015;6360.872782544231 05:09:06 INFO - PID 1693 | |4;prototype.html;384.9233665341441;390.22929713815216;410.96301332880034;419.10521037584766;420.54371007456916;6015.586337210763;6222.968885155574;6228.377162283769;6252.249730032402;6258.217722784658;4923.178423983131;5992.161097446361;6033.939660603392;6044.788432404866;6091.847703807396;4415.425994620695;4439.977800110995;4440.600345968862;4447.266201076818;4482.798274077658;3646.6535679110443;3950.2297052074855;4024.907048334864;4286.464191976003;4471.82112715491;4367.628751556122;4376.649868010568;4387.29803231483;4388.846390376338;4389.297712366022;4381.627561657263;4413.183561041217;4420.3369494575745;4423.314386270134;4427.623651989585;3520.436730123168;3535.328287625343;3727.6458736419995;3789.4315852622326;3832.156925476391;4494.662900282459;5829.708514574297;5838.941610583882;5866.066966516742;5910.763569457216;4501.234790085693;4573.947991961834;4971.850844474671;5254.684718916839;5256.737163141827;5166.837461571154;5378.327709036371;6346;6431.517636177306;6480.092787009822;4308.31067029277;4334.934975975363;4352.086061926999;4352.499462561815;4358.803853826554;6019.247594050744;6726.226483954359;6777.2054893066215;6845.623490707959;6896.965515172392;3363.630000699921;3900.941485877714;4809.470958194595;4838.225883858566;4855.36880205571;4505.504394516601;4753.524647535219;4957.925631115536;4967.5032496750755;4967.7019378837385;5553.944460555343;5554.389017208104;5563.638363506359;5565.888682226414;5574.275344205227;6309.801137783807;6342.460890824332;6494.772682956074;6528.314526974599;6551.4103730664465;1443.7617793064028;1597.840215978393;1679.0261648243988;1681.7645529625863;1695.6100096977764;932.5150921520772;1095.4741723972538;1111.7276267314398;1136.2273653915418;1157.716359491913;6078.544109191828;6096.902557539685;6106.603070800384;6153.907691384633;6160.322364539897;6694.732210711517;6697.564658297195;6708.463322934153;6714.026466162477;6724.899126513106;5490.780368785284;5698.834442911667;6048.909266361008;6076.210092687922;6097.646294537986;3479.460683594047;3510.526078979356;3516.9648303517147;3517.472379143098;3538.1862171700654;6063.605865618721;6485.54601177913;6775.22084960226;6859.279775623588;6920.619365934922;5741.540676745851;6146.815595532141;6870.20992585859;6870.31296870319;6930.029795828588;5480.3971563128025;5870.765169393177;6244.313125556185;6894.758683446055;6970.989206565121;6425.341627320342;6620.5834870272965;6640.468762499085;6681.465482761465;6714.194296684429;5279.973600131974;6274.560780745304;6601.801945941629;6621.834454138685;6627.072209890715;5478.671279723229;6363.300036996019;6854.320691430631;6959.512834101767;6965.721371145098;4577.3591697161755;4826.493218212037;4836.298736683231;4837.733924634038;4839.41926968766;6356.745730170742;6622.07290979273;6681.83295417599;6695.163104611924;6726.39462448382;5427.348718153847;5780.843831233686;6080.787172448943;6553.246376666744;6558.114654521579;5414.404415514212;6200.596961197508;6563.04490109983;6563.540552161303;6580.696756135314;5566.22072909801;6344.65247858277;6354.555181137276;6379.840503987438;6424.458130048848;5702;6441.581297215666;6492.123563319081;6524.706388212637;6530.281669016309;5555.055910303568;6096.963516202168;6305.211848518935;6390.680465976776;6417.679116044273 05:09:06 INFO - PID 1693 | |5;yui.html;748.9251074892511;811.3711873298197;824.9587520623967;850.0819115355416;852.1521086518912;14369.137851728903;14909.25453727312;16053.51839444817;16626.50120496387;16645.83354166458;14169.079009864377;16565.66868662629;16911.830881691178;17281.30874765011;17357.91321043393;991.2516050381952;992.990070099297;996.681062060141;997.5361456922566;999.7500624843789;962.687126683827;997.6009596161521;999.6451259802774;1002.3885429887799;1011.9190464762838;1032.4579595712273;1045.681067274481;1046.199657262195;1049.8372752223418;1057.6456886942883;1038.5689938675441;1041.5469270867197;1044.29510080696;1045.4772613693153;1050.8213603687354;766.4519868294196;769.6651956398985;770.2490072179636;771.1863983497408;780.3367137932769;15977.760333595006;16834.24245908937;17025.318987240495;17038.48884533466;17122.14389280531;16161.838381616151;16663.833361666348;16730.498085057345;16870.987740735596;16980.660386792195;11699.590514332043;13586.796198057036;13801;13830.446782128703;13830.930845345709;2972.4798160322075;3399.065257054305;3430.588329400463;3434.742394320436;3479.512868198429;115289;117021;117800.23299650512;118743;123097;12932.806007909889;13210.669733256553;13375.53185638498;13404.865951340362;13446.529371472147;24845.751542484344;25033.12384066549;25079.498410031698;25277;25457.87271063633;6726.831829204309;6942.340477654615;7484.176740558534;7791.10402303731;7844.725434609762;3694.7598406103516;3788;3788.3938569829247;3789.052736815796;3792.6586607205486;4122.2786012447705;4222.092250166229;4236.301010333261;4302.483701955723;4303.182395344875;926.9814603708023;936.4989730494153;948.0993056596261;957.2772556719632;957.6073809738114;623.9500839932795;635.3202073781102;644.6293381305768;647.3009150117862;662.8740539297518;10933.289336193122;11593.304401735923;11747.353895535827;11985.101117416229;12137.332446715516;548.9835304940858;592.6473748119862;600.9729562169713;623.8378021714387;645.6481217736344;5014.27007682349;5241.50205730455;5273.34083239595;5518.33779946401;5643.294588176478;95892;98512.50743746235;98770.5061474688;101294;102561.74382561684;82294;84851;87562;89705;90818;61791.691041545404;77136.22863771403;80799.5960020196;81157.59421202856;82165;11613.245139065933;12359.32023738667;12393.760623937535;12430.751384972069;12439.315837629018;36332.27335453329;36382.454263185544;36840.63159368479;36969.26061478702;37382.2523549522;49235.75382123067;49971.75070623263;50054.499455006444;50305;50710.74644626901;12519.436625351698;13615.727685446434;14147.726704596636;15808.130552819246;15970.8402915974;17253.309867605658;17769.46691599254;17914.925104493774;18016.009119498554;18225.99757013377;16047.438339658524;16077.67844643124;16086.839131609002;16141;16315.265813038204;15260.389584416498;16100.919495402448;16192.757108643615;16247.025178489328;16293.185340733153;15725.916616578439;15867.841321586637;16100.355985760438;16129;16233.756493652369;9868.730192055724;11540.596079137189;11546.0763138947;12074.973627241783;12198.878011219775;12059.15585908978;12419.565315213924;13388.799168012292;13526.323683815966;13572.592822215349 05:09:06 INFO - PID 1693 | __end_tp_report 05:09:06 INFO - PID 1693 | __start_cc_report 05:09:06 INFO - PID 1693 | _x_x_mozilla_cycle_collect,412 05:09:06 INFO - PID 1693 | __end_cc_report 05:09:06 INFO - PID 1693 | __startTimestamp1492949346881__endTimestamp 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | ------- Summary: start ------- 05:09:06 INFO - PID 1693 | Number of tests: 6 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | [#0] dojo.html Cycles:165 Average:5989.28 Median:6291.15 stddev:768.07 (12.2%) stddev-sans-first:734.27 05:09:06 INFO - PID 1693 | Values: 3020.9 3548.1 3601.6 3609.9 3612.1 5244.6 5909.5 6120.3 6153.9 6170.1 6104.6 6117.0 6132.4 6180.1 6189.6 5302.9 5341.3 5379.1 5425.3 5473.8 4103.3 4447.8 4578.4 4787.7 5391.6 4729.8 5344.3 5403.3 5442.5 5510.0 5248.9 5282.5 5319.1 5350.8 5430.2 5295.5 5313.7 5323.3 5351.6 5378.8 5306.9 5420.7 6171.9 6179.1 6207.6 5432.6 6310.5 6372.8 6542.0 6606.9 6709.5 6713.8 6723.1 6727.0 6731.8 6254.1 6275.2 6305.2 6317.3 6322.7 5759.9 6206.8 6628.2 6750.5 6857.7 5296.3 5893.9 5981.7 6335.9 6476.1 6106.0 6608.0 6639.3 6672.7 6686.9 5388.6 6511.5 6573.8 6574.0 6592.8 6292.9 6375.6 6574.8 6580.0 6610.5 4476.7 5166.9 5263.8 5319.5 5328.6 4689.7 4695.9 4710.9 4727.6 4743.3 5751.0 6198.2 6240.4 6291.2 6291.6 6373.6 6448.8 6614.2 6644.2 6682.1 6250.0 6271.5 6309.7 6330.2 6347.1 5822.2 5834.3 5835.2 5847.6 5884.8 6499.1 6606.9 6803.4 6814.3 6866.7 6658.3 6676.5 6698.7 6711.4 6736.6 6840.7 6865.7 6865.9 6875.1 6904.4 5224.6 6316.9 6341.7 6464.6 6623.6 6551.6 6554.0 6675.2 6679.3 6701.8 6478.2 6493.2 6513.5 6533.6 6536.0 6149.4 6297.9 6404.6 6495.7 6495.9 5932.8 6225.8 6362.7 6369.2 6375.7 5241.0 5284.9 6329.3 6412.1 6465.0 6190.3 6331.3 6359.7 6360.1 6371.2 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | [#1] ext.html Cycles:180 Average:44220.14 Median:327854.03 stddev:77126.54 (23.5%) stddev-sans-first:77273.58 05:09:06 INFO - PID 1693 | Values: 667.3 758.3 827.7 1252.7 1265.3 34442.5 35612.3 35622.0 35688.0 35785.1 35984.6 36001.5 36373.1 36452.0 36463.6 7937.9 8058.1 8336.6 8568.2 8578.4 7845.8 8519.2 8588.1 8641.3 8646.9 8173.6 8567.8 8670.7 8673.3 8694.3 7711.3 8594.4 8651.2 8673.5 8675.7 7355.8 8118.5 8220.2 8379.2 8421.4 37298.8 37342.4 37354.4 37407.1 37556.2 3494.4 3501.1 3502.2 3542.8 3547.4 30542.8 30578.4 30633.7 30669.4 30754.0 3161.5 3189.6 3190.1 3198.7 3206.7 231691.8 237990.0 286077.0 286719.6 288407.0 46926.1 47046.0 47063.0 47076.5 47135.3 42773.6 46606.8 47988.0 48593.0 48651.0 13869.1 13875.3 13934.9 13949.4 14016.4 11235.8 11472.8 11477.4 11504.4 11509.5 10838.3 13317.6 13349.5 13397.7 13504.6 6014.4 6021.5 6047.6 6068.8 6079.9 1026.5 1050.6 1051.4 1080.7 1086.6 23414.9 24297.5 24339.6 24357.0 24581.5 1011.7 1100.7 1146.7 1173.5 1178.8 12402.0 12465.3 12546.9 12583.7 12590.3 324687.0 325085.0 326948.0 326989.0 328719.1 51921.0 51978.5 52339.7 52351.0 52470.5 1487.6 1497.0 1535.8 1549.2 1549.9 23713.2 23984.2 24014.5 24036.2 24077.8 37073.3 37193.4 37241.0 37370.6 37473.6 284354.0 285391.0 285982.0 286198.0 286692.0 33625.0 33711.0 33717.0 34383.8 34429.0 43838.8 44591.0 44616.6 44632.6 44689.0 29701.3 30240.0 30376.2 31206.7 31236.4 30432.0 30546.0 30768.8 31160.4 31222.7 36141.6 36718.3 36877.8 37361.8 37364.0 30866.0 31151.8 31234.4 31778.7 31807.4 23569.1 23694.5 23825.3 24463.8 24860.3 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | [#2] jquery.html Cycles:180 Average:35666.37 Median:22470.94 stddev:92830.28 (413.1%) stddev-sans-first:93053.02 05:09:06 INFO - PID 1693 | Values: 438.8 442.3 447.4 454.6 465.3 18222.8 19343.0 19986.8 20140.0 20158.8 20860.3 22230.1 22418.3 22523.5 22634.3 6104.2 6256.5 6270.7 6277.1 6288.2 6031.2 6214.6 6263.6 6266.4 6283.1 6060.4 6216.8 6227.8 6236.2 6237.7 6134.8 6246.8 6255.7 6279.5 6282.3 4607.0 4961.8 5489.6 5521.1 5602.8 24182.6 27301.3 28209.9 28243.3 28254.4 1752.9 2167.3 2187.7 2191.6 2197.6 17749.7 17907.9 18057.2 18291.8 18591.8 2172.5 2182.2 2224.9 2225.7 2230.2 170265.0 171269.3 173189.0 173863.0 175642.2 12047.1 12529.2 12735.7 12846.8 12962.9 13914.7 15418.8 16582.4 16611.4 16679.7 7904.0 8782.2 9065.8 9211.8 9216.7 7731.3 8152.3 8623.6 8792.7 8794.1 7449.4 8081.7 8166.3 8197.9 8247.7 2115.3 2202.6 2207.2 2209.7 2383.4 894.4 985.1 998.8 1003.4 1025.1 16227.3 16722.4 18576.0 20304.1 20596.6 953.4 997.3 1001.8 1012.4 1038.2 10478.8 10851.3 10893.5 10912.0 10938.7 513564.0 532457.0 537473.0 555047.2 568006.0 120348.8 135321.6 137293.0 137940.3 140630.3 1066.3 1167.0 1211.0 1226.3 1233.1 18702.3 20779.3 22562.0 22795.9 22824.9 42868.4 58429.0 58437.4 59459.4 61091.0 57768.7 68667.0 70280.3 79600.0 82714.6 7748.1 7950.6 8813.7 8938.6 8976.0 11618.2 13582.9 13856.0 13927.1 14165.3 9484.7 10225.8 11721.5 11770.3 12106.3 9433.9 11161.0 11200.8 11311.5 11437.2 9707.8 10155.4 11958.5 12025.2 12216.7 8602.5 8689.5 8745.7 9075.5 9133.0 11303.8 11626.5 11898.9 12087.6 12117.2 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | [#3] mootools.html Cycles:180 Average:7135.62 Median:3873.56 stddev:4513.93 (116.5%) stddev-sans-first:4504.53 05:09:06 INFO - PID 1693 | Values: 1197.7 1394.1 1407.1 1408.5 1419.7 10641.7 10698.2 11791.7 11859.5 12157.6 11763.2 11910.2 11912.6 11930.4 11968.6 2536.2 2590.2 2590.8 2598.1 2598.8 2503.3 2555.7 2557.4 2559.3 2566.2 2494.5 2517.5 2541.3 2552.4 2558.6 2481.3 2508.2 2539.0 2541.5 2545.6 2437.7 2517.8 2534.7 2554.5 2558.6 11780.8 11865.5 11871.4 11886.3 11900.3 6628.3 6842.9 6866.9 6876.1 6878.1 4068.4 4386.9 4438.7 4441.3 4462.9 1211.2 1222.3 1271.0 1274.9 1275.5 15042.8 15561.8 16669.9 16823.0 16847.3 4915.2 5326.8 5668.8 5781.6 5788.4 12166.4 12323.1 12343.0 12347.8 12448.3 6613.1 6652.2 6653.8 6666.4 6668.5 5276.5 6007.4 6056.8 6185.5 6199.8 4369.7 4436.6 4444.7 4469.6 4530.1 1286.3 1301.2 1303.3 1313.3 1325.8 667.5 788.5 790.5 790.9 802.5 6108.6 6155.9 6182.4 6291.6 6342.1 583.3 584.4 605.1 612.9 613.7 3678.7 4298.8 4302.8 4437.0 4495.6 14585.3 14606.5 14858.0 15235.2 15256.5 14534.6 15027.2 15081.7 15091.5 15109.4 8391.2 8457.8 8607.0 8626.3 8629.7 5723.6 6874.9 6889.9 7118.6 7118.9 12966.2 13211.9 13291.1 13444.5 13694.2 13623.0 13778.3 13785.9 13948.6 13983.7 9476.3 9513.5 9521.0 9599.0 9622.5 10653.4 10745.6 10764.8 10765.7 10772.3 8962.7 9203.1 9243.5 9253.7 9313.0 8863.0 8908.4 8926.3 8979.5 9104.3 7312.7 7988.2 8072.8 8146.2 8192.0 6029.7 6041.9 6098.3 6248.5 6323.0 6025.9 6044.4 6156.0 6229.9 6360.9 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | [#4] prototype.html Cycles:180 Average:5230.18 Median:5834.33 stddev:1611.21 (27.6%) stddev-sans-first:1574.15 05:09:06 INFO - PID 1693 | Values: 384.9 390.2 411.0 419.1 420.5 6015.6 6223.0 6228.4 6252.2 6258.2 4923.2 5992.2 6033.9 6044.8 6091.8 4415.4 4440.0 4440.6 4447.3 4482.8 3646.7 3950.2 4024.9 4286.5 4471.8 4367.6 4376.6 4387.3 4388.8 4389.3 4381.6 4413.2 4420.3 4423.3 4427.6 3520.4 3535.3 3727.6 3789.4 3832.2 4494.7 5829.7 5838.9 5866.1 5910.8 4501.2 4573.9 4971.9 5254.7 5256.7 5166.8 5378.3 6346.0 6431.5 6480.1 4308.3 4334.9 4352.1 4352.5 4358.8 6019.2 6726.2 6777.2 6845.6 6897.0 3363.6 3900.9 4809.5 4838.2 4855.4 4505.5 4753.5 4957.9 4967.5 4967.7 5553.9 5554.4 5563.6 5565.9 5574.3 6309.8 6342.5 6494.8 6528.3 6551.4 1443.8 1597.8 1679.0 1681.8 1695.6 932.5 1095.5 1111.7 1136.2 1157.7 6078.5 6096.9 6106.6 6153.9 6160.3 6694.7 6697.6 6708.5 6714.0 6724.9 5490.8 5698.8 6048.9 6076.2 6097.6 3479.5 3510.5 3517.0 3517.5 3538.2 6063.6 6485.5 6775.2 6859.3 6920.6 5741.5 6146.8 6870.2 6870.3 6930.0 5480.4 5870.8 6244.3 6894.8 6971.0 6425.3 6620.6 6640.5 6681.5 6714.2 5280.0 6274.6 6601.8 6621.8 6627.1 5478.7 6363.3 6854.3 6959.5 6965.7 4577.4 4826.5 4836.3 4837.7 4839.4 6356.7 6622.1 6681.8 6695.2 6726.4 5427.3 5780.8 6080.8 6553.2 6558.1 5414.4 6200.6 6563.0 6563.5 6580.7 5566.2 6344.7 6354.6 6379.8 6424.5 5702.0 6441.6 6492.1 6524.7 6530.3 5555.1 6097.0 6305.2 6390.7 6417.7 05:09:06 INFO - PID 1693 | 05:09:06 INFO - PID 1693 | [#5] yui.html Cycles:180 Average:20733.23 Median:17965.47 stddev:28898.56 (160.9%) stddev-sans-first:28940.67 05:09:06 INFO - PID 1693 | Values: 748.9 811.4 825.0 850.1 852.2 14369.1 14909.3 16053.5 16626.5 16645.8 14169.1 16565.7 16911.8 17281.3 17357.9 991.3 993.0 996.7 997.5 999.8 962.7 997.6 999.6 1002.4 1011.9 1032.5 1045.7 1046.2 1049.8 1057.6 1038.6 1041.5 1044.3 1045.5 1050.8 766.5 769.7 770.2 771.2 780.3 15977.8 16834.2 17025.3 17038.5 17122.1 16161.8 16663.8 16730.5 16871.0 16980.7 11699.6 13586.8 13801.0 13830.4 13830.9 2972.5 3399.1 3430.6 3434.7 3479.5 115289.0 117021.0 117800.2 118743.0 123097.0 12932.8 13210.7 13375.5 13404.9 13446.5 24845.8 25033.1 25079.5 25277.0 25457.9 6726.8 6942.3 7484.2 7791.1 7844.7 3694.8 3788.0 3788.4 3789.1 3792.7 4122.3 4222.1 4236.3 4302.5 4303.2 927.0 936.5 948.1 957.3 957.6 624.0 635.3 644.6 647.3 662.9 10933.3 11593.3 11747.4 11985.1 12137.3 549.0 592.6 601.0 623.8 645.6 5014.3 5241.5 5273.3 5518.3 5643.3 95892.0 98512.5 98770.5 101294.0 102561.7 82294.0 84851.0 87562.0 89705.0 90818.0 61791.7 77136.2 80799.6 81157.6 82165.0 11613.2 12359.3 12393.8 12430.8 12439.3 36332.3 36382.5 36840.6 36969.3 37382.3 49235.8 49971.8 50054.5 50305.0 50710.7 12519.4 13615.7 14147.7 15808.1 15970.8 17253.3 17769.5 17914.9 18016.0 18226.0 16047.4 16077.7 16086.8 16141.0 16315.3 15260.4 16100.9 16192.8 16247.0 16293.2 15725.9 15867.8 16100.4 16129.0 16233.8 9868.7 11540.6 11546.1 12075.0 12198.9 12059.2 12419.6 13388.8 13526.3 13572.6 05:09:06 INFO - PID 1693 | -------- Summary: end -------- 05:09:06 INFO - PID 1693 | 05:09:07 INFO - TEST-INFO | 1693: exit 0 05:09:07 INFO - TEST-OK | dromaeo_css | took 1115636ms 05:09:07 INFO - TEST-START | kraken 05:09:07 INFO - operating with platform_type : mac_ 05:09:07 INFO - Initialising browser for kraken test... 05:09:07 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpJLaigA/profile http://localhost:49253/getInfo.html) 05:09:10 INFO - PID 1700 | 2017-04-23 05:09:10.315 plugin-container[1702:15661] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 05:09:10 INFO - PID 1700 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:09:10 INFO - PID 1700 | 2017-04-23 05:09:10.315 plugin-container[1702:15661] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 05:09:10 INFO - PID 1700 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:09:10 INFO - PID 1700 | 2017-04-23 05:09:10.315 plugin-container[1702:15661] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:09:10 INFO - PID 1700 | __metrics Screen width/height:1600/1200 05:09:10 INFO - PID 1700 | colorDepth:24 05:09:10 INFO - PID 1700 | Browser inner width/height: 1024/689 05:09:10 INFO - PID 1700 | __metrics 05:09:10 ERROR - PID 1700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 05:09:11 INFO - TEST-INFO | 1700: exit 0 05:09:11 INFO - Browser initialized. 05:09:11 INFO - Running cycle 1/1 for kraken test... 05:09:11 INFO - TEST-INFO | started process 1703 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpJLaigA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:13 INFO - PID 1703 | 2017-04-23 05:09:13.908 plugin-container[1704:15788] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 05:09:13 INFO - PID 1703 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:09:13 INFO - PID 1703 | 2017-04-23 05:09:13.909 plugin-container[1704:15788] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 05:09:13 INFO - PID 1703 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:09:13 INFO - PID 1703 | 2017-04-23 05:09:13.909 plugin-container[1704:15788] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:09:23 INFO - PID 1703 | RSS: Main: 236597248 05:09:23 INFO - PID 1703 | 05:09:26 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:27 INFO - PID 1703 | RSS: Main: 249503744 05:09:27 INFO - PID 1703 | 05:09:29 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 05:09:30 INFO - PID 1703 | RSS: Main: 257560576 05:09:30 INFO - PID 1703 | 05:09:33 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 05:09:34 INFO - PID 1703 | RSS: Main: 259637248 05:09:34 INFO - PID 1703 | 05:09:36 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 05:09:37 INFO - PID 1703 | RSS: Main: 262164480 05:09:37 INFO - PID 1703 | 05:09:39 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:39 INFO - PID 1703 | RSS: Main: 262774784 05:09:39 INFO - PID 1703 | 05:09:42 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:43 INFO - PID 1703 | RSS: Main: 268713984 05:09:43 INFO - PID 1703 | 05:09:45 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:46 INFO - PID 1703 | RSS: Main: 270229504 05:09:46 INFO - PID 1703 | 05:09:49 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 05:09:50 INFO - PID 1703 | RSS: Main: 269840384 05:09:50 INFO - PID 1703 | 05:09:51 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:52 INFO - PID 1703 | RSS: Main: 269287424 05:09:52 INFO - PID 1703 | 05:09:54 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:54 INFO - PID 1703 | RSS: Main: 269008896 05:09:54 INFO - PID 1703 | 05:09:56 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:57 INFO - PID 1703 | RSS: Main: 268587008 05:09:57 INFO - PID 1703 | 05:10:00 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:01 INFO - PID 1703 | RSS: Main: 268627968 05:10:01 INFO - PID 1703 | 05:10:04 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:05 INFO - PID 1703 | RSS: Main: 268988416 05:10:05 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 05:10:06 INFO - PID 1703 | RSS: Main: 270725120 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | __start_tp_report 05:10:06 INFO - PID 1703 | _x_x_mozilla_page_load 05:10:06 INFO - PID 1703 | _x_x_mozilla_page_load_details 05:10:06 INFO - PID 1703 | |i|pagename|runs| 05:10:06 INFO - PID 1703 | |0;ai-astar;102;121;152;116;115;115;114;115;112;114 05:10:06 INFO - PID 1703 | |1;audio-beat-detection;139;111;109;148;116;150;137;112;136;140 05:10:06 INFO - PID 1703 | |2;audio-dft;199;202;210;227;215;204;196;196;198;195 05:10:06 INFO - PID 1703 | |3;audio-fft;82;59;58;81;57;54;58;64;80;58 05:10:06 INFO - PID 1703 | |4;audio-oscillator;93;58;78;94;101;101;105;72;69;90 05:10:06 INFO - PID 1703 | |5;imaging-gaussian-blur;89;90;88;89;95;89;88;89;89;90 05:10:06 INFO - PID 1703 | |6;imaging-darkroom;97;97;96;97;96;97;97;96;96;97 05:10:06 INFO - PID 1703 | |7;imaging-desaturate;89;92;94;91;80;140;146;91;92;94 05:10:06 INFO - PID 1703 | |8;json-parse-financial;50;51;50;51;50;49;50;50;50;49 05:10:06 INFO - PID 1703 | |9;json-stringify-tinderbox;57;80;82;82;59;58;58;57;59;55 05:10:06 INFO - PID 1703 | |10;stanford-crypto-aes;83;82;84;84;83;84;84;86;83;84 05:10:06 INFO - PID 1703 | |11;stanford-crypto-ccm;141;136;139;136;134;148;150;154;188;137 05:10:06 INFO - PID 1703 | |12;stanford-crypto-pbkdf2;183;190;181;186;185;183;185;195;234;243 05:10:06 INFO - PID 1703 | |13;stanford-crypto-sha256-iterative;69;70;71;70;65;69;67;68;67;72 05:10:06 INFO - PID 1703 | __end_tp_report 05:10:06 INFO - PID 1703 | __start_cc_report 05:10:06 INFO - PID 1703 | _x_x_mozilla_cycle_collect,1010 05:10:06 INFO - PID 1703 | __end_cc_report 05:10:06 INFO - PID 1703 | __startTimestamp1492949406986__endTimestamp 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | ------- Summary: start ------- 05:10:06 INFO - PID 1703 | Number of tests: 14 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#0] ai-astar Cycles:10 Average:117.60 Median:115.00 stddev:12.99 (11.3%) stddev-sans-first:12.49 05:10:06 INFO - PID 1703 | Values: 102.0 121.0 152.0 116.0 115.0 115.0 114.0 115.0 112.0 114.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:138.00 stddev:16.03 (11.6%) stddev-sans-first:16.65 05:10:06 INFO - PID 1703 | Values: 139.0 111.0 109.0 148.0 116.0 150.0 137.0 112.0 136.0 140.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#2] audio-dft Cycles:10 Average:204.20 Median:203.00 stddev:10.33 (5.1%) stddev-sans-first:10.78 05:10:06 INFO - PID 1703 | Values: 199.0 202.0 210.0 227.0 215.0 204.0 196.0 196.0 198.0 195.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#3] audio-fft Cycles:10 Average:65.10 Median:61.50 stddev:11.25 (18.3%) stddev-sans-first:10.13 05:10:06 INFO - PID 1703 | Values: 82.0 59.0 58.0 81.0 57.0 54.0 58.0 64.0 80.0 58.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:75.00 stddev:15.89 (21.2%) stddev-sans-first:16.66 05:10:06 INFO - PID 1703 | Values: 93.0 58.0 78.0 94.0 101.0 101.0 105.0 72.0 69.0 90.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:89.00 stddev:2.01 (2.3%) stddev-sans-first:2.12 05:10:06 INFO - PID 1703 | Values: 89.0 90.0 88.0 89.0 95.0 89.0 88.0 89.0 89.0 90.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:10:06 INFO - PID 1703 | Values: 97.0 97.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 97.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#7] imaging-desaturate Cycles:10 Average:100.90 Median:91.50 stddev:22.59 (24.7%) stddev-sans-first:23.54 05:10:06 INFO - PID 1703 | Values: 89.0 92.0 94.0 91.0 80.0 140.0 146.0 91.0 92.0 94.0 05:10:06 INFO - PID 1703 | 05:10:06 INFO - PID 1703 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 05:10:06 INFO - PID 1703 | Values: 50.0 51.0 50.0 51.0 50.0 49.0 50.0 50.0 50.0 49.0 05:10:07 INFO - PID 1703 | 05:10:07 INFO - PID 1703 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:59.00 stddev:11.55 (19.6%) stddev-sans-first:11.91 05:10:07 INFO - PID 1703 | Values: 57.0 80.0 82.0 82.0 59.0 58.0 58.0 57.0 59.0 55.0 05:10:07 INFO - PID 1703 | 05:10:07 INFO - PID 1703 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 05:10:07 INFO - PID 1703 | Values: 83.0 82.0 84.0 84.0 83.0 84.0 84.0 86.0 83.0 84.0 05:10:07 INFO - PID 1703 | 05:10:07 INFO - PID 1703 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:144.50 stddev:16.15 (11.2%) stddev-sans-first:17.01 05:10:07 INFO - PID 1703 | Values: 141.0 136.0 139.0 136.0 134.0 148.0 150.0 154.0 188.0 137.0 05:10:07 INFO - PID 1703 | 05:10:07 INFO - PID 1703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.50 Median:188.00 stddev:22.59 (12.0%) stddev-sans-first:23.43 05:10:07 INFO - PID 1703 | Values: 183.0 190.0 181.0 186.0 185.0 183.0 185.0 195.0 234.0 243.0 05:10:07 INFO - PID 1703 | 05:10:07 INFO - PID 1703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:2.10 (3.0%) stddev-sans-first:2.22 05:10:07 INFO - PID 1703 | Values: 69.0 70.0 71.0 70.0 65.0 69.0 67.0 68.0 67.0 72.0 05:10:07 INFO - PID 1703 | -------- Summary: end -------- 05:10:07 INFO - PID 1703 | 05:10:07 INFO - TEST-INFO | 1703: exit 0 05:10:08 INFO - TEST-OK | kraken | took 60508ms 05:10:08 INFO - SUITE-END | took 1176s 05:10:08 INFO - Completed test suite (00:19:36) 05:10:08 INFO - javascript benchmark 05:10:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7773.296493665859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.924476888078, 3548.059764162496, 3601.639836016397, 3609.8917032489016, 3612.0789198754314, 5244.606654500909, 5909.468147866691, 6120.326764055956, 6153.907691384633, 6170.136180934667, 6104.550104788481, 6117.0, 6132.3555089925, 6180.134781130634, 6189.597676151058, 5302.92045619315, 5341.332333458317, 5379.085555455582, 5425.348958125031, 5473.8357849264385, 4103.343465045593, 4447.777611119447, 4578.412685936594, 4787.688800227991, 5391.595630327722, 4729.7635118244125, 5344.331958505187, 5403.324584426947, 5442.537384322337, 5510.008198524264, 5248.947510524922, 5282.498162674578, 5319.069162896516, 5350.785968561253, 5430.15832545956, 5295.4704529547125, 5313.734313284321, 5323.307969963918, 5351.57187425005, 5378.784848606051, 5306.946930530722, 5420.7018613976215, 6171.938280617182, 6179.104029915637, 6207.565470417073, 5432.6468779529205, 6310.463610593105, 6372.808815735489, 6541.967290163567, 6606.867862642768, 6709.463242940553, 6713.832154196135, 6723.058771771955, 6726.966365168192, 6731.831704207385, 6254.124422580842, 6275.1842260506755, 6305.243370795488, 6317.273513546001, 6322.71547780351, 5759.94240057594, 6206.844828879224, 6628.204615446178, 6750.493712971449, 6857.725690972405, 5296.25852380667, 5893.882122357529, 5981.700914954235, 6335.873282534416, 6476.125723027425, 6106.0, 6608.0, 6639.269680335159, 6672.733090676318, 6686.899696504556, 5388.568914486832, 6511.511636627272, 6573.80278591643, 6573.967130164414, 6592.76925307612, 6292.905606415908, 6375.649339286291, 6574.8356291093105, 6580.0, 6610.537262391683, 4476.731396116178, 5166.870828229249, 5263.842084737464, 5319.468053194727, 5328.600354973392, 4689.6717229793585, 4695.929561056587, 4710.905781884411, 4727.57451829337, 4743.335932969387, 5750.971245143747, 6198.194234749544, 6240.375962403723, 6291.150694656254, 6291.559590828598, 6373.649449280334, 6448.774292899726, 6614.173228346457, 6644.169478815148, 6682.064510968468, 6250.0, 6271.498280137669, 6309.652969086653, 6330.208723909512, 6347.1114044033875, 5822.243108395966, 5834.3290521589715, 5835.183074369592, 5847.590668653239, 5884.823455296348, 6499.057636642566, 6606.900896486461, 6803.353681400259, 6814.250432452525, 6866.725330986705, 6658.267590564937, 6676.532642714963, 6698.698558564779, 6711.429528490133, 6736.562123461959, 6840.657967101724, 6865.691043902936, 6865.931340686529, 6875.140607424072, 6904.4131248842405, 5224.582033437392, 6316.905246421215, 6341.682915854281, 6464.5798023128345, 6623.569467984566, 6551.6069035858, 6553.967230163818, 6675.165604299463, 6679.298673639198, 6701.765438209639, 6478.1578394808375, 6493.188351456068, 6513.54405191632, 6533.575317604341, 6535.967320163369, 6149.44654981036, 6297.937020629735, 6404.583702059351, 6495.675216239264, 6495.935040649533, 5932.792352267823, 6225.782097626561, 6362.6818659067785, 6369.235691717024, 6375.6812159392775, 5240.973795131, 5284.867878302919, 6329.335419780857, 6412.102305677302, 6465.0, 6190.2571691397325, 6331.3352098029045, 6359.650219237987, 6360.077788720702, 6371.23545174582], "value": 5938.302741555528, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.2993356975177, 758.2872100225787, 827.6523859978806, 1252.7244006318606, 1265.2598230035428, 34442.483362749546, 35612.2877542449, 35622.0, 35688.0, 35785.10537236567, 35984.640153598455, 36001.45997810028, 36373.0906727332, 36452.0, 36463.635363646354, 7937.880931786028, 8058.113607503199, 8336.583170841464, 8568.1860223279, 8578.356623253281, 7845.783903494939, 8519.233269005788, 8588.055313915464, 8641.30869530436, 8646.913530864675, 8173.591320433984, 8567.82864342716, 8670.653173873037, 8673.262772664331, 8694.304455643565, 7711.26742959418, 8594.355423343242, 8651.178138076873, 8673.522956237404, 8675.69635062776, 7355.77932662021, 8118.472299300585, 8220.219079187467, 8379.203975622306, 8421.36839737016, 37298.813505932565, 37342.43986340207, 37354.43968340477, 37407.06482337936, 37556.24887502262, 3494.353544594258, 3501.107217659506, 3502.22950950793, 3542.787432754017, 3547.3614749345106, 30542.84728576365, 30578.38843223145, 30633.693663063306, 30669.38661226763, 30754.0, 3161.541576471399, 3189.569408129896, 3190.1386625611185, 3198.7441004719567, 3206.695363940422, 231691.8415407912, 237990.0, 286077.0, 286719.5664021687, 288407.0, 46926.061478770236, 47046.0, 47063.0, 47076.5292347079, 47135.29297060547, 42773.57226427696, 46606.76696616495, 47988.0, 48593.0, 48651.0, 13869.09850859691, 13875.306234688225, 13934.860651393356, 13949.3722782473, 14016.369263383172, 11235.775284494264, 11472.827907581393, 11477.426128693533, 11504.42477876103, 11509.539618415338, 10838.295510791773, 13317.600471985856, 13349.466021359036, 13397.732045359038, 13504.594862154152, 6014.368491308437, 6021.5182785377065, 6047.637141771508, 6068.786242751379, 6079.908801367983, 1026.4918865161792, 1050.5902697947654, 1051.358671210561, 1080.719013056611, 1086.6196831109207, 23414.88292558526, 24297.51404971926, 24339.634905476432, 24357.0, 24581.508369832503, 1011.716719318592, 1100.6642973892879, 1146.6674664347245, 1173.495396979307, 1178.8172833210865, 12402.0, 12465.314407707481, 12546.874531254753, 12583.685407864694, 12590.307533085585, 324687.0, 325085.0, 326948.0, 326989.0, 328719.069213962, 51920.96158076818, 51978.48021519812, 52339.73830130825, 52351.0, 52470.47529524732, 1487.605784467117, 1496.9700605988037, 1535.7619568966827, 1549.1711934115194, 1549.8760099192264, 23713.17003904855, 23984.160554380513, 24014.51970960536, 24036.158734444212, 24077.79611019477, 37073.25853482969, 37193.442098368, 37241.0, 37370.626293736714, 37473.6252637481, 284354.0, 285391.0, 285982.0, 286198.0, 286692.0, 33624.99125026253, 33711.0, 33717.0, 34383.828080859435, 34429.0, 43838.78080609577, 44591.0, 44616.55383446124, 44632.55367446284, 44689.0, 29701.257468563457, 30240.0, 30376.240593985327, 31206.687933120378, 31236.37527249488, 30432.0, 30546.0, 30768.84615576908, 31160.37679246357, 31222.68777312198, 36141.63858361383, 36718.26563468769, 36877.815610922844, 37361.81319093387, 37364.0, 30866.0, 31151.84424077865, 31234.375312494078, 31778.682213178497, 31807.36385272328, 23569.050379977216, 23694.526109478058, 23825.285241442783, 24463.755362446147, 24860.254192374257], "value": 17391.095839639107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.8310500457323, 442.29233226837056, 447.4116536754168, 454.62720569133313, 465.3043699668995, 18222.81777182228, 19343.0, 19986.800131998676, 20140.0, 20158.798412015876, 20860.269890553835, 22230.11079556816, 22418.32745017652, 22523.54952900941, 22634.320970370874, 6104.206453161094, 6256.468200202966, 6270.7178176981915, 6277.089821975811, 6288.24541055074, 6031.215941927543, 6214.601714614221, 6263.592866463665, 6266.436020758131, 6283.12036314914, 6060.363661815512, 6216.844578885519, 6227.813165605039, 6236.158118653992, 6237.71930263137, 6134.846628834271, 6246.781362652308, 6255.655938923357, 6279.497640188774, 6282.308946015912, 4607.0, 4961.751912404366, 5489.560835133179, 5521.089020311644, 5602.803901863415, 24182.637260441108, 27301.317467063283, 28209.858950705115, 28243.293917652016, 28254.434911301865, 1752.8510076643372, 2167.2956289205913, 2187.6937228787983, 2191.638379667353, 2197.637389830676, 17749.7337539937, 17907.925524468574, 18057.187426565837, 18291.817081829144, 18591.814081859142, 2172.4894649757452, 2182.159868450642, 2224.8887555622155, 2225.6550234713645, 2230.174835310945, 170265.0, 171269.2873071266, 173189.0, 173863.0, 175642.24357756387, 12047.096467764954, 12529.18560293578, 12735.68160795969, 12846.84378405948, 12962.935185324013, 13914.721705566035, 15418.768718469231, 16582.419615313647, 16611.41860034917, 16679.6664066718, 7903.9724835770985, 8782.165694259034, 9065.81868362629, 9211.815763684823, 9216.723498295061, 7731.304182623591, 8152.317517611348, 8623.568821559022, 8792.692255771017, 8794.120587941283, 7449.441291903129, 8081.676732930617, 8166.305864001626, 8197.877031844528, 8247.711330103417, 2115.3336698940093, 2202.64757638777, 2207.2054060538194, 2209.723784526934, 2383.427977285439, 894.3784070071368, 985.1281615769952, 998.8401855703053, 1003.4130033930087, 1025.123519390925, 16227.269772860249, 16722.414715484898, 18576.0, 20304.08631611581, 20596.588068238852, 953.3612479638658, 997.2769741937037, 1001.8447140693204, 1012.3875055591409, 1038.1694644284541, 10478.790424191473, 10851.274066533042, 10893.509792059376, 10912.0, 10938.671839844817, 513564.0, 532457.0, 537473.0, 555047.2247638816, 568006.0, 120348.79651203551, 135321.64678353287, 137293.0, 137940.31029844788, 140630.2968485151, 1066.328213225663, 1167.0160726764534, 1211.0, 1226.2826246645811, 1233.105998151351, 18702.345417910306, 20779.272725455143, 22562.0, 22795.886020570455, 22824.85875706241, 42868.35697464603, 58429.0, 58437.4156258449, 59459.405405945385, 61091.0, 57768.71115644563, 68667.0, 70280.29719702738, 79600.0, 82714.58642706748, 7748.14770375247, 7950.602469876368, 8813.735587932373, 8938.597763100806, 8975.955120224357, 11618.186726929034, 13582.86417135816, 13856.0, 13927.094738841943, 14165.291735413395, 9484.668036618961, 10225.750334926304, 11721.472533736172, 11770.293782373084, 12106.273623582612, 9433.858492122486, 11161.0, 11200.775984480428, 11311.490982905625, 11437.199396042197, 9707.83505979287, 10155.375139977568, 11958.521659133885, 12025.158238923541, 12216.694582635506, 8602.483850968962, 8689.478631282143, 8745.650173992968, 9075.546222688707, 9133.041030691948, 11303.7739245213, 11626.476808543466, 11898.940505297418, 12087.576934807239, 12117.212381195193], "value": 10377.499092167764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.6886009637494, 1394.1217033269038, 1407.1064873805144, 1408.4718230663495, 1419.7160567886422, 10641.66979127609, 10698.197635177354, 11791.705207369798, 11859.525618975242, 12157.635270941864, 11763.235389699663, 11910.166288359818, 11912.583059592916, 11930.403479826018, 11968.581099661513, 2536.2010966545527, 2590.222933120066, 2590.766830985211, 2598.116640342283, 2598.8180827342094, 2503.2990762586505, 2555.718870924197, 2557.360659835041, 2559.2834006478215, 2566.153169454076, 2494.5260400523935, 2517.471331020479, 2541.275736415122, 2552.3619095226195, 2558.6289987951736, 2481.268025932345, 2508.2475257422793, 2538.9746102538925, 2541.4789968056502, 2545.6253623043535, 2437.707475102999, 2517.8489290642437, 2534.657821194152, 2554.463562651845, 2558.616207568861, 11780.764384712258, 11865.466054027589, 11871.406429678482, 11886.346250956194, 11900.345480998541, 6628.270890202074, 6842.897356539655, 6866.896996545056, 6876.106106206161, 6878.105846239957, 4068.3897415387632, 4386.8903277418, 4438.733675979452, 4441.289393697025, 4462.910741785178, 1211.2066596379386, 1222.2727477151082, 1271.0467149637773, 1274.8533918599387, 1275.5280546197873, 15042.849571504365, 15561.844381556266, 16669.91665041679, 16823.0, 16847.32610695571, 4915.238138088602, 5326.813561525328, 5668.829935101953, 5781.566382521328, 5788.392218816964, 12166.35754173193, 12323.137380383287, 12342.95084917792, 12347.814782778265, 12448.31534265624, 6613.074169616258, 6652.168478940132, 6653.800385988428, 6666.366695163952, 6668.499862510331, 5276.5251127398715, 6007.369226231182, 6056.818295451144, 6185.474234690102, 6199.814005579839, 4369.737815731003, 4436.6228870546365, 4444.688871779009, 4469.5530446955045, 4530.116627257653, 1286.2539726958341, 1301.2322729589398, 1303.2506308872437, 1313.299277435704, 1325.7812460944028, 667.506045526307, 788.5111231036794, 790.4624855098588, 790.9485883417559, 802.5273622901924, 6108.572399932051, 6155.907661385083, 6182.443580077815, 6291.622502649856, 6342.112104305401, 583.2650859916536, 584.4185035889317, 605.1467430922378, 612.9387061293835, 613.6502193749609, 3678.7240956928335, 4298.76356800379, 4302.827886884552, 4436.977815110969, 4495.640348772155, 14585.270736463135, 14606.48877289311, 14858.0, 15235.238238088274, 15256.542303730906, 14534.636634084021, 15027.248637568078, 15081.698366032619, 15091.54725358241, 15109.39562417491, 8391.160883911682, 8457.830843383097, 8606.956965215133, 8626.309895208367, 8629.69796057135, 5723.627964182315, 6874.8625027500175, 6889.862202755817, 7118.644067796693, 7118.85762284741, 12966.222026678051, 13211.933940330622, 13291.069625126534, 13444.46222151103, 13694.246816425193, 13623.0, 13778.311084445939, 13785.931070344584, 13948.568193331294, 13983.650408739455, 9476.336656433983, 9513.476758778057, 9521.047895210424, 9599.040095990345, 9622.470764107762, 10653.414062226651, 10745.570177192825, 10764.784704306026, 10765.730856728644, 10772.299800512941, 8962.68630597926, 9203.125703058198, 9243.537823108953, 9253.67612133572, 9313.0, 8863.0, 8908.376413650982, 8926.330525210506, 8979.50612716307, 9104.317176211944, 7312.670929808278, 7988.241117093867, 8072.757817265491, 8146.185381461806, 8192.016957965083, 6029.668368239789, 6041.9395806041375, 6098.298695650057, 6248.468880145057, 6322.988321868479, 6025.939740602538, 6044.425779550936, 6156.045812899008, 6229.875402492015, 6360.872782544231], "value": 5344.885320779205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9233665341441, 390.22929713815216, 410.96301332880034, 419.10521037584766, 420.54371007456916, 6015.586337210763, 6222.968885155574, 6228.377162283769, 6252.249730032402, 6258.217722784658, 4923.178423983131, 5992.161097446361, 6033.939660603392, 6044.788432404866, 6091.847703807396, 4415.425994620695, 4439.977800110995, 4440.600345968862, 4447.266201076818, 4482.798274077658, 3646.6535679110443, 3950.2297052074855, 4024.907048334864, 4286.464191976003, 4471.82112715491, 4367.628751556122, 4376.649868010568, 4387.29803231483, 4388.846390376338, 4389.297712366022, 4381.627561657263, 4413.183561041217, 4420.3369494575745, 4423.314386270134, 4427.623651989585, 3520.436730123168, 3535.328287625343, 3727.6458736419995, 3789.4315852622326, 3832.156925476391, 4494.662900282459, 5829.708514574297, 5838.941610583882, 5866.066966516742, 5910.763569457216, 4501.234790085693, 4573.947991961834, 4971.850844474671, 5254.684718916839, 5256.737163141827, 5166.837461571154, 5378.327709036371, 6346.0, 6431.517636177306, 6480.092787009822, 4308.31067029277, 4334.934975975363, 4352.086061926999, 4352.499462561815, 4358.803853826554, 6019.247594050744, 6726.226483954359, 6777.2054893066215, 6845.623490707959, 6896.965515172392, 3363.630000699921, 3900.941485877714, 4809.470958194595, 4838.225883858566, 4855.36880205571, 4505.504394516601, 4753.524647535219, 4957.925631115536, 4967.5032496750755, 4967.7019378837385, 5553.944460555343, 5554.389017208104, 5563.638363506359, 5565.888682226414, 5574.275344205227, 6309.801137783807, 6342.460890824332, 6494.772682956074, 6528.314526974599, 6551.4103730664465, 1443.7617793064028, 1597.840215978393, 1679.0261648243988, 1681.7645529625863, 1695.6100096977764, 932.5150921520772, 1095.4741723972538, 1111.7276267314398, 1136.2273653915418, 1157.716359491913, 6078.544109191828, 6096.902557539685, 6106.603070800384, 6153.907691384633, 6160.322364539897, 6694.732210711517, 6697.564658297195, 6708.463322934153, 6714.026466162477, 6724.899126513106, 5490.780368785284, 5698.834442911667, 6048.909266361008, 6076.210092687922, 6097.646294537986, 3479.460683594047, 3510.526078979356, 3516.9648303517147, 3517.472379143098, 3538.1862171700654, 6063.605865618721, 6485.54601177913, 6775.22084960226, 6859.279775623588, 6920.619365934922, 5741.540676745851, 6146.815595532141, 6870.20992585859, 6870.31296870319, 6930.029795828588, 5480.3971563128025, 5870.765169393177, 6244.313125556185, 6894.758683446055, 6970.989206565121, 6425.341627320342, 6620.5834870272965, 6640.468762499085, 6681.465482761465, 6714.194296684429, 5279.973600131974, 6274.560780745304, 6601.801945941629, 6621.834454138685, 6627.072209890715, 5478.671279723229, 6363.300036996019, 6854.320691430631, 6959.512834101767, 6965.721371145098, 4577.3591697161755, 4826.493218212037, 4836.298736683231, 4837.733924634038, 4839.41926968766, 6356.745730170742, 6622.07290979273, 6681.83295417599, 6695.163104611924, 6726.39462448382, 5427.348718153847, 5780.843831233686, 6080.787172448943, 6553.246376666744, 6558.114654521579, 5414.404415514212, 6200.596961197508, 6563.04490109983, 6563.540552161303, 6580.696756135314, 5566.22072909801, 6344.65247858277, 6354.555181137276, 6379.840503987438, 6424.458130048848, 5702.0, 6441.581297215666, 6492.123563319081, 6524.706388212637, 6530.281669016309, 5555.055910303568, 6096.963516202168, 6305.211848518935, 6390.680465976776, 6417.679116044273], "value": 4741.800129352994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.9251074892511, 811.3711873298197, 824.9587520623967, 850.0819115355416, 852.1521086518912, 14369.137851728903, 14909.25453727312, 16053.51839444817, 16626.50120496387, 16645.83354166458, 14169.079009864377, 16565.66868662629, 16911.830881691178, 17281.30874765011, 17357.91321043393, 991.2516050381952, 992.990070099297, 996.681062060141, 997.5361456922566, 999.7500624843789, 962.687126683827, 997.6009596161521, 999.6451259802774, 1002.3885429887799, 1011.9190464762838, 1032.4579595712273, 1045.681067274481, 1046.199657262195, 1049.8372752223418, 1057.6456886942883, 1038.5689938675441, 1041.5469270867197, 1044.29510080696, 1045.4772613693153, 1050.8213603687354, 766.4519868294196, 769.6651956398985, 770.2490072179636, 771.1863983497408, 780.3367137932769, 15977.760333595006, 16834.24245908937, 17025.318987240495, 17038.48884533466, 17122.14389280531, 16161.838381616151, 16663.833361666348, 16730.498085057345, 16870.987740735596, 16980.660386792195, 11699.590514332043, 13586.796198057036, 13801.0, 13830.446782128703, 13830.930845345709, 2972.4798160322075, 3399.065257054305, 3430.588329400463, 3434.742394320436, 3479.512868198429, 115289.0, 117021.0, 117800.23299650512, 118743.0, 123097.0, 12932.806007909889, 13210.669733256553, 13375.53185638498, 13404.865951340362, 13446.529371472147, 24845.751542484344, 25033.12384066549, 25079.498410031698, 25277.0, 25457.87271063633, 6726.831829204309, 6942.340477654615, 7484.176740558534, 7791.10402303731, 7844.725434609762, 3694.7598406103516, 3788.0, 3788.3938569829247, 3789.052736815796, 3792.6586607205486, 4122.2786012447705, 4222.092250166229, 4236.301010333261, 4302.483701955723, 4303.182395344875, 926.9814603708023, 936.4989730494153, 948.0993056596261, 957.2772556719632, 957.6073809738114, 623.9500839932795, 635.3202073781102, 644.6293381305768, 647.3009150117862, 662.8740539297518, 10933.289336193122, 11593.304401735923, 11747.353895535827, 11985.101117416229, 12137.332446715516, 548.9835304940858, 592.6473748119862, 600.9729562169713, 623.8378021714387, 645.6481217736344, 5014.27007682349, 5241.50205730455, 5273.34083239595, 5518.33779946401, 5643.294588176478, 95892.0, 98512.50743746235, 98770.5061474688, 101294.0, 102561.74382561684, 82294.0, 84851.0, 87562.0, 89705.0, 90818.0, 61791.691041545404, 77136.22863771403, 80799.5960020196, 81157.59421202856, 82165.0, 11613.245139065933, 12359.32023738667, 12393.760623937535, 12430.751384972069, 12439.315837629018, 36332.27335453329, 36382.454263185544, 36840.63159368479, 36969.26061478702, 37382.2523549522, 49235.75382123067, 49971.75070623263, 50054.499455006444, 50305.0, 50710.74644626901, 12519.436625351698, 13615.727685446434, 14147.726704596636, 15808.130552819246, 15970.8402915974, 17253.309867605658, 17769.46691599254, 17914.925104493774, 18016.009119498554, 18225.99757013377, 16047.438339658524, 16077.67844643124, 16086.839131609002, 16141.0, 16315.265813038204, 15260.389584416498, 16100.919495402448, 16192.757108643615, 16247.025178489328, 16293.185340733153, 15725.916616578439, 15867.841321586637, 16100.355985760438, 16129.0, 16233.756493652369, 9868.730192055724, 11540.596079137189, 11546.0763138947, 12074.973627241783, 12198.878011219775, 12059.15585908978, 12419.565315213924, 13388.799168012292, 13526.323683815966, 13572.592822215349], "value": 8121.509012330413, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 121.0, 152.0, 116.0, 115.0, 115.0, 114.0, 115.0, 112.0, 114.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 109.0, 148.0, 116.0, 150.0, 137.0, 112.0, 136.0, 140.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 202.0, 210.0, 227.0, 215.0, 204.0, 196.0, 196.0, 198.0, 195.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 81.0, 57.0, 54.0, 58.0, 64.0, 80.0, 58.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 58.0, 78.0, 94.0, 101.0, 101.0, 105.0, 72.0, 69.0, 90.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 89.0, 95.0, 89.0, 88.0, 89.0, 89.0, 90.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 94.0, 91.0, 80.0, 140.0, 146.0, 91.0, 92.0, 94.0], "value": 100.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 50.0, 49.0, 50.0, 50.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 80.0, 82.0, 82.0, 59.0, 58.0, 58.0, 57.0, 59.0, 55.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 84.0, 83.0, 84.0, 84.0, 86.0, 83.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 139.0, 136.0, 134.0, 148.0, 150.0, 154.0, 188.0, 137.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 190.0, 181.0, 186.0, 185.0, 183.0, 185.0, 195.0, 234.0, 243.0], "value": 196.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 71.0, 70.0, 65.0, 69.0, 67.0, 68.0, 67.0, 72.0], "value": 68.8, "unit": "score"}]}]} 05:10:08 INFO - Return code: 0 05:10:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:10:08 ERROR - # TBPL SUCCESS # 05:10:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:08 INFO - 2017-04-23 05:10:08.325 screenresolution[1708:16192] starting screenresolution argv=screenresolution get 05:10:08 INFO - 2017-04-23 05:10:08.328 screenresolution[1708:16192] Display 0: 1600x1200x32@60 05:10:08 INFO - 2017-04-23 05:10:08.335 screenresolution[1709:16195] starting screenresolution argv=screenresolution list 05:10:08 INFO - Available Modes on Display 0 05:10:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:08 INFO - Intel Iris: 05:10:08 INFO - Chipset Model: Intel Iris 05:10:08 INFO - Type: GPU 05:10:08 INFO - Bus: Built-In 05:10:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:08 INFO - Vendor: Intel (0x8086) 05:10:08 INFO - Device ID: 0x0a2e 05:10:08 INFO - Revision ID: 0x0009 05:10:08 INFO - Displays: 05:10:08 INFO - Display: 05:10:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:08 INFO - Display Serial Number: 1600x1200 60 05:10:08 INFO - Main Display: Yes 05:10:08 INFO - Mirror: Off 05:10:08 INFO - Online: Yes 05:10:08 INFO - Rotation: Supported 05:10:08 INFO - Return code: 0 05:10:08 INFO - Running post-action listener: _resource_record_post_action 05:10:08 INFO - [mozharness: 2017-04-23 12:10:08.577258Z] Finished run-tests step (success) 05:10:08 INFO - Running post-run listener: _resource_record_post_run 05:10:08 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 34189312; Write bytes: 515557376; Read time: 206; Write time: 1607 05:10:08 INFO - TinderboxPrint: CPU usage
54.1% 05:10:08 INFO - TinderboxPrint: I/O read bytes / time
34,189,312 / 206 05:10:08 INFO - TinderboxPrint: I/O write bytes / time
515,557,376 / 1,607 05:10:08 INFO - TinderboxPrint: CPU idle
2,196.0 (45.9%) 05:10:08 INFO - TinderboxPrint: CPU system
959.2 (20.0%) 05:10:08 INFO - TinderboxPrint: CPU user
1,630.4 (34.1%) 05:10:08 INFO - TinderboxPrint: Swap in / out
238,084,096 / 0 05:10:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209293824; Write bytes: 211519488; Read time: 15981; Write time: 455 05:10:08 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30171136; Write bytes: 302673920; Read time: 180; Write time: 1147 05:10:09 INFO - Running post-run listener: _upload_blobber_files 05:10:09 INFO - Blob upload gear active. 05:10:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:09 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 05:10:09 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'] 05:10:09 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 05:10:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:10 INFO - (blobuploader) - INFO - Done attempting. 05:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:11 INFO - (blobuploader) - INFO - Done attempting. 05:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:12 INFO - (blobuploader) - INFO - Done attempting. 05:10:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:14 INFO - (blobuploader) - INFO - Done attempting. 05:10:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:14 INFO - Return code: 0 05:10:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98642953906dd4f8b36624b3a6527a731d897c959b9712fe45661c823d4daccfc1a201df9bd8062536224fbb924fd2ef5aaeb359fbe8ebfb531f300c7ac62df2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a1625c6da74260c61e67a2a02b0b57b08c79f4ddfb63bcf5bd04f9c4d6b44947ac92c31b5be723bc5cc23ba497a66afdca3717bac4f0180946c6461730fdc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ebe9030ecaeefe1baa80e1999f9c946848b57fb79cd686be4ead8e18d54b02b7b3a6e676f88606944becf31a543851a89c7e7b47ee5e772dc018b2400f61dc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da28d1c7e8901b82504bc58e32c9f01f8795f0626fa64626e568ada64676f190af8a913fef26cf03b6ddac9b0079b7f994d5f3335b1d5c0f7f5a2de358de80c"} 05:10:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:14 INFO - Contents: 05:10:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98642953906dd4f8b36624b3a6527a731d897c959b9712fe45661c823d4daccfc1a201df9bd8062536224fbb924fd2ef5aaeb359fbe8ebfb531f300c7ac62df2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a1625c6da74260c61e67a2a02b0b57b08c79f4ddfb63bcf5bd04f9c4d6b44947ac92c31b5be723bc5cc23ba497a66afdca3717bac4f0180946c6461730fdc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ebe9030ecaeefe1baa80e1999f9c946848b57fb79cd686be4ead8e18d54b02b7b3a6e676f88606944becf31a543851a89c7e7b47ee5e772dc018b2400f61dc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da28d1c7e8901b82504bc58e32c9f01f8795f0626fa64626e568ada64676f190af8a913fef26cf03b6ddac9b0079b7f994d5f3335b1d5c0f7f5a2de358de80c"} 05:10:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:10:14 INFO - Copying logs to upload dir... 05:10:14 INFO - mkdir: /builds/slave/test/build/upload/logs 05:10:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.687282 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-23 05:10:14.589542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:14.593710) ========= 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.EBiz4UEjiV/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.QgstyK8hYv/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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/98642953906dd4f8b36624b3a6527a731d897c959b9712fe45661c823d4daccfc1a201df9bd8062536224fbb924fd2ef5aaeb359fbe8ebfb531f300c7ac62df2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a1625c6da74260c61e67a2a02b0b57b08c79f4ddfb63bcf5bd04f9c4d6b44947ac92c31b5be723bc5cc23ba497a66afdca3717bac4f0180946c6461730fdc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ebe9030ecaeefe1baa80e1999f9c946848b57fb79cd686be4ead8e18d54b02b7b3a6e676f88606944becf31a543851a89c7e7b47ee5e772dc018b2400f61dc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da28d1c7e8901b82504bc58e32c9f01f8795f0626fa64626e568ada64676f190af8a913fef26cf03b6ddac9b0079b7f994d5f3335b1d5c0f7f5a2de358de80c"} build_url:https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/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/98642953906dd4f8b36624b3a6527a731d897c959b9712fe45661c823d4daccfc1a201df9bd8062536224fbb924fd2ef5aaeb359fbe8ebfb531f300c7ac62df2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a1625c6da74260c61e67a2a02b0b57b08c79f4ddfb63bcf5bd04f9c4d6b44947ac92c31b5be723bc5cc23ba497a66afdca3717bac4f0180946c6461730fdc20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ebe9030ecaeefe1baa80e1999f9c946848b57fb79cd686be4ead8e18d54b02b7b3a6e676f88606944becf31a543851a89c7e7b47ee5e772dc018b2400f61dc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da28d1c7e8901b82504bc58e32c9f01f8795f0626fa64626e568ada64676f190af8a913fef26cf03b6ddac9b0079b7f994d5f3335b1d5c0f7f5a2de358de80c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:14.632655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:14.633258) ========= 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.EBiz4UEjiV/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.QgstyK8hYv/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.005274 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:14.683382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 05:10:14.683728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 05:10:14.684079) ========= ========= Total master_lag: 0.40 =========